builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-026 starttime: 1448430767.09 results: success (0) buildid: 20151124204732 builduid: 5ddd73fe3d4b461180f55970d6d58c26 revision: 31cf031ca23e4927db55f9e5469ac3e4c6599a35 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 21:52:47.090986) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 21:52:47.091473) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 21:52:47.095263) ========= 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=a65b340e283ce644d68cb24e000001c9-1448428203.279784-1963275012 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006532 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 21:52:47.125575) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 21:52:47.125904) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 21:52:47.151968) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 21:52:47.152298) ========= 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=a65b340e283ce644d68cb24e000001c9-1448428203.279784-1963275012 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004638 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 21:52:47.201835) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 21:52:47.205182) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 21:52:47.205642) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 21:52:47.205967) ========= 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=a65b340e283ce644d68cb24e000001c9-1448428203.279784-1963275012 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-24 21:52:47-- 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% 42.3M=0s 2015-11-24 21:52:47 (42.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.177518 ========= master_lag: 0.22 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 21:52:47.602243) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 21:52:47.602592) ========= 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=a65b340e283ce644d68cb24e000001c9-1448428203.279784-1963275012 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016202 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 21:52:47.646271) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-24 21:52:47.646660) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 31cf031ca23e4927db55f9e5469ac3e4c6599a35 --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 31cf031ca23e4927db55f9e5469ac3e4c6599a35 --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=a65b340e283ce644d68cb24e000001c9-1448428203.279784-1963275012 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-24 21:52:48,306 truncating revision to first 12 chars 2015-11-24 21:52:48,306 Setting DEBUG logging. 2015-11-24 21:52:48,306 attempt 1/10 2015-11-24 21:52:48,306 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/31cf031ca23e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-24 21:52:49,019 unpacking tar archive at: fx-team-31cf031ca23e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.011205 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-24 21:52:48.677915) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 21:52:48.678744) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 21:52:48.690389) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 21:52:48.690679) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 21:52:48.691985) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2015-11-24 21:52:48.692331) ========= /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=a65b340e283ce644d68cb24e000001c9-1448428203.279784-1963275012 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:52:49 INFO - MultiFileLogger online at 20151124 21:52:49 in /builds/slave/test 21:52:49 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 21:52:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:52:49 INFO - {'append_to_log': False, 21:52:49 INFO - 'base_work_dir': '/builds/slave/test', 21:52:49 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 21:52:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:52:49 INFO - 'branch': 'Fx-Team-Non-PGO', 21:52:49 INFO - 'buildbot_json_path': 'buildprops.json', 21:52:49 INFO - 'config_files': ('talos/linux_config.py',), 21:52:49 INFO - 'default_actions': ('clobber', 21:52:49 INFO - 'read-buildbot-config', 21:52:49 INFO - 'download-and-extract', 21:52:49 INFO - 'populate-webroot', 21:52:49 INFO - 'create-virtualenv', 21:52:49 INFO - 'install', 21:52:49 INFO - 'run-tests'), 21:52:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:52:49 INFO - 'download_minidump_stackwalk': True, 21:52:49 INFO - 'download_symbols': 'ondemand', 21:52:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:52:49 INFO - 'tooltool.py': '/tools/tooltool.py', 21:52:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:52:49 INFO - '/tools/misc-python/virtualenv.py')}, 21:52:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:52:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:52:49 INFO - 'installer_path': 'installer.exe', 21:52:49 INFO - 'log_level': 'info', 21:52:49 INFO - 'log_name': 'talos', 21:52:49 INFO - 'log_to_console': True, 21:52:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:52:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:52:49 INFO - 'opt_config_files': (), 21:52:49 INFO - 'pip_index': False, 21:52:49 INFO - 'sps_profile': False, 21:52:49 INFO - 'sps_profile_interval': 0, 21:52:49 INFO - 'suite': 'dromaeojs', 21:52:49 INFO - 'system_bits': '64', 21:52:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:52:49 INFO - 'title': 'talos-linux64-ix-026', 21:52:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:52:49 INFO - 'use_talos_json': True, 21:52:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:52:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:52:49 INFO - 'work_dir': 'build'} 21:52:49 INFO - ##### 21:52:49 INFO - ##### Running clobber step. 21:52:49 INFO - ##### 21:52:49 INFO - Running pre-action listener: _resource_record_pre_action 21:52:49 INFO - Running main action method: clobber 21:52:49 INFO - rmtree: /builds/slave/test/build 21:52:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:52:49 INFO - Running post-action listener: _resource_record_post_action 21:52:49 INFO - ##### 21:52:49 INFO - ##### Running read-buildbot-config step. 21:52:49 INFO - ##### 21:52:49 INFO - Running pre-action listener: _resource_record_pre_action 21:52:49 INFO - Running main action method: read_buildbot_config 21:52:49 INFO - Using buildbot properties: 21:52:49 INFO - { 21:52:49 INFO - "properties": { 21:52:49 INFO - "buildnumber": 1131, 21:52:49 INFO - "product": "firefox", 21:52:49 INFO - "script_repo_revision": "production", 21:52:49 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 21:52:49 INFO - "repository": "", 21:52:49 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 21:52:49 INFO - "buildid": "20151124204732", 21:52:49 INFO - "slavename": "talos-linux64-ix-026", 21:52:49 INFO - "pgo_build": "False", 21:52:49 INFO - "basedir": "/builds/slave/test", 21:52:49 INFO - "project": "", 21:52:49 INFO - "platform": "ubuntu64_hw", 21:52:49 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:52:49 INFO - "slavebuilddir": "test", 21:52:49 INFO - "scheduler": "tests-fx-team-linux64-talos", 21:52:49 INFO - "branch": "fx-team", 21:52:49 INFO - "repo_path": "integration/fx-team", 21:52:49 INFO - "stage_platform": "linux64", 21:52:49 INFO - "builduid": "5ddd73fe3d4b461180f55970d6d58c26", 21:52:49 INFO - "revision": "31cf031ca23e4927db55f9e5469ac3e4c6599a35" 21:52:49 INFO - }, 21:52:49 INFO - "sourcestamp": { 21:52:49 INFO - "repository": "", 21:52:49 INFO - "hasPatch": false, 21:52:49 INFO - "project": "", 21:52:49 INFO - "branch": "fx-team-linux64-talos", 21:52:49 INFO - "changes": [ 21:52:49 INFO - { 21:52:49 INFO - "category": null, 21:52:49 INFO - "files": [ 21:52:49 INFO - { 21:52:49 INFO - "url": null, 21:52:49 INFO - "name": "https://queue.taskcluster.net/v1/task/hT7zJH2ER-eDxKutAN0qaw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 21:52:49 INFO - } 21:52:49 INFO - ], 21:52:49 INFO - "repository": "", 21:52:49 INFO - "rev": "31cf031ca23e4927db55f9e5469ac3e4c6599a35", 21:52:49 INFO - "who": "mconley@mozilla.com", 21:52:49 INFO - "when": 1448430721, 21:52:49 INFO - "number": 6703867, 21:52:49 INFO - "comments": "Backed out changeset aef73dcc9acc for bustage.", 21:52:49 INFO - "project": "", 21:52:49 INFO - "at": "Tue 24 Nov 2015 21:52:01", 21:52:49 INFO - "branch": "fx-team-linux64-talos", 21:52:49 INFO - "revlink": "", 21:52:49 INFO - "properties": [ 21:52:49 INFO - [ 21:52:49 INFO - "buildid", 21:52:49 INFO - "20151124204732", 21:52:49 INFO - "Change" 21:52:49 INFO - ], 21:52:49 INFO - [ 21:52:49 INFO - "builduid", 21:52:49 INFO - "5ddd73fe3d4b461180f55970d6d58c26", 21:52:49 INFO - "Change" 21:52:49 INFO - ], 21:52:49 INFO - [ 21:52:49 INFO - "pgo_build", 21:52:49 INFO - "False", 21:52:49 INFO - "Change" 21:52:49 INFO - ] 21:52:49 INFO - ], 21:52:49 INFO - "revision": "31cf031ca23e4927db55f9e5469ac3e4c6599a35" 21:52:49 INFO - } 21:52:49 INFO - ], 21:52:49 INFO - "revision": "31cf031ca23e4927db55f9e5469ac3e4c6599a35" 21:52:49 INFO - } 21:52:49 INFO - } 21:52:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/hT7zJH2ER-eDxKutAN0qaw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 21:52:49 INFO - Running post-action listener: _resource_record_post_action 21:52:49 INFO - ##### 21:52:49 INFO - ##### Running download-and-extract step. 21:52:49 INFO - ##### 21:52:49 INFO - Running pre-action listener: _resource_record_pre_action 21:52:49 INFO - Running main action method: download_and_extract 21:52:49 INFO - mkdir: /builds/slave/test/build/tests 21:52: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')]} 21:52:49 INFO - https://queue.taskcluster.net/v1/task/hT7zJH2ER-eDxKutAN0qaw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 21:52:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hT7zJH2ER-eDxKutAN0qaw/artifacts/public/build/test_packages.json 21:52:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hT7zJH2ER-eDxKutAN0qaw/artifacts/public/build/test_packages.json 21:52:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hT7zJH2ER-eDxKutAN0qaw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 21:52:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hT7zJH2ER-eDxKutAN0qaw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 21:52:50 INFO - Downloaded 1302 bytes. 21:52:50 INFO - Reading from file /builds/slave/test/build/test_packages.json 21:52:50 INFO - Using the following test package requirements: 21:52:50 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:52:50 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:52:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:52:50 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:52:50 INFO - u'jsshell-linux-x86_64.zip'], 21:52:50 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:52:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:52:50 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:52:50 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:52:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:52:50 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:52:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:52:50 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:52:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:52:50 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:52:50 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:52:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:52:50 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:52:50 INFO - https://queue.taskcluster.net/v1/task/hT7zJH2ER-eDxKutAN0qaw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:52:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hT7zJH2ER-eDxKutAN0qaw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:52:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hT7zJH2ER-eDxKutAN0qaw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:52:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hT7zJH2ER-eDxKutAN0qaw/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 21:52:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hT7zJH2ER-eDxKutAN0qaw/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 21:52:51 INFO - Downloaded 21345683 bytes. 21:52:51 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 21:52:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:52:51 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 21:52:52 INFO - Return code: 0 21:52:52 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 21:52:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:52:52 INFO - https://queue.taskcluster.net/v1/task/hT7zJH2ER-eDxKutAN0qaw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:52:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hT7zJH2ER-eDxKutAN0qaw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:52:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hT7zJH2ER-eDxKutAN0qaw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:52:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hT7zJH2ER-eDxKutAN0qaw/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 21:52:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hT7zJH2ER-eDxKutAN0qaw/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 21:52:55 INFO - Downloaded 21345683 bytes. 21:52:55 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 21:52:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:52:55 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 21:52:56 INFO - Return code: 0 21:52:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:52:56 INFO - https://queue.taskcluster.net/v1/task/hT7zJH2ER-eDxKutAN0qaw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:52:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hT7zJH2ER-eDxKutAN0qaw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:52:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hT7zJH2ER-eDxKutAN0qaw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:52:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hT7zJH2ER-eDxKutAN0qaw/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 21:52:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hT7zJH2ER-eDxKutAN0qaw/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 21:52:57 INFO - Downloaded 11131717 bytes. 21:52:57 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 21:52:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:52:57 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 21:52:57 INFO - Return code: 0 21:52:57 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')]} 21:52:57 INFO - https://queue.taskcluster.net/v1/task/hT7zJH2ER-eDxKutAN0qaw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:52:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hT7zJH2ER-eDxKutAN0qaw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:52:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hT7zJH2ER-eDxKutAN0qaw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:52:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hT7zJH2ER-eDxKutAN0qaw/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 21:52:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hT7zJH2ER-eDxKutAN0qaw/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 21:52:59 INFO - Downloaded 56846488 bytes. 21:52:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/hT7zJH2ER-eDxKutAN0qaw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:52:59 INFO - mkdir: /builds/slave/test/properties 21:52:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:52:59 INFO - Writing to file /builds/slave/test/properties/build_url 21:52:59 INFO - Contents: 21:52:59 INFO - build_url:https://queue.taskcluster.net/v1/task/hT7zJH2ER-eDxKutAN0qaw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:52:59 INFO - Running post-action listener: _resource_record_post_action 21:52:59 INFO - Running post-action listener: set_extra_try_arguments 21:52:59 INFO - ##### 21:52:59 INFO - ##### Running populate-webroot step. 21:52:59 INFO - ##### 21:52:59 INFO - Running pre-action listener: _resource_record_pre_action 21:52:59 INFO - Running main action method: populate_webroot 21:52:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:52:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:52:59 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 21:52:59 INFO - '../fennec_ids.txt'], 21:52:59 INFO - 'tests': ['tcheck2']}, 21:52:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:52:59 INFO - '--tppagecycles', 21:52:59 INFO - '7'], 21:52:59 INFO - 'tests': ['tsvgm']}}, 21:52:59 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:52:59 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:52:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:52:59 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:52:59 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:52:59 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:52:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:52:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:52:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:52:59 INFO - 'talos_options': ['--e10s'], 21:52:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:52:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:52:59 INFO - 'tests': ['damp', 'tps']}, 21:52:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:52:59 INFO - 'talos_options': ['--e10s'], 21:52:59 INFO - 'tests': ['damp', 'tps']}, 21:52:59 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:52:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:52:59 INFO - 'other': {'tests': ['a11yr', 21:52:59 INFO - 'ts_paint', 21:52:59 INFO - 'tpaint', 21:52:59 INFO - 'sessionrestore', 21:52:59 INFO - 'sessionrestore_no_auto_restore']}, 21:52:59 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:52:59 INFO - 'tests': ['a11yr', 21:52:59 INFO - 'ts_paint', 21:52:59 INFO - 'tpaint', 21:52:59 INFO - 'sessionrestore', 21:52:59 INFO - 'sessionrestore_no_auto_restore']}, 21:52:59 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:52:59 INFO - 'tests': ['a11yr', 21:52:59 INFO - 'ts_paint', 21:52:59 INFO - 'tpaint', 21:52:59 INFO - 'sessionrestore', 21:52:59 INFO - 'sessionrestore_no_auto_restore']}, 21:52:59 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:52:59 INFO - 'tests': ['a11yr', 21:52:59 INFO - 'ts_paint', 21:52:59 INFO - 'tpaint', 21:52:59 INFO - 'sessionrestore', 21:52:59 INFO - 'sessionrestore_no_auto_restore']}, 21:52:59 INFO - 'other_l64': {'tests': ['a11yr', 21:52:59 INFO - 'ts_paint', 21:52:59 INFO - 'tpaint', 21:52:59 INFO - 'sessionrestore', 21:52:59 INFO - 'sessionrestore_no_auto_restore']}, 21:52:59 INFO - 'other_nol64': {'tests': ['a11yr', 21:52:59 INFO - 'ts_paint', 21:52:59 INFO - 'tpaint', 21:52:59 INFO - 'sessionrestore', 21:52:59 INFO - 'sessionrestore_no_auto_restore']}, 21:52:59 INFO - 'svgr': {'tests': ['tsvgx', 21:52:59 INFO - 'tsvgr_opacity', 21:52:59 INFO - 'tart', 21:52:59 INFO - 'tscrollx', 21:52:59 INFO - 'cart']}, 21:52:59 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:52:59 INFO - 'tests': ['tsvgx', 21:52:59 INFO - 'tsvgr_opacity', 21:52:59 INFO - 'tart', 21:52:59 INFO - 'tscrollx', 21:52:59 INFO - 'cart']}, 21:52:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:52:59 INFO - 'tests': ['tp5o']}, 21:52:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:52:59 INFO - 'talos_options': ['--e10s'], 21:52:59 INFO - 'tests': ['tp5o']}, 21:52:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:52:59 INFO - 'talos_options': ['--xperf_path', 21:52:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:52:59 INFO - 'tests': ['tp5n']}, 21:52:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:52:59 INFO - 'talos_options': ['--e10s', 21:52:59 INFO - '--xperf_path', 21:52:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:52:59 INFO - 'tests': ['tp5n']}}, 21:52:59 INFO - 'talos.zip': {'path': '', 21:52:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:52:59 INFO - Running post-action listener: _resource_record_post_action 21:52:59 INFO - ##### 21:52:59 INFO - ##### Running create-virtualenv step. 21:52:59 INFO - ##### 21:52:59 INFO - Running pre-action listener: _resource_record_pre_action 21:52:59 INFO - Running main action method: create_virtualenv 21:52:59 INFO - Creating virtualenv /builds/slave/test/build/venv 21:52:59 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 21:52:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:52:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:52:59 INFO - Using real prefix '/usr' 21:52:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:52:59 INFO - Installing distribute.............................................................................................................................................................................................done. 21:53:01 INFO - Installing pip.................done. 21:53:01 INFO - Return code: 0 21:53:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:53:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:53:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:53:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:53:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:53:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:53:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f3210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1285220>, '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 0x11f12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f1740>, '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': 'a65b340e283ce644d68cb24e000001c9-1448428203.279784-1963275012', '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 21:53:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:53:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:53:01 INFO - Using env: {'DISPLAY': ':0', 21:53:01 INFO - 'HOME': '/home/cltbld', 21:53:01 INFO - 'LANG': 'en_US.UTF-8', 21:53:01 INFO - 'LANGUAGE': 'en_US:en', 21:53:01 INFO - 'LOGNAME': 'cltbld', 21:53:01 INFO - 'MAIL': '/var/mail/cltbld', 21:53:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:53:01 INFO - 'MOZ_NO_REMOTE': '1', 21:53:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:53:01 INFO - 'NO_EM_RESTART': '1', 21:53:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:53:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:53:01 INFO - 'PWD': '/builds/slave/test', 21:53:01 INFO - 'SHELL': '/bin/bash', 21:53:01 INFO - 'SHLVL': '1', 21:53:01 INFO - 'TERM': 'linux', 21:53:01 INFO - 'TMOUT': '86400', 21:53:01 INFO - 'USER': 'cltbld', 21:53:01 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1448428203.279784-1963275012', 21:53:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:53:01 INFO - '_': '/tools/buildbot/bin/python'} 21:53:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:53:02 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 21:53:02 INFO - Cleaning up... 21:53:02 INFO - Return code: 0 21:53:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 21:53:02 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')]} 21:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:53:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:53:02 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')]} 21:53:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:53:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:53:02 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 0xfc2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f3210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1285220>, '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 0x11f12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f1740>, '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': 'a65b340e283ce644d68cb24e000001c9-1448428203.279784-1963275012', '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 21:53:02 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 21:53:02 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 21:53:02 INFO - Using env: {'DISPLAY': ':0', 21:53:02 INFO - 'HOME': '/home/cltbld', 21:53:02 INFO - 'LANG': 'en_US.UTF-8', 21:53:02 INFO - 'LANGUAGE': 'en_US:en', 21:53:02 INFO - 'LOGNAME': 'cltbld', 21:53:02 INFO - 'MAIL': '/var/mail/cltbld', 21:53:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:53:02 INFO - 'MOZ_NO_REMOTE': '1', 21:53:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:53:02 INFO - 'NO_EM_RESTART': '1', 21:53:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:53:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:53:02 INFO - 'PWD': '/builds/slave/test', 21:53:02 INFO - 'SHELL': '/bin/bash', 21:53:02 INFO - 'SHLVL': '1', 21:53:02 INFO - 'TERM': 'linux', 21:53:02 INFO - 'TMOUT': '86400', 21:53:02 INFO - 'USER': 'cltbld', 21:53:02 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1448428203.279784-1963275012', 21:53:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:53:02 INFO - '_': '/tools/buildbot/bin/python'} 21:53:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:53:02 INFO - Downloading/unpacking psutil>=0.7.1 21:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:53:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:53:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:53:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:53:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:53:03 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 21:53:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 21:53:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:53:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:53:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:53:04 INFO - Installing collected packages: psutil 21:53:04 INFO - Running setup.py install for psutil 21:53:04 INFO - building 'psutil._psutil_linux' extension 21:53:04 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 21:53:04 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 21:53:04 INFO - building 'psutil._psutil_posix' extension 21:53:04 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 21:53:04 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 21:53:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:53:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:53:04 INFO - Successfully installed psutil 21:53:04 INFO - Cleaning up... 21:53:04 INFO - Return code: 0 21:53:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 21:53: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')]} 21:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:53:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:53: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')]} 21:53:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:53:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:53:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0xfc2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f3210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1285220>, '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 0x11f12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f1740>, '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': 'a65b340e283ce644d68cb24e000001c9-1448428203.279784-1963275012', '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 21:53:04 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 21:53:04 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 21:53:04 INFO - Using env: {'DISPLAY': ':0', 21:53:04 INFO - 'HOME': '/home/cltbld', 21:53:04 INFO - 'LANG': 'en_US.UTF-8', 21:53:04 INFO - 'LANGUAGE': 'en_US:en', 21:53:04 INFO - 'LOGNAME': 'cltbld', 21:53:04 INFO - 'MAIL': '/var/mail/cltbld', 21:53:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:53:04 INFO - 'MOZ_NO_REMOTE': '1', 21:53:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:53:04 INFO - 'NO_EM_RESTART': '1', 21:53:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:53:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:53:04 INFO - 'PWD': '/builds/slave/test', 21:53:04 INFO - 'SHELL': '/bin/bash', 21:53:04 INFO - 'SHLVL': '1', 21:53:04 INFO - 'TERM': 'linux', 21:53:04 INFO - 'TMOUT': '86400', 21:53:04 INFO - 'USER': 'cltbld', 21:53:04 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1448428203.279784-1963275012', 21:53:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:53:04 INFO - '_': '/tools/buildbot/bin/python'} 21:53:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:53:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:53:04 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 21:53:04 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 21:53:04 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 21:53:04 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 21:53:04 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 21:53:04 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 21:53:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:53:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 21:53:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:53:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:53:06 INFO - Installing collected packages: mozsystemmonitor 21:53:06 INFO - Running setup.py install for mozsystemmonitor 21:53:06 INFO - Successfully installed mozsystemmonitor 21:53:06 INFO - Cleaning up... 21:53:06 INFO - Return code: 0 21:53:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:53:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:53:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:53:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:53:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:53:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:53:06 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 0xfc2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f3210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1285220>, '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 0x11f12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f1740>, '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': 'a65b340e283ce644d68cb24e000001c9-1448428203.279784-1963275012', '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 21:53:06 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 21:53:06 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 21:53:06 INFO - Using env: {'DISPLAY': ':0', 21:53:06 INFO - 'HOME': '/home/cltbld', 21:53:06 INFO - 'LANG': 'en_US.UTF-8', 21:53:06 INFO - 'LANGUAGE': 'en_US:en', 21:53:06 INFO - 'LOGNAME': 'cltbld', 21:53:06 INFO - 'MAIL': '/var/mail/cltbld', 21:53:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:53:06 INFO - 'MOZ_NO_REMOTE': '1', 21:53:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:53:06 INFO - 'NO_EM_RESTART': '1', 21:53:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:53:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:53:06 INFO - 'PWD': '/builds/slave/test', 21:53:06 INFO - 'SHELL': '/bin/bash', 21:53:06 INFO - 'SHLVL': '1', 21:53:06 INFO - 'TERM': 'linux', 21:53:06 INFO - 'TMOUT': '86400', 21:53:06 INFO - 'USER': 'cltbld', 21:53:06 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1448428203.279784-1963275012', 21:53:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:53:06 INFO - '_': '/tools/buildbot/bin/python'} 21:53:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:53:06 INFO - Downloading/unpacking blobuploader==1.2.4 21:53:06 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 21:53:06 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 21:53:06 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 21:53:06 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 21:53:06 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 21:53:06 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 21:53:08 INFO - Downloading blobuploader-1.2.4.tar.gz 21:53:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 21:53:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:53:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:53:08 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 21:53:08 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 21:53:08 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 21:53:08 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 21:53:08 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 21:53:08 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 21:53:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 21:53:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:53:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:53:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:53:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:53:09 INFO - Downloading docopt-0.6.1.tar.gz 21:53:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 21:53:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:53:09 INFO - Installing collected packages: blobuploader, requests, docopt 21:53:09 INFO - Running setup.py install for blobuploader 21:53:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:53:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:53:09 INFO - Running setup.py install for requests 21:53:09 INFO - Running setup.py install for docopt 21:53:09 INFO - Successfully installed blobuploader requests docopt 21:53:09 INFO - Cleaning up... 21:53:09 INFO - Return code: 0 21:53:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:53:09 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')]} 21:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:53:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:53:09 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')]} 21:53:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:53:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:53:09 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 0xfc2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f3210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1285220>, '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 0x11f12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f1740>, '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': 'a65b340e283ce644d68cb24e000001c9-1448428203.279784-1963275012', '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 21:53:09 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 21:53:09 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 21:53:09 INFO - Using env: {'DISPLAY': ':0', 21:53:09 INFO - 'HOME': '/home/cltbld', 21:53:09 INFO - 'LANG': 'en_US.UTF-8', 21:53:09 INFO - 'LANGUAGE': 'en_US:en', 21:53:09 INFO - 'LOGNAME': 'cltbld', 21:53:09 INFO - 'MAIL': '/var/mail/cltbld', 21:53:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:53:09 INFO - 'MOZ_NO_REMOTE': '1', 21:53:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:53:09 INFO - 'NO_EM_RESTART': '1', 21:53:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:53:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:53:09 INFO - 'PWD': '/builds/slave/test', 21:53:09 INFO - 'SHELL': '/bin/bash', 21:53:09 INFO - 'SHLVL': '1', 21:53:09 INFO - 'TERM': 'linux', 21:53:09 INFO - 'TMOUT': '86400', 21:53:09 INFO - 'USER': 'cltbld', 21:53:09 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1448428203.279784-1963275012', 21:53:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:53:09 INFO - '_': '/tools/buildbot/bin/python'} 21:53:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:53:10 INFO - Running setup.py (path:/tmp/pip-lcQowL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:53:10 INFO - Running setup.py (path:/tmp/pip-Gp0mzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:53:10 INFO - Running setup.py (path:/tmp/pip-NrvFPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:53:10 INFO - Running setup.py (path:/tmp/pip-voihIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:53:10 INFO - Running setup.py (path:/tmp/pip-ENbbWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:53:10 INFO - Running setup.py (path:/tmp/pip-BB5KaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:53:10 INFO - Running setup.py (path:/tmp/pip-1G5h3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:53:10 INFO - Running setup.py (path:/tmp/pip-alyeV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:53:10 INFO - Running setup.py (path:/tmp/pip-mdYYEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:53:10 INFO - Running setup.py (path:/tmp/pip-UvoKsP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:53:10 INFO - Running setup.py (path:/tmp/pip-l0253r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:53:10 INFO - Running setup.py (path:/tmp/pip-iSeXQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:53:11 INFO - Running setup.py (path:/tmp/pip-2eUCeW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:53:11 INFO - Running setup.py (path:/tmp/pip-mWqIOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:53:11 INFO - Running setup.py (path:/tmp/pip-Xl4d3d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:53:11 INFO - Running setup.py (path:/tmp/pip-j8IFsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:53:11 INFO - Running setup.py (path:/tmp/pip-L4C84H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:53:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:53:11 INFO - Running setup.py install for manifestparser 21:53:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:53:11 INFO - Running setup.py install for mozcrash 21:53:11 INFO - Running setup.py install for mozdebug 21:53:11 INFO - Running setup.py install for mozdevice 21:53:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:53:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:53:11 INFO - Running setup.py install for mozfile 21:53:11 INFO - Running setup.py install for mozhttpd 21:53:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:53:11 INFO - Running setup.py install for mozinfo 21:53:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:53:12 INFO - Running setup.py install for mozInstall 21:53:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:53:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:53:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:53:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:53:12 INFO - Running setup.py install for mozleak 21:53:12 INFO - Running setup.py install for mozlog 21:53:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:53:12 INFO - Running setup.py install for moznetwork 21:53:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:53:12 INFO - Running setup.py install for mozprocess 21:53:12 INFO - Running setup.py install for mozprofile 21:53:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:53:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:53:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:53:12 INFO - Running setup.py install for mozrunner 21:53:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:53:12 INFO - Running setup.py install for mozscreenshot 21:53:12 INFO - Running setup.py install for moztest 21:53:12 INFO - Running setup.py install for mozversion 21:53:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:53:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:53:13 INFO - Cleaning up... 21:53:13 INFO - Return code: 0 21:53:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:53:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:53:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:53:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:53:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:53:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:53:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0xfc2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f3210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1285220>, '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 0x11f12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f1740>, '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': 'a65b340e283ce644d68cb24e000001c9-1448428203.279784-1963275012', '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 21:53:13 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 21:53:13 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 21:53:13 INFO - Using env: {'DISPLAY': ':0', 21:53:13 INFO - 'HOME': '/home/cltbld', 21:53:13 INFO - 'LANG': 'en_US.UTF-8', 21:53:13 INFO - 'LANGUAGE': 'en_US:en', 21:53:13 INFO - 'LOGNAME': 'cltbld', 21:53:13 INFO - 'MAIL': '/var/mail/cltbld', 21:53:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:53:13 INFO - 'MOZ_NO_REMOTE': '1', 21:53:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:53:13 INFO - 'NO_EM_RESTART': '1', 21:53:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:53:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:53:13 INFO - 'PWD': '/builds/slave/test', 21:53:13 INFO - 'SHELL': '/bin/bash', 21:53:13 INFO - 'SHLVL': '1', 21:53:13 INFO - 'TERM': 'linux', 21:53:13 INFO - 'TMOUT': '86400', 21:53:13 INFO - 'USER': 'cltbld', 21:53:13 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1448428203.279784-1963275012', 21:53:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:53:13 INFO - '_': '/tools/buildbot/bin/python'} 21:53:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:53:13 INFO - Running setup.py (path:/tmp/pip-UWqBPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:53:13 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)) 21:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:53:13 INFO - Running setup.py (path:/tmp/pip-INfuwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:53:13 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)) 21:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:53:13 INFO - Running setup.py (path:/tmp/pip-KMnD_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:53:13 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)) 21:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:53:13 INFO - Running setup.py (path:/tmp/pip-5A3rBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:53:13 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)) 21:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:53:13 INFO - Running setup.py (path:/tmp/pip-93XzcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:53:13 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)) 21:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:53:13 INFO - Running setup.py (path:/tmp/pip-ff1yno-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:53:13 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)) 21:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:53:13 INFO - Running setup.py (path:/tmp/pip-f6jFeW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:53:13 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)) 21:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:53:13 INFO - Running setup.py (path:/tmp/pip-tRiBVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:53:13 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)) 21:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:53:13 INFO - Running setup.py (path:/tmp/pip-nK5Xdv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:53:13 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)) 21:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:53:13 INFO - Running setup.py (path:/tmp/pip-i63rs8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:53:14 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)) 21:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:53:14 INFO - Running setup.py (path:/tmp/pip-XpVfwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:53:14 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)) 21:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:53:14 INFO - Running setup.py (path:/tmp/pip-JnT6Fi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:53:14 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)) 21:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:53:14 INFO - Running setup.py (path:/tmp/pip-_uCdSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:53:14 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)) 21:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:53:14 INFO - Running setup.py (path:/tmp/pip-8wyfG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:53:14 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)) 21:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:53:14 INFO - Running setup.py (path:/tmp/pip-21U9NN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:53:14 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)) 21:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:53:14 INFO - Running setup.py (path:/tmp/pip-9lp8ZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:53:14 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)) 21:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:53:14 INFO - Running setup.py (path:/tmp/pip-OMDiBR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:53:14 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)) 21:53:14 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)) 21:53:14 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)) 21:53:14 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)) 21:53:14 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)) 21:53:14 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)) 21:53:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:53:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:53:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:53:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:53:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:53:16 INFO - Downloading blessings-1.5.1.tar.gz 21:53:16 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 21:53:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:53:16 INFO - Installing collected packages: blessings 21:53:16 INFO - Running setup.py install for blessings 21:53:16 INFO - Successfully installed blessings 21:53:16 INFO - Cleaning up... 21:53:16 INFO - Return code: 0 21:53:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:53:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:53:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:53:16 INFO - Reading from file tmpfile_stdout 21:53:16 INFO - Current package versions: 21:53:16 INFO - argparse == 1.2.1 21:53:16 INFO - blessings == 1.5.1 21:53:16 INFO - blobuploader == 1.2.4 21:53:16 INFO - docopt == 0.6.1 21:53:16 INFO - manifestparser == 1.1 21:53:16 INFO - mozInstall == 1.12 21:53:16 INFO - mozcrash == 0.16 21:53:16 INFO - mozdebug == 0.1 21:53:16 INFO - mozdevice == 0.47 21:53:16 INFO - mozfile == 1.2 21:53:16 INFO - mozhttpd == 0.7 21:53:16 INFO - mozinfo == 0.9 21:53:16 INFO - mozleak == 0.1 21:53:16 INFO - mozlog == 3.1 21:53:16 INFO - moznetwork == 0.27 21:53:16 INFO - mozprocess == 0.22 21:53:16 INFO - mozprofile == 0.27 21:53:16 INFO - mozrunner == 6.11 21:53:16 INFO - mozscreenshot == 0.1 21:53:16 INFO - mozsystemmonitor == 0.0 21:53:16 INFO - moztest == 0.7 21:53:16 INFO - mozversion == 1.4 21:53:16 INFO - psutil == 3.1.1 21:53:16 INFO - requests == 1.2.3 21:53:16 INFO - wsgiref == 0.1.2 21:53:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:53:16 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')]} 21:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:53:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:53:16 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')]} 21:53:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:53:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:53:16 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 0xfc2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f3210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1285220>, '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 0x11f12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f1740>, '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': 'a65b340e283ce644d68cb24e000001c9-1448428203.279784-1963275012', '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 21:53:16 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 21:53:16 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 21:53:16 INFO - Using env: {'DISPLAY': ':0', 21:53:16 INFO - 'HOME': '/home/cltbld', 21:53:16 INFO - 'LANG': 'en_US.UTF-8', 21:53:16 INFO - 'LANGUAGE': 'en_US:en', 21:53:16 INFO - 'LOGNAME': 'cltbld', 21:53:16 INFO - 'MAIL': '/var/mail/cltbld', 21:53:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:53:16 INFO - 'MOZ_NO_REMOTE': '1', 21:53:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:53:16 INFO - 'NO_EM_RESTART': '1', 21:53:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:53:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:53:16 INFO - 'PWD': '/builds/slave/test', 21:53:16 INFO - 'SHELL': '/bin/bash', 21:53:16 INFO - 'SHLVL': '1', 21:53:16 INFO - 'TERM': 'linux', 21:53:16 INFO - 'TMOUT': '86400', 21:53:16 INFO - 'USER': 'cltbld', 21:53:16 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1448428203.279784-1963275012', 21:53:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:53:16 INFO - '_': '/tools/buildbot/bin/python'} 21:53:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:53:16 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)) 21:53:16 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)) 21:53:16 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)) 21:53:16 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)) 21:53:16 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)) 21:53:16 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)) 21:53:16 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)) 21:53:16 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)) 21:53:16 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)) 21:53:16 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)) 21:53:16 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)) 21:53:16 INFO - Cleaning up... 21:53:16 INFO - Return code: 0 21:53:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:53:16 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')]} 21:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:53:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:53:16 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')]} 21:53:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:53:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:53:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f3210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1285220>, '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 0x11f12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f1740>, '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': 'a65b340e283ce644d68cb24e000001c9-1448428203.279784-1963275012', '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 21:53:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:53:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:53:16 INFO - Using env: {'DISPLAY': ':0', 21:53:16 INFO - 'HOME': '/home/cltbld', 21:53:16 INFO - 'LANG': 'en_US.UTF-8', 21:53:16 INFO - 'LANGUAGE': 'en_US:en', 21:53:16 INFO - 'LOGNAME': 'cltbld', 21:53:16 INFO - 'MAIL': '/var/mail/cltbld', 21:53:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:53:16 INFO - 'MOZ_NO_REMOTE': '1', 21:53:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:53:16 INFO - 'NO_EM_RESTART': '1', 21:53:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:53:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:53:16 INFO - 'PWD': '/builds/slave/test', 21:53:16 INFO - 'SHELL': '/bin/bash', 21:53:16 INFO - 'SHLVL': '1', 21:53:16 INFO - 'TERM': 'linux', 21:53:16 INFO - 'TMOUT': '86400', 21:53:16 INFO - 'USER': 'cltbld', 21:53:16 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1448428203.279784-1963275012', 21:53:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:53:16 INFO - '_': '/tools/buildbot/bin/python'} 21:53:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:53:17 INFO - Downloading/unpacking jsonschema 21:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:53:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:53:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:53:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:53:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:53:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:53:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 21:53:18 INFO - Downloading/unpacking functools32 (from jsonschema) 21:53:18 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 21:53:18 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 21:53:18 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 21:53:18 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 21:53:18 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 21:53:18 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 21:53:18 INFO - Downloading functools32-3.2.3-2.tar.gz 21:53:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 21:53:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:53:19 INFO - warning: no files found matching '*.txt' 21:53:19 INFO - no previously-included directories found matching 'build' 21:53:19 INFO - no previously-included directories found matching 'dist' 21:53:19 INFO - no previously-included directories found matching '.git*' 21:53:19 INFO - Installing collected packages: jsonschema, functools32 21:53:19 INFO - Running setup.py install for functools32 21:53:19 INFO - warning: no files found matching '*.txt' 21:53:19 INFO - no previously-included directories found matching 'build' 21:53:19 INFO - no previously-included directories found matching 'dist' 21:53:19 INFO - no previously-included directories found matching '.git*' 21:53:19 INFO - Successfully installed jsonschema functools32 21:53:19 INFO - Cleaning up... 21:53:19 INFO - Return code: 0 21:53:19 INFO - Running post-action listener: _resource_record_post_action 21:53:19 INFO - Running post-action listener: _start_resource_monitoring 21:53:19 INFO - Starting resource monitoring. 21:53:19 INFO - ##### 21:53:19 INFO - ##### Running install step. 21:53:19 INFO - ##### 21:53:19 INFO - Running pre-action listener: _resource_record_pre_action 21:53:19 INFO - Running main action method: install 21:53:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:53:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:53:19 INFO - Reading from file tmpfile_stdout 21:53:19 INFO - Detecting whether we're running mozinstall >=1.0... 21:53:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:53:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:53:19 INFO - Reading from file tmpfile_stdout 21:53:19 INFO - Output received: 21:53:19 INFO - Usage: mozinstall [options] installer 21:53:19 INFO - Options: 21:53:19 INFO - -h, --help show this help message and exit 21:53:19 INFO - -d DEST, --destination=DEST 21:53:19 INFO - Directory to install application into. [default: 21:53:19 INFO - "/builds/slave/test"] 21:53:19 INFO - --app=APP Application being installed. [default: firefox] 21:53:19 INFO - mkdir: /builds/slave/test/build/application 21:53:19 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'] 21:53:19 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 21:53:33 INFO - Reading from file tmpfile_stdout 21:53:33 INFO - Output received: 21:53:33 INFO - /builds/slave/test/build/application/firefox/firefox 21:53:33 INFO - Running post-action listener: _resource_record_post_action 21:53:33 INFO - ##### 21:53:33 INFO - ##### Running run-tests step. 21:53:33 INFO - ##### 21:53:33 INFO - Running pre-action listener: _resource_record_pre_action 21:53:33 INFO - Running main action method: run_tests 21:53:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:53:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:53:33 INFO - Python 2.7.3 21:53:33 INFO - Return code: 0 21:53:33 INFO - grabbing minidump binary from tooltool 21:53:33 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')]} 21:53:33 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 0x1285220>, '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 0x11f12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f1740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:53:33 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 21:53:33 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 21:53:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:53:33 INFO - Return code: 0 21:53:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:53:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:53:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:53:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:53:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:53:33 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/hT7zJH2ER-eDxKutAN0qaw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost'] in /builds/slave/test/build 21:53:33 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/hT7zJH2ER-eDxKutAN0qaw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --webServer localhost 21:53:34 INFO - Using env: {'DISPLAY': ':0', 21:53:34 INFO - 'HOME': '/home/cltbld', 21:53:34 INFO - 'LANG': 'en_US.UTF-8', 21:53:34 INFO - 'LANGUAGE': 'en_US:en', 21:53:34 INFO - 'LOGNAME': 'cltbld', 21:53:34 INFO - 'MAIL': '/var/mail/cltbld', 21:53:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:53:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:53:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:53:34 INFO - 'MOZ_NO_REMOTE': '1', 21:53:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:53:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:53:34 INFO - 'NO_EM_RESTART': '1', 21:53:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:53:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:53:34 INFO - 'PWD': '/builds/slave/test', 21:53:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:53:34 INFO - 'SHELL': '/bin/bash', 21:53:34 INFO - 'SHLVL': '1', 21:53:34 INFO - 'TERM': 'linux', 21:53:34 INFO - 'TMOUT': '86400', 21:53:34 INFO - 'USER': 'cltbld', 21:53:34 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1448428203.279784-1963275012', 21:53:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:53:34 INFO - '_': '/tools/buildbot/bin/python'} 21:53:34 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/hT7zJH2ER-eDxKutAN0qaw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost'] with output_timeout 3600 21:53:34 INFO - mozversion INFO | application_buildid: 20151124204732 21:53:34 INFO - mozversion INFO | application_changeset: 31cf031ca23e4927db55f9e5469ac3e4c6599a35 21:53:34 INFO - mozversion INFO | application_display_name: Nightly 21:53:34 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:53:34 INFO - mozversion INFO | application_name: Firefox 21:53:34 INFO - mozversion INFO | application_remotingname: firefox 21:53:34 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 21:53:34 INFO - mozversion INFO | application_vendor: Mozilla 21:53:34 INFO - mozversion INFO | application_version: 45.0a1 21:53:34 INFO - mozversion INFO | platform_buildid: 20151124204732 21:53:34 INFO - mozversion INFO | platform_changeset: 31cf031ca23e4927db55f9e5469ac3e4c6599a35 21:53:34 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 21:53:34 INFO - mozversion INFO | platform_version: 45.0a1 21:53:34 INFO - 2015-11-24 21:53:34,197 DEBUG : using testdate: 1448430814 21:53:34 INFO - 2015-11-24 21:53:34,197 DEBUG : actual date: 1448430814 21:53:34 INFO - 2015-11-24 21:53:34,206 INFO : starting webserver on 'localhost:41114' 21:53:34 INFO - 2015-11-24 21:53:34,207 INFO : Starting test suite talos-linux64-ix-026 21:53:34 INFO - 2015-11-24 21:53:34,207 INFO : Starting test dromaeo_css 21:53:34 INFO - 2015-11-24 21:53:34,207 DEBUG : operating with platform_type : linux_ 21:53:34 INFO - 2015-11-24 21:53:34,208 INFO : Initialising browser for dromaeo_css test... 21:53:34 INFO - 2015-11-24 21:53:34,224 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ5R2aA/profile http://localhost:41114/getInfo.html 21:53:38 INFO - 2015-11-24 21:53:38,461 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:53:38 INFO - 2015-11-24 21:53:38,461 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:53:38 INFO - 2015-11-24 21:53:38,461 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:53:38 INFO - 2015-11-24 21:53:38,461 DEBUG : BROWSER_OUTPUT: __metrics 21:53:38 INFO - 2015-11-24 21:53:38,618 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:53:39 INFO - 2015-11-24 21:53:39,793 INFO : Browser initialized. 21:53:39 INFO - 2015-11-24 21:53:39,794 INFO : Running cycle 1/1 for dromaeo_css test... 21:53:39 INFO - 2015-11-24 21:53:39,794 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ5R2aA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:53:51 INFO - 2015-11-24 21:53:51,673 DEBUG : BROWSER_OUTPUT: RSS: Main: 138518528 21:53:51 INFO - 2015-11-24 21:53:51,673 DEBUG : BROWSER_OUTPUT: 21:54:42 INFO - 2015-11-24 21:54:42,912 DEBUG : BROWSER_OUTPUT: 1448430882910 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] 21:56:54 INFO - 2015-11-24 21:56:54,589 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41114/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41114/tests/dromaeo/cssquery-ext.html) 21:56:55 INFO - 2015-11-24 21:56:55,781 DEBUG : BROWSER_OUTPUT: RSS: Main: 249917440 21:56:55 INFO - 2015-11-24 21:56:55,781 DEBUG : BROWSER_OUTPUT: 21:59:58 INFO - 2015-11-24 21:59:58,276 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41114/tests/dromaeo/cssquery-ext.html (next: http://localhost:41114/tests/dromaeo/cssquery-jquery.html) 21:59:58 INFO - 2015-11-24 21:59:58,845 DEBUG : BROWSER_OUTPUT: RSS: Main: 223408128 21:59:58 INFO - 2015-11-24 21:59:58,845 DEBUG : BROWSER_OUTPUT: 22:03:00 INFO - 2015-11-24 22:03:00,918 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41114/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41114/tests/dromaeo/cssquery-mootools.html) 22:03:01 INFO - 2015-11-24 22:03:01,501 DEBUG : BROWSER_OUTPUT: RSS: Main: 215322624 22:03:01 INFO - 2015-11-24 22:03:01,501 DEBUG : BROWSER_OUTPUT: 22:06:03 INFO - 2015-11-24 22:06:03,463 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41114/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41114/tests/dromaeo/cssquery-prototype.html) 22:06:04 INFO - 2015-11-24 22:06:04,037 DEBUG : BROWSER_OUTPUT: RSS: Main: 207568896 22:06:04 INFO - 2015-11-24 22:06:04,037 DEBUG : BROWSER_OUTPUT: 22:09:06 INFO - 2015-11-24 22:09:06,995 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41114/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41114/tests/dromaeo/cssquery-yui.html) 22:09:07 INFO - 2015-11-24 22:09:07,576 DEBUG : BROWSER_OUTPUT: RSS: Main: 204476416 22:09:07 INFO - 2015-11-24 22:09:07,577 DEBUG : BROWSER_OUTPUT: 22:12:10 INFO - 2015-11-24 22:12:10,120 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41114/tests/dromaeo/cssquery-yui.html (next: http://localhost:41114/tests/dromaeo/cssquery-dojo.html) 22:12:10 INFO - 2015-11-24 22:12:10,366 DEBUG : BROWSER_OUTPUT: RSS: Main: 294285312 22:12:10 INFO - 2015-11-24 22:12:10,366 DEBUG : BROWSER_OUTPUT: 22:12:10 INFO - 2015-11-24 22:12:10,366 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:12:10 INFO - 2015-11-24 22:12:10,367 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:12:10 INFO - 2015-11-24 22:12:10,367 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:12:10 INFO - 2015-11-24 22:12:10,367 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:12:10 INFO - 2015-11-24 22:12:10,367 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2582.780463660589;2698.17705599792;2706.215197592698;2710.5121078205925;2727.3999720061584;4462.12988467249;4552.590266875981;4619.099275641252;4621.6533759968015;4676.953230467699;4502.797374118164;4520.977395113028;4525.2080885844925;4640.211164102102;4641.7214967102;4276.379924910886;4284.635805956497;4291.485021797389;4305.590968857953;4325.610695037446;4046.979765101185;4331.45856767904;4367.934480982788;4373.497047839507;4381.890452738675;4164.104717485755;4200.579942005806;4233.767142807144;4264.850730224458;4267.445232119804;4220.986963128827;4221.050263690645;4271.039016221325;4278.866100483375;4314.072474417983;4090.3455447128317;4199.958000419987;4241.34259189826;4268.317069268902;4305.397244385788;4407.60331570157;4413.161499315152;4445.777711114463;4471.23988921884;4503.887402814923;4887.853364399074;4918.754062296871;4919.655624106314;4935.605151587864;4944.283078953567;4702.6002789762915;4827.710337379768;4947.802087916479;4961.776720047606;4992.400911890596;4496.4829044659955;4534.841280555164;4568.200564901129;4585.908281834345;4620.376249206314;5003.4746351633285;5010.924836127461;5023.2214006829;5042.268871013683;5046.6719663221775;4614.561616646413;4722.456917454468;4809.639277054165;4814.5907597854575;4836.3712717347225;4805.447373552016;4806.8798280043275;4848.7090774553635;4871;4917.803287868517;4806.062817750505;4806.399200099988;4810.831620893252;4842.394700662418;4850.587700045465;4679;4791.880202994883;4805.447373552016;4812;4851.636127290467;3935.822887969991;3980.9402858957137;4012.1574469361763;4019.0354314964197;4033.9596604033586;3571.6428357164596;3575.7318201135017;3584.946225806615;3613.584437789635;3614.2590768892314;4083.4487344208746;4228.534861165269;4234.830606775695;4242.215190189825;4279.101388708406;4748.928766068511;4814.6870453420415;4858.222684370484;4861.7326047067045;4899.461059283476;4198.181354635817;4198.328267477189;4204.894877628084;4205.894852628648;4225.429567008476;4120.7733574653685;4321.049369138785;4327.112941846914;4353.238183317907;4354.847580334673;4576.542345765397;4605.631549476034;4614.031053478807;4655.162070827284;4688;4899.559039686445;4957.206846904478;4958.305837182726;4966.329545511309;4998.6500944933505;4693.483716791218;4702.835400760957;4703.529647035269;4714.764261786965;4749.4063242094735;4620.168369693488;4693.530646935279;4726.692764970266;4728.668993170582;4798.47216806144;4946.08497427977;4949.232868905326;4952.306677065286;4956.182229932021;4963.950360496493;4788.712677239377;4791.880202994953;4794.808207671654;4831.0096430232425;4836.588889944253;4600.608948239437;4628.745419001987;4696.459907110726;4717.693349932243;4788.640851936049;4646.6979646324235;4691.272852707836;4696.812127514998;4704.364910737144;4707.388039554836;4828.830990915301;4830;4835.8065677372515;4857.125717370907;4875.3174555562955;4524.479684836154;4644.907101857876;4660.161170989254;4694.201985662377;4765.023170250021 22:12:10 INFO - 2015-11-24 22:12:10,369 DEBUG : BROWSER_OUTPUT: |1;ext.html;558.8348293807411;564.5032371513068;573.6070791507815;578.8842231553689;587.0372588954116;26820.195394138183;27190.86404567977;36448.81775591119;37069.629303706955;37211.813940930326;40868;40934.59065409345;41237;41361.58638413615;41364.172716545654;6927.896081558755;7959.801004974864;8091.150429204937;8131.959340203291;8147.918520814805;7058.294170582926;7163.4627402944725;7163.89254161188;7164.355208031277;10153.086222239997;10225.846612300822;10343.534540945675;10346;10348.586056557766;10357.689269321932;10100.343477673965;10212.387256764581;10213.387196768217;10217.540210690462;10226.181905447545;7099.964500177518;7310.926890731078;10021.59913603455;10136.290459667825;10480.371177729285;37556;38066.23867522662;38074;38091.4286285706;38152.23695526074;2834.107256214286;2848.87294066335;2901.3181902252954;2962.7777916656123;3531.7527773055895;28036.43927121446;28332.575011374847;28349.85825070882;28496.070994769754;29027.85486072556;3014.9095527134223;3057.296821730992;3059.602251707264;3155.7159855613104;3516.40221162403;225321.87339063364;227261;227443;227615;227877;45188.418405356315;48442.5155748445;56563;57139;61001.69499152476;57416;57459;57699.71150144222;57704;57713.71143144257;13520.661983450296;13719.176849389069;13726.45094196221;13737.381817818223;13746.450141994408;10118.342307749972;10159.796804064024;10212.387256764618;10222.795544089076;10248.180145588334;19110.80889191118;19271.51821204481;19356.225750969803;19357.870634230225;19373.128209230337;7425.331720145213;7695.730649427243;7797.92202077972;7813;7831.530108193413;840.684743221292;857.3741168946704;876.9210771030511;1016.8325665551753;1029.3875144289286;26227.688615569146;26238.606420903703;26317.47365052688;26390.47219055608;26414.471710566064;937.3532262738688;940.7459985803931;962.0667952086465;977.9853302200472;1088.553692985888;15201.467948621967;15390.769138462932;16165.676686466204;16253.268602912898;16299;316534;319704;321143;321491;322681;49326.75336623366;49737;49771.50228497669;49873.50126498761;49935.75032124889;1144.2905398652722;1208.6434501821984;1211.3398197982121;1212.042486435706;1228.1280290993495;26507;27185;27445;27710.307242318297;27784.444311114068;38213.4267985986;38996.73544071514;39203.41194882136;39241;39346.60653393544;216026;219330;231749;237128;237484;27024;27077.59383609208;27119.72880271251;27128.32179195536;27134.050308239115;35010.29979400449;44207.77896110499;45356.54643453523;45742.542574573825;46326.76836615795;33010.33979320352;33624.663753362154;34043.82978085094;34204.14489637779;34489.65510344865;33936.490952635235;34020.829895850366;34379.484307735904;34400.82799585986;34442.2446204298;33860.3227935435;34687.82656086703;34705.479417809256;34716;34776.47835282524;28205.43589128247;30195.698043020166;30779.84610076935;30825.845870770503;30942;29565.85217073987;32244.19389515281;32256.35487290288;32289.51565726469;32629.836850815595 22:12:10 INFO - 2015-11-24 22:12:10,370 DEBUG : BROWSER_OUTPUT: |2;jquery.html;327.4760383386583;329.5468730495568;330.58841742031166;337.35060009481725;341.2066944354375;12291.44688489018;12514.624561263177;14850.851491485082;15291.158986255752;15579.766303505456;9719.708408747749;9816.705498835028;10012.949935250314;10016.499175041237;10059.49702514875;4494.280915053592;4620.653450991173;4631;4632.86101416958;4633.536646335357;3274.1978215337276;3989.940150897739;4520.412346394981;5238.68567885928;5264.526192642661;5171.948280517185;5203.219517072451;5214.556762675177;5237.45006774289;5254.894902101955;5196.116660167761;5361.731913404334;5763.5101016413655;5777.797777077803;5818.592698511064;5160.8967820643375;5161.7161056141895;5164.509371609691;5172.043172013152;5174.404943431516;17771.733423998652;17824.91087544567;18088.82422642524;18153.636927261512;18533.629327413375;1668.0658831054648;1727.7322015087682;1762.1805860274906;1797.3080364059801;1805.077399380805;9221.492817895012;9782.657606983792;10730.892691073146;12057;12558.74882502345;1772.5745821002865;1778.2086971297779;1814.7550080739063;1821.2805941653105;1863.6924907390264;50211;51701.08630774751;53317.46682533164;53417.465825341635;53661.731691341294;9577.808443831085;9711.174550163316;9823.705288841345;9916.603335866628;9998.200143988464;12552.81170782439;12556.434960426803;12559.995200383948;12560;12574.68563285907;6838.709032474177;6896.27589103147;6931.722731090801;6975.3024697529845;7072.611006394698;6428.19647544057;6433.774817881352;6438.3883531064475;6498.220213574401;6505.60966342021;4126.298529250034;4174.165166966619;4199;4215.346621273708;4220.155968806251;1576.393088660851;1644.2981514132814;1645.0705351476377;1718.2353852535502;1751.7459968304524;372.80986696784834;379.391077320896;384.45407521319794;392.38983380842495;748.3825843678878;9307.488088155082;9661.372010819416;15505.457308994357;16112.355505779638;16437.671246575002;410.6182695230528;411.34595992371675;413.65873154647534;417.2781088716537;421.8755467137141;4806.279058141236;5004.07424626438;5554.08357620988;5562.554995600423;5585.273914391184;453233;456898;457059;457740;473887;47553.76223118862;59015.11477327844;59049;60508.69745651243;60919.69540152271;443.4678385936824;453.7935239466035;453.85930361588015;454.3820404250217;454.84307913770357;8923.15230053144;9168.35821492489;9249.398789078688;9402.576884040098;9451.196648284698;29086.7091329084;31583.684163158076;31834.522482162323;31889.36221275515;32290;37808;39328.2134357317;39844;40121.39817902676;40274.59725402708;8844.115588441104;8900.198982091642;9105.634154876821;9195.678151264674;9209.493477858781;10724.088452481627;10838.566457341618;14980.1760903147;15286.847131528988;15699.293531791325;13051.608451746462;13248.271345076113;13466.192028478323;13587.45650173982;13597.660058498617;13072.738545228853;13154.605361838778;13305.933470332586;13313.134646247963;13319.334033298102;13161.210327380388;13433.26117063571;13543.59369218925;13621.863781362059;13905.652358691113;9108.362414631178;9135.132162444557;9305;9319.906800931903;9365.85951210746;9536.666216682383;10161.745956351151;13832.031757777262;14135;14153 22:12:10 INFO - 2015-11-24 22:12:10,372 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1225.8844451549091;1614.3058484851513;1647.8928869623473;1675.3298680527796;1693.4750227429497;5956.910646340309;6542.934570654292;6953.826154346131;6973.6513174341335;6977.686004129813;6770.255271920085;6862.931370686291;6903.309669033094;6905.447564194865;6909.516333856632;1741.6168442942533;1773.6718707039174;1775.112443778111;2037.6026674798384;2085.635013872574;1786.6337400832863;1792.6952418088956;2006.2877678424168;2050.261905713949;2052.9281475148373;2031.7460317460318;2031.7968203179637;2043.3257025181729;2044.090379780998;2044.6524090904581;1949.385943427823;2014.405750303664;2018.6467368210651;2024.4938765308673;2024.503996520847;2065.06039751914;2069.4722845674255;2091.1948899673584;2121.565079158784;2121.862078964862;6834.350736680008;6904.896426553606;6915.101036865226;6921.065656136408;6925.376716095576;4122.896927576805;4203.516595591515;4219.43037689914;4223.936640950388;4227;2696.5011472877386;2729.072115480746;2775.777937764974;2819.5629677400034;2826;878.3193025405362;899.7300809757112;918.4902379179553;926.0507979321183;930.9953450232773;9226.308026897943;9242.722718318393;9262.212711919496;9262.259019278441;9271.072892710743;3784.3188226119564;3834.3673293906195;3889.0666240102173;3899.259140763246;3930.7051971102283;8029.277365037175;8037.477563958441;8089.595520224083;8117.472364296302;8118.3099436548555;4253.893652658709;4262.339337402707;4264.530901600821;4267.679924005712;4267.97866010668;3826.5408151022057;3858.5948475409677;3859.1895701902354;3861.864834730771;3863.30460517104;3332.7000569948823;3378.273671160712;3401.8603767738086;3406.0463070340343;3415.6584341565645;922.6805667894974;958.9808203835884;1016.1007508355159;1085.858838351025;1087.994560027195;802.2178376083272;810.9189081091844;813.495632707725;814.470594113819;899.5322432335149;6406.295307516262;6455.644939528371;6462.967685161638;6487.967560162263;6502.284748677642;1014.8325526288228;1034.4414016431194;1034.5034383495963;1047.554789214596;1055.567217440861;4861.489543597942;4948.505149485023;4954.900901982012;4960.131976904027;4987.326710894055;7913.485623434458;8119.350451963829;8216.589170541449;8289.378296627778;8369.3304535637;8243.793905152299;8295.211954864279;8342.040665323444;8366.916330836735;8375.790605234795;6534.901976470357;6535.411812936859;6584.11114499546;6595.340465953366;6596.175478065242;6075.453209211192;6175.84560385994;6191.25704915413;6202.751889924352;6203.348648391854;7399.963000184965;7408.407327413686;7451.92548074534;7484.139323977813;7524.661390237343;7327.523710958771;7606.581638009962;7688.8077798053255;7707.576083315472;7711;6098.146259523582;6180.845478863064;6184.381561843779;6186.505079593711;6186.907196392148;6077.787277445268;6162.845928851635;6546.443552298108;6585.835354115994;6604.801855944329;5325.254464374913;5488.945110548843;5586.636868603528;5929.169916211647;6056.757729690763;5819.156222347651;5864.765409383577;5887.970560147171;5953.702314884152;5981.611195272293;5863.912041319469;5925.792597259076;5939.554533409925;5944.524438044859;5947.9405205949115;5715.485606295453;5783.710814459344;5784.2191304175085;5789.160571716993;5789.363170051207;5679.346875109415;5744;5769.653820770767;5799.217105690678;5908.527317814479 22:12:10 INFO - 2015-11-24 22:12:10,373 DEBUG : BROWSER_OUTPUT: |4;prototype.html;304.61009907318635;312.49688002316265;313.46397660001384;315.1663849119079;315.66854802457414;5208.583313334929;5257.342832145981;5321.467853214676;5322.121849894763;5337.733113344327;5208.192730126836;5227.137522308814;5232.189010703338;5233.633645644806;5237.47625237476;3867.0719027433356;3939.7439166454087;4106.096658735073;4111.239420707164;4130.896727581804;4017;4115.753054816706;4120.608542188487;4143.979280103596;4144.564820693829;4080.8367665293354;4088.6524645405175;4095.4061661059127;4097.364908439196;4103.281925663012;3853.3834586466173;3972.245273398074;3973.841046358142;3990.4014397840265;4102.282100632392;3504.5268888700207;3511.052015955703;3564.1446052947367;3634.691051260646;3637.217998130415;4998;5010.924836127461;5022.673526220784;5026.447090820006;5029.622778291606;4688.156131896258;4689.531046895318;4694.694844835075;4696.272077827942;4698.036902435027;5283.207518872162;5452.154915988028;5484.61607687462;5490.6431081979545;5491.450854914517;3868.0909986153233;3868.4777555030273;3873.283442563135;3875.670568001723;3881.126746482047;5712.828615141552;5780.566457515703;5782.132680097977;5783.16144159103;5787.623804452697;3971.4439978403047;3976.701747368959;3981.303271927401;3983.8008099595486;3984.6613037891525;3577.159367548624;3764.5670747864347;3831.50190475242;4040.2727509048063;4045.110075783323;4414.337849322627;4415.757133357632;4485.0805584855025;4555.817767289338;4604.378408914754;5351.705656188869;5500.532454741312;5521.089020311603;5525.4474552544425;5534.003879301765;1407.5777266819914;1431.2342896550504;1431.992840035793;1434.089353260687;1434.6915413186216;960.7213907966751;964.8842138943372;973.2700474644017;990.2028866762325;990.9900900991042;4848.442429120626;4857.077155340474;4858.951410485921;4861.1006963711825;4862;5700.486956173964;5706.828795136153;5709.115087161496;5711.828645140652;5714.0571805652435;4836;4836.202026665561;4840.2255639098275;4849.515048495122;4851.490593487703;2840.7585355244623;2940.206144341016;3020.2751339678757;3038.255627371308;3070.293832418556;5388.245645609618;5460.399356070829;5487.98472282629;5510.641808282448;5512.6968016758665;5869.735861886225;5889.646621202742;5894.852628684317;5895.616784908967;5895.823125306248;5417.783288668488;5432.75552600134;5440.347158341025;5444.700541470257;5444.754986025559;5555.30558680165;5668.886622267614;5731.885362292647;5732.140178973187;5733.369329373682;5609.607327487037;5617.241672374177;5618.073017951992;5625.071863142535;5626.437356264504;5430.212619170277;5432.701201433959;5434.864128396822;5437.13005919051;5440.836774896759;3981.044549308203;3982.044309365789;3988.581198974066;3988.74073185242;3990.780507072023;5549.250851135045;5708.80019199326;5715.542756579547;5721.199032135588;5721.771129154788;5506.063969125338;5507.7246137692155;5515.917261241165;5519.034169020486;5521.1442226454965;5502;5504.4495550444635;5509.393966663744;5516.475934786189;5516.586256030733;5243.161094224905;5393.325834270716;5399;5429.484199001088;5441.211024401518;5565.276514053147;5570.805021824217;5573.303337082864;5573.944260557342;5577.721113944205;5210.062188806051;5290.576753859605;5343.145096784496;5432.538234250133;5443.891122177613 22:12:10 INFO - 2015-11-24 22:12:10,376 DEBUG : BROWSER_OUTPUT: |5;yui.html;657.8322527755423;734.5812886654608;754.3512579181906;758.3857075768624;768.1089935674619;11439.59961401351;11668.766624667502;11690.707732306697;11691.824622630656;11722.23805452646;11303.773924521505;11398.886011139886;11431.02836258917;11441;11470.426478676054;579.6377264209868;585.0960266388419;754.5057987018498;762.0550517358463;777.3547955197173;755.0674916478146;756.1908757629338;761.6648674583166;761.756238003839;762.1083332500987;803.6704950970103;810.3881569415083;810.6595230003384;810.6878851642131;811.0024669656326;573.489594261108;575.0741306496537;783.2285199078902;797.5095316380442;799.3245707377257;593.5518683394054;593.6289818863211;593.8010766393263;593.9732712027926;594.0673143165233;11937.701557461132;12149;12186.634400967896;12188.20776649515;12188.20776649515;11520.251183673117;12105.273683578926;12269.447874845653;12296.877031229753;12576.68558286041;9166.495842728647;9220.677276295364;9264.351495395325;9411.43531388119;9467.621295148187;3259.3970115528705;3318.734501239895;3337.5494308268317;3345.3142105868237;3414.146463384154;41004.589954100375;41346;41370.172596548204;41378.1724365514;41474.79262603698;8728.519931403707;8889.155530224618;9110.86333704995;9177.219936305355;9253.352265341497;16329.918350408172;16366.83633163653;16367.91816040912;16386.83613163877;16396.09821459831;6326.652034138075;6358.841028974312;6375.489960803217;6437.742490300336;6585.9012114818315;3437.5359326491102;3440.9483857742152;3511.122219445139;3524.1894364296354;3524.806135662563;2708.7155848636003;2721.6597925259343;2737.6167336572894;2740.328619488238;2741.068036867435;489.86038978890844;494.04402481198997;503.90173916086746;503.9496050394931;537.4330081763777;410.79665565545247;467.85964210737325;481.2012059980416;529.5154933236046;554.4400155842548;7266.672999715025;7892.723754668674;8017.158198389202;8089.595520223966;8205.220504052106;388.55122333704054;488.76539261154846;513.7636687123891;522.9424763276037;582.6620560075146;3400.7619466637098;3489.7557170998293;3551.2897420515483;3582.6417358263966;3596.7482276240935;53800.46199537955;53950.73024634852;54142;54286.72856635691;54752.726236368566;46496;46564.301535476996;46694.53305466902;46739.29891051637;47165;42095.36856947148;43190.784046080196;43285.78357108194;43521.78239108784;43686.344704829455;7222.422206223385;7261.673224704795;7266.491345605757;7341.229170937188;7383.593902335208;31168;31425.52861707122;31556.684433156293;31590.52614210743;32021.519677204393;38030.429543557424;38531;41798.373024405264;41955.58044419517;42251;8575.828483430421;8607.741767746978;8640.56797160152;8775.648974040967;8816.735497935073;9473.24214062887;9643.9035609643;9847.507624618596;9943.701688949342;10049;8948.328875334246;9430.811383772423;9440.055994400505;9671.613135474503;9717;9170.358074934691;9177.311701622271;9232.353735238468;9487.715368538955;9507.809843802946;8705.651773929225;8745.256653184297;8807.735767926972;8942.642294308414;9011.143941325563;8107.635156417858;8108.594570271581;8281.751547453587;8335.666573337;8618.35362347839;7714.884276735741;8036.638351274323;8125.959370203348;8223.835523289381;8225.876611850947 22:12:10 INFO - 2015-11-24 22:12:10,377 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:12:10 INFO - 2015-11-24 22:12:10,377 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:12:10 INFO - 2015-11-24 22:12:10,377 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,983 22:12:10 INFO - 2015-11-24 22:12:10,377 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:12:10 INFO - 2015-11-24 22:12:10,377 DEBUG : BROWSER_OUTPUT: __startTimestamp1448431930365__endTimestamp 22:12:10 INFO - 2015-11-24 22:12:10,377 DEBUG : BROWSER_OUTPUT: 22:12:10 INFO - 2015-11-24 22:12:10,377 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:12:10 INFO - 2015-11-24 22:12:10,377 DEBUG : BROWSER_OUTPUT: Number of tests: 6 22:12:10 INFO - 2015-11-24 22:12:10,377 DEBUG : BROWSER_OUTPUT: 22:12:10 INFO - 2015-11-24 22:12:10,377 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4515.10 Median:4644.91 stddev:458.90 (9.9%) stddev-sans-first:434.55 22:12:10 INFO - 2015-11-24 22:12:10,377 DEBUG : BROWSER_OUTPUT: Values: 2582.8 2698.2 2706.2 2710.5 2727.4 4462.1 4552.6 4619.1 4621.7 4677.0 4502.8 4521.0 4525.2 4640.2 4641.7 4276.4 4284.6 4291.5 4305.6 4325.6 4047.0 4331.5 4367.9 4373.5 4381.9 4164.1 4200.6 4233.8 4264.9 4267.4 4221.0 4221.1 4271.0 4278.9 4314.1 4090.3 4200.0 4241.3 4268.3 4305.4 4407.6 4413.2 4445.8 4471.2 4503.9 4887.9 4918.8 4919.7 4935.6 4944.3 4702.6 4827.7 4947.8 4961.8 4992.4 4496.5 4534.8 4568.2 4585.9 4620.4 5003.5 5010.9 5023.2 5042.3 5046.7 4614.6 4722.5 4809.6 4814.6 4836.4 4805.4 4806.9 4848.7 4871.0 4917.8 4806.1 4806.4 4810.8 4842.4 4850.6 4679.0 4791.9 4805.4 4812.0 4851.6 3935.8 3980.9 4012.2 4019.0 4034.0 3571.6 3575.7 3584.9 3613.6 3614.3 4083.4 4228.5 4234.8 4242.2 4279.1 4748.9 4814.7 4858.2 4861.7 4899.5 4198.2 4198.3 4204.9 4205.9 4225.4 4120.8 4321.0 4327.1 4353.2 4354.8 4576.5 4605.6 4614.0 4655.2 4688.0 4899.6 4957.2 4958.3 4966.3 4998.7 4693.5 4702.8 4703.5 4714.8 4749.4 4620.2 4693.5 4726.7 4728.7 4798.5 4946.1 4949.2 4952.3 4956.2 4964.0 4788.7 4791.9 4794.8 4831.0 4836.6 4600.6 4628.7 4696.5 4717.7 4788.6 4646.7 4691.3 4696.8 4704.4 4707.4 4828.8 4830.0 4835.8 4857.1 4875.3 4524.5 4644.9 4660.2 4694.2 4765.0 22:12:10 INFO - 2015-11-24 22:12:10,377 DEBUG : BROWSER_OUTPUT: 22:12:10 INFO - 2015-11-24 22:12:10,377 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42409.26 Median:321317.00 stddev:68474.73 (21.3%) stddev-sans-first:68594.72 22:12:10 INFO - 2015-11-24 22:12:10,378 DEBUG : BROWSER_OUTPUT: Values: 558.8 564.5 573.6 578.9 587.0 26820.2 27190.9 36448.8 37069.6 37211.8 40868.0 40934.6 41237.0 41361.6 41364.2 6927.9 7959.8 8091.2 8132.0 8147.9 7058.3 7163.5 7163.9 7164.4 10153.1 10225.8 10343.5 10346.0 10348.6 10357.7 10100.3 10212.4 10213.4 10217.5 10226.2 7100.0 7310.9 10021.6 10136.3 10480.4 37556.0 38066.2 38074.0 38091.4 38152.2 2834.1 2848.9 2901.3 2962.8 3531.8 28036.4 28332.6 28349.9 28496.1 29027.9 3014.9 3057.3 3059.6 3155.7 3516.4 225321.9 227261.0 227443.0 227615.0 227877.0 45188.4 48442.5 56563.0 57139.0 61001.7 57416.0 57459.0 57699.7 57704.0 57713.7 13520.7 13719.2 13726.5 13737.4 13746.5 10118.3 10159.8 10212.4 10222.8 10248.2 19110.8 19271.5 19356.2 19357.9 19373.1 7425.3 7695.7 7797.9 7813.0 7831.5 840.7 857.4 876.9 1016.8 1029.4 26227.7 26238.6 26317.5 26390.5 26414.5 937.4 940.7 962.1 978.0 1088.6 15201.5 15390.8 16165.7 16253.3 16299.0 316534.0 319704.0 321143.0 321491.0 322681.0 49326.8 49737.0 49771.5 49873.5 49935.8 1144.3 1208.6 1211.3 1212.0 1228.1 26507.0 27185.0 27445.0 27710.3 27784.4 38213.4 38996.7 39203.4 39241.0 39346.6 216026.0 219330.0 231749.0 237128.0 237484.0 27024.0 27077.6 27119.7 27128.3 27134.1 35010.3 44207.8 45356.5 45742.5 46326.8 33010.3 33624.7 34043.8 34204.1 34489.7 33936.5 34020.8 34379.5 34400.8 34442.2 33860.3 34687.8 34705.5 34716.0 34776.5 28205.4 30195.7 30779.8 30825.8 30942.0 29565.9 32244.2 32256.4 32289.5 32629.8 22:12:10 INFO - 2015-11-24 22:12:10,378 DEBUG : BROWSER_OUTPUT: 22:12:10 INFO - 2015-11-24 22:12:10,378 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24376.69 Median:2310.44 stddev:74978.06 (3245.2%) stddev-sans-first:75166.65 22:12:10 INFO - 2015-11-24 22:12:10,378 DEBUG : BROWSER_OUTPUT: Values: 327.5 329.5 330.6 337.4 341.2 12291.4 12514.6 14850.9 15291.2 15579.8 9719.7 9816.7 10012.9 10016.5 10059.5 4494.3 4620.7 4631.0 4632.9 4633.5 3274.2 3989.9 4520.4 5238.7 5264.5 5171.9 5203.2 5214.6 5237.5 5254.9 5196.1 5361.7 5763.5 5777.8 5818.6 5160.9 5161.7 5164.5 5172.0 5174.4 17771.7 17824.9 18088.8 18153.6 18533.6 1668.1 1727.7 1762.2 1797.3 1805.1 9221.5 9782.7 10730.9 12057.0 12558.7 1772.6 1778.2 1814.8 1821.3 1863.7 50211.0 51701.1 53317.5 53417.5 53661.7 9577.8 9711.2 9823.7 9916.6 9998.2 12552.8 12556.4 12560.0 12560.0 12574.7 6838.7 6896.3 6931.7 6975.3 7072.6 6428.2 6433.8 6438.4 6498.2 6505.6 4126.3 4174.2 4199.0 4215.3 4220.2 1576.4 1644.3 1645.1 1718.2 1751.7 372.8 379.4 384.5 392.4 748.4 9307.5 9661.4 15505.5 16112.4 16437.7 410.6 411.3 413.7 417.3 421.9 4806.3 5004.1 5554.1 5562.6 5585.3 453233.0 456898.0 457059.0 457740.0 473887.0 47553.8 59015.1 59049.0 60508.7 60919.7 443.5 453.8 453.9 454.4 454.8 8923.2 9168.4 9249.4 9402.6 9451.2 29086.7 31583.7 31834.5 31889.4 32290.0 37808.0 39328.2 39844.0 40121.4 40274.6 8844.1 8900.2 9105.6 9195.7 9209.5 10724.1 10838.6 14980.2 15286.8 15699.3 13051.6 13248.3 13466.2 13587.5 13597.7 13072.7 13154.6 13305.9 13313.1 13319.3 13161.2 13433.3 13543.6 13621.9 13905.7 9108.4 9135.1 9305.0 9319.9 9365.9 9536.7 10161.7 13832.0 14135.0 14153.0 22:12:10 INFO - 2015-11-24 22:12:10,378 DEBUG : BROWSER_OUTPUT: 22:12:10 INFO - 2015-11-24 22:12:10,378 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4799.34 Median:5927.48 stddev:2463.16 (41.6%) stddev-sans-first:2455.43 22:12:10 INFO - 2015-11-24 22:12:10,378 DEBUG : BROWSER_OUTPUT: Values: 1225.9 1614.3 1647.9 1675.3 1693.5 5956.9 6542.9 6953.8 6973.7 6977.7 6770.3 6862.9 6903.3 6905.4 6909.5 1741.6 1773.7 1775.1 2037.6 2085.6 1786.6 1792.7 2006.3 2050.3 2052.9 2031.7 2031.8 2043.3 2044.1 2044.7 1949.4 2014.4 2018.6 2024.5 2024.5 2065.1 2069.5 2091.2 2121.6 2121.9 6834.4 6904.9 6915.1 6921.1 6925.4 4122.9 4203.5 4219.4 4223.9 4227.0 2696.5 2729.1 2775.8 2819.6 2826.0 878.3 899.7 918.5 926.1 931.0 9226.3 9242.7 9262.2 9262.3 9271.1 3784.3 3834.4 3889.1 3899.3 3930.7 8029.3 8037.5 8089.6 8117.5 8118.3 4253.9 4262.3 4264.5 4267.7 4268.0 3826.5 3858.6 3859.2 3861.9 3863.3 3332.7 3378.3 3401.9 3406.0 3415.7 922.7 959.0 1016.1 1085.9 1088.0 802.2 810.9 813.5 814.5 899.5 6406.3 6455.6 6463.0 6488.0 6502.3 1014.8 1034.4 1034.5 1047.6 1055.6 4861.5 4948.5 4954.9 4960.1 4987.3 7913.5 8119.4 8216.6 8289.4 8369.3 8243.8 8295.2 8342.0 8366.9 8375.8 6534.9 6535.4 6584.1 6595.3 6596.2 6075.5 6175.8 6191.3 6202.8 6203.3 7400.0 7408.4 7451.9 7484.1 7524.7 7327.5 7606.6 7688.8 7707.6 7711.0 6098.1 6180.8 6184.4 6186.5 6186.9 6077.8 6162.8 6546.4 6585.8 6604.8 5325.3 5488.9 5586.6 5929.2 6056.8 5819.2 5864.8 5888.0 5953.7 5981.6 5863.9 5925.8 5939.6 5944.5 5947.9 5715.5 5783.7 5784.2 5789.2 5789.4 5679.3 5744.0 5769.7 5799.2 5908.5 22:12:10 INFO - 2015-11-24 22:12:10,378 DEBUG : BROWSER_OUTPUT: 22:12:10 INFO - 2015-11-24 22:12:10,378 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4570.52 Median:5235.55 stddev:1343.80 (25.7%) stddev-sans-first:1308.87 22:12:10 INFO - 2015-11-24 22:12:10,378 DEBUG : BROWSER_OUTPUT: Values: 304.6 312.5 313.5 315.2 315.7 5208.6 5257.3 5321.5 5322.1 5337.7 5208.2 5227.1 5232.2 5233.6 5237.5 3867.1 3939.7 4106.1 4111.2 4130.9 4017.0 4115.8 4120.6 4144.0 4144.6 4080.8 4088.7 4095.4 4097.4 4103.3 3853.4 3972.2 3973.8 3990.4 4102.3 3504.5 3511.1 3564.1 3634.7 3637.2 4998.0 5010.9 5022.7 5026.4 5029.6 4688.2 4689.5 4694.7 4696.3 4698.0 5283.2 5452.2 5484.6 5490.6 5491.5 3868.1 3868.5 3873.3 3875.7 3881.1 5712.8 5780.6 5782.1 5783.2 5787.6 3971.4 3976.7 3981.3 3983.8 3984.7 3577.2 3764.6 3831.5 4040.3 4045.1 4414.3 4415.8 4485.1 4555.8 4604.4 5351.7 5500.5 5521.1 5525.4 5534.0 1407.6 1431.2 1432.0 1434.1 1434.7 960.7 964.9 973.3 990.2 991.0 4848.4 4857.1 4859.0 4861.1 4862.0 5700.5 5706.8 5709.1 5711.8 5714.1 4836.0 4836.2 4840.2 4849.5 4851.5 2840.8 2940.2 3020.3 3038.3 3070.3 5388.2 5460.4 5488.0 5510.6 5512.7 5869.7 5889.6 5894.9 5895.6 5895.8 5417.8 5432.8 5440.3 5444.7 5444.8 5555.3 5668.9 5731.9 5732.1 5733.4 5609.6 5617.2 5618.1 5625.1 5626.4 5430.2 5432.7 5434.9 5437.1 5440.8 3981.0 3982.0 3988.6 3988.7 3990.8 5549.3 5708.8 5715.5 5721.2 5721.8 5506.1 5507.7 5515.9 5519.0 5521.1 5502.0 5504.4 5509.4 5516.5 5516.6 5243.2 5393.3 5399.0 5429.5 5441.2 5565.3 5570.8 5573.3 5573.9 5577.7 5210.1 5290.6 5343.1 5432.5 5443.9 22:12:10 INFO - 2015-11-24 22:12:10,378 DEBUG : BROWSER_OUTPUT: 22:12:10 INFO - 2015-11-24 22:12:10,378 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12288.86 Median:574.28 stddev:14621.68 (2546.1%) stddev-sans-first:14636.61 22:12:10 INFO - 2015-11-24 22:12:10,380 DEBUG : BROWSER_OUTPUT: Values: 657.8 734.6 754.4 758.4 768.1 11439.6 11668.8 11690.7 11691.8 11722.2 11303.8 11398.9 11431.0 11441.0 11470.4 579.6 585.1 754.5 762.1 777.4 755.1 756.2 761.7 761.8 762.1 803.7 810.4 810.7 810.7 811.0 573.5 575.1 783.2 797.5 799.3 593.6 593.6 593.8 594.0 594.1 11937.7 12149.0 12186.6 12188.2 12188.2 11520.3 12105.3 12269.4 12296.9 12576.7 9166.5 9220.7 9264.4 9411.4 9467.6 3259.4 3318.7 3337.5 3345.3 3414.1 41004.6 41346.0 41370.2 41378.2 41474.8 8728.5 8889.2 9110.9 9177.2 9253.4 16329.9 16366.8 16367.9 16386.8 16396.1 6326.7 6358.8 6375.5 6437.7 6585.9 3437.5 3440.9 3511.1 3524.2 3524.8 2708.7 2721.7 2737.6 2740.3 2741.1 489.9 494.0 503.9 503.9 537.4 410.8 467.9 481.2 529.5 554.4 7266.7 7892.7 8017.2 8089.6 8205.2 388.6 488.8 513.8 522.9 582.7 3400.8 3489.8 3551.3 3582.6 3596.7 53800.5 53950.7 54142.0 54286.7 54752.7 46496.0 46564.3 46694.5 46739.3 47165.0 42095.4 43190.8 43285.8 43521.8 43686.3 7222.4 7261.7 7266.5 7341.2 7383.6 31168.0 31425.5 31556.7 31590.5 32021.5 38030.4 38531.0 41798.4 41955.6 42251.0 8575.8 8607.7 8640.6 8775.6 8816.7 9473.2 9643.9 9847.5 9943.7 10049.0 8948.3 9430.8 9440.1 9671.6 9717.0 9170.4 9177.3 9232.4 9487.7 9507.8 8705.7 8745.3 8807.7 8942.6 9011.1 8107.6 8108.6 8281.8 8335.7 8618.4 7714.9 8036.6 8126.0 8223.8 8225.9 22:12:10 INFO - 2015-11-24 22:12:10,380 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:12:10 INFO - 2015-11-24 22:12:10,380 DEBUG : BROWSER_OUTPUT: 22:12:11 INFO - 2015-11-24 22:12:11,123 INFO : Browser exited with error code: 0 22:12:11 INFO - 2015-11-24 22:12:11,140 INFO : Completed test dromaeo_css (00:18:36) 22:12:11 INFO - 2015-11-24 22:12:11,140 INFO : Starting test kraken 22:12:11 INFO - 2015-11-24 22:12:11,140 DEBUG : operating with platform_type : linux_ 22:12:11 INFO - 2015-11-24 22:12:11,140 INFO : Initialising browser for kraken test... 22:12:11 INFO - 2015-11-24 22:12:11,146 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppRGVMw/profile http://localhost:41114/getInfo.html 22:12:15 INFO - 2015-11-24 22:12:15,120 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:12:15 INFO - 2015-11-24 22:12:15,121 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:12:15 INFO - 2015-11-24 22:12:15,121 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:12:15 INFO - 2015-11-24 22:12:15,121 DEBUG : BROWSER_OUTPUT: __metrics 22:12:15 INFO - 2015-11-24 22:12:15,242 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:12:16 INFO - 2015-11-24 22:12:16,465 INFO : Browser initialized. 22:12:16 INFO - 2015-11-24 22:12:16,466 INFO : Running cycle 1/1 for kraken test... 22:12:16 INFO - 2015-11-24 22:12:16,466 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppRGVMw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:12:28 INFO - 2015-11-24 22:12:28,398 DEBUG : BROWSER_OUTPUT: RSS: Main: 139149312 22:12:28 INFO - 2015-11-24 22:12:28,398 DEBUG : BROWSER_OUTPUT: 22:12:30 INFO - 2015-11-24 22:12:30,982 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41114/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41114/tests/kraken/driver.html?testName=audio-beat-detection) 22:12:31 INFO - 2015-11-24 22:12:31,568 DEBUG : BROWSER_OUTPUT: RSS: Main: 178356224 22:12:31 INFO - 2015-11-24 22:12:31,568 DEBUG : BROWSER_OUTPUT: 22:12:34 INFO - 2015-11-24 22:12:34,307 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41114/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41114/tests/kraken/driver.html?testName=audio-dft) 22:12:34 INFO - 2015-11-24 22:12:34,873 DEBUG : BROWSER_OUTPUT: RSS: Main: 165646336 22:12:34 INFO - 2015-11-24 22:12:34,873 DEBUG : BROWSER_OUTPUT: 22:12:37 INFO - 2015-11-24 22:12:37,893 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41114/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41114/tests/kraken/driver.html?testName=audio-fft) 22:12:38 INFO - 2015-11-24 22:12:38,475 DEBUG : BROWSER_OUTPUT: RSS: Main: 149983232 22:12:38 INFO - 2015-11-24 22:12:38,475 DEBUG : BROWSER_OUTPUT: 22:12:40 INFO - 2015-11-24 22:12:40,508 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41114/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41114/tests/kraken/driver.html?testName=audio-oscillator) 22:12:41 INFO - 2015-11-24 22:12:41,081 DEBUG : BROWSER_OUTPUT: RSS: Main: 152510464 22:12:41 INFO - 2015-11-24 22:12:41,081 DEBUG : BROWSER_OUTPUT: 22:12:43 INFO - 2015-11-24 22:12:43,336 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41114/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41114/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:12:43 INFO - 2015-11-24 22:12:43,903 DEBUG : BROWSER_OUTPUT: RSS: Main: 154947584 22:12:43 INFO - 2015-11-24 22:12:43,904 DEBUG : BROWSER_OUTPUT: 22:12:46 INFO - 2015-11-24 22:12:46,843 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41114/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41114/tests/kraken/driver.html?testName=imaging-darkroom) 22:12:47 INFO - 2015-11-24 22:12:47,424 DEBUG : BROWSER_OUTPUT: RSS: Main: 153489408 22:12:47 INFO - 2015-11-24 22:12:47,424 DEBUG : BROWSER_OUTPUT: 22:12:50 INFO - 2015-11-24 22:12:50,797 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41114/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41114/tests/kraken/driver.html?testName=imaging-desaturate) 22:12:51 INFO - 2015-11-24 22:12:51,379 DEBUG : BROWSER_OUTPUT: RSS: Main: 154800128 22:12:51 INFO - 2015-11-24 22:12:51,379 DEBUG : BROWSER_OUTPUT: 22:12:54 INFO - 2015-11-24 22:12:54,229 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41114/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41114/tests/kraken/driver.html?testName=json-parse-financial) 22:12:54 INFO - 2015-11-24 22:12:54,810 DEBUG : BROWSER_OUTPUT: RSS: Main: 154267648 22:12:54 INFO - 2015-11-24 22:12:54,810 DEBUG : BROWSER_OUTPUT: 22:12:56 INFO - 2015-11-24 22:12:56,606 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41114/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41114/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:12:57 INFO - 2015-11-24 22:12:57,171 DEBUG : BROWSER_OUTPUT: RSS: Main: 163414016 22:12:57 INFO - 2015-11-24 22:12:57,172 DEBUG : BROWSER_OUTPUT: 22:12:59 INFO - 2015-11-24 22:12:59,082 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41114/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41114/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:12:59 INFO - 2015-11-24 22:12:59,672 DEBUG : BROWSER_OUTPUT: RSS: Main: 164720640 22:12:59 INFO - 2015-11-24 22:12:59,672 DEBUG : BROWSER_OUTPUT: 22:13:01 INFO - 2015-11-24 22:13:01,764 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41114/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41114/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:13:02 INFO - 2015-11-24 22:13:02,345 DEBUG : BROWSER_OUTPUT: RSS: Main: 171622400 22:13:02 INFO - 2015-11-24 22:13:02,345 DEBUG : BROWSER_OUTPUT: 22:13:04 INFO - 2015-11-24 22:13:04,840 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41114/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41114/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:13:05 INFO - 2015-11-24 22:13:05,421 DEBUG : BROWSER_OUTPUT: RSS: Main: 178876416 22:13:05 INFO - 2015-11-24 22:13:05,422 DEBUG : BROWSER_OUTPUT: 22:13:08 INFO - 2015-11-24 22:13:08,016 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41114/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41114/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:13:08 INFO - 2015-11-24 22:13:08,589 DEBUG : BROWSER_OUTPUT: RSS: Main: 175501312 22:13:08 INFO - 2015-11-24 22:13:08,589 DEBUG : BROWSER_OUTPUT: 22:13:10 INFO - 2015-11-24 22:13:10,380 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41114/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41114/tests/kraken/driver.html?testName=ai-astar) 22:13:10 INFO - 2015-11-24 22:13:10,631 DEBUG : BROWSER_OUTPUT: RSS: Main: 236236800 22:13:10 INFO - 2015-11-24 22:13:10,631 DEBUG : BROWSER_OUTPUT: 22:13:10 INFO - 2015-11-24 22:13:10,632 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:13:10 INFO - 2015-11-24 22:13:10,633 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:13:10 INFO - 2015-11-24 22:13:10,633 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:13:10 INFO - 2015-11-24 22:13:10,633 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:13:10 INFO - 2015-11-24 22:13:10,633 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;112;106;112;112;113;100;112;111;104 22:13:10 INFO - 2015-11-24 22:13:10,634 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;133;157;174;139;161;155;141;177;130 22:13:10 INFO - 2015-11-24 22:13:10,634 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;162;162;162;161;161;165;164;162;162 22:13:10 INFO - 2015-11-24 22:13:10,634 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;73;84;93;72;73;72;113;92;72 22:13:10 INFO - 2015-11-24 22:13:10,634 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;96;94;131;93;95;94;145;94;94;134 22:13:10 INFO - 2015-11-24 22:13:10,635 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;109;110;110;109;109;110;109 22:13:10 INFO - 2015-11-24 22:13:10,635 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;147;147;148;147;148;146;147;147;147 22:13:10 INFO - 2015-11-24 22:13:10,635 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;94;95;95;95;95;95;95 22:13:10 INFO - 2015-11-24 22:13:10,635 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;70;70;71;71;71;71;83;70;69 22:13:10 INFO - 2015-11-24 22:13:10,636 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;71;71;71;73;73;73;71;72;72;72 22:13:10 INFO - 2015-11-24 22:13:10,636 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;82;85;84;82;85;83;84;84;83 22:13:10 INFO - 2015-11-24 22:13:10,636 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;118;126;130;118;121;127;134;122;129;120 22:13:10 INFO - 2015-11-24 22:13:10,637 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;148;146;147;136;146;148;140;149;137 22:13:10 INFO - 2015-11-24 22:13:10,637 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;71;72;68;67;69;69;68;67;69 22:13:10 INFO - 2015-11-24 22:13:10,637 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:13:10 INFO - 2015-11-24 22:13:10,637 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:13:10 INFO - 2015-11-24 22:13:10,638 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,979 22:13:10 INFO - 2015-11-24 22:13:10,638 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:13:10 INFO - 2015-11-24 22:13:10,638 DEBUG : BROWSER_OUTPUT: __startTimestamp1448431990632__endTimestamp 22:13:10 INFO - 2015-11-24 22:13:10,638 DEBUG : BROWSER_OUTPUT: 22:13:10 INFO - 2015-11-24 22:13:10,642 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:13:10 INFO - 2015-11-24 22:13:10,642 DEBUG : BROWSER_OUTPUT: Number of tests: 14 22:13:10 INFO - 2015-11-24 22:13:10,642 DEBUG : BROWSER_OUTPUT: 22:13:10 INFO - 2015-11-24 22:13:10,642 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.40 Median:112.00 stddev:4.45 (4.0%) stddev-sans-first:4.62 22:13:10 INFO - 2015-11-24 22:13:10,642 DEBUG : BROWSER_OUTPUT: Values: 112.0 112.0 106.0 112.0 112.0 113.0 100.0 112.0 111.0 104.0 22:13:10 INFO - 2015-11-24 22:13:10,642 DEBUG : BROWSER_OUTPUT: 22:13:10 INFO - 2015-11-24 22:13:10,642 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:152.30 Median:156.50 stddev:16.24 (10.4%) stddev-sans-first:17.17 22:13:10 INFO - 2015-11-24 22:13:10,642 DEBUG : BROWSER_OUTPUT: Values: 156.0 133.0 157.0 174.0 139.0 161.0 155.0 141.0 177.0 130.0 22:13:10 INFO - 2015-11-24 22:13:10,643 DEBUG : BROWSER_OUTPUT: 22:13:10 INFO - 2015-11-24 22:13:10,643 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.40 Median:162.00 stddev:1.26 (0.8%) stddev-sans-first:1.32 22:13:10 INFO - 2015-11-24 22:13:10,643 DEBUG : BROWSER_OUTPUT: Values: 163.0 162.0 162.0 162.0 161.0 161.0 165.0 164.0 162.0 162.0 22:13:10 INFO - 2015-11-24 22:13:10,643 DEBUG : BROWSER_OUTPUT: 22:13:10 INFO - 2015-11-24 22:13:10,643 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.80 Median:73.50 stddev:13.79 (18.8%) stddev-sans-first:14.34 22:13:10 INFO - 2015-11-24 22:13:10,643 DEBUG : BROWSER_OUTPUT: Values: 74.0 73.0 84.0 93.0 72.0 73.0 72.0 113.0 92.0 72.0 22:13:10 INFO - 2015-11-24 22:13:10,643 DEBUG : BROWSER_OUTPUT: 22:13:10 INFO - 2015-11-24 22:13:10,643 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.00 Median:94.00 stddev:20.78 (22.1%) stddev-sans-first:21.66 22:13:10 INFO - 2015-11-24 22:13:10,643 DEBUG : BROWSER_OUTPUT: Values: 96.0 94.0 131.0 93.0 95.0 94.0 145.0 94.0 94.0 134.0 22:13:10 INFO - 2015-11-24 22:13:10,643 DEBUG : BROWSER_OUTPUT: 22:13:10 INFO - 2015-11-24 22:13:10,644 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 22:13:10 INFO - 2015-11-24 22:13:10,644 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 109.0 110.0 110.0 109.0 109.0 110.0 109.0 22:13:10 INFO - 2015-11-24 22:13:10,644 DEBUG : BROWSER_OUTPUT: 22:13:10 INFO - 2015-11-24 22:13:10,644 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 22:13:10 INFO - 2015-11-24 22:13:10,644 DEBUG : BROWSER_OUTPUT: Values: 146.0 147.0 147.0 148.0 147.0 148.0 146.0 147.0 147.0 147.0 22:13:10 INFO - 2015-11-24 22:13:10,644 DEBUG : BROWSER_OUTPUT: 22:13:10 INFO - 2015-11-24 22:13:10,644 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 22:13:10 INFO - 2015-11-24 22:13:10,644 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 22:13:10 INFO - 2015-11-24 22:13:10,644 DEBUG : BROWSER_OUTPUT: 22:13:10 INFO - 2015-11-24 22:13:10,644 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.70 Median:71.00 stddev:4.03 (5.7%) stddev-sans-first:4.27 22:13:10 INFO - 2015-11-24 22:13:10,645 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 70.0 71.0 71.0 71.0 71.0 83.0 70.0 69.0 22:13:10 INFO - 2015-11-24 22:13:10,645 DEBUG : BROWSER_OUTPUT: 22:13:10 INFO - 2015-11-24 22:13:10,645 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:71.90 Median:72.00 stddev:0.88 (1.2%) stddev-sans-first:0.87 22:13:10 INFO - 2015-11-24 22:13:10,645 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 71.0 73.0 73.0 73.0 71.0 72.0 72.0 72.0 22:13:10 INFO - 2015-11-24 22:13:10,645 DEBUG : BROWSER_OUTPUT: 22:13:10 INFO - 2015-11-24 22:13:10,645 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:84.00 stddev:1.34 (1.6%) stddev-sans-first:1.13 22:13:10 INFO - 2015-11-24 22:13:10,645 DEBUG : BROWSER_OUTPUT: Values: 81.0 82.0 85.0 84.0 82.0 85.0 83.0 84.0 84.0 83.0 22:13:10 INFO - 2015-11-24 22:13:10,645 DEBUG : BROWSER_OUTPUT: 22:13:10 INFO - 2015-11-24 22:13:10,645 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.50 Median:126.50 stddev:5.50 (4.3%) stddev-sans-first:5.31 22:13:10 INFO - 2015-11-24 22:13:10,645 DEBUG : BROWSER_OUTPUT: Values: 118.0 126.0 130.0 118.0 121.0 127.0 134.0 122.0 129.0 120.0 22:13:10 INFO - 2015-11-24 22:13:10,646 DEBUG : BROWSER_OUTPUT: 22:13:10 INFO - 2015-11-24 22:13:10,646 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.20 Median:146.50 stddev:5.55 (3.8%) stddev-sans-first:5.04 22:13:10 INFO - 2015-11-24 22:13:10,646 DEBUG : BROWSER_OUTPUT: Values: 135.0 148.0 146.0 147.0 136.0 146.0 148.0 140.0 149.0 137.0 22:13:10 INFO - 2015-11-24 22:13:10,646 DEBUG : BROWSER_OUTPUT: 22:13:10 INFO - 2015-11-24 22:13:10,646 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:1.63 (2.4%) stddev-sans-first:1.69 22:13:10 INFO - 2015-11-24 22:13:10,646 DEBUG : BROWSER_OUTPUT: Values: 70.0 71.0 72.0 68.0 67.0 69.0 69.0 68.0 67.0 69.0 22:13:10 INFO - 2015-11-24 22:13:10,646 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:13:10 INFO - 2015-11-24 22:13:10,646 DEBUG : BROWSER_OUTPUT: 22:13:11 INFO - 2015-11-24 22:13:11,532 INFO : Browser exited with error code: 0 22:13:11 INFO - 2015-11-24 22:13:11,589 INFO : Completed test kraken (00:01:00) 22:13:11 INFO - 2015-11-24 22:13:11,589 INFO : Starting test v8_7 22:13:11 INFO - 2015-11-24 22:13:11,589 DEBUG : operating with platform_type : linux_ 22:13:11 INFO - 2015-11-24 22:13:11,589 INFO : Initialising browser for v8_7 test... 22:13:11 INFO - 2015-11-24 22:13:11,595 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0LNNsp/profile http://localhost:41114/getInfo.html 22:13:15 INFO - 2015-11-24 22:13:15,521 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:13:15 INFO - 2015-11-24 22:13:15,521 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:13:15 INFO - 2015-11-24 22:13:15,521 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:13:15 INFO - 2015-11-24 22:13:15,521 DEBUG : BROWSER_OUTPUT: __metrics 22:13:15 INFO - 2015-11-24 22:13:15,649 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:13:16 INFO - 2015-11-24 22:13:16,964 INFO : Browser initialized. 22:13:16 INFO - 2015-11-24 22:13:16,965 INFO : Running cycle 1/1 for v8_7 test... 22:13:16 INFO - 2015-11-24 22:13:16,965 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0LNNsp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:13:28 INFO - 2015-11-24 22:13:28,848 DEBUG : BROWSER_OUTPUT: RSS: Main: 138850304 22:13:28 INFO - 2015-11-24 22:13:28,849 DEBUG : BROWSER_OUTPUT: 22:13:50 INFO - 2015-11-24 22:13:50,305 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41114/tests/v8_7/run.html (next: http://localhost:41114/tests/v8_7/run.html) 22:13:50 INFO - 2015-11-24 22:13:50,551 DEBUG : BROWSER_OUTPUT: RSS: Main: 460521472 22:13:50 INFO - 2015-11-24 22:13:50,551 DEBUG : BROWSER_OUTPUT: 22:13:50 INFO - 2015-11-24 22:13:50,552 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:13:50 INFO - 2015-11-24 22:13:50,552 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:13:50 INFO - 2015-11-24 22:13:50,552 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:13:50 INFO - 2015-11-24 22:13:50,553 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:13:50 INFO - 2015-11-24 22:13:50,553 DEBUG : BROWSER_OUTPUT: |0;Richards;164.6090534979424 22:13:50 INFO - 2015-11-24 22:13:50,553 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.63207722294413 22:13:50 INFO - 2015-11-24 22:13:50,553 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.623542476402 22:13:50 INFO - 2015-11-24 22:13:50,553 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5117.34693877551 22:13:50 INFO - 2015-11-24 22:13:50,553 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1976.2845849802372 22:13:50 INFO - 2015-11-24 22:13:50,554 DEBUG : BROWSER_OUTPUT: |5;Earley;790.5138339920949 22:13:50 INFO - 2015-11-24 22:13:50,554 DEBUG : BROWSER_OUTPUT: |6;Boyer;12358.024691358025 22:13:50 INFO - 2015-11-24 22:13:50,554 DEBUG : BROWSER_OUTPUT: |7;RegExp;26179.48717948718 22:13:50 INFO - 2015-11-24 22:13:50,554 DEBUG : BROWSER_OUTPUT: |8;Splay;629.9559471365639 22:13:50 INFO - 2015-11-24 22:13:50,554 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4854.368932038835 22:13:50 INFO - 2015-11-24 22:13:50,554 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:13:50 INFO - 2015-11-24 22:13:50,554 DEBUG : BROWSER_OUTPUT: __startTimestamp1448432030551__endTimestamp 22:13:50 INFO - 2015-11-24 22:13:50,555 DEBUG : BROWSER_OUTPUT: 22:13:50 INFO - 2015-11-24 22:13:50,555 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:13:50 INFO - 2015-11-24 22:13:50,555 DEBUG : BROWSER_OUTPUT: Number of tests: 10 22:13:50 INFO - 2015-11-24 22:13:50,555 DEBUG : BROWSER_OUTPUT: 22:13:50 INFO - 2015-11-24 22:13:50,555 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.61 Median:164.61 stddev:0.00 (0.0%) 22:13:50 INFO - 2015-11-24 22:13:50,556 DEBUG : BROWSER_OUTPUT: Values: 164.6 22:13:50 INFO - 2015-11-24 22:13:50,556 DEBUG : BROWSER_OUTPUT: 22:13:50 INFO - 2015-11-24 22:13:50,556 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.63 Median:185.63 stddev:0.00 (0.0%) 22:13:50 INFO - 2015-11-24 22:13:50,556 DEBUG : BROWSER_OUTPUT: Values: 185.6 22:13:50 INFO - 2015-11-24 22:13:50,556 DEBUG : BROWSER_OUTPUT: 22:13:50 INFO - 2015-11-24 22:13:50,557 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.62 Median:277.62 stddev:0.00 (0.0%) 22:13:50 INFO - 2015-11-24 22:13:50,558 DEBUG : BROWSER_OUTPUT: Values: 277.6 22:13:50 INFO - 2015-11-24 22:13:50,558 DEBUG : BROWSER_OUTPUT: 22:13:50 INFO - 2015-11-24 22:13:50,558 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5117.35 Median:5117.35 stddev:0.00 (0.0%) 22:13:50 INFO - 2015-11-24 22:13:50,558 DEBUG : BROWSER_OUTPUT: Values: 5117.3 22:13:50 INFO - 2015-11-24 22:13:50,558 DEBUG : BROWSER_OUTPUT: 22:13:50 INFO - 2015-11-24 22:13:50,558 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1976.28 Median:1976.28 stddev:0.00 (0.0%) 22:13:50 INFO - 2015-11-24 22:13:50,558 DEBUG : BROWSER_OUTPUT: Values: 1976.3 22:13:50 INFO - 2015-11-24 22:13:50,559 DEBUG : BROWSER_OUTPUT: 22:13:50 INFO - 2015-11-24 22:13:50,559 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:790.51 Median:790.51 stddev:0.00 (0.0%) 22:13:50 INFO - 2015-11-24 22:13:50,559 DEBUG : BROWSER_OUTPUT: Values: 790.5 22:13:50 INFO - 2015-11-24 22:13:50,559 DEBUG : BROWSER_OUTPUT: 22:13:50 INFO - 2015-11-24 22:13:50,559 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12358.02 Median:12358.02 stddev:0.00 (0.0%) 22:13:50 INFO - 2015-11-24 22:13:50,559 DEBUG : BROWSER_OUTPUT: Values: 12358.0 22:13:50 INFO - 2015-11-24 22:13:50,559 DEBUG : BROWSER_OUTPUT: 22:13:50 INFO - 2015-11-24 22:13:50,560 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26179.49 Median:26179.49 stddev:0.00 (0.0%) 22:13:50 INFO - 2015-11-24 22:13:50,560 DEBUG : BROWSER_OUTPUT: Values: 26179.5 22:13:50 INFO - 2015-11-24 22:13:50,560 DEBUG : BROWSER_OUTPUT: 22:13:50 INFO - 2015-11-24 22:13:50,560 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:629.96 Median:629.96 stddev:0.00 (0.0%) 22:13:50 INFO - 2015-11-24 22:13:50,560 DEBUG : BROWSER_OUTPUT: Values: 630.0 22:13:50 INFO - 2015-11-24 22:13:50,560 DEBUG : BROWSER_OUTPUT: 22:13:50 INFO - 2015-11-24 22:13:50,560 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 22:13:50 INFO - 2015-11-24 22:13:50,560 DEBUG : BROWSER_OUTPUT: Values: 4854.4 22:13:50 INFO - 2015-11-24 22:13:50,561 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:13:50 INFO - 2015-11-24 22:13:50,561 DEBUG : BROWSER_OUTPUT: 22:13:51 INFO - 2015-11-24 22:13:51,492 INFO : Browser exited with error code: 0 22:13:51 INFO - 2015-11-24 22:13:51,504 INFO : Completed test v8_7 (00:00:39) 22:13:51 INFO - 2015-11-24 22:13:51,513 INFO : Completed test suite (00:20:17) 22:13:51 INFO - 2015-11-24 22:13:51,513 DEBUG : Working with test: dromaeo_css 22:13:51 INFO - 2015-11-24 22:13:51,513 DEBUG : Generating results file: dromaeo_css 22:13:51 INFO - 2015-11-24 22:13:51,514 DEBUG : Working with test: kraken 22:13:51 INFO - 2015-11-24 22:13:51,514 DEBUG : Generating results file: kraken 22:13:51 INFO - 2015-11-24 22:13:51,515 INFO : javascript benchmark 22:13:51 INFO - 2015-11-24 22:13:51,515 DEBUG : Working with test: v8_7 22:13:51 INFO - 2015-11-24 22:13:51,515 DEBUG : Generating results file: v8_7 22:13:51 INFO - 2015-11-24 22:13:51,515 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:13:51 INFO - 2015-11-24 22:13:51,565 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 22:13:51 INFO - 2015-11-24 22:13:51,566 DEBUG : process_Request line: dromaeo_css 6100.02 graph.html#tests=[[72,132,35]] 22:13:51 INFO - 2015-11-24 22:13:51,566 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:13:51 INFO - 2015-11-24 22:13:51,596 DEBUG : process_Request line: kraken 1528.00 graph.html#tests=[[232,132,35]] 22:13:51 INFO - 2015-11-24 22:13:51,596 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:13:51 INFO - 2015-11-24 22:13:51,628 DEBUG : process_Request line: v8_7 19803.37 graph.html#tests=[[230,132,35]] 22:13:51 INFO - 2015-11-24 22:13:51,633 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2582.780463660589, 2698.17705599792, 2706.215197592698, 2710.5121078205925, 2727.3999720061584, 4462.12988467249, 4552.590266875981, 4619.099275641252, 4621.6533759968015, 4676.953230467699, 4502.797374118164, 4520.977395113028, 4525.2080885844925, 4640.211164102102, 4641.7214967102, 4276.379924910886, 4284.635805956497, 4291.485021797389, 4305.590968857953, 4325.610695037446, 4046.979765101185, 4331.45856767904, 4367.934480982788, 4373.497047839507, 4381.890452738675, 4164.104717485755, 4200.579942005806, 4233.767142807144, 4264.850730224458, 4267.445232119804, 4220.986963128827, 4221.050263690645, 4271.039016221325, 4278.866100483375, 4314.072474417983, 4090.3455447128317, 4199.958000419987, 4241.34259189826, 4268.317069268902, 4305.397244385788, 4407.60331570157, 4413.161499315152, 4445.777711114463, 4471.23988921884, 4503.887402814923, 4887.853364399074, 4918.754062296871, 4919.655624106314, 4935.605151587864, 4944.283078953567, 4702.6002789762915, 4827.710337379768, 4947.802087916479, 4961.776720047606, 4992.400911890596, 4496.4829044659955, 4534.841280555164, 4568.200564901129, 4585.908281834345, 4620.376249206314, 5003.4746351633285, 5010.924836127461, 5023.2214006829, 5042.268871013683, 5046.6719663221775, 4614.561616646413, 4722.456917454468, 4809.639277054165, 4814.5907597854575, 4836.3712717347225, 4805.447373552016, 4806.8798280043275, 4848.7090774553635, 4871.0, 4917.803287868517, 4806.062817750505, 4806.399200099988, 4810.831620893252, 4842.394700662418, 4850.587700045465, 4679.0, 4791.880202994883, 4805.447373552016, 4812.0, 4851.636127290467, 3935.822887969991, 3980.9402858957137, 4012.1574469361763, 4019.0354314964197, 4033.9596604033586, 3571.6428357164596, 3575.7318201135017, 3584.946225806615, 3613.584437789635, 3614.2590768892314, 4083.4487344208746, 4228.534861165269, 4234.830606775695, 4242.215190189825, 4279.101388708406, 4748.928766068511, 4814.6870453420415, 4858.222684370484, 4861.7326047067045, 4899.461059283476, 4198.181354635817, 4198.328267477189, 4204.894877628084, 4205.894852628648, 4225.429567008476, 4120.7733574653685, 4321.049369138785, 4327.112941846914, 4353.238183317907, 4354.847580334673, 4576.542345765397, 4605.631549476034, 4614.031053478807, 4655.162070827284, 4688.0, 4899.559039686445, 4957.206846904478, 4958.305837182726, 4966.329545511309, 4998.6500944933505, 4693.483716791218, 4702.835400760957, 4703.529647035269, 4714.764261786965, 4749.4063242094735, 4620.168369693488, 4693.530646935279, 4726.692764970266, 4728.668993170582, 4798.47216806144, 4946.08497427977, 4949.232868905326, 4952.306677065286, 4956.182229932021, 4963.950360496493, 4788.712677239377, 4791.880202994953, 4794.808207671654, 4831.0096430232425, 4836.588889944253, 4600.608948239437, 4628.745419001987, 4696.459907110726, 4717.693349932243, 4788.640851936049, 4646.6979646324235, 4691.272852707836, 4696.812127514998, 4704.364910737144, 4707.388039554836, 4828.830990915301, 4830.0, 4835.8065677372515, 4857.125717370907, 4875.3174555562955, 4524.479684836154, 4644.907101857876, 4660.161170989254, 4694.201985662377, 4765.023170250021], "unit": "ms", "name": "dojo.html", "value": 4487.614283366076}, {"lowerIsBetter": false, "replicates": [558.8348293807411, 564.5032371513068, 573.6070791507815, 578.8842231553689, 587.0372588954116, 26820.195394138183, 27190.86404567977, 36448.81775591119, 37069.629303706955, 37211.813940930326, 40868.0, 40934.59065409345, 41237.0, 41361.58638413615, 41364.172716545654, 6927.896081558755, 7959.801004974864, 8091.150429204937, 8131.959340203291, 8147.918520814805, 7058.294170582926, 7163.4627402944725, 7163.89254161188, 7164.355208031277, 10153.086222239997, 10225.846612300822, 10343.534540945675, 10346.0, 10348.586056557766, 10357.689269321932, 10100.343477673965, 10212.387256764581, 10213.387196768217, 10217.540210690462, 10226.181905447545, 7099.964500177518, 7310.926890731078, 10021.59913603455, 10136.290459667825, 10480.371177729285, 37556.0, 38066.23867522662, 38074.0, 38091.4286285706, 38152.23695526074, 2834.107256214286, 2848.87294066335, 2901.3181902252954, 2962.7777916656123, 3531.7527773055895, 28036.43927121446, 28332.575011374847, 28349.85825070882, 28496.070994769754, 29027.85486072556, 3014.9095527134223, 3057.296821730992, 3059.602251707264, 3155.7159855613104, 3516.40221162403, 225321.87339063364, 227261.0, 227443.0, 227615.0, 227877.0, 45188.418405356315, 48442.5155748445, 56563.0, 57139.0, 61001.69499152476, 57416.0, 57459.0, 57699.71150144222, 57704.0, 57713.71143144257, 13520.661983450296, 13719.176849389069, 13726.45094196221, 13737.381817818223, 13746.450141994408, 10118.342307749972, 10159.796804064024, 10212.387256764618, 10222.795544089076, 10248.180145588334, 19110.80889191118, 19271.51821204481, 19356.225750969803, 19357.870634230225, 19373.128209230337, 7425.331720145213, 7695.730649427243, 7797.92202077972, 7813.0, 7831.530108193413, 840.684743221292, 857.3741168946704, 876.9210771030511, 1016.8325665551753, 1029.3875144289286, 26227.688615569146, 26238.606420903703, 26317.47365052688, 26390.47219055608, 26414.471710566064, 937.3532262738688, 940.7459985803931, 962.0667952086465, 977.9853302200472, 1088.553692985888, 15201.467948621967, 15390.769138462932, 16165.676686466204, 16253.268602912898, 16299.0, 316534.0, 319704.0, 321143.0, 321491.0, 322681.0, 49326.75336623366, 49737.0, 49771.50228497669, 49873.50126498761, 49935.75032124889, 1144.2905398652722, 1208.6434501821984, 1211.3398197982121, 1212.042486435706, 1228.1280290993495, 26507.0, 27185.0, 27445.0, 27710.307242318297, 27784.444311114068, 38213.4267985986, 38996.73544071514, 39203.41194882136, 39241.0, 39346.60653393544, 216026.0, 219330.0, 231749.0, 237128.0, 237484.0, 27024.0, 27077.59383609208, 27119.72880271251, 27128.32179195536, 27134.050308239115, 35010.29979400449, 44207.77896110499, 45356.54643453523, 45742.542574573825, 46326.76836615795, 33010.33979320352, 33624.663753362154, 34043.82978085094, 34204.14489637779, 34489.65510344865, 33936.490952635235, 34020.829895850366, 34379.484307735904, 34400.82799585986, 34442.2446204298, 33860.3227935435, 34687.82656086703, 34705.479417809256, 34716.0, 34776.47835282524, 28205.43589128247, 30195.698043020166, 30779.84610076935, 30825.845870770503, 30942.0, 29565.85217073987, 32244.19389515281, 32256.35487290288, 32289.51565726469, 32629.836850815595], "unit": "ms", "name": "ext.html", "value": 17478.556946961704}, {"lowerIsBetter": false, "replicates": [327.4760383386583, 329.5468730495568, 330.58841742031166, 337.35060009481725, 341.2066944354375, 12291.44688489018, 12514.624561263177, 14850.851491485082, 15291.158986255752, 15579.766303505456, 9719.708408747749, 9816.705498835028, 10012.949935250314, 10016.499175041237, 10059.49702514875, 4494.280915053592, 4620.653450991173, 4631.0, 4632.86101416958, 4633.536646335357, 3274.1978215337276, 3989.940150897739, 4520.412346394981, 5238.68567885928, 5264.526192642661, 5171.948280517185, 5203.219517072451, 5214.556762675177, 5237.45006774289, 5254.894902101955, 5196.116660167761, 5361.731913404334, 5763.5101016413655, 5777.797777077803, 5818.592698511064, 5160.8967820643375, 5161.7161056141895, 5164.509371609691, 5172.043172013152, 5174.404943431516, 17771.733423998652, 17824.91087544567, 18088.82422642524, 18153.636927261512, 18533.629327413375, 1668.0658831054648, 1727.7322015087682, 1762.1805860274906, 1797.3080364059801, 1805.077399380805, 9221.492817895012, 9782.657606983792, 10730.892691073146, 12057.0, 12558.74882502345, 1772.5745821002865, 1778.2086971297779, 1814.7550080739063, 1821.2805941653105, 1863.6924907390264, 50211.0, 51701.08630774751, 53317.46682533164, 53417.465825341635, 53661.731691341294, 9577.808443831085, 9711.174550163316, 9823.705288841345, 9916.603335866628, 9998.200143988464, 12552.81170782439, 12556.434960426803, 12559.995200383948, 12560.0, 12574.68563285907, 6838.709032474177, 6896.27589103147, 6931.722731090801, 6975.3024697529845, 7072.611006394698, 6428.19647544057, 6433.774817881352, 6438.3883531064475, 6498.220213574401, 6505.60966342021, 4126.298529250034, 4174.165166966619, 4199.0, 4215.346621273708, 4220.155968806251, 1576.393088660851, 1644.2981514132814, 1645.0705351476377, 1718.2353852535502, 1751.7459968304524, 372.80986696784834, 379.391077320896, 384.45407521319794, 392.38983380842495, 748.3825843678878, 9307.488088155082, 9661.372010819416, 15505.457308994357, 16112.355505779638, 16437.671246575002, 410.6182695230528, 411.34595992371675, 413.65873154647534, 417.2781088716537, 421.8755467137141, 4806.279058141236, 5004.07424626438, 5554.08357620988, 5562.554995600423, 5585.273914391184, 453233.0, 456898.0, 457059.0, 457740.0, 473887.0, 47553.76223118862, 59015.11477327844, 59049.0, 60508.69745651243, 60919.69540152271, 443.4678385936824, 453.7935239466035, 453.85930361588015, 454.3820404250217, 454.84307913770357, 8923.15230053144, 9168.35821492489, 9249.398789078688, 9402.576884040098, 9451.196648284698, 29086.7091329084, 31583.684163158076, 31834.522482162323, 31889.36221275515, 32290.0, 37808.0, 39328.2134357317, 39844.0, 40121.39817902676, 40274.59725402708, 8844.115588441104, 8900.198982091642, 9105.634154876821, 9195.678151264674, 9209.493477858781, 10724.088452481627, 10838.566457341618, 14980.1760903147, 15286.847131528988, 15699.293531791325, 13051.608451746462, 13248.271345076113, 13466.192028478323, 13587.45650173982, 13597.660058498617, 13072.738545228853, 13154.605361838778, 13305.933470332586, 13313.134646247963, 13319.334033298102, 13161.210327380388, 13433.26117063571, 13543.59369218925, 13621.863781362059, 13905.652358691113, 9108.362414631178, 9135.132162444557, 9305.0, 9319.906800931903, 9365.85951210746, 9536.666216682383, 10161.745956351151, 13832.031757777262, 14135.0, 14153.0], "unit": "ms", "name": "jquery.html", "value": 7286.83991834949}, {"lowerIsBetter": false, "replicates": [1225.8844451549091, 1614.3058484851513, 1647.8928869623473, 1675.3298680527796, 1693.4750227429497, 5956.910646340309, 6542.934570654292, 6953.826154346131, 6973.6513174341335, 6977.686004129813, 6770.255271920085, 6862.931370686291, 6903.309669033094, 6905.447564194865, 6909.516333856632, 1741.6168442942533, 1773.6718707039174, 1775.112443778111, 2037.6026674798384, 2085.635013872574, 1786.6337400832863, 1792.6952418088956, 2006.2877678424168, 2050.261905713949, 2052.9281475148373, 2031.7460317460318, 2031.7968203179637, 2043.3257025181729, 2044.090379780998, 2044.6524090904581, 1949.385943427823, 2014.405750303664, 2018.6467368210651, 2024.4938765308673, 2024.503996520847, 2065.06039751914, 2069.4722845674255, 2091.1948899673584, 2121.565079158784, 2121.862078964862, 6834.350736680008, 6904.896426553606, 6915.101036865226, 6921.065656136408, 6925.376716095576, 4122.896927576805, 4203.516595591515, 4219.43037689914, 4223.936640950388, 4227.0, 2696.5011472877386, 2729.072115480746, 2775.777937764974, 2819.5629677400034, 2826.0, 878.3193025405362, 899.7300809757112, 918.4902379179553, 926.0507979321183, 930.9953450232773, 9226.308026897943, 9242.722718318393, 9262.212711919496, 9262.259019278441, 9271.072892710743, 3784.3188226119564, 3834.3673293906195, 3889.0666240102173, 3899.259140763246, 3930.7051971102283, 8029.277365037175, 8037.477563958441, 8089.595520224083, 8117.472364296302, 8118.3099436548555, 4253.893652658709, 4262.339337402707, 4264.530901600821, 4267.679924005712, 4267.97866010668, 3826.5408151022057, 3858.5948475409677, 3859.1895701902354, 3861.864834730771, 3863.30460517104, 3332.7000569948823, 3378.273671160712, 3401.8603767738086, 3406.0463070340343, 3415.6584341565645, 922.6805667894974, 958.9808203835884, 1016.1007508355159, 1085.858838351025, 1087.994560027195, 802.2178376083272, 810.9189081091844, 813.495632707725, 814.470594113819, 899.5322432335149, 6406.295307516262, 6455.644939528371, 6462.967685161638, 6487.967560162263, 6502.284748677642, 1014.8325526288228, 1034.4414016431194, 1034.5034383495963, 1047.554789214596, 1055.567217440861, 4861.489543597942, 4948.505149485023, 4954.900901982012, 4960.131976904027, 4987.326710894055, 7913.485623434458, 8119.350451963829, 8216.589170541449, 8289.378296627778, 8369.3304535637, 8243.793905152299, 8295.211954864279, 8342.040665323444, 8366.916330836735, 8375.790605234795, 6534.901976470357, 6535.411812936859, 6584.11114499546, 6595.340465953366, 6596.175478065242, 6075.453209211192, 6175.84560385994, 6191.25704915413, 6202.751889924352, 6203.348648391854, 7399.963000184965, 7408.407327413686, 7451.92548074534, 7484.139323977813, 7524.661390237343, 7327.523710958771, 7606.581638009962, 7688.8077798053255, 7707.576083315472, 7711.0, 6098.146259523582, 6180.845478863064, 6184.381561843779, 6186.505079593711, 6186.907196392148, 6077.787277445268, 6162.845928851635, 6546.443552298108, 6585.835354115994, 6604.801855944329, 5325.254464374913, 5488.945110548843, 5586.636868603528, 5929.169916211647, 6056.757729690763, 5819.156222347651, 5864.765409383577, 5887.970560147171, 5953.702314884152, 5981.611195272293, 5863.912041319469, 5925.792597259076, 5939.554533409925, 5944.524438044859, 5947.9405205949115, 5715.485606295453, 5783.710814459344, 5784.2191304175085, 5789.160571716993, 5789.363170051207, 5679.346875109415, 5744.0, 5769.653820770767, 5799.217105690678, 5908.527317814479], "unit": "ms", "name": "mootools.html", "value": 3950.8378236177987}, {"lowerIsBetter": false, "replicates": [304.61009907318635, 312.49688002316265, 313.46397660001384, 315.1663849119079, 315.66854802457414, 5208.583313334929, 5257.342832145981, 5321.467853214676, 5322.121849894763, 5337.733113344327, 5208.192730126836, 5227.137522308814, 5232.189010703338, 5233.633645644806, 5237.47625237476, 3867.0719027433356, 3939.7439166454087, 4106.096658735073, 4111.239420707164, 4130.896727581804, 4017.0, 4115.753054816706, 4120.608542188487, 4143.979280103596, 4144.564820693829, 4080.8367665293354, 4088.6524645405175, 4095.4061661059127, 4097.364908439196, 4103.281925663012, 3853.3834586466173, 3972.245273398074, 3973.841046358142, 3990.4014397840265, 4102.282100632392, 3504.5268888700207, 3511.052015955703, 3564.1446052947367, 3634.691051260646, 3637.217998130415, 4998.0, 5010.924836127461, 5022.673526220784, 5026.447090820006, 5029.622778291606, 4688.156131896258, 4689.531046895318, 4694.694844835075, 4696.272077827942, 4698.036902435027, 5283.207518872162, 5452.154915988028, 5484.61607687462, 5490.6431081979545, 5491.450854914517, 3868.0909986153233, 3868.4777555030273, 3873.283442563135, 3875.670568001723, 3881.126746482047, 5712.828615141552, 5780.566457515703, 5782.132680097977, 5783.16144159103, 5787.623804452697, 3971.4439978403047, 3976.701747368959, 3981.303271927401, 3983.8008099595486, 3984.6613037891525, 3577.159367548624, 3764.5670747864347, 3831.50190475242, 4040.2727509048063, 4045.110075783323, 4414.337849322627, 4415.757133357632, 4485.0805584855025, 4555.817767289338, 4604.378408914754, 5351.705656188869, 5500.532454741312, 5521.089020311603, 5525.4474552544425, 5534.003879301765, 1407.5777266819914, 1431.2342896550504, 1431.992840035793, 1434.089353260687, 1434.6915413186216, 960.7213907966751, 964.8842138943372, 973.2700474644017, 990.2028866762325, 990.9900900991042, 4848.442429120626, 4857.077155340474, 4858.951410485921, 4861.1006963711825, 4862.0, 5700.486956173964, 5706.828795136153, 5709.115087161496, 5711.828645140652, 5714.0571805652435, 4836.0, 4836.202026665561, 4840.2255639098275, 4849.515048495122, 4851.490593487703, 2840.7585355244623, 2940.206144341016, 3020.2751339678757, 3038.255627371308, 3070.293832418556, 5388.245645609618, 5460.399356070829, 5487.98472282629, 5510.641808282448, 5512.6968016758665, 5869.735861886225, 5889.646621202742, 5894.852628684317, 5895.616784908967, 5895.823125306248, 5417.783288668488, 5432.75552600134, 5440.347158341025, 5444.700541470257, 5444.754986025559, 5555.30558680165, 5668.886622267614, 5731.885362292647, 5732.140178973187, 5733.369329373682, 5609.607327487037, 5617.241672374177, 5618.073017951992, 5625.071863142535, 5626.437356264504, 5430.212619170277, 5432.701201433959, 5434.864128396822, 5437.13005919051, 5440.836774896759, 3981.044549308203, 3982.044309365789, 3988.581198974066, 3988.74073185242, 3990.780507072023, 5549.250851135045, 5708.80019199326, 5715.542756579547, 5721.199032135588, 5721.771129154788, 5506.063969125338, 5507.7246137692155, 5515.917261241165, 5519.034169020486, 5521.1442226454965, 5502.0, 5504.4495550444635, 5509.393966663744, 5516.475934786189, 5516.586256030733, 5243.161094224905, 5393.325834270716, 5399.0, 5429.484199001088, 5441.211024401518, 5565.276514053147, 5570.805021824217, 5573.303337082864, 5573.944260557342, 5577.721113944205, 5210.062188806051, 5290.576753859605, 5343.145096784496, 5432.538234250133, 5443.891122177613], "unit": "ms", "name": "prototype.html", "value": 4144.18685332049}, {"lowerIsBetter": false, "replicates": [657.8322527755423, 734.5812886654608, 754.3512579181906, 758.3857075768624, 768.1089935674619, 11439.59961401351, 11668.766624667502, 11690.707732306697, 11691.824622630656, 11722.23805452646, 11303.773924521505, 11398.886011139886, 11431.02836258917, 11441.0, 11470.426478676054, 579.6377264209868, 585.0960266388419, 754.5057987018498, 762.0550517358463, 777.3547955197173, 755.0674916478146, 756.1908757629338, 761.6648674583166, 761.756238003839, 762.1083332500987, 803.6704950970103, 810.3881569415083, 810.6595230003384, 810.6878851642131, 811.0024669656326, 573.489594261108, 575.0741306496537, 783.2285199078902, 797.5095316380442, 799.3245707377257, 593.5518683394054, 593.6289818863211, 593.8010766393263, 593.9732712027926, 594.0673143165233, 11937.701557461132, 12149.0, 12186.634400967896, 12188.20776649515, 12188.20776649515, 11520.251183673117, 12105.273683578926, 12269.447874845653, 12296.877031229753, 12576.68558286041, 9166.495842728647, 9220.677276295364, 9264.351495395325, 9411.43531388119, 9467.621295148187, 3259.3970115528705, 3318.734501239895, 3337.5494308268317, 3345.3142105868237, 3414.146463384154, 41004.589954100375, 41346.0, 41370.172596548204, 41378.1724365514, 41474.79262603698, 8728.519931403707, 8889.155530224618, 9110.86333704995, 9177.219936305355, 9253.352265341497, 16329.918350408172, 16366.83633163653, 16367.91816040912, 16386.83613163877, 16396.09821459831, 6326.652034138075, 6358.841028974312, 6375.489960803217, 6437.742490300336, 6585.9012114818315, 3437.5359326491102, 3440.9483857742152, 3511.122219445139, 3524.1894364296354, 3524.806135662563, 2708.7155848636003, 2721.6597925259343, 2737.6167336572894, 2740.328619488238, 2741.068036867435, 489.86038978890844, 494.04402481198997, 503.90173916086746, 503.9496050394931, 537.4330081763777, 410.79665565545247, 467.85964210737325, 481.2012059980416, 529.5154933236046, 554.4400155842548, 7266.672999715025, 7892.723754668674, 8017.158198389202, 8089.595520223966, 8205.220504052106, 388.55122333704054, 488.76539261154846, 513.7636687123891, 522.9424763276037, 582.6620560075146, 3400.7619466637098, 3489.7557170998293, 3551.2897420515483, 3582.6417358263966, 3596.7482276240935, 53800.46199537955, 53950.73024634852, 54142.0, 54286.72856635691, 54752.726236368566, 46496.0, 46564.301535476996, 46694.53305466902, 46739.29891051637, 47165.0, 42095.36856947148, 43190.784046080196, 43285.78357108194, 43521.78239108784, 43686.344704829455, 7222.422206223385, 7261.673224704795, 7266.491345605757, 7341.229170937188, 7383.593902335208, 31168.0, 31425.52861707122, 31556.684433156293, 31590.52614210743, 32021.519677204393, 38030.429543557424, 38531.0, 41798.373024405264, 41955.58044419517, 42251.0, 8575.828483430421, 8607.741767746978, 8640.56797160152, 8775.648974040967, 8816.735497935073, 9473.24214062887, 9643.9035609643, 9847.507624618596, 9943.701688949342, 10049.0, 8948.328875334246, 9430.811383772423, 9440.055994400505, 9671.613135474503, 9717.0, 9170.358074934691, 9177.311701622271, 9232.353735238468, 9487.715368538955, 9507.809843802946, 8705.651773929225, 8745.256653184297, 8807.735767926972, 8942.642294308414, 9011.143941325563, 8107.635156417858, 8108.594570271581, 8281.751547453587, 8335.666573337, 8618.35362347839, 7714.884276735741, 8036.638351274323, 8125.959370203348, 8223.835523289381, 8225.876611850947], "unit": "ms", "name": "yui.html", "value": 5504.898121611231}], "name": "dromaeo_css"}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 112.0, 106.0, 112.0, 112.0, 113.0, 100.0, 112.0, 111.0, 104.0], "unit": "ms", "name": "ai-astar", "value": 109.4}, {"lowerIsBetter": true, "replicates": [156.0, 133.0, 157.0, 174.0, 139.0, 161.0, 155.0, 141.0, 177.0, 130.0], "unit": "ms", "name": "audio-beat-detection", "value": 152.3}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 162.0, 162.0, 161.0, 161.0, 165.0, 164.0, 162.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 162.4}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 84.0, 93.0, 72.0, 73.0, 72.0, 113.0, 92.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 81.8}, {"lowerIsBetter": true, "replicates": [96.0, 94.0, 131.0, 93.0, 95.0, 94.0, 145.0, 94.0, 94.0, 134.0], "unit": "ms", "name": "audio-oscillator", "value": 107.0}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 109.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 147.0, 148.0, 147.0, 148.0, 146.0, 147.0, 147.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.0}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 94.9}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 70.0, 71.0, 71.0, 71.0, 71.0, 83.0, 70.0, 69.0], "unit": "ms", "name": "json-parse-financial", "value": 71.7}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 71.0, 73.0, 73.0, 73.0, 71.0, 72.0, 72.0, 72.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 71.9}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 85.0, 84.0, 82.0, 85.0, 83.0, 84.0, 84.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.3}, {"lowerIsBetter": true, "replicates": [118.0, 126.0, 130.0, 118.0, 121.0, 127.0, 134.0, 122.0, 129.0, 120.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.5}, {"lowerIsBetter": true, "replicates": [135.0, 148.0, 146.0, 147.0, 136.0, 146.0, 148.0, 140.0, 149.0, 137.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 143.2}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 72.0, 68.0, 67.0, 69.0, 69.0, 68.0, 67.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.0}], "name": "kraken"}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.6090534979424], "unit": "score", "name": "Richards", "value": 214.45965}, {"lowerIsBetter": false, "replicates": [185.63207722294413], "unit": "score", "name": "DeltaBlue", "value": 356.1776659999999}, {"lowerIsBetter": false, "replicates": [277.623542476402], "unit": "score", "name": "Encrypt", "value": 958.7839620000002}, {"lowerIsBetter": false, "replicates": [5117.34693877551], "unit": "score", "name": "Decrypt", "value": 52.01542971086741}, {"lowerIsBetter": false, "replicates": [1976.2845849802372], "unit": "score", "name": "RayTrace", "value": 374.434434}, {"lowerIsBetter": false, "replicates": [790.5138339920949], "unit": "score", "name": "Earley", "value": 843.0756950000003}, {"lowerIsBetter": false, "replicates": [12358.024691358025], "unit": "score", "name": "Boyer", "value": 53.929573426573455}, {"lowerIsBetter": false, "replicates": [26179.48717948718], "unit": "score", "name": "RegExp", "value": 34.79766405484819}, {"lowerIsBetter": false, "replicates": [629.9559471365639], "unit": "score", "name": "Splay", "value": 129.35983916083913}, {"lowerIsBetter": false, "replicates": [4854.368932038835], "unit": "score", "name": "NavierStokes", "value": 305.7040000000001}], "name": "v8_7"}]} 22:13:51 INFO - RETURN: dromaeo_css: 6100.02 22:13:51 INFO - RETURN: kraken: 1528.00 22:13:51 INFO - RETURN: v8_7: 19803.37 22:13:51 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19803.37"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1528.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6100.02"}}} 22:13:51 INFO - Return code: 0 22:13:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:13:51 INFO - # TBPL SUCCESS # 22:13:51 INFO - Running post-action listener: _resource_record_post_action 22:13:51 INFO - Running post-run listener: _resource_record_post_run 22:13:52 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 4096; Write bytes: 514445312; Read time: 16; Write time: 541380 22:13:52 INFO - install - Wall time: 15s; CPU: 16.0%; Read bytes: 0; Write bytes: 238206976; Read time: 0; Write time: 355468 22:13:52 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 4096; Write bytes: 276238336; Read time: 16; Write time: 185912 22:13:52 INFO - Running post-run listener: _upload_blobber_files 22:13:52 INFO - Blob upload gear active. 22:13:52 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 22:13:52 INFO - Copying logs to upload dir... 22:13:52 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1263.561164 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2015-11-24 22:13:52.274403) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 22:13:52.279538) ========= 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=a65b340e283ce644d68cb24e000001c9-1448428203.279784-1963275012 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/hT7zJH2ER-eDxKutAN0qaw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009996 build_url: 'https://queue.taskcluster.net/v1/task/hT7zJH2ER-eDxKutAN0qaw/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-24 22:13:52.333633) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 22:13:52.333989) ========= 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=a65b340e283ce644d68cb24e000001c9-1448428203.279784-1963275012 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004495 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 22:13:52.386658) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 22:13:52.387456) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 22:13:52.387800) ========= ========= Total master_lag: 0.45 =========