builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-059 starttime: 1448443473.32 results: success (0) buildid: 20151125004137 builduid: 7cf7bb3b84604eee8c5d2969e7318101 revision: 57dbf05c9f5bce0c726723f5403e61fd2ae88dee ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-25 01:24:33.318022) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-25 01:24:33.318663) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 01:24:33.319259) ========= 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=5752742a61d0f534093fa7a9000001cb-1448443233.377111-2008430280 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006525 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 01:24:33.360370) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 01:24:33.360698) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 01:24:33.404924) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 01:24:33.405379) ========= 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=5752742a61d0f534093fa7a9000001cb-1448443233.377111-2008430280 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004601 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 01:24:33.455537) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-25 01:24:33.456006) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-25 01:24:33.456478) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 01:24:33.456770) ========= 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=5752742a61d0f534093fa7a9000001cb-1448443233.377111-2008430280 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-25 01:24:34-- 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% 225M=0s 2015-11-25 01:24:34 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116838 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 01:24:33.587627) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 01:24:33.587964) ========= 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=5752742a61d0f534093fa7a9000001cb-1448443233.377111-2008430280 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021860 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 01:24:33.637184) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 01:24:33.637512) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 57dbf05c9f5bce0c726723f5403e61fd2ae88dee --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 57dbf05c9f5bce0c726723f5403e61fd2ae88dee --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=5752742a61d0f534093fa7a9000001cb-1448443233.377111-2008430280 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-25 01:24:34,263 truncating revision to first 12 chars 2015-11-25 01:24:34,263 Setting DEBUG logging. 2015-11-25 01:24:34,263 attempt 1/10 2015-11-25 01:24:34,263 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/57dbf05c9f5b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-25 01:24:34,523 unpacking tar archive at: fx-team-57dbf05c9f5b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.544372 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 01:24:34.194755) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 01:24:34.195058) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 01:24:34.203547) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-25 01:24:34.203832) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-25 01:24:34.204259) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-11-25 01:24:34.204566) ========= /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=5752742a61d0f534093fa7a9000001cb-1448443233.377111-2008430280 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:24:34 INFO - MultiFileLogger online at 20151125 01:24:34 in /builds/slave/test 01:24:34 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 01:24:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:24:34 INFO - {'append_to_log': False, 01:24:34 INFO - 'base_work_dir': '/builds/slave/test', 01:24:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 01:24:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:24:34 INFO - 'branch': 'Fx-Team-Non-PGO', 01:24:34 INFO - 'buildbot_json_path': 'buildprops.json', 01:24:34 INFO - 'config_files': ('talos/linux_config.py',), 01:24:34 INFO - 'default_actions': ('clobber', 01:24:34 INFO - 'read-buildbot-config', 01:24:34 INFO - 'download-and-extract', 01:24:34 INFO - 'populate-webroot', 01:24:34 INFO - 'create-virtualenv', 01:24:34 INFO - 'install', 01:24:34 INFO - 'run-tests'), 01:24:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:24:34 INFO - 'download_minidump_stackwalk': True, 01:24:34 INFO - 'download_symbols': 'ondemand', 01:24:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:24:34 INFO - 'tooltool.py': '/tools/tooltool.py', 01:24:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:24:34 INFO - '/tools/misc-python/virtualenv.py')}, 01:24:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:24:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:24:34 INFO - 'installer_path': 'installer.exe', 01:24:34 INFO - 'log_level': 'info', 01:24:34 INFO - 'log_name': 'talos', 01:24:34 INFO - 'log_to_console': True, 01:24:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:24:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:24:34 INFO - 'opt_config_files': (), 01:24:34 INFO - 'pip_index': False, 01:24:34 INFO - 'sps_profile': False, 01:24:34 INFO - 'sps_profile_interval': 0, 01:24:34 INFO - 'suite': 'dromaeojs', 01:24:34 INFO - 'system_bits': '64', 01:24:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:24:34 INFO - 'title': 'talos-linux64-ix-059', 01:24:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:24:34 INFO - 'use_talos_json': True, 01:24:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:24:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:24:34 INFO - 'work_dir': 'build'} 01:24:34 INFO - ##### 01:24:34 INFO - ##### Running clobber step. 01:24:34 INFO - ##### 01:24:34 INFO - Running pre-action listener: _resource_record_pre_action 01:24:34 INFO - Running main action method: clobber 01:24:34 INFO - rmtree: /builds/slave/test/build 01:24:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:24:35 INFO - Running post-action listener: _resource_record_post_action 01:24:35 INFO - ##### 01:24:35 INFO - ##### Running read-buildbot-config step. 01:24:35 INFO - ##### 01:24:35 INFO - Running pre-action listener: _resource_record_pre_action 01:24:35 INFO - Running main action method: read_buildbot_config 01:24:35 INFO - Using buildbot properties: 01:24:35 INFO - { 01:24:35 INFO - "properties": { 01:24:35 INFO - "buildnumber": 923, 01:24:35 INFO - "product": "firefox", 01:24:35 INFO - "script_repo_revision": "production", 01:24:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 01:24:35 INFO - "repository": "", 01:24:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 01:24:35 INFO - "buildid": "20151125004137", 01:24:35 INFO - "slavename": "talos-linux64-ix-059", 01:24:35 INFO - "pgo_build": "False", 01:24:35 INFO - "basedir": "/builds/slave/test", 01:24:35 INFO - "project": "", 01:24:35 INFO - "platform": "ubuntu64_hw", 01:24:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:24:35 INFO - "slavebuilddir": "test", 01:24:35 INFO - "scheduler": "tests-fx-team-linux64-talos", 01:24:35 INFO - "branch": "fx-team", 01:24:35 INFO - "repo_path": "integration/fx-team", 01:24:35 INFO - "stage_platform": "linux64", 01:24:35 INFO - "builduid": "7cf7bb3b84604eee8c5d2969e7318101", 01:24:35 INFO - "revision": "57dbf05c9f5bce0c726723f5403e61fd2ae88dee" 01:24:35 INFO - }, 01:24:35 INFO - "sourcestamp": { 01:24:35 INFO - "repository": "", 01:24:35 INFO - "hasPatch": false, 01:24:35 INFO - "project": "", 01:24:35 INFO - "branch": "fx-team-linux64-talos", 01:24:35 INFO - "changes": [ 01:24:35 INFO - { 01:24:35 INFO - "category": null, 01:24:35 INFO - "files": [ 01:24:35 INFO - { 01:24:35 INFO - "url": null, 01:24:35 INFO - "name": "https://queue.taskcluster.net/v1/task/Tg0zBMa9RVSrk7I6sI53eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 01:24:35 INFO - } 01:24:35 INFO - ], 01:24:35 INFO - "repository": "", 01:24:35 INFO - "rev": "57dbf05c9f5bce0c726723f5403e61fd2ae88dee", 01:24:35 INFO - "who": "cbook@mozilla.com", 01:24:35 INFO - "when": 1448443431, 01:24:35 INFO - "number": 6704718, 01:24:35 INFO - "comments": "Bug 951714 - DevTools Themes: Update network panel table headers to match new theme. r=vporof", 01:24:35 INFO - "project": "", 01:24:35 INFO - "at": "Wed 25 Nov 2015 01:23:51", 01:24:35 INFO - "branch": "fx-team-linux64-talos", 01:24:35 INFO - "revlink": "", 01:24:35 INFO - "properties": [ 01:24:35 INFO - [ 01:24:35 INFO - "buildid", 01:24:35 INFO - "20151125004137", 01:24:35 INFO - "Change" 01:24:35 INFO - ], 01:24:35 INFO - [ 01:24:35 INFO - "builduid", 01:24:35 INFO - "7cf7bb3b84604eee8c5d2969e7318101", 01:24:35 INFO - "Change" 01:24:35 INFO - ], 01:24:35 INFO - [ 01:24:35 INFO - "pgo_build", 01:24:35 INFO - "False", 01:24:35 INFO - "Change" 01:24:35 INFO - ] 01:24:35 INFO - ], 01:24:35 INFO - "revision": "57dbf05c9f5bce0c726723f5403e61fd2ae88dee" 01:24:35 INFO - } 01:24:35 INFO - ], 01:24:35 INFO - "revision": "57dbf05c9f5bce0c726723f5403e61fd2ae88dee" 01:24:35 INFO - } 01:24:35 INFO - } 01:24:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/Tg0zBMa9RVSrk7I6sI53eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 01:24:35 INFO - Running post-action listener: _resource_record_post_action 01:24:35 INFO - ##### 01:24:35 INFO - ##### Running download-and-extract step. 01:24:35 INFO - ##### 01:24:35 INFO - Running pre-action listener: _resource_record_pre_action 01:24:35 INFO - Running main action method: download_and_extract 01:24:35 INFO - mkdir: /builds/slave/test/build/tests 01:24:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:35 INFO - https://queue.taskcluster.net/v1/task/Tg0zBMa9RVSrk7I6sI53eQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:24:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tg0zBMa9RVSrk7I6sI53eQ/artifacts/public/build/test_packages.json 01:24:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tg0zBMa9RVSrk7I6sI53eQ/artifacts/public/build/test_packages.json 01:24:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tg0zBMa9RVSrk7I6sI53eQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 01:24:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tg0zBMa9RVSrk7I6sI53eQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 01:24:40 INFO - Downloaded 1302 bytes. 01:24:40 INFO - Reading from file /builds/slave/test/build/test_packages.json 01:24:40 INFO - Using the following test package requirements: 01:24:40 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 01:24:40 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:24:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:24:40 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:24:40 INFO - u'jsshell-linux-x86_64.zip'], 01:24:40 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:24:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:24:40 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 01:24:40 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:24:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:24:40 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:24:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:24:40 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:24:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:24:40 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 01:24:40 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:24:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:24:40 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:24:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:40 INFO - https://queue.taskcluster.net/v1/task/Tg0zBMa9RVSrk7I6sI53eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:24:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tg0zBMa9RVSrk7I6sI53eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:24:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tg0zBMa9RVSrk7I6sI53eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:24:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tg0zBMa9RVSrk7I6sI53eQ/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 01:24:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tg0zBMa9RVSrk7I6sI53eQ/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 01:24:46 INFO - Downloaded 21346027 bytes. 01:24:46 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 01:24:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:24:46 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 01:24:47 INFO - Return code: 0 01:24:47 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 01:24:47 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')]} 01:24:47 INFO - https://queue.taskcluster.net/v1/task/Tg0zBMa9RVSrk7I6sI53eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:24:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tg0zBMa9RVSrk7I6sI53eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:24:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tg0zBMa9RVSrk7I6sI53eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:24:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tg0zBMa9RVSrk7I6sI53eQ/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 01:24:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tg0zBMa9RVSrk7I6sI53eQ/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 01:24:52 INFO - Downloaded 21346027 bytes. 01:24:52 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 01:24:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:24:52 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 01:24:53 INFO - Return code: 0 01:24:53 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')]} 01:24:53 INFO - https://queue.taskcluster.net/v1/task/Tg0zBMa9RVSrk7I6sI53eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:24:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tg0zBMa9RVSrk7I6sI53eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 01:24:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tg0zBMa9RVSrk7I6sI53eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 01:24:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tg0zBMa9RVSrk7I6sI53eQ/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 01:24:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tg0zBMa9RVSrk7I6sI53eQ/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 01:24:54 INFO - Downloaded 11131717 bytes. 01:24:54 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 01:24:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 01:24:54 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 01:24:55 INFO - Return code: 0 01:24:55 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')]} 01:24:55 INFO - https://queue.taskcluster.net/v1/task/Tg0zBMa9RVSrk7I6sI53eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:24:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tg0zBMa9RVSrk7I6sI53eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:24:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tg0zBMa9RVSrk7I6sI53eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:24:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tg0zBMa9RVSrk7I6sI53eQ/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 01:24:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tg0zBMa9RVSrk7I6sI53eQ/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 01:24:56 INFO - Downloaded 56850769 bytes. 01:24:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Tg0zBMa9RVSrk7I6sI53eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:24:56 INFO - mkdir: /builds/slave/test/properties 01:24:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:24:56 INFO - Writing to file /builds/slave/test/properties/build_url 01:24:56 INFO - Contents: 01:24:56 INFO - build_url:https://queue.taskcluster.net/v1/task/Tg0zBMa9RVSrk7I6sI53eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:24:56 INFO - Running post-action listener: _resource_record_post_action 01:24:56 INFO - Running post-action listener: set_extra_try_arguments 01:24:56 INFO - ##### 01:24:56 INFO - ##### Running populate-webroot step. 01:24:56 INFO - ##### 01:24:56 INFO - Running pre-action listener: _resource_record_pre_action 01:24:56 INFO - Running main action method: populate_webroot 01:24:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:24:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:24:56 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 01:24:56 INFO - '../fennec_ids.txt'], 01:24:56 INFO - 'tests': ['tcheck2']}, 01:24:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:24:56 INFO - '--tppagecycles', 01:24:56 INFO - '7'], 01:24:56 INFO - 'tests': ['tsvgm']}}, 01:24:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:24:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:24:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:24:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:24:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:24:56 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:24:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:24:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:56 INFO - 'talos_options': ['--e10s'], 01:24:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:24:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:56 INFO - 'tests': ['damp', 'tps']}, 01:24:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:56 INFO - 'talos_options': ['--e10s'], 01:24:56 INFO - 'tests': ['damp', 'tps']}, 01:24:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:24:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:24:56 INFO - 'other': {'tests': ['a11yr', 01:24:56 INFO - 'ts_paint', 01:24:56 INFO - 'tpaint', 01:24:56 INFO - 'sessionrestore', 01:24:56 INFO - 'sessionrestore_no_auto_restore']}, 01:24:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:24:56 INFO - 'tests': ['a11yr', 01:24:56 INFO - 'ts_paint', 01:24:56 INFO - 'tpaint', 01:24:56 INFO - 'sessionrestore', 01:24:56 INFO - 'sessionrestore_no_auto_restore']}, 01:24:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:24:56 INFO - 'tests': ['a11yr', 01:24:56 INFO - 'ts_paint', 01:24:56 INFO - 'tpaint', 01:24:56 INFO - 'sessionrestore', 01:24:56 INFO - 'sessionrestore_no_auto_restore']}, 01:24:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:24:56 INFO - 'tests': ['a11yr', 01:24:56 INFO - 'ts_paint', 01:24:56 INFO - 'tpaint', 01:24:56 INFO - 'sessionrestore', 01:24:56 INFO - 'sessionrestore_no_auto_restore']}, 01:24:56 INFO - 'other_l64': {'tests': ['a11yr', 01:24:56 INFO - 'ts_paint', 01:24:56 INFO - 'tpaint', 01:24:56 INFO - 'sessionrestore', 01:24:56 INFO - 'sessionrestore_no_auto_restore']}, 01:24:56 INFO - 'other_nol64': {'tests': ['a11yr', 01:24:56 INFO - 'ts_paint', 01:24:56 INFO - 'tpaint', 01:24:56 INFO - 'sessionrestore', 01:24:56 INFO - 'sessionrestore_no_auto_restore']}, 01:24:56 INFO - 'svgr': {'tests': ['tsvgx', 01:24:56 INFO - 'tsvgr_opacity', 01:24:56 INFO - 'tart', 01:24:56 INFO - 'tscrollx', 01:24:56 INFO - 'cart']}, 01:24:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:24:56 INFO - 'tests': ['tsvgx', 01:24:56 INFO - 'tsvgr_opacity', 01:24:56 INFO - 'tart', 01:24:56 INFO - 'tscrollx', 01:24:56 INFO - 'cart']}, 01:24:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:56 INFO - 'tests': ['tp5o']}, 01:24:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:56 INFO - 'talos_options': ['--e10s'], 01:24:56 INFO - 'tests': ['tp5o']}, 01:24:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:56 INFO - 'talos_options': ['--xperf_path', 01:24:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:24:56 INFO - 'tests': ['tp5n']}, 01:24:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:56 INFO - 'talos_options': ['--e10s', 01:24:56 INFO - '--xperf_path', 01:24:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:24:56 INFO - 'tests': ['tp5n']}}, 01:24:56 INFO - 'talos.zip': {'path': '', 01:24:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:24:56 INFO - Running post-action listener: _resource_record_post_action 01:24:56 INFO - ##### 01:24:56 INFO - ##### Running create-virtualenv step. 01:24:56 INFO - ##### 01:24:56 INFO - Running pre-action listener: _resource_record_pre_action 01:24:56 INFO - Running main action method: create_virtualenv 01:24:56 INFO - Creating virtualenv /builds/slave/test/build/venv 01:24:56 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 01:24:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:24:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:24:56 INFO - Using real prefix '/usr' 01:24:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:24:57 INFO - Installing distribute.............................................................................................................................................................................................done. 01:24:59 INFO - Installing pip.................done. 01:24:59 INFO - Return code: 0 01:24:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:24:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xab4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce5210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd77220>, '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 0xce32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xce3740>, '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': '5752742a61d0f534093fa7a9000001cb-1448443233.377111-2008430280', '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 01:24:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:24:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:24:59 INFO - Using env: {'DISPLAY': ':0', 01:24:59 INFO - 'HOME': '/home/cltbld', 01:24:59 INFO - 'LANG': 'en_US.UTF-8', 01:24:59 INFO - 'LANGUAGE': 'en_US:en', 01:24:59 INFO - 'LOGNAME': 'cltbld', 01:24:59 INFO - 'MAIL': '/var/mail/cltbld', 01:24:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:59 INFO - 'MOZ_NO_REMOTE': '1', 01:24:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:59 INFO - 'NO_EM_RESTART': '1', 01:24:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:59 INFO - 'PWD': '/builds/slave/test', 01:24:59 INFO - 'SHELL': '/bin/bash', 01:24:59 INFO - 'SHLVL': '1', 01:24:59 INFO - 'TERM': 'linux', 01:24:59 INFO - 'TMOUT': '86400', 01:24:59 INFO - 'USER': 'cltbld', 01:24:59 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1448443233.377111-2008430280', 01:24:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:59 INFO - '_': '/tools/buildbot/bin/python'} 01:24:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:59 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 01:24:59 INFO - Cleaning up... 01:24:59 INFO - Return code: 0 01:24:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:24:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xab4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce5210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd77220>, '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 0xce32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xce3740>, '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': '5752742a61d0f534093fa7a9000001cb-1448443233.377111-2008430280', '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 01:24:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 01:24:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 01:24:59 INFO - Using env: {'DISPLAY': ':0', 01:24:59 INFO - 'HOME': '/home/cltbld', 01:24:59 INFO - 'LANG': 'en_US.UTF-8', 01:24:59 INFO - 'LANGUAGE': 'en_US:en', 01:24:59 INFO - 'LOGNAME': 'cltbld', 01:24:59 INFO - 'MAIL': '/var/mail/cltbld', 01:24:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:59 INFO - 'MOZ_NO_REMOTE': '1', 01:24:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:59 INFO - 'NO_EM_RESTART': '1', 01:24:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:59 INFO - 'PWD': '/builds/slave/test', 01:24:59 INFO - 'SHELL': '/bin/bash', 01:24:59 INFO - 'SHLVL': '1', 01:24:59 INFO - 'TERM': 'linux', 01:24:59 INFO - 'TMOUT': '86400', 01:24:59 INFO - 'USER': 'cltbld', 01:24:59 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1448443233.377111-2008430280', 01:24:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:59 INFO - '_': '/tools/buildbot/bin/python'} 01:24:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:59 INFO - Downloading/unpacking psutil>=0.7.1 01:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:01 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 01:25:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 01:25:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:25:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:25:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:25:01 INFO - Installing collected packages: psutil 01:25:01 INFO - Running setup.py install for psutil 01:25:01 INFO - building 'psutil._psutil_linux' extension 01:25:01 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 01:25:01 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 01:25:01 INFO - building 'psutil._psutil_posix' extension 01:25:01 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 01:25:01 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 01:25:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:25:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:25:02 INFO - Successfully installed psutil 01:25:02 INFO - Cleaning up... 01:25:02 INFO - Return code: 0 01:25:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:25: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')]} 01:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25: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')]} 01:25:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25: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', '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 0xab4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce5210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd77220>, '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 0xce32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xce3740>, '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': '5752742a61d0f534093fa7a9000001cb-1448443233.377111-2008430280', '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 01:25: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 01:25: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 mozsystemmonitor==0.0.0 01:25:02 INFO - Using env: {'DISPLAY': ':0', 01:25:02 INFO - 'HOME': '/home/cltbld', 01:25:02 INFO - 'LANG': 'en_US.UTF-8', 01:25:02 INFO - 'LANGUAGE': 'en_US:en', 01:25:02 INFO - 'LOGNAME': 'cltbld', 01:25:02 INFO - 'MAIL': '/var/mail/cltbld', 01:25:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:02 INFO - 'MOZ_NO_REMOTE': '1', 01:25:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:02 INFO - 'NO_EM_RESTART': '1', 01:25:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:02 INFO - 'PWD': '/builds/slave/test', 01:25:02 INFO - 'SHELL': '/bin/bash', 01:25:02 INFO - 'SHLVL': '1', 01:25:02 INFO - 'TERM': 'linux', 01:25:02 INFO - 'TMOUT': '86400', 01:25:02 INFO - 'USER': 'cltbld', 01:25:02 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1448443233.377111-2008430280', 01:25:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:02 INFO - '_': '/tools/buildbot/bin/python'} 01:25:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:25: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 01:25: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 01:25: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 01:25: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 01:25: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 01:25: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 01:25:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:25:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 01:25:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:25:04 INFO - Installing collected packages: mozsystemmonitor 01:25:04 INFO - Running setup.py install for mozsystemmonitor 01:25:04 INFO - Successfully installed mozsystemmonitor 01:25:04 INFO - Cleaning up... 01:25:04 INFO - Return code: 0 01:25:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:25: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')]} 01:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25: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')]} 01:25:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25: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', '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 0xab4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce5210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd77220>, '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 0xce32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xce3740>, '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': '5752742a61d0f534093fa7a9000001cb-1448443233.377111-2008430280', '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 01:25: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:25: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 blobuploader==1.2.4 01:25:04 INFO - Using env: {'DISPLAY': ':0', 01:25:04 INFO - 'HOME': '/home/cltbld', 01:25:04 INFO - 'LANG': 'en_US.UTF-8', 01:25:04 INFO - 'LANGUAGE': 'en_US:en', 01:25:04 INFO - 'LOGNAME': 'cltbld', 01:25:04 INFO - 'MAIL': '/var/mail/cltbld', 01:25:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:04 INFO - 'MOZ_NO_REMOTE': '1', 01:25:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:04 INFO - 'NO_EM_RESTART': '1', 01:25:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:04 INFO - 'PWD': '/builds/slave/test', 01:25:04 INFO - 'SHELL': '/bin/bash', 01:25:04 INFO - 'SHLVL': '1', 01:25:04 INFO - 'TERM': 'linux', 01:25:04 INFO - 'TMOUT': '86400', 01:25:04 INFO - 'USER': 'cltbld', 01:25:04 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1448443233.377111-2008430280', 01:25:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:04 INFO - '_': '/tools/buildbot/bin/python'} 01:25:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:04 INFO - Downloading/unpacking blobuploader==1.2.4 01:25: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 01:25: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 01:25: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 01:25: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 01:25: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 01:25: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 01:25:06 INFO - Downloading blobuploader-1.2.4.tar.gz 01:25:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 01:25:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:25:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:25: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 01:25: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 01:25: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 01:25: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 01:25: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 01:25: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 01:25:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 01:25:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:25:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:25: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 01:25: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 01:25: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 01:25: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 01:25: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 01:25: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 01:25:06 INFO - Downloading docopt-0.6.1.tar.gz 01:25:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 01:25:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:25:06 INFO - Installing collected packages: blobuploader, requests, docopt 01:25:06 INFO - Running setup.py install for blobuploader 01:25:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:25:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:25:06 INFO - Running setup.py install for requests 01:25:07 INFO - Running setup.py install for docopt 01:25:07 INFO - Successfully installed blobuploader requests docopt 01:25:07 INFO - Cleaning up... 01:25:07 INFO - Return code: 0 01:25:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:25:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:07 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 0xab4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce5210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd77220>, '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 0xce32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xce3740>, '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': '5752742a61d0f534093fa7a9000001cb-1448443233.377111-2008430280', '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 01:25:07 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 01:25:07 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 01:25:07 INFO - Using env: {'DISPLAY': ':0', 01:25:07 INFO - 'HOME': '/home/cltbld', 01:25:07 INFO - 'LANG': 'en_US.UTF-8', 01:25:07 INFO - 'LANGUAGE': 'en_US:en', 01:25:07 INFO - 'LOGNAME': 'cltbld', 01:25:07 INFO - 'MAIL': '/var/mail/cltbld', 01:25:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:07 INFO - 'MOZ_NO_REMOTE': '1', 01:25:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:07 INFO - 'NO_EM_RESTART': '1', 01:25:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:07 INFO - 'PWD': '/builds/slave/test', 01:25:07 INFO - 'SHELL': '/bin/bash', 01:25:07 INFO - 'SHLVL': '1', 01:25:07 INFO - 'TERM': 'linux', 01:25:07 INFO - 'TMOUT': '86400', 01:25:07 INFO - 'USER': 'cltbld', 01:25:07 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1448443233.377111-2008430280', 01:25:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:07 INFO - '_': '/tools/buildbot/bin/python'} 01:25:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:25:07 INFO - Running setup.py (path:/tmp/pip-wahzZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:25:07 INFO - Running setup.py (path:/tmp/pip-5XNQUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:25:07 INFO - Running setup.py (path:/tmp/pip-N9r7hC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:25:07 INFO - Running setup.py (path:/tmp/pip-ao_p7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:25:07 INFO - Running setup.py (path:/tmp/pip-yFWHWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:25:08 INFO - Running setup.py (path:/tmp/pip-6HDTcZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:25:08 INFO - Running setup.py (path:/tmp/pip-SWEhSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:25:08 INFO - Running setup.py (path:/tmp/pip-fllT9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:25:08 INFO - Running setup.py (path:/tmp/pip-fGIL37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:25:08 INFO - Running setup.py (path:/tmp/pip-THSey4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:25:08 INFO - Running setup.py (path:/tmp/pip-yEf8bR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:25:08 INFO - Running setup.py (path:/tmp/pip-pABftD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:25:08 INFO - Running setup.py (path:/tmp/pip-t2CxAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:25:08 INFO - Running setup.py (path:/tmp/pip-L_cTA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:25:08 INFO - Running setup.py (path:/tmp/pip-JjC0M2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:25:08 INFO - Running setup.py (path:/tmp/pip-QgaxFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:25:08 INFO - Running setup.py (path:/tmp/pip-0HN8Q5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:25:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:25:08 INFO - Running setup.py install for manifestparser 01:25:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:25:08 INFO - Running setup.py install for mozcrash 01:25:09 INFO - Running setup.py install for mozdebug 01:25:09 INFO - Running setup.py install for mozdevice 01:25:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:25:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:25:09 INFO - Running setup.py install for mozfile 01:25:09 INFO - Running setup.py install for mozhttpd 01:25:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:25:09 INFO - Running setup.py install for mozinfo 01:25:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:25:09 INFO - Running setup.py install for mozInstall 01:25:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:25:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:25:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:25:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:25:09 INFO - Running setup.py install for mozleak 01:25:09 INFO - Running setup.py install for mozlog 01:25:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:25:09 INFO - Running setup.py install for moznetwork 01:25:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:25:09 INFO - Running setup.py install for mozprocess 01:25:10 INFO - Running setup.py install for mozprofile 01:25:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:25:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:25:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:25:10 INFO - Running setup.py install for mozrunner 01:25:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:25:10 INFO - Running setup.py install for mozscreenshot 01:25:10 INFO - Running setup.py install for moztest 01:25:10 INFO - Running setup.py install for mozversion 01:25:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:25:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:25:10 INFO - Cleaning up... 01:25:10 INFO - Return code: 0 01:25:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:25:10 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')]} 01:25:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:10 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')]} 01:25:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:10 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 0xab4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce5210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd77220>, '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 0xce32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xce3740>, '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': '5752742a61d0f534093fa7a9000001cb-1448443233.377111-2008430280', '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 01:25:10 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 01:25:10 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 01:25:10 INFO - Using env: {'DISPLAY': ':0', 01:25:10 INFO - 'HOME': '/home/cltbld', 01:25:10 INFO - 'LANG': 'en_US.UTF-8', 01:25:10 INFO - 'LANGUAGE': 'en_US:en', 01:25:10 INFO - 'LOGNAME': 'cltbld', 01:25:10 INFO - 'MAIL': '/var/mail/cltbld', 01:25:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:10 INFO - 'MOZ_NO_REMOTE': '1', 01:25:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:10 INFO - 'NO_EM_RESTART': '1', 01:25:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:10 INFO - 'PWD': '/builds/slave/test', 01:25:10 INFO - 'SHELL': '/bin/bash', 01:25:10 INFO - 'SHLVL': '1', 01:25:10 INFO - 'TERM': 'linux', 01:25:10 INFO - 'TMOUT': '86400', 01:25:10 INFO - 'USER': 'cltbld', 01:25:10 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1448443233.377111-2008430280', 01:25:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:10 INFO - '_': '/tools/buildbot/bin/python'} 01:25:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:25:10 INFO - Running setup.py (path:/tmp/pip-Y97W7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:25:10 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)) 01:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:25:10 INFO - Running setup.py (path:/tmp/pip-hLtpSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:25:11 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)) 01:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:25:11 INFO - Running setup.py (path:/tmp/pip-UUKrqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:25:11 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)) 01:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:25:11 INFO - Running setup.py (path:/tmp/pip-c0JdjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:25:11 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)) 01:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:25:11 INFO - Running setup.py (path:/tmp/pip-lT3Fk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:25:11 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)) 01:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:25:11 INFO - Running setup.py (path:/tmp/pip-3jfK4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:25:11 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)) 01:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:25:11 INFO - Running setup.py (path:/tmp/pip-pKXYrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:25:11 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)) 01:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:25:11 INFO - Running setup.py (path:/tmp/pip-OTInQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:25:11 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)) 01:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:25:11 INFO - Running setup.py (path:/tmp/pip-w9PApX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:25:11 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)) 01:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:25:11 INFO - Running setup.py (path:/tmp/pip-lcRBAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:25:11 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)) 01:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:25:11 INFO - Running setup.py (path:/tmp/pip-zzS9LY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:25:11 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)) 01:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:25:11 INFO - Running setup.py (path:/tmp/pip-KGwhuB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:25:11 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)) 01:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:25:11 INFO - Running setup.py (path:/tmp/pip-8KUYAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:25:11 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)) 01:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:25:11 INFO - Running setup.py (path:/tmp/pip-m6HUGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:25:11 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)) 01:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:25:11 INFO - Running setup.py (path:/tmp/pip-Qo466m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:25:11 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)) 01:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:25:11 INFO - Running setup.py (path:/tmp/pip-P0vqT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:25:12 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)) 01:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:25:12 INFO - Running setup.py (path:/tmp/pip-WkYhF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:25:12 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)) 01:25:12 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)) 01:25:12 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)) 01:25:12 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)) 01:25:12 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)) 01:25:12 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)) 01:25:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:25:12 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 01:25:12 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 01:25:12 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 01:25:12 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 01:25:12 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 01:25:12 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 01:25:13 INFO - Downloading blessings-1.5.1.tar.gz 01:25:13 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 01:25:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:25:13 INFO - Installing collected packages: blessings 01:25:13 INFO - Running setup.py install for blessings 01:25:13 INFO - Successfully installed blessings 01:25:13 INFO - Cleaning up... 01:25:14 INFO - Return code: 0 01:25:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:25:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:25:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:25:14 INFO - Reading from file tmpfile_stdout 01:25:14 INFO - Current package versions: 01:25:14 INFO - argparse == 1.2.1 01:25:14 INFO - blessings == 1.5.1 01:25:14 INFO - blobuploader == 1.2.4 01:25:14 INFO - docopt == 0.6.1 01:25:14 INFO - manifestparser == 1.1 01:25:14 INFO - mozInstall == 1.12 01:25:14 INFO - mozcrash == 0.16 01:25:14 INFO - mozdebug == 0.1 01:25:14 INFO - mozdevice == 0.47 01:25:14 INFO - mozfile == 1.2 01:25:14 INFO - mozhttpd == 0.7 01:25:14 INFO - mozinfo == 0.9 01:25:14 INFO - mozleak == 0.1 01:25:14 INFO - mozlog == 3.1 01:25:14 INFO - moznetwork == 0.27 01:25:14 INFO - mozprocess == 0.22 01:25:14 INFO - mozprofile == 0.27 01:25:14 INFO - mozrunner == 6.11 01:25:14 INFO - mozscreenshot == 0.1 01:25:14 INFO - mozsystemmonitor == 0.0 01:25:14 INFO - moztest == 0.7 01:25:14 INFO - mozversion == 1.4 01:25:14 INFO - psutil == 3.1.1 01:25:14 INFO - requests == 1.2.3 01:25:14 INFO - wsgiref == 0.1.2 01:25:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:25:14 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')]} 01:25:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:14 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')]} 01:25:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:14 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 0xab4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce5210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd77220>, '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 0xce32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xce3740>, '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': '5752742a61d0f534093fa7a9000001cb-1448443233.377111-2008430280', '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 01:25:14 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 01:25:14 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 01:25:14 INFO - Using env: {'DISPLAY': ':0', 01:25:14 INFO - 'HOME': '/home/cltbld', 01:25:14 INFO - 'LANG': 'en_US.UTF-8', 01:25:14 INFO - 'LANGUAGE': 'en_US:en', 01:25:14 INFO - 'LOGNAME': 'cltbld', 01:25:14 INFO - 'MAIL': '/var/mail/cltbld', 01:25:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:14 INFO - 'MOZ_NO_REMOTE': '1', 01:25:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:14 INFO - 'NO_EM_RESTART': '1', 01:25:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:14 INFO - 'PWD': '/builds/slave/test', 01:25:14 INFO - 'SHELL': '/bin/bash', 01:25:14 INFO - 'SHLVL': '1', 01:25:14 INFO - 'TERM': 'linux', 01:25:14 INFO - 'TMOUT': '86400', 01:25:14 INFO - 'USER': 'cltbld', 01:25:14 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1448443233.377111-2008430280', 01:25:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:14 INFO - '_': '/tools/buildbot/bin/python'} 01:25:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:14 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)) 01:25:14 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)) 01:25:14 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)) 01:25:14 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)) 01:25:14 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)) 01:25:14 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)) 01:25:14 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)) 01:25:14 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)) 01:25: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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:25:14 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)) 01:25:14 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)) 01:25:14 INFO - Cleaning up... 01:25:14 INFO - Return code: 0 01:25:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:25:14 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')]} 01:25:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:14 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')]} 01:25:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:14 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 0xab4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce5210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd77220>, '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 0xce32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xce3740>, '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': '5752742a61d0f534093fa7a9000001cb-1448443233.377111-2008430280', '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 01:25:14 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 01:25:14 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 01:25:14 INFO - Using env: {'DISPLAY': ':0', 01:25:14 INFO - 'HOME': '/home/cltbld', 01:25:14 INFO - 'LANG': 'en_US.UTF-8', 01:25:14 INFO - 'LANGUAGE': 'en_US:en', 01:25:14 INFO - 'LOGNAME': 'cltbld', 01:25:14 INFO - 'MAIL': '/var/mail/cltbld', 01:25:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:14 INFO - 'MOZ_NO_REMOTE': '1', 01:25:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:14 INFO - 'NO_EM_RESTART': '1', 01:25:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:14 INFO - 'PWD': '/builds/slave/test', 01:25:14 INFO - 'SHELL': '/bin/bash', 01:25:14 INFO - 'SHLVL': '1', 01:25:14 INFO - 'TERM': 'linux', 01:25:14 INFO - 'TMOUT': '86400', 01:25:14 INFO - 'USER': 'cltbld', 01:25:14 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1448443233.377111-2008430280', 01:25:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:14 INFO - '_': '/tools/buildbot/bin/python'} 01:25:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:14 INFO - Downloading/unpacking jsonschema 01:25: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 01:25: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 01:25: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 01:25: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 01:25: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 01:25: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 01:25:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:25:16 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 01:25:16 INFO - Downloading/unpacking functools32 (from jsonschema) 01:25:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:16 INFO - Downloading functools32-3.2.3-2.tar.gz 01:25:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 01:25:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:25:16 INFO - warning: no files found matching '*.txt' 01:25:16 INFO - no previously-included directories found matching 'build' 01:25:16 INFO - no previously-included directories found matching 'dist' 01:25:16 INFO - no previously-included directories found matching '.git*' 01:25:16 INFO - Installing collected packages: jsonschema, functools32 01:25:16 INFO - Running setup.py install for functools32 01:25:16 INFO - warning: no files found matching '*.txt' 01:25:16 INFO - no previously-included directories found matching 'build' 01:25:16 INFO - no previously-included directories found matching 'dist' 01:25:16 INFO - no previously-included directories found matching '.git*' 01:25:16 INFO - Successfully installed jsonschema functools32 01:25:16 INFO - Cleaning up... 01:25:16 INFO - Return code: 0 01:25:16 INFO - Running post-action listener: _resource_record_post_action 01:25:16 INFO - Running post-action listener: _start_resource_monitoring 01:25:16 INFO - Starting resource monitoring. 01:25:16 INFO - ##### 01:25:16 INFO - ##### Running install step. 01:25:16 INFO - ##### 01:25:16 INFO - Running pre-action listener: _resource_record_pre_action 01:25:16 INFO - Running main action method: install 01:25:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:25:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:25:17 INFO - Reading from file tmpfile_stdout 01:25:17 INFO - Detecting whether we're running mozinstall >=1.0... 01:25:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:25:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:25:17 INFO - Reading from file tmpfile_stdout 01:25:17 INFO - Output received: 01:25:17 INFO - Usage: mozinstall [options] installer 01:25:17 INFO - Options: 01:25:17 INFO - -h, --help show this help message and exit 01:25:17 INFO - -d DEST, --destination=DEST 01:25:17 INFO - Directory to install application into. [default: 01:25:17 INFO - "/builds/slave/test"] 01:25:17 INFO - --app=APP Application being installed. [default: firefox] 01:25:17 INFO - mkdir: /builds/slave/test/build/application 01:25:17 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'] 01:25:17 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 01:25:31 INFO - Reading from file tmpfile_stdout 01:25:31 INFO - Output received: 01:25:31 INFO - /builds/slave/test/build/application/firefox/firefox 01:25:31 INFO - Running post-action listener: _resource_record_post_action 01:25:31 INFO - ##### 01:25:31 INFO - ##### Running run-tests step. 01:25:31 INFO - ##### 01:25:31 INFO - Running pre-action listener: _resource_record_pre_action 01:25:31 INFO - Running main action method: run_tests 01:25:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:25:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:25:31 INFO - Python 2.7.3 01:25:31 INFO - Return code: 0 01:25:31 INFO - grabbing minidump binary from tooltool 01:25:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:31 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd77220>, '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 0xce32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xce3740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:25:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 01:25:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 01:25:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:25:31 INFO - Return code: 0 01:25:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:25:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:25:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:25:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:25:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:25:31 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/Tg0zBMa9RVSrk7I6sI53eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost'] in /builds/slave/test/build 01:25:31 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/Tg0zBMa9RVSrk7I6sI53eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --webServer localhost 01:25:31 INFO - Using env: {'DISPLAY': ':0', 01:25:31 INFO - 'HOME': '/home/cltbld', 01:25:31 INFO - 'LANG': 'en_US.UTF-8', 01:25:31 INFO - 'LANGUAGE': 'en_US:en', 01:25:31 INFO - 'LOGNAME': 'cltbld', 01:25:31 INFO - 'MAIL': '/var/mail/cltbld', 01:25:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:25:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:25:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:31 INFO - 'MOZ_NO_REMOTE': '1', 01:25:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:25:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:31 INFO - 'NO_EM_RESTART': '1', 01:25:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:31 INFO - 'PWD': '/builds/slave/test', 01:25:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:25:31 INFO - 'SHELL': '/bin/bash', 01:25:31 INFO - 'SHLVL': '1', 01:25:31 INFO - 'TERM': 'linux', 01:25:31 INFO - 'TMOUT': '86400', 01:25:31 INFO - 'USER': 'cltbld', 01:25:31 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1448443233.377111-2008430280', 01:25:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:31 INFO - '_': '/tools/buildbot/bin/python'} 01:25:31 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/Tg0zBMa9RVSrk7I6sI53eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost'] with output_timeout 3600 01:25:31 INFO - mozversion INFO | application_buildid: 20151125004137 01:25:31 INFO - mozversion INFO | application_changeset: 57dbf05c9f5bce0c726723f5403e61fd2ae88dee 01:25:31 INFO - mozversion INFO | application_display_name: Nightly 01:25:31 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:25:31 INFO - mozversion INFO | application_name: Firefox 01:25:31 INFO - mozversion INFO | application_remotingname: firefox 01:25:31 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 01:25:31 INFO - mozversion INFO | application_vendor: Mozilla 01:25:31 INFO - mozversion INFO | application_version: 45.0a1 01:25:31 INFO - mozversion INFO | platform_buildid: 20151125004137 01:25:31 INFO - mozversion INFO | platform_changeset: 57dbf05c9f5bce0c726723f5403e61fd2ae88dee 01:25:31 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 01:25:31 INFO - mozversion INFO | platform_version: 45.0a1 01:25:31 INFO - 2015-11-25 01:25:31,772 DEBUG : using testdate: 1448443531 01:25:31 INFO - 2015-11-25 01:25:31,772 DEBUG : actual date: 1448443531 01:25:31 INFO - 2015-11-25 01:25:31,780 INFO : starting webserver on 'localhost:57919' 01:25:31 INFO - 2015-11-25 01:25:31,781 INFO : Starting test suite talos-linux64-ix-059 01:25:31 INFO - 2015-11-25 01:25:31,781 INFO : Starting test dromaeo_css 01:25:31 INFO - 2015-11-25 01:25:31,781 DEBUG : operating with platform_type : linux_ 01:25:31 INFO - 2015-11-25 01:25:31,782 INFO : Initialising browser for dromaeo_css test... 01:25:31 INFO - 2015-11-25 01:25:31,795 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMVwv93/profile http://localhost:57919/getInfo.html 01:25:35 INFO - 2015-11-25 01:25:35,699 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:25:35 INFO - 2015-11-25 01:25:35,700 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:25:35 INFO - 2015-11-25 01:25:35,700 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:25:35 INFO - 2015-11-25 01:25:35,700 DEBUG : BROWSER_OUTPUT: __metrics 01:25:35 INFO - 2015-11-25 01:25:35,829 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] 01:25:36 INFO - 2015-11-25 01:25:36,913 INFO : Browser initialized. 01:25:36 INFO - 2015-11-25 01:25:36,914 INFO : Running cycle 1/1 for dromaeo_css test... 01:25:36 INFO - 2015-11-25 01:25:36,914 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMVwv93/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:25:48 INFO - 2015-11-25 01:25:48,734 DEBUG : BROWSER_OUTPUT: RSS: Main: 141598720 01:25:48 INFO - 2015-11-25 01:25:48,734 DEBUG : BROWSER_OUTPUT: 01:26:39 INFO - 2015-11-25 01:26:39,872 DEBUG : BROWSER_OUTPUT: 1448443599871 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] 01:28:51 INFO - 2015-11-25 01:28:51,373 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57919/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57919/tests/dromaeo/cssquery-ext.html) 01:28:52 INFO - 2015-11-25 01:28:52,591 DEBUG : BROWSER_OUTPUT: RSS: Main: 217260032 01:28:52 INFO - 2015-11-25 01:28:52,591 DEBUG : BROWSER_OUTPUT: 01:31:55 INFO - 2015-11-25 01:31:55,047 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57919/tests/dromaeo/cssquery-ext.html (next: http://localhost:57919/tests/dromaeo/cssquery-jquery.html) 01:31:55 INFO - 2015-11-25 01:31:55,616 DEBUG : BROWSER_OUTPUT: RSS: Main: 221962240 01:31:55 INFO - 2015-11-25 01:31:55,616 DEBUG : BROWSER_OUTPUT: 01:34:57 INFO - 2015-11-25 01:34:57,572 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57919/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57919/tests/dromaeo/cssquery-mootools.html) 01:34:58 INFO - 2015-11-25 01:34:58,158 DEBUG : BROWSER_OUTPUT: RSS: Main: 212574208 01:34:58 INFO - 2015-11-25 01:34:58,158 DEBUG : BROWSER_OUTPUT: 01:38:00 INFO - 2015-11-25 01:38:00,056 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57919/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57919/tests/dromaeo/cssquery-prototype.html) 01:38:00 INFO - 2015-11-25 01:38:00,624 DEBUG : BROWSER_OUTPUT: RSS: Main: 200368128 01:38:00 INFO - 2015-11-25 01:38:00,624 DEBUG : BROWSER_OUTPUT: 01:41:03 INFO - 2015-11-25 01:41:03,272 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57919/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57919/tests/dromaeo/cssquery-yui.html) 01:41:03 INFO - 2015-11-25 01:41:03,853 DEBUG : BROWSER_OUTPUT: RSS: Main: 208736256 01:41:03 INFO - 2015-11-25 01:41:03,854 DEBUG : BROWSER_OUTPUT: 01:44:06 INFO - 2015-11-25 01:44:06,246 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57919/tests/dromaeo/cssquery-yui.html (next: http://localhost:57919/tests/dromaeo/cssquery-dojo.html) 01:44:06 INFO - 2015-11-25 01:44:06,504 DEBUG : BROWSER_OUTPUT: RSS: Main: 225464320 01:44:06 INFO - 2015-11-25 01:44:06,505 DEBUG : BROWSER_OUTPUT: 01:44:06 INFO - 2015-11-25 01:44:06,505 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:44:06 INFO - 2015-11-25 01:44:06,505 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:44:06 INFO - 2015-11-25 01:44:06,505 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:44:06 INFO - 2015-11-25 01:44:06,505 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:44:06 INFO - 2015-11-25 01:44:06,506 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2613.255222261655;2720.891164353426;2721.6597925259343;2739.3014781230772;2744.423671029084;4372.950491881941;4474.932876006863;4589.829593453673;4600.930986035204;4615.846038490377;4479.686421950465;4555.271156614942;4629.444466664005;4644.396228490292;4651.069786042796;4204.516480604724;4238.470191226097;4267.573242675739;4284.228838809013;4301.0537681709975;3946.9210615787665;4258.041940563364;4291.034517233628;4307.698461107724;4350.390945267665;4114.855980040684;4154.979225103885;4226.070264541796;4235.343521754133;4268.274393353137;4261.850835220753;4298.097399546099;4299.161663475624;4300.290452075404;4329.480462344539;4253.319468884994;4259.488861336659;4275.508316543606;4294;4311.137772445523;4303.763293018883;4397.824087036514;4414.271645178542;4454.688171827974;4579.267317229261;4925.458199598042;4945.901081978341;4947.1837146871085;4948.208286674115;4987.052460032619;4947.727874966876;4948.05986862495;4951.084049450863;4956.801727930914;4992.326035985132;4360.847370342023;4462.973516091317;4466.7766611669285;4476.888077798081;4577.22187228172;5039.4708555601865;5092.083424983464;5094.719790411489;5100.438951715309;5140.820071297561;4851.490593487633;4859.489753575895;4862.3922009748785;4869.1722407190155;4902.362692849907;4677.064587082597;4740.336352910595;4794.736289504111;4804.42346918372;4915.410150781929;4888.486708895514;4931;4934.6545741798445;4942.629302802305;4982.501749825061;4914.852554423373;4924.606031517542;4927.507249275044;4928.778204980785;4971.45314015458;3895.0651843557343;3967.0677390813134;3992.301347264217;3995.5005624296964;4003.139325045129;3445.552078229864;3518.4546395308766;3537.752357335013;3561.394562924309;3587.443946188345;4233.534311225762;4238.427812245369;4242.787860607019;4265.232258193555;4287.421198138274;4899.265110233422;4900.044491324157;4904.166291730415;4912.066707325596;4944.134776414185;4075.7758323292505;4176.185643799491;4186.1418409226035;4187.748735075906;4282.057947251599;4390.780460976938;4418.734875907456;4425.402570652985;4452.977735111369;4488.169688607618;4756.881077973078;4763.309320148559;4767.570918617341;4770.522947705202;4814.374131362901;4668.673192876466;4795.64032697556;4796.880077998078;4973.726445045557;4993.450720420823;4601.171789077865;4649.976750116228;4755.405574303212;4764.618830493621;4782.689125206851;4861.65968382224;4868.634852386156;4873.098476781806;4875.780589873535;4892.510748925079;4896.828610998598;4925.655204135676;4946.4558898521855;4952.752362381939;4992.101421744121;4546.61353784932;4682.1338052460405;4696.906061878675;4707.035057813072;4850.80596776125;4811.133995880775;4839.830605928775;4841.491643377535;4842.4189097308545;4877.585405240452;4730.432348118248;4749.501302363202;4755.239161734106;4766.833160839354;4788.976055119702;4563.452385713736;4678.719276843401;4686.507916668837;4691.483936766885;4771;4634.281686338623;4652.092841895933;4655.976720116378;4660.091282199938;4694.765261736968 01:44:06 INFO - 2015-11-25 01:44:06,506 DEBUG : BROWSER_OUTPUT: |1;ext.html;555.9555235581154;577.2553406106123;579.1284117403308;579.137085742244;583.1602492410931;28533.714662853366;28976.56535151972;37210.62789372102;37543.812280938626;37628.247435051286;39879.20241595174;40419.191616167656;40633.39049914254;40707.18585628293;40715.185696286055;6986.510944233905;7103.751368702096;7902.96048519758;8064.475809072421;8070.596470176497;10136.84794728076;10338.9483052585;10372.222083343742;10387.324823886462;10409.06318431341;10134;10251.077403033725;10252.436116013616;10255.179585633132;10259.487025648725;7087.964560177218;7271.89092163618;9877.209823214125;10044.347117437379;10070;9582.185514231298;9672.70981870545;9704.417734935856;9706.980767019431;9714.61141554337;34785.130371740655;35240.29519409623;35275.1181220469;35336;35347;2816.1973837456226;2854.300696329392;2972.895948641787;3269.9019029429155;3271.9345613087603;28650.713492865012;28866.71133288661;28877.42245155106;28900.421991560263;29380.993462357474;3376.3753705564304;3414.5219669246326;3435.9656403435897;3536.222031153168;3666.981665091684;222055;223653;224519;224597.87701061554;224654;51896.48103518992;52912.20631690528;53198.734006330495;55460.16809747776;55769.163462548095;48691.26963095556;59853;61756;61819.690901545204;61852.69073654603;13219.206847589176;13288.3355832208;13294.20234785916;13360.93319533396;13411.664708382174;9791.853122203172;9849.310548261696;9879.753006174904;9881.209503239723;9885.110340069428;18722.157502912403;18880.527986800163;18934.43196704101;19046.238150473826;19537.706934395996;7684;7778.727744528915;7808.336291415179;7879.448438609357;7894.64474098667;869.891263592051;891.8038031633031;941.6186444489992;982.3074732313845;1051.8527406163143;26462.601333812563;26807.329816754347;26824;27072.864635676695;27124.457510849672;901.4990041580695;961.5528779117744;968.3560432312433;969.8642190093393;1029.7785976015193;13730.176189428666;13818.894488440901;13840.377183026789;14021.789673154912;14035.43858245679;328401;333423;333893;334227;334820;48644.27033594499;49271.75364123157;49331.26003109956;49332.75333623309;49347.25979110316;1175.9235649682744;1182.988170118305;1188.8811118888043;1189.1854079955258;1220.200768496636;25435.6184657234;25856.61215081738;26039.479210416066;26371.4725705481;26464;37236;38201.23597528089;38206;38883.805580971915;38944.22111557696;332196;338080;338272;341091;341798;29688.55467167951;30098;30105.247368815955;30115.397692046474;30119.698803011688;39051;39367.606323936394;39610;40114.79942600268;40447.393289101274;33627.83186084054;33775;34304.656953430145;34379.312413752086;34385.31229375448;33810;34434.48348274828;34492.65507344995;34512.65487345094;37709;34357.312853743286;34469.310613787085;34737.30525389528;38313.4252986211;39383;30370;31154.844225778725;31621.36757264796;31680.36639267248;32028;23807.761922380556;24027.159049433187;24081.638775418734;24275.150369736974;24369.634455483538 01:44:06 INFO - 2015-11-25 01:44:06,506 DEBUG : BROWSER_OUTPUT: |2;jquery.html;334.4815535919326;334.99999999999994;336.2820378491921;338.37738561047667;339.7689571091657;12017.339046352468;12461.813072803916;15119.773203401945;15277.847221527796;15608.687826243467;12214.51141954323;14701;15149.394024239018;15516.99139555931;15567.84432155678;4109.321961876301;4554.362389265489;4772.522747725235;4974.228994505839;5205.635605507616;3562.251927095313;3709.406494960807;3712.0905378182383;3713.5172427584375;5112.463191364909;3676.209614932789;5608.074667679828;5755.280589926259;5767.567432442563;5784.971075144618;5751.338596061465;5844.327902291248;5891.293044834647;5893.58744887858;5950.970245148768;5070.340855688773;5072.036313100536;5080.923786143211;5093;5122.897542049138;19512.80487195124;19844;19914.302999395095;20632;20682.276120335868;1648.884578079535;1717.3044916808713;1837.7427160197583;1914.607505461377;2005.6189324028535;13035.283059431727;13336.399862006234;13437.126586771828;13862.168269903737;13978.440862365595;1845.4186931116656;1859.33064096925;1872.6441976024512;1923.278770461077;1963.4109767069822;60709;66591.66704166448;66631.333686663;66740.99999999952;68606.65696671484;15481.612959676098;15551.844481555267;15554.22228888551;15593.064416134841;15692.372305107896;22777.544449111258;22887.08451661948;22968.885155574117;23197.7680223199;23254;8100.270975612223;8101;8143.982002249719;8156;8467.745967620982;6732.629705366154;6761.661916904233;6793.796186114326;6802.319768023158;6823.931760682429;7630.465867389229;7657.502262352929;7761.223877612307;7775.22247775218;7831.2560306770765;1655.238590248475;1664.4424117920632;1720.8279172082941;2164.1992462788867;2950.439416510856;768.2931702833407;839.093778718982;889.3285569395065;907.4736652741394;912.8128733609594;13364.599062028155;14430.783538246935;15223.771643425136;15270.77093843571;16282.185890705417;833.9457935234191;847.9448835825651;862.7454900804278;892.3218354050838;912.1927094521263;8637.481751094954;8784.648614055493;8812.647494100163;8837.29301655866;8860.601272942733;482091;490753;491274;497540;516629;53353;53913.1913021305;63605.36394636087;64263;64478.355216447235;1042.2599954032721;1056.4823236614004;1066.0278484803052;1066.6533376652465;1069.844872493484;13392.26342551169;13699.863001369858;14103.788443173566;14252.073615214978;14602.926985365006;31787.841060794548;32672.83663581762;32926.67073329332;33254.833725832184;34322.313553729284;39778.60221397749;41006.384904225866;41713.37429938614;42669.78665106655;44161.779191105124;9016.954915225382;9028.36801423894;9053.321000924825;9066.773330666521;9129.087091291083;16045.919770401073;16174.514764557081;16283.430079947146;16457.341706331612;16908.40820571274;13819.654508637364;13821.239831809347;13863.329530565798;13879.375428105557;14095.365708542935;12626.747465050465;12765.93617031909;13300.135491193041;13994.650133746738;14066.085704429588;13849.061131441807;13851.16892986424;14167.858321416654;14272.429102835771;14689.19209443491;8829.514376709085;9097.363184577016;9116;9200.539973001458;9203.171714545722;9686.51567421612;11539.884601154217;13868.930655347061;14145.929270353994;14346.067505612102 01:44:06 INFO - 2015-11-25 01:44:06,507 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1408.64783804049;1584.152478424043;1624.7644091606717;1647.1023292305692;1649.9175041247927;5666.461686139821;6703.3966942975185;6786.355296246861;6802.999999999994;6818.59088454693;6450.258220304667;6570.474362051036;6570.704318305676;6572.671366431671;6595.439387652055;1693.5935375509912;1723.5691077230692;1958.8628795984287;1991.4523506035812;2013.5570174561574;2016;2018.606371757508;2026.544027593787;2026.8885211313373;2027.472857057161;1939.6023815117867;1939.7090436434507;2005.9598808023832;2007.6988451732211;2011.0347033423893;2012.4767560434245;2030.3299911029326;2036.7963203679662;2060.031785061019;2063.3294179391683;2039.8776073435492;2057.4136371134155;2059.3204242599904;2060.5054786851197;2062.5359294158843;6670.899936500957;6746.392824645756;6749.8650026999185;6762.425193858478;6763.830904227384;4042.757434553936;4087.632113109805;4120.299549076664;4121.278776214151;4122.361034039729;2236.6197746383154;2553.616957456378;2681.4905168018013;2693.340131667754;2710.2953232159584;791.5409062743595;858.6608289725585;861.2093641635747;866.9479831210148;889.5463313709989;8372.958135209346;8421.663133474654;8422.915770842274;8427.915720842775;8460.196281353261;3780.1683629601443;3782.6028267032116;3835.4822099016274;3835.7890316032326;3929.096307849211;7641.235876412315;7692.884606730903;7726.9613651932505;7743.961280193563;7749.457537972288;4157.397177409259;4169.437125988014;4171.416001759756;4173.165366926627;4177.3316269397355;3764.5670747864347;3765.8305376258136;3766.0961369271176;3766.5668448128267;3781.0736369589627;3127.7654175936896;3145.2765863850987;3145.8269795161486;3147.1502694272417;3180.25264062945;1073.382804887193;1074.3661239868359;1078.8759292681443;1086.9076128529164;1093.0326660905157;805.9717909873243;813.4265342933218;816.8447994880953;817.264461984219;913.1051569461964;6251.187345645037;6253.343398943045;6261.24865016201;6270.2475702915945;6272.027835685385;424.2999051564943;433.56859924374817;434.4070343980444;435.58836899130654;437.7351702220175;4877.048975449824;4948.802047918115;4960.47914968923;4961.231009193581;4965.3048573199785;7947.682092716343;8010.919890801134;8073.39449541275;8112.148224436467;8185.79535511617;8070.112287648354;8085.919140808634;8107.148749381348;8109.391795615353;8123.47197432165;6157.6613286269685;6260.217472815898;6271.7804876830005;6334.113224148623;6350.587211831216;5987.670678112746;6024.186734790747;6071.058985857199;6083.7870674526175;6084.087386891824;7109.146902371748;7167.534110282815;7184.46116541251;7232.349088582053;7256.7460138896995;7278.126624805057;7333.1200255969625;7350.411967042517;7439.851202976019;7510.248975102446;5916.467517923407;5930.822075337746;5978.880422391441;5980.5514586405325;5985.341612422717;6334.6832658365975;6343.016832390987;6379.840503987438;6400.1679781629955;6409.294977552372;5925.703714814156;5991.400859914148;6008.5493587981955;6012.789552365646;6100.908486372619;5963.880722385615;5996.610220335664;6001.819945401645;6028.276606807036;6055.273367195965;6044.153818465506;6057.061155520902;6073;6088.6042407243385;6092.177556029879;5441.700706461183;5568.693721845176;5579.972100139474;5667.858303542444;5727.8568035799435;4877.780499877443;5692.573057020657;5695.686737229492;5735;5736.942630573641 01:44:06 INFO - 2015-11-25 01:44:06,511 DEBUG : BROWSER_OUTPUT: |4;prototype.html;302.5461807289066;309.19609016556956;311.93137509747845;315.569247976512;316.8114971591905;5162.070827251098;5199.3760748710165;5266.683998960065;5286.31277933868;5293.788248470061;4928.088303663816;5040.6471546991725;5063.544281014708;5195.116830138876;5218.19118036704;4096.938545921814;4109.383592461125;4112.074783173777;4127.545969943311;4127.752334859903;3881.68946484282;4121.237571049351;4125.257453658341;4128.876133715993;4139.296319625671;3943.2113577284513;3957.445957565943;4042.73722208057;4065.2072845795083;4073.5111786585653;4016.1766837798327;4046.1098558317417;4047;4050.9594904050878;4074.388841673743;3552.431610942237;3574.4459608760685;3575.0526110580718;3577.266660334651;3581.0510214793103;5028.899422011576;5045.293658887758;5045.772940217699;5047.671901326439;5048.495150484959;4557.202489564313;4648.767561621906;4655.441347038343;4659.580637742585;4670.766461676936;5458.890822183574;5461.290032295816;5461.453854614547;5465.371482279549;5473.75368108436;3877.515310586177;3881.3207688654657;3886.24218277436;3892.6691231245377;3893.415987601854;5736.3403208631125;5831.067029275338;5834.474897259267;5840.211571437844;5842.503387212092;3959.604039596075;4048.0891799344913;4083.3670781028986;4084.4077608746566;4088.9591104088577;4139.9793001035405;4142.171565686875;4142.937855932163;4144.937825932613;4146.875593732193;4663.813447462131;4669.2062349400685;4677.4387073550715;4680.485146633868;4689.484156742756;5496.450354964471;5500.972495137498;5501.587380946445;5508.20131080991;5511.696856672921;1445.6313640021938;1448.5654303708845;1465.5896349022291;1476.4758510728752;1476.483230869187;988.663854289545;1006.5168719014767;1032.4115254304975;1036.0934182590233;1039.5789705169418;4862.124817532878;4873.049755297683;4880.389951256093;4880.511948805162;4880.902381952412;5693.459121383462;5694;5694.60137790359;5699.515541178963;5702.572307076985;4734.573888349996;4793.281007848851;4853.174960256765;4861.465238823726;4872.829450969199;3049.100515347933;3068.2636167319683;3075.5694202811624;3076.7230949214677;3077.215310095956;5439.48324909133;5487.64330318528;5496.31296087989;5510.559155267569;5512.310961129859;5896.941030589639;5899.203607512931;5905.763769449174;5906.084556893688;5915.290165180206;5339.626226164209;5525.281713377235;5525.668459892419;5530.972345138329;5531.3362396512675;5749.252597162342;5763.510101641407;5765.5675824314185;5766.826995190151;5769.336526299529;5628.465295796893;5630.211770352072;5630.408807075198;5635.8591035224445;5639.577031722555;5349.705766182898;5504.697241651747;5505.421930697219;5509.228707980966;5512.118061110203;3939.7833119177576;3983.3029219886985;3989.880303590897;3990.4812374391145;3996.4005399190355;5732.111522713986;5739.885202295847;5741.942580574141;5743.59794814359;5752.252207213036;5528.281323428089;5535.667859928256;5535.695536745357;5535.944640553543;5538.556915446835;5409.6213265071065;5530.55755539564;5546;5548.334199896039;5549.38956714753;5410.918836217538;5427.1045277528765;5429.239906413184;5443.700596467233;5444.074507333684;5532.695701736443;5544.944550554443;5545.140503222007;5548.750306236148;5553.750081246434;5278.81524146653;5411.810586629449;5421.891562168814;5422.593305502024;5438.945610543844 01:44:06 INFO - 2015-11-25 01:44:06,511 DEBUG : BROWSER_OUTPUT: |5;yui.html;693.6497068980165;700.8983697363884;774.65140686691;783.2793829676697;786.7246463737689;8968.551572421376;9045.909540904597;9086.409383390082;9091.909080909189;9108.726738197847;11407.828882566768;11521.36632485213;11534.192606517547;11535.192536522447;11546;598.6557729305656;611.8011646214998;761.5050217358706;777.8055486128468;778.7507997440821;769.7690692792168;770.2759406158193;771.2172145272552;776.3129630277189;777.1800750208528;628.6008384675741;641.1664835713577;802.7872613757359;803.6423791412824;808.3694718119876;791.3036527855479;805.2068712318362;805.4522924411427;806.3790881021639;807.8424707182043;598.8742364103543;598.8832177725345;599.0415335463267;599.2539288585696;599.7511032921333;11678.474468648932;11765.294082355085;11837.704057398549;11848.526058957632;11883.346415947119;10919.672409827717;11218.887811121866;11375.260608060533;11652.825207621892;11872.465739041763;9581.904180958241;9592.66425675098;9595.42427454355;9674.806503869953;9712.902870971271;3292.4721434940043;3304.5869266341706;3331.083951913219;3334.683205095512;3371.258323168899;40501.18997620061;40566.79716601428;40859.182816343506;42123.578764212274;42206.57793422057;9379.516571143782;9483.146516813382;9521.333506654606;9587.233021358414;9591.472469014272;16619.83380166183;16642.08468534218;16675.749863752055;16691.0819904904;16750.497485075466;6366.64983425916;6385.074164246158;6466.967665161644;6468.611883287018;6672.399484046459;3408.625051244361;3458.7060099891287;3472.6874581287807;3474.2704032153024;3497.7376696747847;2884.5528943013865;2944.4552757739457;2953.719396657314;2958.9112326630234;2959.2749776304513;509.297169905528;514.0720998597567;514.6577525945205;515.1757188498373;522.6367674466286;421.6310728112901;437.3134179338408;459.1276574508461;478.4617305531277;478.6481935777201;7324.926750732531;7456.440766942501;7487.775366739006;7552.131504876899;7592.126905405838;555.3169601390232;565.9009673307155;569.7578529125105;570.8430181700065;590.819799961016;3395.830208489566;3551.5738111426276;3587;3596.6403359663823;3634.890953271406;48018.5198148014;48199.5180048195;48540.51459485431;48543.5145648546;49127.508724912295;42873;44113.77943110328;44761.776191118835;44882.77558612186;45287.32069018967;40799.59200408017;42113.57886421158;42428.57571424308;43375;43901.56098439039;7634.389248859967;7891.002837843165;7896.84206315882;8011.198880111942;8320.583970801557;30201.697983019887;30644.84677576598;30749;31070.844645776626;31112.533311999887;36369.45445818262;39065.414018789175;39308.6069139305;39592.40611390889;39698.80150599228;9186.724398268063;9295.628174872929;9368.250539956924;9402.952985235304;9703.66037188695;10705.678829635124;10759.89240107589;10812.729681757704;10884.292520986111;10910.563577457131;9848.556814943488;10002.44986525748;10135.290529662852;10217.948910255402;10320.793584128125;10038.247131465023;10317.638882639072;10370.533326000499;10389.84415233757;10422.530986105796;9943.751406214613;10073.949630251802;10082.899171008195;10207.438590877573;10464;8480.448770829877;8657.91342086571;8660.82678346417;8667.956660216658;8686.609102590272;7917.208279172037;8498.702545411128;8551.401401901807;8773.649054038022;8774.736757897273 01:44:06 INFO - 2015-11-25 01:44:06,511 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:44:06 INFO - 2015-11-25 01:44:06,511 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:44:06 INFO - 2015-11-25 01:44:06,511 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,955 01:44:06 INFO - 2015-11-25 01:44:06,511 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:44:06 INFO - 2015-11-25 01:44:06,511 DEBUG : BROWSER_OUTPUT: __startTimestamp1448444646498__endTimestamp 01:44:06 INFO - 2015-11-25 01:44:06,512 DEBUG : BROWSER_OUTPUT: 01:44:06 INFO - 2015-11-25 01:44:06,512 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:44:06 INFO - 2015-11-25 01:44:06,512 DEBUG : BROWSER_OUTPUT: Number of tests: 6 01:44:06 INFO - 2015-11-25 01:44:06,512 DEBUG : BROWSER_OUTPUT: 01:44:06 INFO - 2015-11-25 01:44:06,512 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4533.04 Median:4660.09 stddev:474.54 (10.2%) stddev-sans-first:451.47 01:44:06 INFO - 2015-11-25 01:44:06,512 DEBUG : BROWSER_OUTPUT: Values: 2613.3 2720.9 2721.7 2739.3 2744.4 4373.0 4474.9 4589.8 4600.9 4615.8 4479.7 4555.3 4629.4 4644.4 4651.1 4204.5 4238.5 4267.6 4284.2 4301.1 3946.9 4258.0 4291.0 4307.7 4350.4 4114.9 4155.0 4226.1 4235.3 4268.3 4261.9 4298.1 4299.2 4300.3 4329.5 4253.3 4259.5 4275.5 4294.0 4311.1 4303.8 4397.8 4414.3 4454.7 4579.3 4925.5 4945.9 4947.2 4948.2 4987.1 4947.7 4948.1 4951.1 4956.8 4992.3 4360.8 4463.0 4466.8 4476.9 4577.2 5039.5 5092.1 5094.7 5100.4 5140.8 4851.5 4859.5 4862.4 4869.2 4902.4 4677.1 4740.3 4794.7 4804.4 4915.4 4888.5 4931.0 4934.7 4942.6 4982.5 4914.9 4924.6 4927.5 4928.8 4971.5 3895.1 3967.1 3992.3 3995.5 4003.1 3445.6 3518.5 3537.8 3561.4 3587.4 4233.5 4238.4 4242.8 4265.2 4287.4 4899.3 4900.0 4904.2 4912.1 4944.1 4075.8 4176.2 4186.1 4187.7 4282.1 4390.8 4418.7 4425.4 4453.0 4488.2 4756.9 4763.3 4767.6 4770.5 4814.4 4668.7 4795.6 4796.9 4973.7 4993.5 4601.2 4650.0 4755.4 4764.6 4782.7 4861.7 4868.6 4873.1 4875.8 4892.5 4896.8 4925.7 4946.5 4952.8 4992.1 4546.6 4682.1 4696.9 4707.0 4850.8 4811.1 4839.8 4841.5 4842.4 4877.6 4730.4 4749.5 4755.2 4766.8 4789.0 4563.5 4678.7 4686.5 4691.5 4771.0 4634.3 4652.1 4656.0 4660.1 4694.8 01:44:06 INFO - 2015-11-25 01:44:06,512 DEBUG : BROWSER_OUTPUT: 01:44:06 INFO - 2015-11-25 01:44:06,512 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:45503.47 Median:188051.33 stddev:79553.93 (42.3%) stddev-sans-first:79705.52 01:44:06 INFO - 2015-11-25 01:44:06,514 DEBUG : BROWSER_OUTPUT: Values: 556.0 577.3 579.1 579.1 583.2 28533.7 28976.6 37210.6 37543.8 37628.2 39879.2 40419.2 40633.4 40707.2 40715.2 6986.5 7103.8 7903.0 8064.5 8070.6 10136.8 10338.9 10372.2 10387.3 10409.1 10134.0 10251.1 10252.4 10255.2 10259.5 7088.0 7271.9 9877.2 10044.3 10070.0 9582.2 9672.7 9704.4 9707.0 9714.6 34785.1 35240.3 35275.1 35336.0 35347.0 2816.2 2854.3 2972.9 3269.9 3271.9 28650.7 28866.7 28877.4 28900.4 29381.0 3376.4 3414.5 3436.0 3536.2 3667.0 222055.0 223653.0 224519.0 224597.9 224654.0 51896.5 52912.2 53198.7 55460.2 55769.2 48691.3 59853.0 61756.0 61819.7 61852.7 13219.2 13288.3 13294.2 13360.9 13411.7 9791.9 9849.3 9879.8 9881.2 9885.1 18722.2 18880.5 18934.4 19046.2 19537.7 7684.0 7778.7 7808.3 7879.4 7894.6 869.9 891.8 941.6 982.3 1051.9 26462.6 26807.3 26824.0 27072.9 27124.5 901.5 961.6 968.4 969.9 1029.8 13730.2 13818.9 13840.4 14021.8 14035.4 328401.0 333423.0 333893.0 334227.0 334820.0 48644.3 49271.8 49331.3 49332.8 49347.3 1175.9 1183.0 1188.9 1189.2 1220.2 25435.6 25856.6 26039.5 26371.5 26464.0 37236.0 38201.2 38206.0 38883.8 38944.2 332196.0 338080.0 338272.0 341091.0 341798.0 29688.6 30098.0 30105.2 30115.4 30119.7 39051.0 39367.6 39610.0 40114.8 40447.4 33627.8 33775.0 34304.7 34379.3 34385.3 33810.0 34434.5 34492.7 34512.7 37709.0 34357.3 34469.3 34737.3 38313.4 39383.0 30370.0 31154.8 31621.4 31680.4 32028.0 23807.8 24027.2 24081.6 24275.2 24369.6 01:44:06 INFO - 2015-11-25 01:44:06,514 DEBUG : BROWSER_OUTPUT: 01:44:06 INFO - 2015-11-25 01:44:06,514 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27226.89 Median:337.33 stddev:80793.62 (23950.9%) stddev-sans-first:80995.03 01:44:06 INFO - 2015-11-25 01:44:06,514 DEBUG : BROWSER_OUTPUT: Values: 334.5 335.0 336.3 338.4 339.8 12017.3 12461.8 15119.8 15277.8 15608.7 12214.5 14701.0 15149.4 15517.0 15567.8 4109.3 4554.4 4772.5 4974.2 5205.6 3562.3 3709.4 3712.1 3713.5 5112.5 3676.2 5608.1 5755.3 5767.6 5785.0 5751.3 5844.3 5891.3 5893.6 5951.0 5070.3 5072.0 5080.9 5093.0 5122.9 19512.8 19844.0 19914.3 20632.0 20682.3 1648.9 1717.3 1837.7 1914.6 2005.6 13035.3 13336.4 13437.1 13862.2 13978.4 1845.4 1859.3 1872.6 1923.3 1963.4 60709.0 66591.7 66631.3 66741.0 68606.7 15481.6 15551.8 15554.2 15593.1 15692.4 22777.5 22887.1 22968.9 23197.8 23254.0 8100.3 8101.0 8144.0 8156.0 8467.7 6732.6 6761.7 6793.8 6802.3 6823.9 7630.5 7657.5 7761.2 7775.2 7831.3 1655.2 1664.4 1720.8 2164.2 2950.4 768.3 839.1 889.3 907.5 912.8 13364.6 14430.8 15223.8 15270.8 16282.2 833.9 847.9 862.7 892.3 912.2 8637.5 8784.6 8812.6 8837.3 8860.6 482091.0 490753.0 491274.0 497540.0 516629.0 53353.0 53913.2 63605.4 64263.0 64478.4 1042.3 1056.5 1066.0 1066.7 1069.8 13392.3 13699.9 14103.8 14252.1 14602.9 31787.8 32672.8 32926.7 33254.8 34322.3 39778.6 41006.4 41713.4 42669.8 44161.8 9017.0 9028.4 9053.3 9066.8 9129.1 16045.9 16174.5 16283.4 16457.3 16908.4 13819.7 13821.2 13863.3 13879.4 14095.4 12626.7 12765.9 13300.1 13994.7 14066.1 13849.1 13851.2 14167.9 14272.4 14689.2 8829.5 9097.4 9116.0 9200.5 9203.2 9686.5 11539.9 13868.9 14145.9 14346.1 01:44:06 INFO - 2015-11-25 01:44:06,514 DEBUG : BROWSER_OUTPUT: 01:44:06 INFO - 2015-11-25 01:44:06,514 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4671.25 Median:5979.72 stddev:2393.96 (40.0%) stddev-sans-first:2388.12 01:44:06 INFO - 2015-11-25 01:44:06,514 DEBUG : BROWSER_OUTPUT: Values: 1408.6 1584.2 1624.8 1647.1 1649.9 5666.5 6703.4 6786.4 6803.0 6818.6 6450.3 6570.5 6570.7 6572.7 6595.4 1693.6 1723.6 1958.9 1991.5 2013.6 2016.0 2018.6 2026.5 2026.9 2027.5 1939.6 1939.7 2006.0 2007.7 2011.0 2012.5 2030.3 2036.8 2060.0 2063.3 2039.9 2057.4 2059.3 2060.5 2062.5 6670.9 6746.4 6749.9 6762.4 6763.8 4042.8 4087.6 4120.3 4121.3 4122.4 2236.6 2553.6 2681.5 2693.3 2710.3 791.5 858.7 861.2 866.9 889.5 8373.0 8421.7 8422.9 8427.9 8460.2 3780.2 3782.6 3835.5 3835.8 3929.1 7641.2 7692.9 7727.0 7744.0 7749.5 4157.4 4169.4 4171.4 4173.2 4177.3 3764.6 3765.8 3766.1 3766.6 3781.1 3127.8 3145.3 3145.8 3147.2 3180.3 1073.4 1074.4 1078.9 1086.9 1093.0 806.0 813.4 816.8 817.3 913.1 6251.2 6253.3 6261.2 6270.2 6272.0 424.3 433.6 434.4 435.6 437.7 4877.0 4948.8 4960.5 4961.2 4965.3 7947.7 8010.9 8073.4 8112.1 8185.8 8070.1 8085.9 8107.1 8109.4 8123.5 6157.7 6260.2 6271.8 6334.1 6350.6 5987.7 6024.2 6071.1 6083.8 6084.1 7109.1 7167.5 7184.5 7232.3 7256.7 7278.1 7333.1 7350.4 7439.9 7510.2 5916.5 5930.8 5978.9 5980.6 5985.3 6334.7 6343.0 6379.8 6400.2 6409.3 5925.7 5991.4 6008.5 6012.8 6100.9 5963.9 5996.6 6001.8 6028.3 6055.3 6044.2 6057.1 6073.0 6088.6 6092.2 5441.7 5568.7 5580.0 5667.9 5727.9 4877.8 5692.6 5695.7 5735.0 5736.9 01:44:06 INFO - 2015-11-25 01:44:06,514 DEBUG : BROWSER_OUTPUT: 01:44:06 INFO - 2015-11-25 01:44:06,514 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4598.48 Median:5056.02 stddev:1336.97 (26.4%) stddev-sans-first:1301.26 01:44:06 INFO - 2015-11-25 01:44:06,516 DEBUG : BROWSER_OUTPUT: Values: 302.5 309.2 311.9 315.6 316.8 5162.1 5199.4 5266.7 5286.3 5293.8 4928.1 5040.6 5063.5 5195.1 5218.2 4096.9 4109.4 4112.1 4127.5 4127.8 3881.7 4121.2 4125.3 4128.9 4139.3 3943.2 3957.4 4042.7 4065.2 4073.5 4016.2 4046.1 4047.0 4051.0 4074.4 3552.4 3574.4 3575.1 3577.3 3581.1 5028.9 5045.3 5045.8 5047.7 5048.5 4557.2 4648.8 4655.4 4659.6 4670.8 5458.9 5461.3 5461.5 5465.4 5473.8 3877.5 3881.3 3886.2 3892.7 3893.4 5736.3 5831.1 5834.5 5840.2 5842.5 3959.6 4048.1 4083.4 4084.4 4089.0 4140.0 4142.2 4142.9 4144.9 4146.9 4663.8 4669.2 4677.4 4680.5 4689.5 5496.5 5501.0 5501.6 5508.2 5511.7 1445.6 1448.6 1465.6 1476.5 1476.5 988.7 1006.5 1032.4 1036.1 1039.6 4862.1 4873.0 4880.4 4880.5 4880.9 5693.5 5694.0 5694.6 5699.5 5702.6 4734.6 4793.3 4853.2 4861.5 4872.8 3049.1 3068.3 3075.6 3076.7 3077.2 5439.5 5487.6 5496.3 5510.6 5512.3 5896.9 5899.2 5905.8 5906.1 5915.3 5339.6 5525.3 5525.7 5531.0 5531.3 5749.3 5763.5 5765.6 5766.8 5769.3 5628.5 5630.2 5630.4 5635.9 5639.6 5349.7 5504.7 5505.4 5509.2 5512.1 3939.8 3983.3 3989.9 3990.5 3996.4 5732.1 5739.9 5741.9 5743.6 5752.3 5528.3 5535.7 5535.7 5535.9 5538.6 5409.6 5530.6 5546.0 5548.3 5549.4 5410.9 5427.1 5429.2 5443.7 5444.1 5532.7 5544.9 5545.1 5548.8 5553.8 5278.8 5411.8 5421.9 5422.6 5438.9 01:44:06 INFO - 2015-11-25 01:44:06,516 DEBUG : BROWSER_OUTPUT: 01:44:06 INFO - 2015-11-25 01:44:06,516 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12078.02 Median:48542.01 stddev:13836.48 (28.5%) stddev-sans-first:13848.88 01:44:06 INFO - 2015-11-25 01:44:06,516 DEBUG : BROWSER_OUTPUT: Values: 693.6 700.9 774.7 783.3 786.7 8968.6 9045.9 9086.4 9091.9 9108.7 11407.8 11521.4 11534.2 11535.2 11546.0 598.7 611.8 761.5 777.8 778.8 769.8 770.3 771.2 776.3 777.2 628.6 641.2 802.8 803.6 808.4 791.3 805.2 805.5 806.4 807.8 598.9 598.9 599.0 599.3 599.8 11678.5 11765.3 11837.7 11848.5 11883.3 10919.7 11218.9 11375.3 11652.8 11872.5 9581.9 9592.7 9595.4 9674.8 9712.9 3292.5 3304.6 3331.1 3334.7 3371.3 40501.2 40566.8 40859.2 42123.6 42206.6 9379.5 9483.1 9521.3 9587.2 9591.5 16619.8 16642.1 16675.7 16691.1 16750.5 6366.6 6385.1 6467.0 6468.6 6672.4 3408.6 3458.7 3472.7 3474.3 3497.7 2884.6 2944.5 2953.7 2958.9 2959.3 509.3 514.1 514.7 515.2 522.6 421.6 437.3 459.1 478.5 478.6 7324.9 7456.4 7487.8 7552.1 7592.1 555.3 565.9 569.8 570.8 590.8 3395.8 3551.6 3587.0 3596.6 3634.9 48018.5 48199.5 48540.5 48543.5 49127.5 42873.0 44113.8 44761.8 44882.8 45287.3 40799.6 42113.6 42428.6 43375.0 43901.6 7634.4 7891.0 7896.8 8011.2 8320.6 30201.7 30644.8 30749.0 31070.8 31112.5 36369.5 39065.4 39308.6 39592.4 39698.8 9186.7 9295.6 9368.3 9403.0 9703.7 10705.7 10759.9 10812.7 10884.3 10910.6 9848.6 10002.4 10135.3 10217.9 10320.8 10038.2 10317.6 10370.5 10389.8 10422.5 9943.8 10073.9 10082.9 10207.4 10464.0 8480.4 8657.9 8660.8 8668.0 8686.6 7917.2 8498.7 8551.4 8773.6 8774.7 01:44:06 INFO - 2015-11-25 01:44:06,516 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:44:06 INFO - 2015-11-25 01:44:06,516 DEBUG : BROWSER_OUTPUT: 01:44:07 INFO - 2015-11-25 01:44:07,201 INFO : Browser exited with error code: 0 01:44:07 INFO - 2015-11-25 01:44:07,222 INFO : Completed test dromaeo_css (00:18:35) 01:44:07 INFO - 2015-11-25 01:44:07,223 INFO : Starting test kraken 01:44:07 INFO - 2015-11-25 01:44:07,223 DEBUG : operating with platform_type : linux_ 01:44:07 INFO - 2015-11-25 01:44:07,223 INFO : Initialising browser for kraken test... 01:44:07 INFO - 2015-11-25 01:44:07,229 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0sy3y3/profile http://localhost:57919/getInfo.html 01:44:10 INFO - 2015-11-25 01:44:10,974 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:44:10 INFO - 2015-11-25 01:44:10,975 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:44:10 INFO - 2015-11-25 01:44:10,975 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:44:10 INFO - 2015-11-25 01:44:10,975 DEBUG : BROWSER_OUTPUT: __metrics 01:44:11 INFO - 2015-11-25 01:44:11,096 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] 01:44:11 INFO - 2015-11-25 01:44:11,640 DEBUG : BROWSER_OUTPUT: console.error: 01:44:11 INFO - 2015-11-25 01:44:11,641 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 01:44:11 INFO - 2015-11-25 01:44:11,642 DEBUG : BROWSER_OUTPUT: Stack: 01:44:11 INFO - 2015-11-25 01:44:11,642 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 01:44:11 INFO - 2015-11-25 01:44:11,642 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 01:44:11 INFO - 2015-11-25 01:44:11,642 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 01:44:11 INFO - 2015-11-25 01:44:11,642 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 01:44:11 INFO - 2015-11-25 01:44:11,642 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 01:44:11 INFO - 2015-11-25 01:44:11,642 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 01:44:11 INFO - 2015-11-25 01:44:11,642 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:529:9 01:44:11 INFO - 2015-11-25 01:44:11,642 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 01:44:11 INFO - 2015-11-25 01:44:11,642 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:529:9 01:44:11 INFO - 2015-11-25 01:44:11,643 DEBUG : BROWSER_OUTPUT: 01:44:12 INFO - 2015-11-25 01:44:12,199 INFO : Browser initialized. 01:44:12 INFO - 2015-11-25 01:44:12,200 INFO : Running cycle 1/1 for kraken test... 01:44:12 INFO - 2015-11-25 01:44:12,200 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0sy3y3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:44:24 INFO - 2015-11-25 01:44:24,112 DEBUG : BROWSER_OUTPUT: RSS: Main: 138825728 01:44:24 INFO - 2015-11-25 01:44:24,113 DEBUG : BROWSER_OUTPUT: 01:44:26 INFO - 2015-11-25 01:44:26,708 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57919/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57919/tests/kraken/driver.html?testName=audio-beat-detection) 01:44:27 INFO - 2015-11-25 01:44:27,294 DEBUG : BROWSER_OUTPUT: RSS: Main: 178528256 01:44:27 INFO - 2015-11-25 01:44:27,294 DEBUG : BROWSER_OUTPUT: 01:44:29 INFO - 2015-11-25 01:44:29,995 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57919/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57919/tests/kraken/driver.html?testName=audio-dft) 01:44:30 INFO - 2015-11-25 01:44:30,568 DEBUG : BROWSER_OUTPUT: RSS: Main: 165834752 01:44:30 INFO - 2015-11-25 01:44:30,568 DEBUG : BROWSER_OUTPUT: 01:44:33 INFO - 2015-11-25 01:44:33,601 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57919/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57919/tests/kraken/driver.html?testName=audio-fft) 01:44:34 INFO - 2015-11-25 01:44:34,166 DEBUG : BROWSER_OUTPUT: RSS: Main: 149622784 01:44:34 INFO - 2015-11-25 01:44:34,167 DEBUG : BROWSER_OUTPUT: 01:44:36 INFO - 2015-11-25 01:44:36,183 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57919/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57919/tests/kraken/driver.html?testName=audio-oscillator) 01:44:36 INFO - 2015-11-25 01:44:36,749 DEBUG : BROWSER_OUTPUT: RSS: Main: 153542656 01:44:36 INFO - 2015-11-25 01:44:36,750 DEBUG : BROWSER_OUTPUT: 01:44:39 INFO - 2015-11-25 01:44:39,029 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57919/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57919/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:44:39 INFO - 2015-11-25 01:44:39,595 DEBUG : BROWSER_OUTPUT: RSS: Main: 154931200 01:44:39 INFO - 2015-11-25 01:44:39,595 DEBUG : BROWSER_OUTPUT: 01:44:42 INFO - 2015-11-25 01:44:42,554 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57919/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57919/tests/kraken/driver.html?testName=imaging-darkroom) 01:44:43 INFO - 2015-11-25 01:44:43,127 DEBUG : BROWSER_OUTPUT: RSS: Main: 153989120 01:44:43 INFO - 2015-11-25 01:44:43,127 DEBUG : BROWSER_OUTPUT: 01:44:46 INFO - 2015-11-25 01:44:46,569 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57919/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57919/tests/kraken/driver.html?testName=imaging-desaturate) 01:44:47 INFO - 2015-11-25 01:44:47,150 DEBUG : BROWSER_OUTPUT: RSS: Main: 155869184 01:44:47 INFO - 2015-11-25 01:44:47,151 DEBUG : BROWSER_OUTPUT: 01:44:50 INFO - 2015-11-25 01:44:50,029 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57919/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57919/tests/kraken/driver.html?testName=json-parse-financial) 01:44:50 INFO - 2015-11-25 01:44:50,603 DEBUG : BROWSER_OUTPUT: RSS: Main: 154243072 01:44:50 INFO - 2015-11-25 01:44:50,604 DEBUG : BROWSER_OUTPUT: 01:44:52 INFO - 2015-11-25 01:44:52,374 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57919/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57919/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:44:52 INFO - 2015-11-25 01:44:52,935 DEBUG : BROWSER_OUTPUT: RSS: Main: 165732352 01:44:52 INFO - 2015-11-25 01:44:52,935 DEBUG : BROWSER_OUTPUT: 01:44:54 INFO - 2015-11-25 01:44:54,825 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57919/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57919/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:44:55 INFO - 2015-11-25 01:44:55,427 DEBUG : BROWSER_OUTPUT: RSS: Main: 165613568 01:44:55 INFO - 2015-11-25 01:44:55,427 DEBUG : BROWSER_OUTPUT: 01:44:57 INFO - 2015-11-25 01:44:57,580 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57919/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57919/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:44:58 INFO - 2015-11-25 01:44:58,153 DEBUG : BROWSER_OUTPUT: RSS: Main: 173559808 01:44:58 INFO - 2015-11-25 01:44:58,153 DEBUG : BROWSER_OUTPUT: 01:45:00 INFO - 2015-11-25 01:45:00,710 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57919/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57919/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:45:01 INFO - 2015-11-25 01:45:01,295 DEBUG : BROWSER_OUTPUT: RSS: Main: 181923840 01:45:01 INFO - 2015-11-25 01:45:01,296 DEBUG : BROWSER_OUTPUT: 01:45:03 INFO - 2015-11-25 01:45:03,951 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57919/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57919/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:45:04 INFO - 2015-11-25 01:45:04,533 DEBUG : BROWSER_OUTPUT: RSS: Main: 179249152 01:45:04 INFO - 2015-11-25 01:45:04,533 DEBUG : BROWSER_OUTPUT: 01:45:06 INFO - 2015-11-25 01:45:06,294 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57919/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57919/tests/kraken/driver.html?testName=ai-astar) 01:45:06 INFO - 2015-11-25 01:45:06,544 DEBUG : BROWSER_OUTPUT: RSS: Main: 238682112 01:45:06 INFO - 2015-11-25 01:45:06,544 DEBUG : BROWSER_OUTPUT: 01:45:06 INFO - 2015-11-25 01:45:06,548 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:45:06 INFO - 2015-11-25 01:45:06,548 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:45:06 INFO - 2015-11-25 01:45:06,548 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:45:06 INFO - 2015-11-25 01:45:06,548 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:45:06 INFO - 2015-11-25 01:45:06,548 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;114;106;111;112;113;100;114;113;106 01:45:06 INFO - 2015-11-25 01:45:06,548 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;130;154;163;134;162;164;131;167;130 01:45:06 INFO - 2015-11-25 01:45:06,548 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;161;162;162;160;160;165;162;162;161 01:45:06 INFO - 2015-11-25 01:45:06,549 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;91;89;71;72;72;94;91;72 01:45:06 INFO - 2015-11-25 01:45:06,549 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;127;95;95;95;135;93;95;146 01:45:06 INFO - 2015-11-25 01:45:06,549 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;111;111;111;110;109;111;110;109 01:45:06 INFO - 2015-11-25 01:45:06,549 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;147;146;147;147;148;146;147;148;146 01:45:06 INFO - 2015-11-25 01:45:06,549 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;96;95;96;96;96;96 01:45:06 INFO - 2015-11-25 01:45:06,549 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;73;74;76;73;73;73;73;74;71 01:45:06 INFO - 2015-11-25 01:45:06,549 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;70;69;69;69;69;69;69;70 01:45:06 INFO - 2015-11-25 01:45:06,550 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;92;84;83;83;88;87;84;84;87;93 01:45:06 INFO - 2015-11-25 01:45:06,550 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;126;129;119;128;128;128;123;134;134 01:45:06 INFO - 2015-11-25 01:45:06,550 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;150;162;147;148;152;142;164;149;163;146 01:45:06 INFO - 2015-11-25 01:45:06,550 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;70;68;68;69;70;68;69;68;69 01:45:06 INFO - 2015-11-25 01:45:06,550 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:45:06 INFO - 2015-11-25 01:45:06,550 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:45:06 INFO - 2015-11-25 01:45:06,550 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,983 01:45:06 INFO - 2015-11-25 01:45:06,551 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:45:06 INFO - 2015-11-25 01:45:06,551 DEBUG : BROWSER_OUTPUT: __startTimestamp1448444706546__endTimestamp 01:45:06 INFO - 2015-11-25 01:45:06,551 DEBUG : BROWSER_OUTPUT: 01:45:06 INFO - 2015-11-25 01:45:06,558 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:45:06 INFO - 2015-11-25 01:45:06,558 DEBUG : BROWSER_OUTPUT: Number of tests: 14 01:45:06 INFO - 2015-11-25 01:45:06,559 DEBUG : BROWSER_OUTPUT: 01:45:06 INFO - 2015-11-25 01:45:06,559 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.20 Median:113.00 stddev:4.66 (4.1%) stddev-sans-first:4.83 01:45:06 INFO - 2015-11-25 01:45:06,559 DEBUG : BROWSER_OUTPUT: Values: 113.0 114.0 106.0 111.0 112.0 113.0 100.0 114.0 113.0 106.0 01:45:06 INFO - 2015-11-25 01:45:06,559 DEBUG : BROWSER_OUTPUT: 01:45:06 INFO - 2015-11-25 01:45:06,559 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.90 Median:158.00 stddev:15.76 (10.0%) stddev-sans-first:16.61 01:45:06 INFO - 2015-11-25 01:45:06,559 DEBUG : BROWSER_OUTPUT: Values: 154.0 130.0 154.0 163.0 134.0 162.0 164.0 131.0 167.0 130.0 01:45:06 INFO - 2015-11-25 01:45:06,559 DEBUG : BROWSER_OUTPUT: 01:45:06 INFO - 2015-11-25 01:45:06,559 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.42 (0.9%) stddev-sans-first:1.50 01:45:06 INFO - 2015-11-25 01:45:06,559 DEBUG : BROWSER_OUTPUT: Values: 162.0 161.0 162.0 162.0 160.0 160.0 165.0 162.0 162.0 161.0 01:45:06 INFO - 2015-11-25 01:45:06,559 DEBUG : BROWSER_OUTPUT: 01:45:06 INFO - 2015-11-25 01:45:06,559 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.60 Median:80.50 stddev:10.10 (12.5%) stddev-sans-first:10.33 01:45:06 INFO - 2015-11-25 01:45:06,559 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 91.0 89.0 71.0 72.0 72.0 94.0 91.0 72.0 01:45:06 INFO - 2015-11-25 01:45:06,559 DEBUG : BROWSER_OUTPUT: 01:45:06 INFO - 2015-11-25 01:45:06,560 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.90 Median:94.50 stddev:20.59 (21.8%) stddev-sans-first:21.30 01:45:06 INFO - 2015-11-25 01:45:06,560 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 127.0 95.0 95.0 95.0 135.0 93.0 95.0 146.0 01:45:06 INFO - 2015-11-25 01:45:06,560 DEBUG : BROWSER_OUTPUT: 01:45:06 INFO - 2015-11-25 01:45:06,560 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.50 stddev:0.88 (0.8%) stddev-sans-first:0.93 01:45:06 INFO - 2015-11-25 01:45:06,560 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 111.0 111.0 111.0 110.0 109.0 111.0 110.0 109.0 01:45:06 INFO - 2015-11-25 01:45:06,560 DEBUG : BROWSER_OUTPUT: 01:45:06 INFO - 2015-11-25 01:45:06,560 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 01:45:06 INFO - 2015-11-25 01:45:06,560 DEBUG : BROWSER_OUTPUT: Values: 146.0 147.0 146.0 147.0 147.0 148.0 146.0 147.0 148.0 146.0 01:45:06 INFO - 2015-11-25 01:45:06,561 DEBUG : BROWSER_OUTPUT: 01:45:06 INFO - 2015-11-25 01:45:06,561 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 01:45:06 INFO - 2015-11-25 01:45:06,561 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 96.0 95.0 96.0 96.0 96.0 96.0 01:45:06 INFO - 2015-11-25 01:45:06,561 DEBUG : BROWSER_OUTPUT: 01:45:06 INFO - 2015-11-25 01:45:06,561 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.30 Median:73.00 stddev:1.25 (1.7%) stddev-sans-first:1.32 01:45:06 INFO - 2015-11-25 01:45:06,561 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 74.0 76.0 73.0 73.0 73.0 73.0 74.0 71.0 01:45:06 INFO - 2015-11-25 01:45:06,561 DEBUG : BROWSER_OUTPUT: 01:45:06 INFO - 2015-11-25 01:45:06,561 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:69.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 01:45:06 INFO - 2015-11-25 01:45:06,561 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 70.0 69.0 69.0 69.0 69.0 69.0 69.0 70.0 01:45:06 INFO - 2015-11-25 01:45:06,561 DEBUG : BROWSER_OUTPUT: 01:45:06 INFO - 2015-11-25 01:45:06,561 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:87.00 stddev:3.63 (4.2%) stddev-sans-first:3.26 01:45:06 INFO - 2015-11-25 01:45:06,561 DEBUG : BROWSER_OUTPUT: Values: 92.0 84.0 83.0 83.0 88.0 87.0 84.0 84.0 87.0 93.0 01:45:06 INFO - 2015-11-25 01:45:06,561 DEBUG : BROWSER_OUTPUT: 01:45:06 INFO - 2015-11-25 01:45:06,561 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.90 Median:128.00 stddev:5.11 (4.0%) stddev-sans-first:4.77 01:45:06 INFO - 2015-11-25 01:45:06,562 DEBUG : BROWSER_OUTPUT: Values: 120.0 126.0 129.0 119.0 128.0 128.0 128.0 123.0 134.0 134.0 01:45:06 INFO - 2015-11-25 01:45:06,562 DEBUG : BROWSER_OUTPUT: 01:45:06 INFO - 2015-11-25 01:45:06,562 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.30 Median:151.00 stddev:7.85 (5.2%) stddev-sans-first:8.28 01:45:06 INFO - 2015-11-25 01:45:06,562 DEBUG : BROWSER_OUTPUT: Values: 150.0 162.0 147.0 148.0 152.0 142.0 164.0 149.0 163.0 146.0 01:45:06 INFO - 2015-11-25 01:45:06,562 DEBUG : BROWSER_OUTPUT: 01:45:06 INFO - 2015-11-25 01:45:06,562 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:0.82 (1.2%) stddev-sans-first:0.83 01:45:06 INFO - 2015-11-25 01:45:06,562 DEBUG : BROWSER_OUTPUT: Values: 68.0 70.0 68.0 68.0 69.0 70.0 68.0 69.0 68.0 69.0 01:45:06 INFO - 2015-11-25 01:45:06,562 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:45:06 INFO - 2015-11-25 01:45:06,562 DEBUG : BROWSER_OUTPUT: 01:45:07 INFO - 2015-11-25 01:45:07,457 INFO : Browser exited with error code: 0 01:45:07 INFO - 2015-11-25 01:45:07,511 INFO : Completed test kraken (00:01:00) 01:45:07 INFO - 2015-11-25 01:45:07,512 INFO : Starting test v8_7 01:45:07 INFO - 2015-11-25 01:45:07,512 DEBUG : operating with platform_type : linux_ 01:45:07 INFO - 2015-11-25 01:45:07,512 INFO : Initialising browser for v8_7 test... 01:45:07 INFO - 2015-11-25 01:45:07,518 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYAL6Uv/profile http://localhost:57919/getInfo.html 01:45:11 INFO - 2015-11-25 01:45:11,374 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:45:11 INFO - 2015-11-25 01:45:11,375 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:45:11 INFO - 2015-11-25 01:45:11,375 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:45:11 INFO - 2015-11-25 01:45:11,375 DEBUG : BROWSER_OUTPUT: __metrics 01:45:11 INFO - 2015-11-25 01:45:11,536 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] 01:45:12 INFO - 2015-11-25 01:45:12,085 DEBUG : BROWSER_OUTPUT: console.error: 01:45:12 INFO - 2015-11-25 01:45:12,086 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 01:45:12 INFO - 2015-11-25 01:45:12,086 DEBUG : BROWSER_OUTPUT: Stack: 01:45:12 INFO - 2015-11-25 01:45:12,086 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 01:45:12 INFO - 2015-11-25 01:45:12,087 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 01:45:12 INFO - 2015-11-25 01:45:12,087 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 01:45:12 INFO - 2015-11-25 01:45:12,087 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 01:45:12 INFO - 2015-11-25 01:45:12,087 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 01:45:12 INFO - 2015-11-25 01:45:12,087 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 01:45:12 INFO - 2015-11-25 01:45:12,087 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:529:9 01:45:12 INFO - 2015-11-25 01:45:12,087 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 01:45:12 INFO - 2015-11-25 01:45:12,087 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:529:9 01:45:12 INFO - 2015-11-25 01:45:12,087 DEBUG : BROWSER_OUTPUT: 01:45:12 INFO - 2015-11-25 01:45:12,637 INFO : Browser initialized. 01:45:12 INFO - 2015-11-25 01:45:12,637 INFO : Running cycle 1/1 for v8_7 test... 01:45:12 INFO - 2015-11-25 01:45:12,637 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYAL6Uv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:45:24 INFO - 2015-11-25 01:45:24,516 DEBUG : BROWSER_OUTPUT: RSS: Main: 138657792 01:45:24 INFO - 2015-11-25 01:45:24,516 DEBUG : BROWSER_OUTPUT: 01:45:45 INFO - 2015-11-25 01:45:45,900 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57919/tests/v8_7/run.html (next: http://localhost:57919/tests/v8_7/run.html) 01:45:46 INFO - 2015-11-25 01:45:46,158 DEBUG : BROWSER_OUTPUT: RSS: Main: 440459264 01:45:46 INFO - 2015-11-25 01:45:46,159 DEBUG : BROWSER_OUTPUT: 01:45:46 INFO - 2015-11-25 01:45:46,159 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:45:46 INFO - 2015-11-25 01:45:46,159 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:45:46 INFO - 2015-11-25 01:45:46,159 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:45:46 INFO - 2015-11-25 01:45:46,159 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:45:46 INFO - 2015-11-25 01:45:46,159 DEBUG : BROWSER_OUTPUT: |0;Richards;165.01650165016503 01:45:46 INFO - 2015-11-25 01:45:46,159 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.7984496124031 01:45:46 INFO - 2015-11-25 01:45:46,159 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.8489289740699 01:45:46 INFO - 2015-11-25 01:45:46,159 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5170.103092783505 01:45:46 INFO - 2015-11-25 01:45:46,159 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2032.520325203252 01:45:46 INFO - 2015-11-25 01:45:46,159 DEBUG : BROWSER_OUTPUT: |5;Earley;796.1783439490446 01:45:46 INFO - 2015-11-25 01:45:46,159 DEBUG : BROWSER_OUTPUT: |6;Boyer;12370.37037037037 01:45:46 INFO - 2015-11-25 01:45:46,159 DEBUG : BROWSER_OUTPUT: |7;RegExp;26710.526315789473 01:45:46 INFO - 2015-11-25 01:45:46,160 DEBUG : BROWSER_OUTPUT: |8;Splay;607.9854809437387 01:45:46 INFO - 2015-11-25 01:45:46,160 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 01:45:46 INFO - 2015-11-25 01:45:46,160 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:45:46 INFO - 2015-11-25 01:45:46,160 DEBUG : BROWSER_OUTPUT: __startTimestamp1448444746152__endTimestamp 01:45:46 INFO - 2015-11-25 01:45:46,160 DEBUG : BROWSER_OUTPUT: 01:45:46 INFO - 2015-11-25 01:45:46,160 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:45:46 INFO - 2015-11-25 01:45:46,160 DEBUG : BROWSER_OUTPUT: Number of tests: 10 01:45:46 INFO - 2015-11-25 01:45:46,161 DEBUG : BROWSER_OUTPUT: 01:45:46 INFO - 2015-11-25 01:45:46,161 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.02 Median:165.02 stddev:0.00 (0.0%) 01:45:46 INFO - 2015-11-25 01:45:46,161 DEBUG : BROWSER_OUTPUT: Values: 165.0 01:45:46 INFO - 2015-11-25 01:45:46,161 DEBUG : BROWSER_OUTPUT: 01:45:46 INFO - 2015-11-25 01:45:46,161 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.80 Median:193.80 stddev:0.00 (0.0%) 01:45:46 INFO - 2015-11-25 01:45:46,161 DEBUG : BROWSER_OUTPUT: Values: 193.8 01:45:46 INFO - 2015-11-25 01:45:46,161 DEBUG : BROWSER_OUTPUT: 01:45:46 INFO - 2015-11-25 01:45:46,161 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.85 Median:281.85 stddev:0.00 (0.0%) 01:45:46 INFO - 2015-11-25 01:45:46,161 DEBUG : BROWSER_OUTPUT: Values: 281.8 01:45:46 INFO - 2015-11-25 01:45:46,161 DEBUG : BROWSER_OUTPUT: 01:45:46 INFO - 2015-11-25 01:45:46,161 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5170.10 Median:5170.10 stddev:0.00 (0.0%) 01:45:46 INFO - 2015-11-25 01:45:46,161 DEBUG : BROWSER_OUTPUT: Values: 5170.1 01:45:46 INFO - 2015-11-25 01:45:46,162 DEBUG : BROWSER_OUTPUT: 01:45:46 INFO - 2015-11-25 01:45:46,162 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2032.52 Median:2032.52 stddev:0.00 (0.0%) 01:45:46 INFO - 2015-11-25 01:45:46,162 DEBUG : BROWSER_OUTPUT: Values: 2032.5 01:45:46 INFO - 2015-11-25 01:45:46,162 DEBUG : BROWSER_OUTPUT: 01:45:46 INFO - 2015-11-25 01:45:46,162 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:796.18 Median:796.18 stddev:0.00 (0.0%) 01:45:46 INFO - 2015-11-25 01:45:46,162 DEBUG : BROWSER_OUTPUT: Values: 796.2 01:45:46 INFO - 2015-11-25 01:45:46,162 DEBUG : BROWSER_OUTPUT: 01:45:46 INFO - 2015-11-25 01:45:46,162 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12370.37 Median:12370.37 stddev:0.00 (0.0%) 01:45:46 INFO - 2015-11-25 01:45:46,162 DEBUG : BROWSER_OUTPUT: Values: 12370.4 01:45:46 INFO - 2015-11-25 01:45:46,162 DEBUG : BROWSER_OUTPUT: 01:45:46 INFO - 2015-11-25 01:45:46,162 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26710.53 Median:26710.53 stddev:0.00 (0.0%) 01:45:46 INFO - 2015-11-25 01:45:46,162 DEBUG : BROWSER_OUTPUT: Values: 26710.5 01:45:46 INFO - 2015-11-25 01:45:46,162 DEBUG : BROWSER_OUTPUT: 01:45:46 INFO - 2015-11-25 01:45:46,162 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:607.99 Median:607.99 stddev:0.00 (0.0%) 01:45:46 INFO - 2015-11-25 01:45:46,162 DEBUG : BROWSER_OUTPUT: Values: 608.0 01:45:46 INFO - 2015-11-25 01:45:46,162 DEBUG : BROWSER_OUTPUT: 01:45:46 INFO - 2015-11-25 01:45:46,162 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 01:45:46 INFO - 2015-11-25 01:45:46,163 DEBUG : BROWSER_OUTPUT: Values: 4835.7 01:45:46 INFO - 2015-11-25 01:45:46,163 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:45:46 INFO - 2015-11-25 01:45:46,163 DEBUG : BROWSER_OUTPUT: 01:45:47 INFO - 2015-11-25 01:45:47,001 INFO : Browser exited with error code: 0 01:45:47 INFO - 2015-11-25 01:45:47,014 INFO : Completed test v8_7 (00:00:39) 01:45:47 INFO - 2015-11-25 01:45:47,212 INFO : Completed test suite (00:20:15) 01:45:47 INFO - 2015-11-25 01:45:47,212 DEBUG : Working with test: dromaeo_css 01:45:47 INFO - 2015-11-25 01:45:47,212 DEBUG : Generating results file: dromaeo_css 01:45:47 INFO - 2015-11-25 01:45:47,213 DEBUG : Working with test: kraken 01:45:47 INFO - 2015-11-25 01:45:47,213 DEBUG : Generating results file: kraken 01:45:47 INFO - 2015-11-25 01:45:47,214 INFO : javascript benchmark 01:45:47 INFO - 2015-11-25 01:45:47,214 DEBUG : Working with test: v8_7 01:45:47 INFO - 2015-11-25 01:45:47,214 DEBUG : Generating results file: v8_7 01:45:47 INFO - 2015-11-25 01:45:47,214 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:45:47 INFO - 2015-11-25 01:45:47,273 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 01:45:47 INFO - 2015-11-25 01:45:47,273 DEBUG : process_Request line: dromaeo_css 6284.88 graph.html#tests=[[72,132,35]] 01:45:47 INFO - 2015-11-25 01:45:47,273 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:45:47 INFO - 2015-11-25 01:45:47,312 DEBUG : process_Request line: kraken 1536.60 graph.html#tests=[[232,132,35]] 01:45:47 INFO - 2015-11-25 01:45:47,312 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:45:47 INFO - 2015-11-25 01:45:47,354 DEBUG : process_Request line: v8_7 19630.79 graph.html#tests=[[230,132,35]] 01:45:47 INFO - 2015-11-25 01:45:47,358 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2613.255222261655, 2720.891164353426, 2721.6597925259343, 2739.3014781230772, 2744.423671029084, 4372.950491881941, 4474.932876006863, 4589.829593453673, 4600.930986035204, 4615.846038490377, 4479.686421950465, 4555.271156614942, 4629.444466664005, 4644.396228490292, 4651.069786042796, 4204.516480604724, 4238.470191226097, 4267.573242675739, 4284.228838809013, 4301.0537681709975, 3946.9210615787665, 4258.041940563364, 4291.034517233628, 4307.698461107724, 4350.390945267665, 4114.855980040684, 4154.979225103885, 4226.070264541796, 4235.343521754133, 4268.274393353137, 4261.850835220753, 4298.097399546099, 4299.161663475624, 4300.290452075404, 4329.480462344539, 4253.319468884994, 4259.488861336659, 4275.508316543606, 4294.0, 4311.137772445523, 4303.763293018883, 4397.824087036514, 4414.271645178542, 4454.688171827974, 4579.267317229261, 4925.458199598042, 4945.901081978341, 4947.1837146871085, 4948.208286674115, 4987.052460032619, 4947.727874966876, 4948.05986862495, 4951.084049450863, 4956.801727930914, 4992.326035985132, 4360.847370342023, 4462.973516091317, 4466.7766611669285, 4476.888077798081, 4577.22187228172, 5039.4708555601865, 5092.083424983464, 5094.719790411489, 5100.438951715309, 5140.820071297561, 4851.490593487633, 4859.489753575895, 4862.3922009748785, 4869.1722407190155, 4902.362692849907, 4677.064587082597, 4740.336352910595, 4794.736289504111, 4804.42346918372, 4915.410150781929, 4888.486708895514, 4931.0, 4934.6545741798445, 4942.629302802305, 4982.501749825061, 4914.852554423373, 4924.606031517542, 4927.507249275044, 4928.778204980785, 4971.45314015458, 3895.0651843557343, 3967.0677390813134, 3992.301347264217, 3995.5005624296964, 4003.139325045129, 3445.552078229864, 3518.4546395308766, 3537.752357335013, 3561.394562924309, 3587.443946188345, 4233.534311225762, 4238.427812245369, 4242.787860607019, 4265.232258193555, 4287.421198138274, 4899.265110233422, 4900.044491324157, 4904.166291730415, 4912.066707325596, 4944.134776414185, 4075.7758323292505, 4176.185643799491, 4186.1418409226035, 4187.748735075906, 4282.057947251599, 4390.780460976938, 4418.734875907456, 4425.402570652985, 4452.977735111369, 4488.169688607618, 4756.881077973078, 4763.309320148559, 4767.570918617341, 4770.522947705202, 4814.374131362901, 4668.673192876466, 4795.64032697556, 4796.880077998078, 4973.726445045557, 4993.450720420823, 4601.171789077865, 4649.976750116228, 4755.405574303212, 4764.618830493621, 4782.689125206851, 4861.65968382224, 4868.634852386156, 4873.098476781806, 4875.780589873535, 4892.510748925079, 4896.828610998598, 4925.655204135676, 4946.4558898521855, 4952.752362381939, 4992.101421744121, 4546.61353784932, 4682.1338052460405, 4696.906061878675, 4707.035057813072, 4850.80596776125, 4811.133995880775, 4839.830605928775, 4841.491643377535, 4842.4189097308545, 4877.585405240452, 4730.432348118248, 4749.501302363202, 4755.239161734106, 4766.833160839354, 4788.976055119702, 4563.452385713736, 4678.719276843401, 4686.507916668837, 4691.483936766885, 4771.0, 4634.281686338623, 4652.092841895933, 4655.976720116378, 4660.091282199938, 4694.765261736968], "unit": "ms", "name": "dojo.html", "value": 4504.057841662256}, {"lowerIsBetter": false, "replicates": [555.9555235581154, 577.2553406106123, 579.1284117403308, 579.137085742244, 583.1602492410931, 28533.714662853366, 28976.56535151972, 37210.62789372102, 37543.812280938626, 37628.247435051286, 39879.20241595174, 40419.191616167656, 40633.39049914254, 40707.18585628293, 40715.185696286055, 6986.510944233905, 7103.751368702096, 7902.96048519758, 8064.475809072421, 8070.596470176497, 10136.84794728076, 10338.9483052585, 10372.222083343742, 10387.324823886462, 10409.06318431341, 10134.0, 10251.077403033725, 10252.436116013616, 10255.179585633132, 10259.487025648725, 7087.964560177218, 7271.89092163618, 9877.209823214125, 10044.347117437379, 10070.0, 9582.185514231298, 9672.70981870545, 9704.417734935856, 9706.980767019431, 9714.61141554337, 34785.130371740655, 35240.29519409623, 35275.1181220469, 35336.0, 35347.0, 2816.1973837456226, 2854.300696329392, 2972.895948641787, 3269.9019029429155, 3271.9345613087603, 28650.713492865012, 28866.71133288661, 28877.42245155106, 28900.421991560263, 29380.993462357474, 3376.3753705564304, 3414.5219669246326, 3435.9656403435897, 3536.222031153168, 3666.981665091684, 222055.0, 223653.0, 224519.0, 224597.87701061554, 224654.0, 51896.48103518992, 52912.20631690528, 53198.734006330495, 55460.16809747776, 55769.163462548095, 48691.26963095556, 59853.0, 61756.0, 61819.690901545204, 61852.69073654603, 13219.206847589176, 13288.3355832208, 13294.20234785916, 13360.93319533396, 13411.664708382174, 9791.853122203172, 9849.310548261696, 9879.753006174904, 9881.209503239723, 9885.110340069428, 18722.157502912403, 18880.527986800163, 18934.43196704101, 19046.238150473826, 19537.706934395996, 7684.0, 7778.727744528915, 7808.336291415179, 7879.448438609357, 7894.64474098667, 869.891263592051, 891.8038031633031, 941.6186444489992, 982.3074732313845, 1051.8527406163143, 26462.601333812563, 26807.329816754347, 26824.0, 27072.864635676695, 27124.457510849672, 901.4990041580695, 961.5528779117744, 968.3560432312433, 969.8642190093393, 1029.7785976015193, 13730.176189428666, 13818.894488440901, 13840.377183026789, 14021.789673154912, 14035.43858245679, 328401.0, 333423.0, 333893.0, 334227.0, 334820.0, 48644.27033594499, 49271.75364123157, 49331.26003109956, 49332.75333623309, 49347.25979110316, 1175.9235649682744, 1182.988170118305, 1188.8811118888043, 1189.1854079955258, 1220.200768496636, 25435.6184657234, 25856.61215081738, 26039.479210416066, 26371.4725705481, 26464.0, 37236.0, 38201.23597528089, 38206.0, 38883.805580971915, 38944.22111557696, 332196.0, 338080.0, 338272.0, 341091.0, 341798.0, 29688.55467167951, 30098.0, 30105.247368815955, 30115.397692046474, 30119.698803011688, 39051.0, 39367.606323936394, 39610.0, 40114.79942600268, 40447.393289101274, 33627.83186084054, 33775.0, 34304.656953430145, 34379.312413752086, 34385.31229375448, 33810.0, 34434.48348274828, 34492.65507344995, 34512.65487345094, 37709.0, 34357.312853743286, 34469.310613787085, 34737.30525389528, 38313.4252986211, 39383.0, 30370.0, 31154.844225778725, 31621.36757264796, 31680.36639267248, 32028.0, 23807.761922380556, 24027.159049433187, 24081.638775418734, 24275.150369736974, 24369.634455483538], "unit": "ms", "name": "ext.html", "value": 17619.770439864795}, {"lowerIsBetter": false, "replicates": [334.4815535919326, 334.99999999999994, 336.2820378491921, 338.37738561047667, 339.7689571091657, 12017.339046352468, 12461.813072803916, 15119.773203401945, 15277.847221527796, 15608.687826243467, 12214.51141954323, 14701.0, 15149.394024239018, 15516.99139555931, 15567.84432155678, 4109.321961876301, 4554.362389265489, 4772.522747725235, 4974.228994505839, 5205.635605507616, 3562.251927095313, 3709.406494960807, 3712.0905378182383, 3713.5172427584375, 5112.463191364909, 3676.209614932789, 5608.074667679828, 5755.280589926259, 5767.567432442563, 5784.971075144618, 5751.338596061465, 5844.327902291248, 5891.293044834647, 5893.58744887858, 5950.970245148768, 5070.340855688773, 5072.036313100536, 5080.923786143211, 5093.0, 5122.897542049138, 19512.80487195124, 19844.0, 19914.302999395095, 20632.0, 20682.276120335868, 1648.884578079535, 1717.3044916808713, 1837.7427160197583, 1914.607505461377, 2005.6189324028535, 13035.283059431727, 13336.399862006234, 13437.126586771828, 13862.168269903737, 13978.440862365595, 1845.4186931116656, 1859.33064096925, 1872.6441976024512, 1923.278770461077, 1963.4109767069822, 60709.0, 66591.66704166448, 66631.333686663, 66740.99999999952, 68606.65696671484, 15481.612959676098, 15551.844481555267, 15554.22228888551, 15593.064416134841, 15692.372305107896, 22777.544449111258, 22887.08451661948, 22968.885155574117, 23197.7680223199, 23254.0, 8100.270975612223, 8101.0, 8143.982002249719, 8156.0, 8467.745967620982, 6732.629705366154, 6761.661916904233, 6793.796186114326, 6802.319768023158, 6823.931760682429, 7630.465867389229, 7657.502262352929, 7761.223877612307, 7775.22247775218, 7831.2560306770765, 1655.238590248475, 1664.4424117920632, 1720.8279172082941, 2164.1992462788867, 2950.439416510856, 768.2931702833407, 839.093778718982, 889.3285569395065, 907.4736652741394, 912.8128733609594, 13364.599062028155, 14430.783538246935, 15223.771643425136, 15270.77093843571, 16282.185890705417, 833.9457935234191, 847.9448835825651, 862.7454900804278, 892.3218354050838, 912.1927094521263, 8637.481751094954, 8784.648614055493, 8812.647494100163, 8837.29301655866, 8860.601272942733, 482091.0, 490753.0, 491274.0, 497540.0, 516629.0, 53353.0, 53913.1913021305, 63605.36394636087, 64263.0, 64478.355216447235, 1042.2599954032721, 1056.4823236614004, 1066.0278484803052, 1066.6533376652465, 1069.844872493484, 13392.26342551169, 13699.863001369858, 14103.788443173566, 14252.073615214978, 14602.926985365006, 31787.841060794548, 32672.83663581762, 32926.67073329332, 33254.833725832184, 34322.313553729284, 39778.60221397749, 41006.384904225866, 41713.37429938614, 42669.78665106655, 44161.779191105124, 9016.954915225382, 9028.36801423894, 9053.321000924825, 9066.773330666521, 9129.087091291083, 16045.919770401073, 16174.514764557081, 16283.430079947146, 16457.341706331612, 16908.40820571274, 13819.654508637364, 13821.239831809347, 13863.329530565798, 13879.375428105557, 14095.365708542935, 12626.747465050465, 12765.93617031909, 13300.135491193041, 13994.650133746738, 14066.085704429588, 13849.061131441807, 13851.16892986424, 14167.858321416654, 14272.429102835771, 14689.19209443491, 8829.514376709085, 9097.363184577016, 9116.0, 9200.539973001458, 9203.171714545722, 9686.51567421612, 11539.884601154217, 13868.930655347061, 14145.929270353994, 14346.067505612102], "unit": "ms", "name": "jquery.html", "value": 8819.629779297198}, {"lowerIsBetter": false, "replicates": [1408.64783804049, 1584.152478424043, 1624.7644091606717, 1647.1023292305692, 1649.9175041247927, 5666.461686139821, 6703.3966942975185, 6786.355296246861, 6802.999999999994, 6818.59088454693, 6450.258220304667, 6570.474362051036, 6570.704318305676, 6572.671366431671, 6595.439387652055, 1693.5935375509912, 1723.5691077230692, 1958.8628795984287, 1991.4523506035812, 2013.5570174561574, 2016.0, 2018.606371757508, 2026.544027593787, 2026.8885211313373, 2027.472857057161, 1939.6023815117867, 1939.7090436434507, 2005.9598808023832, 2007.6988451732211, 2011.0347033423893, 2012.4767560434245, 2030.3299911029326, 2036.7963203679662, 2060.031785061019, 2063.3294179391683, 2039.8776073435492, 2057.4136371134155, 2059.3204242599904, 2060.5054786851197, 2062.5359294158843, 6670.899936500957, 6746.392824645756, 6749.8650026999185, 6762.425193858478, 6763.830904227384, 4042.757434553936, 4087.632113109805, 4120.299549076664, 4121.278776214151, 4122.361034039729, 2236.6197746383154, 2553.616957456378, 2681.4905168018013, 2693.340131667754, 2710.2953232159584, 791.5409062743595, 858.6608289725585, 861.2093641635747, 866.9479831210148, 889.5463313709989, 8372.958135209346, 8421.663133474654, 8422.915770842274, 8427.915720842775, 8460.196281353261, 3780.1683629601443, 3782.6028267032116, 3835.4822099016274, 3835.7890316032326, 3929.096307849211, 7641.235876412315, 7692.884606730903, 7726.9613651932505, 7743.961280193563, 7749.457537972288, 4157.397177409259, 4169.437125988014, 4171.416001759756, 4173.165366926627, 4177.3316269397355, 3764.5670747864347, 3765.8305376258136, 3766.0961369271176, 3766.5668448128267, 3781.0736369589627, 3127.7654175936896, 3145.2765863850987, 3145.8269795161486, 3147.1502694272417, 3180.25264062945, 1073.382804887193, 1074.3661239868359, 1078.8759292681443, 1086.9076128529164, 1093.0326660905157, 805.9717909873243, 813.4265342933218, 816.8447994880953, 817.264461984219, 913.1051569461964, 6251.187345645037, 6253.343398943045, 6261.24865016201, 6270.2475702915945, 6272.027835685385, 424.2999051564943, 433.56859924374817, 434.4070343980444, 435.58836899130654, 437.7351702220175, 4877.048975449824, 4948.802047918115, 4960.47914968923, 4961.231009193581, 4965.3048573199785, 7947.682092716343, 8010.919890801134, 8073.39449541275, 8112.148224436467, 8185.79535511617, 8070.112287648354, 8085.919140808634, 8107.148749381348, 8109.391795615353, 8123.47197432165, 6157.6613286269685, 6260.217472815898, 6271.7804876830005, 6334.113224148623, 6350.587211831216, 5987.670678112746, 6024.186734790747, 6071.058985857199, 6083.7870674526175, 6084.087386891824, 7109.146902371748, 7167.534110282815, 7184.46116541251, 7232.349088582053, 7256.7460138896995, 7278.126624805057, 7333.1200255969625, 7350.411967042517, 7439.851202976019, 7510.248975102446, 5916.467517923407, 5930.822075337746, 5978.880422391441, 5980.5514586405325, 5985.341612422717, 6334.6832658365975, 6343.016832390987, 6379.840503987438, 6400.1679781629955, 6409.294977552372, 5925.703714814156, 5991.400859914148, 6008.5493587981955, 6012.789552365646, 6100.908486372619, 5963.880722385615, 5996.610220335664, 6001.819945401645, 6028.276606807036, 6055.273367195965, 6044.153818465506, 6057.061155520902, 6073.0, 6088.6042407243385, 6092.177556029879, 5441.700706461183, 5568.693721845176, 5579.972100139474, 5667.858303542444, 5727.8568035799435, 4877.780499877443, 5692.573057020657, 5695.686737229492, 5735.0, 5736.942630573641], "unit": "ms", "name": "mootools.html", "value": 3787.4889458959415}, {"lowerIsBetter": false, "replicates": [302.5461807289066, 309.19609016556956, 311.93137509747845, 315.569247976512, 316.8114971591905, 5162.070827251098, 5199.3760748710165, 5266.683998960065, 5286.31277933868, 5293.788248470061, 4928.088303663816, 5040.6471546991725, 5063.544281014708, 5195.116830138876, 5218.19118036704, 4096.938545921814, 4109.383592461125, 4112.074783173777, 4127.545969943311, 4127.752334859903, 3881.68946484282, 4121.237571049351, 4125.257453658341, 4128.876133715993, 4139.296319625671, 3943.2113577284513, 3957.445957565943, 4042.73722208057, 4065.2072845795083, 4073.5111786585653, 4016.1766837798327, 4046.1098558317417, 4047.0, 4050.9594904050878, 4074.388841673743, 3552.431610942237, 3574.4459608760685, 3575.0526110580718, 3577.266660334651, 3581.0510214793103, 5028.899422011576, 5045.293658887758, 5045.772940217699, 5047.671901326439, 5048.495150484959, 4557.202489564313, 4648.767561621906, 4655.441347038343, 4659.580637742585, 4670.766461676936, 5458.890822183574, 5461.290032295816, 5461.453854614547, 5465.371482279549, 5473.75368108436, 3877.515310586177, 3881.3207688654657, 3886.24218277436, 3892.6691231245377, 3893.415987601854, 5736.3403208631125, 5831.067029275338, 5834.474897259267, 5840.211571437844, 5842.503387212092, 3959.604039596075, 4048.0891799344913, 4083.3670781028986, 4084.4077608746566, 4088.9591104088577, 4139.9793001035405, 4142.171565686875, 4142.937855932163, 4144.937825932613, 4146.875593732193, 4663.813447462131, 4669.2062349400685, 4677.4387073550715, 4680.485146633868, 4689.484156742756, 5496.450354964471, 5500.972495137498, 5501.587380946445, 5508.20131080991, 5511.696856672921, 1445.6313640021938, 1448.5654303708845, 1465.5896349022291, 1476.4758510728752, 1476.483230869187, 988.663854289545, 1006.5168719014767, 1032.4115254304975, 1036.0934182590233, 1039.5789705169418, 4862.124817532878, 4873.049755297683, 4880.389951256093, 4880.511948805162, 4880.902381952412, 5693.459121383462, 5694.0, 5694.60137790359, 5699.515541178963, 5702.572307076985, 4734.573888349996, 4793.281007848851, 4853.174960256765, 4861.465238823726, 4872.829450969199, 3049.100515347933, 3068.2636167319683, 3075.5694202811624, 3076.7230949214677, 3077.215310095956, 5439.48324909133, 5487.64330318528, 5496.31296087989, 5510.559155267569, 5512.310961129859, 5896.941030589639, 5899.203607512931, 5905.763769449174, 5906.084556893688, 5915.290165180206, 5339.626226164209, 5525.281713377235, 5525.668459892419, 5530.972345138329, 5531.3362396512675, 5749.252597162342, 5763.510101641407, 5765.5675824314185, 5766.826995190151, 5769.336526299529, 5628.465295796893, 5630.211770352072, 5630.408807075198, 5635.8591035224445, 5639.577031722555, 5349.705766182898, 5504.697241651747, 5505.421930697219, 5509.228707980966, 5512.118061110203, 3939.7833119177576, 3983.3029219886985, 3989.880303590897, 3990.4812374391145, 3996.4005399190355, 5732.111522713986, 5739.885202295847, 5741.942580574141, 5743.59794814359, 5752.252207213036, 5528.281323428089, 5535.667859928256, 5535.695536745357, 5535.944640553543, 5538.556915446835, 5409.6213265071065, 5530.55755539564, 5546.0, 5548.334199896039, 5549.38956714753, 5410.918836217538, 5427.1045277528765, 5429.239906413184, 5443.700596467233, 5444.074507333684, 5532.695701736443, 5544.944550554443, 5545.140503222007, 5548.750306236148, 5553.750081246434, 5278.81524146653, 5411.810586629449, 5421.891562168814, 5422.593305502024, 5438.945610543844], "unit": "ms", "name": "prototype.html", "value": 4176.297182017114}, {"lowerIsBetter": false, "replicates": [693.6497068980165, 700.8983697363884, 774.65140686691, 783.2793829676697, 786.7246463737689, 8968.551572421376, 9045.909540904597, 9086.409383390082, 9091.909080909189, 9108.726738197847, 11407.828882566768, 11521.36632485213, 11534.192606517547, 11535.192536522447, 11546.0, 598.6557729305656, 611.8011646214998, 761.5050217358706, 777.8055486128468, 778.7507997440821, 769.7690692792168, 770.2759406158193, 771.2172145272552, 776.3129630277189, 777.1800750208528, 628.6008384675741, 641.1664835713577, 802.7872613757359, 803.6423791412824, 808.3694718119876, 791.3036527855479, 805.2068712318362, 805.4522924411427, 806.3790881021639, 807.8424707182043, 598.8742364103543, 598.8832177725345, 599.0415335463267, 599.2539288585696, 599.7511032921333, 11678.474468648932, 11765.294082355085, 11837.704057398549, 11848.526058957632, 11883.346415947119, 10919.672409827717, 11218.887811121866, 11375.260608060533, 11652.825207621892, 11872.465739041763, 9581.904180958241, 9592.66425675098, 9595.42427454355, 9674.806503869953, 9712.902870971271, 3292.4721434940043, 3304.5869266341706, 3331.083951913219, 3334.683205095512, 3371.258323168899, 40501.18997620061, 40566.79716601428, 40859.182816343506, 42123.578764212274, 42206.57793422057, 9379.516571143782, 9483.146516813382, 9521.333506654606, 9587.233021358414, 9591.472469014272, 16619.83380166183, 16642.08468534218, 16675.749863752055, 16691.0819904904, 16750.497485075466, 6366.64983425916, 6385.074164246158, 6466.967665161644, 6468.611883287018, 6672.399484046459, 3408.625051244361, 3458.7060099891287, 3472.6874581287807, 3474.2704032153024, 3497.7376696747847, 2884.5528943013865, 2944.4552757739457, 2953.719396657314, 2958.9112326630234, 2959.2749776304513, 509.297169905528, 514.0720998597567, 514.6577525945205, 515.1757188498373, 522.6367674466286, 421.6310728112901, 437.3134179338408, 459.1276574508461, 478.4617305531277, 478.6481935777201, 7324.926750732531, 7456.440766942501, 7487.775366739006, 7552.131504876899, 7592.126905405838, 555.3169601390232, 565.9009673307155, 569.7578529125105, 570.8430181700065, 590.819799961016, 3395.830208489566, 3551.5738111426276, 3587.0, 3596.6403359663823, 3634.890953271406, 48018.5198148014, 48199.5180048195, 48540.51459485431, 48543.5145648546, 49127.508724912295, 42873.0, 44113.77943110328, 44761.776191118835, 44882.77558612186, 45287.32069018967, 40799.59200408017, 42113.57886421158, 42428.57571424308, 43375.0, 43901.56098439039, 7634.389248859967, 7891.002837843165, 7896.84206315882, 8011.198880111942, 8320.583970801557, 30201.697983019887, 30644.84677576598, 30749.0, 31070.844645776626, 31112.533311999887, 36369.45445818262, 39065.414018789175, 39308.6069139305, 39592.40611390889, 39698.80150599228, 9186.724398268063, 9295.628174872929, 9368.250539956924, 9402.952985235304, 9703.66037188695, 10705.678829635124, 10759.89240107589, 10812.729681757704, 10884.292520986111, 10910.563577457131, 9848.556814943488, 10002.44986525748, 10135.290529662852, 10217.948910255402, 10320.793584128125, 10038.247131465023, 10317.638882639072, 10370.533326000499, 10389.84415233757, 10422.530986105796, 9943.751406214613, 10073.949630251802, 10082.899171008195, 10207.438590877573, 10464.0, 8480.448770829877, 8657.91342086571, 8660.82678346417, 8667.956660216658, 8686.609102590272, 7917.208279172037, 8498.702545411128, 8551.401401901807, 8773.649054038022, 8774.736757897273], "unit": "ms", "name": "yui.html", "value": 5565.871706954567}], "name": "dromaeo_css"}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 114.0, 106.0, 111.0, 112.0, 113.0, 100.0, 114.0, 113.0, 106.0], "unit": "ms", "name": "ai-astar", "value": 110.2}, {"lowerIsBetter": true, "replicates": [154.0, 130.0, 154.0, 163.0, 134.0, 162.0, 164.0, 131.0, 167.0, 130.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.9}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 162.0, 162.0, 160.0, 160.0, 165.0, 162.0, 162.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 91.0, 89.0, 71.0, 72.0, 72.0, 94.0, 91.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 79.6}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 127.0, 95.0, 95.0, 95.0, 135.0, 93.0, 95.0, 146.0], "unit": "ms", "name": "audio-oscillator", "value": 106.9}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 111.0, 111.0, 111.0, 110.0, 109.0, 111.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 146.0, 147.0, 147.0, 148.0, 146.0, 147.0, 148.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 74.0, 76.0, 73.0, 73.0, 73.0, 73.0, 74.0, 71.0], "unit": "ms", "name": "json-parse-financial", "value": 73.3}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 70.0, 69.0, 69.0, 69.0, 69.0, 69.0, 69.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.2}, {"lowerIsBetter": true, "replicates": [92.0, 84.0, 83.0, 83.0, 88.0, 87.0, 84.0, 84.0, 87.0, 93.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.5}, {"lowerIsBetter": true, "replicates": [120.0, 126.0, 129.0, 119.0, 128.0, 128.0, 128.0, 123.0, 134.0, 134.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 126.9}, {"lowerIsBetter": true, "replicates": [150.0, 162.0, 147.0, 148.0, 152.0, 142.0, 164.0, 149.0, 163.0, 146.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 152.3}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 68.0, 68.0, 69.0, 70.0, 68.0, 69.0, 68.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.7}], "name": "kraken"}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.01650165016503], "unit": "score", "name": "Richards", "value": 213.9301200000001}, {"lowerIsBetter": false, "replicates": [193.7984496124031], "unit": "score", "name": "DeltaBlue", "value": 341.16888000000006}, {"lowerIsBetter": false, "replicates": [281.8489289740699], "unit": "score", "name": "Encrypt", "value": 944.410188}, {"lowerIsBetter": false, "replicates": [5170.103092783505], "unit": "score", "name": "Decrypt", "value": 51.48466001994015}, {"lowerIsBetter": false, "replicates": [2032.520325203252], "unit": "score", "name": "RayTrace", "value": 364.0745880000001}, {"lowerIsBetter": false, "replicates": [796.1783439490446], "unit": "score", "name": "Earley", "value": 837.077528}, {"lowerIsBetter": false, "replicates": [12370.37037037037], "unit": "score", "name": "Boyer", "value": 53.87575149700595}, {"lowerIsBetter": false, "replicates": [26710.526315789473], "unit": "score", "name": "RegExp", "value": 34.105842364532016}, {"lowerIsBetter": false, "replicates": [607.9854809437387], "unit": "score", "name": "Splay", "value": 134.0344507462687}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7"}]} 01:45:47 INFO - RETURN: dromaeo_css: 6284.88 01:45:47 INFO - RETURN: kraken: 1536.60 01:45:47 INFO - RETURN: v8_7: 19630.79 01:45:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19630.79"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1536.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6284.88"}}} 01:45:47 INFO - Return code: 0 01:45:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:45:47 INFO - # TBPL SUCCESS # 01:45:47 INFO - Running post-action listener: _resource_record_post_action 01:45:47 INFO - Running post-run listener: _resource_record_post_run 01:45:48 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 4096; Write bytes: 502554624; Read time: 12; Write time: 321412 01:45:48 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 228827136; Read time: 0; Write time: 187808 01:45:48 INFO - run-tests - Wall time: 1216s; CPU: 13.0%; Read bytes: 0; Write bytes: 273727488; Read time: 0; Write time: 133604 01:45:48 INFO - Running post-run listener: _upload_blobber_files 01:45:48 INFO - Blob upload gear active. 01:45:48 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 01:45:48 INFO - Copying logs to upload dir... 01:45:48 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1273.809530 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-11-25 01:45:48.008722) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-25 01:45:48.012752) ========= 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=5752742a61d0f534093fa7a9000001cb-1448443233.377111-2008430280 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/Tg0zBMa9RVSrk7I6sI53eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009998 build_url: 'https://queue.taskcluster.net/v1/task/Tg0zBMa9RVSrk7I6sI53eQ/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-25 01:45:48.064354) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 01:45:48.064677) ========= 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=5752742a61d0f534093fa7a9000001cb-1448443233.377111-2008430280 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004609 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 01:45:48.114159) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-25 01:45:48.114475) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-25 01:45:48.114767) ========= ========= Total master_lag: 0.22 =========