builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-035 starttime: 1448528100.29 results: success (0) buildid: 20151126002712 builduid: 4b6ee0beb9634b23b0129d0144d858a1 revision: f9798fa516433f4b42b0e2fba402ed39523989e5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-26 00:55:00.294939) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-26 00:55:00.295489) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-26 00:55:00.295913) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1448528054.765993-1090591871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006576 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-26 00:55:00.316373) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-26 00:55:00.316832) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-26 00:55:00.328022) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 00:55:00.328479) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1448528054.765993-1090591871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004619 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 00:55:00.380598) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-26 00:55:00.381205) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-26 00:55:00.381671) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 00:55:00.382023) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1448528054.765993-1090591871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-26 00:55:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2015-11-26 00:55:01 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.182569 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 00:55:00.577653) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 00:55:00.578070) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1448528054.765993-1090591871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020725 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 00:55:00.628369) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-26 00:55:00.628731) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f9798fa516433f4b42b0e2fba402ed39523989e5 --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 f9798fa516433f4b42b0e2fba402ed39523989e5 --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=0d7d1540fd7fba0c6b8b7f12000001dc-1448528054.765993-1090591871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-26 00:55:01,856 truncating revision to first 12 chars 2015-11-26 00:55:01,856 Setting DEBUG logging. 2015-11-26 00:55:01,856 attempt 1/10 2015-11-26 00:55:01,856 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f9798fa51643?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-26 00:55:02,720 unpacking tar archive at: fx-team-f9798fa51643/testing/mozharness/ program finished with exit code 0 elapsedTime=1.144438 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-26 00:55:01.786199) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-26 00:55:01.786879) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-26 00:55:01.797178) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-26 00:55:01.797585) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-26 00:55:01.798074) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2015-11-26 00:55:01.798368) ========= /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=0d7d1540fd7fba0c6b8b7f12000001dc-1448528054.765993-1090591871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:55:03 INFO - MultiFileLogger online at 20151126 00:55:03 in /builds/slave/test 00:55:03 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 00:55:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:55:03 INFO - {'append_to_log': False, 00:55:03 INFO - 'base_work_dir': '/builds/slave/test', 00:55:03 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 00:55:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:55:03 INFO - 'branch': 'Fx-Team-Non-PGO', 00:55:03 INFO - 'buildbot_json_path': 'buildprops.json', 00:55:03 INFO - 'config_files': ('talos/linux_config.py',), 00:55:03 INFO - 'default_actions': ('clobber', 00:55:03 INFO - 'read-buildbot-config', 00:55:03 INFO - 'download-and-extract', 00:55:03 INFO - 'populate-webroot', 00:55:03 INFO - 'create-virtualenv', 00:55:03 INFO - 'install', 00:55:03 INFO - 'run-tests'), 00:55:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:55:03 INFO - 'download_minidump_stackwalk': True, 00:55:03 INFO - 'download_symbols': 'ondemand', 00:55:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:55:03 INFO - 'tooltool.py': '/tools/tooltool.py', 00:55:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:55:03 INFO - '/tools/misc-python/virtualenv.py')}, 00:55:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:55:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:55:03 INFO - 'installer_path': 'installer.exe', 00:55:03 INFO - 'log_level': 'info', 00:55:03 INFO - 'log_name': 'talos', 00:55:03 INFO - 'log_to_console': True, 00:55:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:55:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:55:03 INFO - 'opt_config_files': (), 00:55:03 INFO - 'pip_index': False, 00:55:03 INFO - 'sps_profile': False, 00:55:03 INFO - 'sps_profile_interval': 0, 00:55:03 INFO - 'suite': 'dromaeojs', 00:55:03 INFO - 'system_bits': '64', 00:55:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:55:03 INFO - 'title': 'talos-linux64-ix-035', 00:55:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:55:03 INFO - 'use_talos_json': True, 00:55:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:55:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:55:03 INFO - 'work_dir': 'build'} 00:55:03 INFO - ##### 00:55:03 INFO - ##### Running clobber step. 00:55:03 INFO - ##### 00:55:03 INFO - Running pre-action listener: _resource_record_pre_action 00:55:03 INFO - Running main action method: clobber 00:55:03 INFO - rmtree: /builds/slave/test/build 00:55:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:55:04 INFO - Running post-action listener: _resource_record_post_action 00:55:04 INFO - ##### 00:55:04 INFO - ##### Running read-buildbot-config step. 00:55:04 INFO - ##### 00:55:04 INFO - Running pre-action listener: _resource_record_pre_action 00:55:04 INFO - Running main action method: read_buildbot_config 00:55:04 INFO - Using buildbot properties: 00:55:04 INFO - { 00:55:04 INFO - "properties": { 00:55:04 INFO - "buildnumber": 2127, 00:55:04 INFO - "product": "firefox", 00:55:04 INFO - "script_repo_revision": "production", 00:55:04 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 00:55:04 INFO - "repository": "", 00:55:04 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 00:55:04 INFO - "buildid": "20151126002712", 00:55:04 INFO - "slavename": "talos-linux64-ix-035", 00:55:04 INFO - "pgo_build": "False", 00:55:04 INFO - "basedir": "/builds/slave/test", 00:55:04 INFO - "project": "", 00:55:04 INFO - "platform": "ubuntu64_hw", 00:55:04 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 00:55:04 INFO - "slavebuilddir": "test", 00:55:04 INFO - "scheduler": "tests-fx-team-linux64-talos", 00:55:04 INFO - "branch": "fx-team", 00:55:04 INFO - "repo_path": "integration/fx-team", 00:55:04 INFO - "stage_platform": "linux64", 00:55:04 INFO - "builduid": "4b6ee0beb9634b23b0129d0144d858a1", 00:55:04 INFO - "revision": "f9798fa516433f4b42b0e2fba402ed39523989e5" 00:55:04 INFO - }, 00:55:04 INFO - "sourcestamp": { 00:55:04 INFO - "repository": "", 00:55:04 INFO - "hasPatch": false, 00:55:04 INFO - "project": "", 00:55:04 INFO - "branch": "fx-team-linux64-talos", 00:55:04 INFO - "changes": [ 00:55:04 INFO - { 00:55:04 INFO - "category": null, 00:55:04 INFO - "files": [ 00:55:04 INFO - { 00:55:04 INFO - "url": null, 00:55:04 INFO - "name": "https://queue.taskcluster.net/v1/task/alG-aQhPR2aij5AlCrwedg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 00:55:04 INFO - } 00:55:04 INFO - ], 00:55:04 INFO - "repository": "", 00:55:04 INFO - "rev": "5437ff201b3af733fb700c31074db234e0da6c11", 00:55:04 INFO - "who": "gijskruitbosch@gmail.com", 00:55:04 INFO - "when": 1448528057, 00:55:04 INFO - "number": 6709347, 00:55:04 INFO - "comments": "Bug 1228032 - restore chrome://global/skin/ where chrome://browser/skin/ was removed, r=jryans", 00:55:04 INFO - "project": "", 00:55:04 INFO - "at": "Thu 26 Nov 2015 00:54:17", 00:55:04 INFO - "branch": "fx-team-linux64-talos", 00:55:04 INFO - "revlink": "", 00:55:04 INFO - "properties": [ 00:55:04 INFO - [ 00:55:04 INFO - "buildid", 00:55:04 INFO - "20151126000913", 00:55:04 INFO - "Change" 00:55:04 INFO - ], 00:55:04 INFO - [ 00:55:04 INFO - "builduid", 00:55:04 INFO - "a8634c3542e8487c973758b8b6a2a2dc", 00:55:04 INFO - "Change" 00:55:04 INFO - ], 00:55:04 INFO - [ 00:55:04 INFO - "pgo_build", 00:55:04 INFO - "False", 00:55:04 INFO - "Change" 00:55:04 INFO - ] 00:55:04 INFO - ], 00:55:04 INFO - "revision": "5437ff201b3af733fb700c31074db234e0da6c11" 00:55:04 INFO - }, 00:55:04 INFO - { 00:55:04 INFO - "category": null, 00:55:04 INFO - "files": [ 00:55:04 INFO - { 00:55:04 INFO - "url": null, 00:55:04 INFO - "name": "https://queue.taskcluster.net/v1/task/4ed4osCfS3SsX-H5LVtlbA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 00:55:04 INFO - } 00:55:04 INFO - ], 00:55:04 INFO - "repository": "", 00:55:04 INFO - "rev": "f9798fa516433f4b42b0e2fba402ed39523989e5", 00:55:04 INFO - "who": "pbrosset@mozilla.com", 00:55:04 INFO - "when": 1448528050, 00:55:04 INFO - "number": 6709344, 00:55:04 INFO - "comments": "Bug 1197100 - 5 - Make time blocks selectable; r=tromey", 00:55:04 INFO - "project": "", 00:55:04 INFO - "at": "Thu 26 Nov 2015 00:54:10", 00:55:04 INFO - "branch": "fx-team-linux64-talos", 00:55:04 INFO - "revlink": "", 00:55:04 INFO - "properties": [ 00:55:04 INFO - [ 00:55:04 INFO - "buildid", 00:55:04 INFO - "20151126002712", 00:55:04 INFO - "Change" 00:55:04 INFO - ], 00:55:04 INFO - [ 00:55:04 INFO - "builduid", 00:55:04 INFO - "4b6ee0beb9634b23b0129d0144d858a1", 00:55:04 INFO - "Change" 00:55:04 INFO - ], 00:55:04 INFO - [ 00:55:04 INFO - "pgo_build", 00:55:04 INFO - "False", 00:55:04 INFO - "Change" 00:55:04 INFO - ] 00:55:04 INFO - ], 00:55:04 INFO - "revision": "f9798fa516433f4b42b0e2fba402ed39523989e5" 00:55:04 INFO - } 00:55:04 INFO - ], 00:55:04 INFO - "revision": "f9798fa516433f4b42b0e2fba402ed39523989e5" 00:55:04 INFO - } 00:55:04 INFO - } 00:55:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/4ed4osCfS3SsX-H5LVtlbA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 00:55:04 INFO - Running post-action listener: _resource_record_post_action 00:55:04 INFO - ##### 00:55:04 INFO - ##### Running download-and-extract step. 00:55:04 INFO - ##### 00:55:04 INFO - Running pre-action listener: _resource_record_pre_action 00:55:04 INFO - Running main action method: download_and_extract 00:55:04 INFO - mkdir: /builds/slave/test/build/tests 00:55: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')]} 00:55:04 INFO - https://queue.taskcluster.net/v1/task/4ed4osCfS3SsX-H5LVtlbA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 00:55:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4ed4osCfS3SsX-H5LVtlbA/artifacts/public/build/test_packages.json 00:55:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4ed4osCfS3SsX-H5LVtlbA/artifacts/public/build/test_packages.json 00:55:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4ed4osCfS3SsX-H5LVtlbA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 00:55:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4ed4osCfS3SsX-H5LVtlbA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 00:55:04 INFO - Downloaded 1302 bytes. 00:55:04 INFO - Reading from file /builds/slave/test/build/test_packages.json 00:55:04 INFO - Using the following test package requirements: 00:55:04 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:55:04 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:55:04 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:55:04 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:55:04 INFO - u'jsshell-linux-x86_64.zip'], 00:55:04 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:55:04 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:55:04 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:55:04 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:55:04 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:55:04 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:55:04 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:55:04 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:55:04 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:55:04 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:55:04 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:55:04 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:55:04 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:55: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')]} 00:55:04 INFO - https://queue.taskcluster.net/v1/task/4ed4osCfS3SsX-H5LVtlbA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:55:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4ed4osCfS3SsX-H5LVtlbA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:55:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4ed4osCfS3SsX-H5LVtlbA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:55:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4ed4osCfS3SsX-H5LVtlbA/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 00:55:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4ed4osCfS3SsX-H5LVtlbA/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 00:55:05 INFO - Downloaded 21508487 bytes. 00:55:05 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 00:55:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:55:05 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 00:55:06 INFO - Return code: 0 00:55:06 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 00:55:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:55:06 INFO - https://queue.taskcluster.net/v1/task/4ed4osCfS3SsX-H5LVtlbA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:55:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4ed4osCfS3SsX-H5LVtlbA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:55:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4ed4osCfS3SsX-H5LVtlbA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:55:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4ed4osCfS3SsX-H5LVtlbA/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 00:55:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4ed4osCfS3SsX-H5LVtlbA/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 00:55:08 INFO - Downloaded 21508487 bytes. 00:55:08 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 00:55:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:55:08 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 00:55:09 INFO - Return code: 0 00:55:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:55:09 INFO - https://queue.taskcluster.net/v1/task/4ed4osCfS3SsX-H5LVtlbA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:55:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4ed4osCfS3SsX-H5LVtlbA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:55:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4ed4osCfS3SsX-H5LVtlbA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:55:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4ed4osCfS3SsX-H5LVtlbA/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 00:55:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4ed4osCfS3SsX-H5LVtlbA/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 00:55:10 INFO - Downloaded 11131717 bytes. 00:55:10 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 00:55:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:55:10 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 00:55:10 INFO - Return code: 0 00:55: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')]} 00:55:10 INFO - https://queue.taskcluster.net/v1/task/4ed4osCfS3SsX-H5LVtlbA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:55:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4ed4osCfS3SsX-H5LVtlbA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:55:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4ed4osCfS3SsX-H5LVtlbA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:55:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4ed4osCfS3SsX-H5LVtlbA/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 00:55:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4ed4osCfS3SsX-H5LVtlbA/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 00:55:12 INFO - Downloaded 56848460 bytes. 00:55:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/4ed4osCfS3SsX-H5LVtlbA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:55:12 INFO - mkdir: /builds/slave/test/properties 00:55:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:55:12 INFO - Writing to file /builds/slave/test/properties/build_url 00:55:12 INFO - Contents: 00:55:12 INFO - build_url:https://queue.taskcluster.net/v1/task/4ed4osCfS3SsX-H5LVtlbA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:55:12 INFO - Running post-action listener: _resource_record_post_action 00:55:12 INFO - Running post-action listener: set_extra_try_arguments 00:55:12 INFO - ##### 00:55:12 INFO - ##### Running populate-webroot step. 00:55:12 INFO - ##### 00:55:12 INFO - Running pre-action listener: _resource_record_pre_action 00:55:12 INFO - Running main action method: populate_webroot 00:55:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:55:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:55:12 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 00:55:12 INFO - '../fennec_ids.txt'], 00:55:12 INFO - 'tests': ['tcheck2']}, 00:55:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:55:12 INFO - '--tppagecycles', 00:55:12 INFO - '7'], 00:55:12 INFO - 'tests': ['tsvgm']}}, 00:55:12 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 00:55:12 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 00:55:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:55:12 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:55:12 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 00:55:12 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:55:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:55:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:55:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:55:12 INFO - 'talos_options': ['--e10s'], 00:55:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:55:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:55:12 INFO - 'tests': ['damp', 'tps']}, 00:55:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:55:12 INFO - 'talos_options': ['--e10s'], 00:55:12 INFO - 'tests': ['damp', 'tps']}, 00:55:12 INFO - 'g3': {'tests': ['dromaeo_dom']}, 00:55:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:55:12 INFO - 'other': {'tests': ['a11yr', 00:55:12 INFO - 'ts_paint', 00:55:12 INFO - 'tpaint', 00:55:12 INFO - 'sessionrestore', 00:55:12 INFO - 'sessionrestore_no_auto_restore']}, 00:55:12 INFO - 'other-e10s': {'talos_options': ['--e10s'], 00:55:12 INFO - 'tests': ['a11yr', 00:55:12 INFO - 'ts_paint', 00:55:12 INFO - 'tpaint', 00:55:12 INFO - 'sessionrestore', 00:55:12 INFO - 'sessionrestore_no_auto_restore']}, 00:55:12 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 00:55:12 INFO - 'tests': ['a11yr', 00:55:12 INFO - 'ts_paint', 00:55:12 INFO - 'tpaint', 00:55:12 INFO - 'sessionrestore', 00:55:12 INFO - 'sessionrestore_no_auto_restore']}, 00:55:12 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 00:55:12 INFO - 'tests': ['a11yr', 00:55:12 INFO - 'ts_paint', 00:55:12 INFO - 'tpaint', 00:55:12 INFO - 'sessionrestore', 00:55:12 INFO - 'sessionrestore_no_auto_restore']}, 00:55:12 INFO - 'other_l64': {'tests': ['a11yr', 00:55:12 INFO - 'ts_paint', 00:55:12 INFO - 'tpaint', 00:55:12 INFO - 'sessionrestore', 00:55:12 INFO - 'sessionrestore_no_auto_restore']}, 00:55:12 INFO - 'other_nol64': {'tests': ['a11yr', 00:55:12 INFO - 'ts_paint', 00:55:12 INFO - 'tpaint', 00:55:12 INFO - 'sessionrestore', 00:55:12 INFO - 'sessionrestore_no_auto_restore']}, 00:55:12 INFO - 'svgr': {'tests': ['tsvgx', 00:55:12 INFO - 'tsvgr_opacity', 00:55:12 INFO - 'tart', 00:55:12 INFO - 'tscrollx', 00:55:12 INFO - 'cart']}, 00:55:12 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 00:55:12 INFO - 'tests': ['tsvgx', 00:55:12 INFO - 'tsvgr_opacity', 00:55:12 INFO - 'tart', 00:55:12 INFO - 'tscrollx', 00:55:12 INFO - 'cart']}, 00:55:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:55:12 INFO - 'tests': ['tp5o']}, 00:55:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:55:12 INFO - 'talos_options': ['--e10s'], 00:55:12 INFO - 'tests': ['tp5o']}, 00:55:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:55:12 INFO - 'talos_options': ['--xperf_path', 00:55:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:55:12 INFO - 'tests': ['tp5n']}, 00:55:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:55:12 INFO - 'talos_options': ['--e10s', 00:55:12 INFO - '--xperf_path', 00:55:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:55:12 INFO - 'tests': ['tp5n']}}, 00:55:12 INFO - 'talos.zip': {'path': '', 00:55:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:55:12 INFO - Running post-action listener: _resource_record_post_action 00:55:12 INFO - ##### 00:55:12 INFO - ##### Running create-virtualenv step. 00:55:12 INFO - ##### 00:55:12 INFO - Running pre-action listener: _resource_record_pre_action 00:55:12 INFO - Running main action method: create_virtualenv 00:55:12 INFO - Creating virtualenv /builds/slave/test/build/venv 00:55:12 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 00:55:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:55:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:55:12 INFO - Using real prefix '/usr' 00:55:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:55:12 INFO - Installing distribute.............................................................................................................................................................................................done. 00:55:14 INFO - Installing pip.................done. 00:55:14 INFO - Return code: 0 00:55:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:55: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')]} 00:55:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:55:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55: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')]} 00:55:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:55:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cd210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145f220>, '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 0x13cb2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13cb740>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1448528054.765993-1090591871', '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 00:55: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', 'pip>=1.5'] in /builds/slave/test/build 00:55: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 pip>=1.5 00:55:14 INFO - Using env: {'DISPLAY': ':0', 00:55:14 INFO - 'HOME': '/home/cltbld', 00:55:14 INFO - 'LANG': 'en_US.UTF-8', 00:55:14 INFO - 'LANGUAGE': 'en_US:en', 00:55:14 INFO - 'LOGNAME': 'cltbld', 00:55:14 INFO - 'MAIL': '/var/mail/cltbld', 00:55:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:55:14 INFO - 'MOZ_NO_REMOTE': '1', 00:55:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:55:14 INFO - 'NO_EM_RESTART': '1', 00:55:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:55:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:55:14 INFO - 'PWD': '/builds/slave/test', 00:55:14 INFO - 'SHELL': '/bin/bash', 00:55:14 INFO - 'SHLVL': '1', 00:55:14 INFO - 'TERM': 'linux', 00:55:14 INFO - 'TMOUT': '86400', 00:55:14 INFO - 'USER': 'cltbld', 00:55:14 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1448528054.765993-1090591871', 00:55:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:55:14 INFO - '_': '/tools/buildbot/bin/python'} 00:55:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:55:15 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 00:55:15 INFO - Cleaning up... 00:55:15 INFO - Return code: 0 00:55:15 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 00:55:15 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')]} 00:55:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:55:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:15 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')]} 00:55:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:55:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:15 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 0x119c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cd210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145f220>, '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 0x13cb2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13cb740>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1448528054.765993-1090591871', '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 00:55:15 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 00:55:15 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 00:55:15 INFO - Using env: {'DISPLAY': ':0', 00:55:15 INFO - 'HOME': '/home/cltbld', 00:55:15 INFO - 'LANG': 'en_US.UTF-8', 00:55:15 INFO - 'LANGUAGE': 'en_US:en', 00:55:15 INFO - 'LOGNAME': 'cltbld', 00:55:15 INFO - 'MAIL': '/var/mail/cltbld', 00:55:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:55:15 INFO - 'MOZ_NO_REMOTE': '1', 00:55:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:55:15 INFO - 'NO_EM_RESTART': '1', 00:55:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:55:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:55:15 INFO - 'PWD': '/builds/slave/test', 00:55:15 INFO - 'SHELL': '/bin/bash', 00:55:15 INFO - 'SHLVL': '1', 00:55:15 INFO - 'TERM': 'linux', 00:55:15 INFO - 'TMOUT': '86400', 00:55:15 INFO - 'USER': 'cltbld', 00:55:15 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1448528054.765993-1090591871', 00:55:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:55:15 INFO - '_': '/tools/buildbot/bin/python'} 00:55:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:55:15 INFO - Downloading/unpacking psutil>=0.7.1 00:55:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:55:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:55:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:55:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:55:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:55:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:55:16 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 00:55:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 00:55:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:55:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:55:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:55:17 INFO - Installing collected packages: psutil 00:55:17 INFO - Running setup.py install for psutil 00:55:17 INFO - building 'psutil._psutil_linux' extension 00:55:17 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 00:55:17 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 00:55:17 INFO - building 'psutil._psutil_posix' extension 00:55:17 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 00:55:17 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 00:55:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:55:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:55:17 INFO - Successfully installed psutil 00:55:17 INFO - Cleaning up... 00:55:17 INFO - Return code: 0 00:55:17 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 00:55:17 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')]} 00:55:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:55:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:17 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')]} 00:55:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:55:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:17 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 0x119c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cd210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145f220>, '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 0x13cb2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13cb740>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1448528054.765993-1090591871', '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 00:55:17 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 00:55:17 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 00:55:17 INFO - Using env: {'DISPLAY': ':0', 00:55:17 INFO - 'HOME': '/home/cltbld', 00:55:17 INFO - 'LANG': 'en_US.UTF-8', 00:55:17 INFO - 'LANGUAGE': 'en_US:en', 00:55:17 INFO - 'LOGNAME': 'cltbld', 00:55:17 INFO - 'MAIL': '/var/mail/cltbld', 00:55:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:55:17 INFO - 'MOZ_NO_REMOTE': '1', 00:55:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:55:17 INFO - 'NO_EM_RESTART': '1', 00:55:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:55:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:55:17 INFO - 'PWD': '/builds/slave/test', 00:55:17 INFO - 'SHELL': '/bin/bash', 00:55:17 INFO - 'SHLVL': '1', 00:55:17 INFO - 'TERM': 'linux', 00:55:17 INFO - 'TMOUT': '86400', 00:55:17 INFO - 'USER': 'cltbld', 00:55:17 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1448528054.765993-1090591871', 00:55:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:55:17 INFO - '_': '/tools/buildbot/bin/python'} 00:55:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:55:17 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:55:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:55:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:55:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:55:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:55:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:55:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:55:19 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:55:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 00:55:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:55:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:55:19 INFO - Installing collected packages: mozsystemmonitor 00:55:19 INFO - Running setup.py install for mozsystemmonitor 00:55:19 INFO - Successfully installed mozsystemmonitor 00:55:19 INFO - Cleaning up... 00:55:19 INFO - Return code: 0 00:55:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:55:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:55:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:55:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:55:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:55:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:19 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 0x119c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cd210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145f220>, '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 0x13cb2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13cb740>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1448528054.765993-1090591871', '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 00:55:19 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 00:55:19 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 00:55:19 INFO - Using env: {'DISPLAY': ':0', 00:55:19 INFO - 'HOME': '/home/cltbld', 00:55:19 INFO - 'LANG': 'en_US.UTF-8', 00:55:19 INFO - 'LANGUAGE': 'en_US:en', 00:55:19 INFO - 'LOGNAME': 'cltbld', 00:55:19 INFO - 'MAIL': '/var/mail/cltbld', 00:55:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:55:19 INFO - 'MOZ_NO_REMOTE': '1', 00:55:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:55:19 INFO - 'NO_EM_RESTART': '1', 00:55:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:55:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:55:19 INFO - 'PWD': '/builds/slave/test', 00:55:19 INFO - 'SHELL': '/bin/bash', 00:55:19 INFO - 'SHLVL': '1', 00:55:19 INFO - 'TERM': 'linux', 00:55:19 INFO - 'TMOUT': '86400', 00:55:19 INFO - 'USER': 'cltbld', 00:55:19 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1448528054.765993-1090591871', 00:55:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:55:19 INFO - '_': '/tools/buildbot/bin/python'} 00:55:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:55:19 INFO - Downloading/unpacking blobuploader==1.2.4 00:55:19 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 00:55:19 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 00:55:19 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 00:55:19 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 00:55:19 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 00:55:19 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 00:55:21 INFO - Downloading blobuploader-1.2.4.tar.gz 00:55:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 00:55:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:55:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:55:21 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 00:55:21 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 00:55:21 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 00:55:21 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 00:55:21 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 00:55:21 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 00:55:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 00:55:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:55:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:55:22 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 00:55:22 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 00:55:22 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 00:55:22 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 00:55:22 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 00:55:22 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 00:55:22 INFO - Downloading docopt-0.6.1.tar.gz 00:55:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 00:55:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:55:22 INFO - Installing collected packages: blobuploader, requests, docopt 00:55:22 INFO - Running setup.py install for blobuploader 00:55:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:55:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:55:22 INFO - Running setup.py install for requests 00:55:22 INFO - Running setup.py install for docopt 00:55:22 INFO - Successfully installed blobuploader requests docopt 00:55:22 INFO - Cleaning up... 00:55:22 INFO - Return code: 0 00:55:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:55:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:55:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:55:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:55:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:55:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:22 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 0x119c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cd210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145f220>, '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 0x13cb2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13cb740>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1448528054.765993-1090591871', '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 00:55:22 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 00:55:22 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 00:55:22 INFO - Using env: {'DISPLAY': ':0', 00:55:22 INFO - 'HOME': '/home/cltbld', 00:55:22 INFO - 'LANG': 'en_US.UTF-8', 00:55:22 INFO - 'LANGUAGE': 'en_US:en', 00:55:22 INFO - 'LOGNAME': 'cltbld', 00:55:22 INFO - 'MAIL': '/var/mail/cltbld', 00:55:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:55:22 INFO - 'MOZ_NO_REMOTE': '1', 00:55:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:55:22 INFO - 'NO_EM_RESTART': '1', 00:55:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:55:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:55:22 INFO - 'PWD': '/builds/slave/test', 00:55:22 INFO - 'SHELL': '/bin/bash', 00:55:22 INFO - 'SHLVL': '1', 00:55:22 INFO - 'TERM': 'linux', 00:55:22 INFO - 'TMOUT': '86400', 00:55:22 INFO - 'USER': 'cltbld', 00:55:22 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1448528054.765993-1090591871', 00:55:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:55:22 INFO - '_': '/tools/buildbot/bin/python'} 00:55:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:55:23 INFO - Running setup.py (path:/tmp/pip-1s_Ja2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:55:23 INFO - Running setup.py (path:/tmp/pip-tJbaqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:55:23 INFO - Running setup.py (path:/tmp/pip-gDZCtU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:55:23 INFO - Running setup.py (path:/tmp/pip-ERJnWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:55:23 INFO - Running setup.py (path:/tmp/pip-ONXj0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:55:23 INFO - Running setup.py (path:/tmp/pip-HtN7WB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:55:23 INFO - Running setup.py (path:/tmp/pip-Rdkeyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:55:23 INFO - Running setup.py (path:/tmp/pip-03_Jn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:55:23 INFO - Running setup.py (path:/tmp/pip-DaQIaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:55:23 INFO - Running setup.py (path:/tmp/pip-YDaMxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:55:23 INFO - Running setup.py (path:/tmp/pip-CxZSPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:55:23 INFO - Running setup.py (path:/tmp/pip-xhkTfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:55:24 INFO - Running setup.py (path:/tmp/pip-1YomAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:55:24 INFO - Running setup.py (path:/tmp/pip-W0yP3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:55:24 INFO - Running setup.py (path:/tmp/pip-j2onrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:55:24 INFO - Running setup.py (path:/tmp/pip-LBxvON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:55:24 INFO - Running setup.py (path:/tmp/pip-YLK1x_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:55:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:55:24 INFO - Running setup.py install for manifestparser 00:55:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:55:24 INFO - Running setup.py install for mozcrash 00:55:24 INFO - Running setup.py install for mozdebug 00:55:24 INFO - Running setup.py install for mozdevice 00:55:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:55:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:55:24 INFO - Running setup.py install for mozfile 00:55:24 INFO - Running setup.py install for mozhttpd 00:55:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:55:25 INFO - Running setup.py install for mozinfo 00:55:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:55:25 INFO - Running setup.py install for mozInstall 00:55:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:55:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:55:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:55:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:55:25 INFO - Running setup.py install for mozleak 00:55:25 INFO - Running setup.py install for mozlog 00:55:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:55:25 INFO - Running setup.py install for moznetwork 00:55:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:55:25 INFO - Running setup.py install for mozprocess 00:55:25 INFO - Running setup.py install for mozprofile 00:55:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:55:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:55:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:55:25 INFO - Running setup.py install for mozrunner 00:55:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:55:25 INFO - Running setup.py install for mozscreenshot 00:55:25 INFO - Running setup.py install for moztest 00:55:26 INFO - Running setup.py install for mozversion 00:55:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:55:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:55:26 INFO - Cleaning up... 00:55:26 INFO - Return code: 0 00:55:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:55:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:55:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:55:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:55:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:55:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:26 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 0x119c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cd210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145f220>, '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 0x13cb2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13cb740>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1448528054.765993-1090591871', '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 00:55:26 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 00:55:26 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 00:55:26 INFO - Using env: {'DISPLAY': ':0', 00:55:26 INFO - 'HOME': '/home/cltbld', 00:55:26 INFO - 'LANG': 'en_US.UTF-8', 00:55:26 INFO - 'LANGUAGE': 'en_US:en', 00:55:26 INFO - 'LOGNAME': 'cltbld', 00:55:26 INFO - 'MAIL': '/var/mail/cltbld', 00:55:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:55:26 INFO - 'MOZ_NO_REMOTE': '1', 00:55:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:55:26 INFO - 'NO_EM_RESTART': '1', 00:55:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:55:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:55:26 INFO - 'PWD': '/builds/slave/test', 00:55:26 INFO - 'SHELL': '/bin/bash', 00:55:26 INFO - 'SHLVL': '1', 00:55:26 INFO - 'TERM': 'linux', 00:55:26 INFO - 'TMOUT': '86400', 00:55:26 INFO - 'USER': 'cltbld', 00:55:26 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1448528054.765993-1090591871', 00:55:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:55:26 INFO - '_': '/tools/buildbot/bin/python'} 00:55:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:55:26 INFO - Running setup.py (path:/tmp/pip-oxca_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:55:26 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)) 00:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:55:26 INFO - Running setup.py (path:/tmp/pip-fMrva0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:55:26 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)) 00:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:55:26 INFO - Running setup.py (path:/tmp/pip-Y4wEu5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:55:26 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)) 00:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:55:26 INFO - Running setup.py (path:/tmp/pip-pGEqmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:55:26 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)) 00:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:55:26 INFO - Running setup.py (path:/tmp/pip-1G7Ykj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:55:26 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)) 00:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:55:26 INFO - Running setup.py (path:/tmp/pip-helXpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:55:26 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)) 00:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:55:26 INFO - Running setup.py (path:/tmp/pip-qolYj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:55:26 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)) 00:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:55:26 INFO - Running setup.py (path:/tmp/pip-qE8I0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:55:26 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)) 00:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:55:26 INFO - Running setup.py (path:/tmp/pip-C1u_fk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:55:27 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)) 00:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:55:27 INFO - Running setup.py (path:/tmp/pip-eClYWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:55:27 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)) 00:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:55:27 INFO - Running setup.py (path:/tmp/pip-LzyHWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:55:27 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)) 00:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:55:27 INFO - Running setup.py (path:/tmp/pip-pqPURI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:55:27 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)) 00:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:55:27 INFO - Running setup.py (path:/tmp/pip-9W3c4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:55:27 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)) 00:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:55:27 INFO - Running setup.py (path:/tmp/pip-Wx38r2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:55:27 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)) 00:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:55:27 INFO - Running setup.py (path:/tmp/pip-6p9SgI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:55:27 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)) 00:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:55:27 INFO - Running setup.py (path:/tmp/pip-2FEE_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:55:27 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)) 00:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:55:27 INFO - Running setup.py (path:/tmp/pip-6wOjdx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:55:27 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)) 00:55:27 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)) 00:55:27 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)) 00:55:27 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)) 00:55:27 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)) 00:55:27 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)) 00:55:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:55:27 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 00:55:27 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 00:55:27 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 00:55:27 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 00:55:27 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 00:55:27 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 00:55:29 INFO - Downloading blessings-1.5.1.tar.gz 00:55:29 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 00:55:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:55:29 INFO - Installing collected packages: blessings 00:55:29 INFO - Running setup.py install for blessings 00:55:29 INFO - Successfully installed blessings 00:55:29 INFO - Cleaning up... 00:55:29 INFO - Return code: 0 00:55:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:55:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:55:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:55:29 INFO - Reading from file tmpfile_stdout 00:55:29 INFO - Current package versions: 00:55:29 INFO - argparse == 1.2.1 00:55:29 INFO - blessings == 1.5.1 00:55:29 INFO - blobuploader == 1.2.4 00:55:29 INFO - docopt == 0.6.1 00:55:29 INFO - manifestparser == 1.1 00:55:29 INFO - mozInstall == 1.12 00:55:29 INFO - mozcrash == 0.16 00:55:29 INFO - mozdebug == 0.1 00:55:29 INFO - mozdevice == 0.47 00:55:29 INFO - mozfile == 1.2 00:55:29 INFO - mozhttpd == 0.7 00:55:29 INFO - mozinfo == 0.9 00:55:29 INFO - mozleak == 0.1 00:55:29 INFO - mozlog == 3.1 00:55:29 INFO - moznetwork == 0.27 00:55:29 INFO - mozprocess == 0.22 00:55:29 INFO - mozprofile == 0.27 00:55:29 INFO - mozrunner == 6.11 00:55:29 INFO - mozscreenshot == 0.1 00:55:29 INFO - mozsystemmonitor == 0.0 00:55:29 INFO - moztest == 0.7 00:55:29 INFO - mozversion == 1.4 00:55:29 INFO - psutil == 3.1.1 00:55:29 INFO - requests == 1.2.3 00:55:29 INFO - wsgiref == 0.1.2 00:55:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:55:29 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')]} 00:55:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:55:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:29 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')]} 00:55:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:55:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:29 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 0x119c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cd210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145f220>, '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 0x13cb2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13cb740>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1448528054.765993-1090591871', '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 00:55:29 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 00:55:29 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 00:55:29 INFO - Using env: {'DISPLAY': ':0', 00:55:29 INFO - 'HOME': '/home/cltbld', 00:55:29 INFO - 'LANG': 'en_US.UTF-8', 00:55:29 INFO - 'LANGUAGE': 'en_US:en', 00:55:29 INFO - 'LOGNAME': 'cltbld', 00:55:29 INFO - 'MAIL': '/var/mail/cltbld', 00:55:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:55:29 INFO - 'MOZ_NO_REMOTE': '1', 00:55:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:55:29 INFO - 'NO_EM_RESTART': '1', 00:55:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:55:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:55:29 INFO - 'PWD': '/builds/slave/test', 00:55:29 INFO - 'SHELL': '/bin/bash', 00:55:29 INFO - 'SHLVL': '1', 00:55:29 INFO - 'TERM': 'linux', 00:55:29 INFO - 'TMOUT': '86400', 00:55:29 INFO - 'USER': 'cltbld', 00:55:29 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1448528054.765993-1090591871', 00:55:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:55:29 INFO - '_': '/tools/buildbot/bin/python'} 00:55:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:55:29 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)) 00:55:29 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)) 00:55:29 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)) 00:55:29 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)) 00:55:29 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)) 00:55:29 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)) 00:55:29 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)) 00:55:29 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)) 00:55:29 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)) 00:55:29 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)) 00:55:29 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)) 00:55:29 INFO - Cleaning up... 00:55:29 INFO - Return code: 0 00:55:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:55:29 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')]} 00:55:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:55:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:29 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')]} 00:55:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:55:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:55:29 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 0x119c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cd210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145f220>, '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 0x13cb2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13cb740>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1448528054.765993-1090591871', '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 00:55:29 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 00:55:29 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 00:55:29 INFO - Using env: {'DISPLAY': ':0', 00:55:29 INFO - 'HOME': '/home/cltbld', 00:55:29 INFO - 'LANG': 'en_US.UTF-8', 00:55:29 INFO - 'LANGUAGE': 'en_US:en', 00:55:29 INFO - 'LOGNAME': 'cltbld', 00:55:29 INFO - 'MAIL': '/var/mail/cltbld', 00:55:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:55:29 INFO - 'MOZ_NO_REMOTE': '1', 00:55:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:55:29 INFO - 'NO_EM_RESTART': '1', 00:55:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:55:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:55:29 INFO - 'PWD': '/builds/slave/test', 00:55:29 INFO - 'SHELL': '/bin/bash', 00:55:29 INFO - 'SHLVL': '1', 00:55:29 INFO - 'TERM': 'linux', 00:55:29 INFO - 'TMOUT': '86400', 00:55:29 INFO - 'USER': 'cltbld', 00:55:29 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1448528054.765993-1090591871', 00:55:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:55:29 INFO - '_': '/tools/buildbot/bin/python'} 00:55:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:55:30 INFO - Downloading/unpacking jsonschema 00:55:30 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 00:55:30 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 00:55:30 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 00:55:30 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 00:55:30 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 00:55:30 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 00:55:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:55:31 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 00:55:31 INFO - Downloading/unpacking functools32 (from jsonschema) 00:55:31 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 00:55:31 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 00:55:31 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 00:55:31 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 00:55:31 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 00:55:31 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 00:55:32 INFO - Downloading functools32-3.2.3-2.tar.gz 00:55:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 00:55:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:55:32 INFO - warning: no files found matching '*.txt' 00:55:32 INFO - no previously-included directories found matching 'build' 00:55:32 INFO - no previously-included directories found matching 'dist' 00:55:32 INFO - no previously-included directories found matching '.git*' 00:55:32 INFO - Installing collected packages: jsonschema, functools32 00:55:32 INFO - Running setup.py install for functools32 00:55:32 INFO - warning: no files found matching '*.txt' 00:55:32 INFO - no previously-included directories found matching 'build' 00:55:32 INFO - no previously-included directories found matching 'dist' 00:55:32 INFO - no previously-included directories found matching '.git*' 00:55:32 INFO - Successfully installed jsonschema functools32 00:55:32 INFO - Cleaning up... 00:55:32 INFO - Return code: 0 00:55:32 INFO - Running post-action listener: _resource_record_post_action 00:55:32 INFO - Running post-action listener: _start_resource_monitoring 00:55:32 INFO - Starting resource monitoring. 00:55:32 INFO - ##### 00:55:32 INFO - ##### Running install step. 00:55:32 INFO - ##### 00:55:32 INFO - Running pre-action listener: _resource_record_pre_action 00:55:32 INFO - Running main action method: install 00:55:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:55:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:55:32 INFO - Reading from file tmpfile_stdout 00:55:32 INFO - Detecting whether we're running mozinstall >=1.0... 00:55:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:55:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:55:32 INFO - Reading from file tmpfile_stdout 00:55:32 INFO - Output received: 00:55:32 INFO - Usage: mozinstall [options] installer 00:55:32 INFO - Options: 00:55:32 INFO - -h, --help show this help message and exit 00:55:32 INFO - -d DEST, --destination=DEST 00:55:32 INFO - Directory to install application into. [default: 00:55:32 INFO - "/builds/slave/test"] 00:55:32 INFO - --app=APP Application being installed. [default: firefox] 00:55:32 INFO - mkdir: /builds/slave/test/build/application 00:55:32 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'] 00:55:32 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 00:55:47 INFO - Reading from file tmpfile_stdout 00:55:47 INFO - Output received: 00:55:47 INFO - /builds/slave/test/build/application/firefox/firefox 00:55:47 INFO - Running post-action listener: _resource_record_post_action 00:55:47 INFO - ##### 00:55:47 INFO - ##### Running run-tests step. 00:55:47 INFO - ##### 00:55:47 INFO - Running pre-action listener: _resource_record_pre_action 00:55:47 INFO - Running main action method: run_tests 00:55:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:55:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:55:47 INFO - Python 2.7.3 00:55:47 INFO - Return code: 0 00:55:47 INFO - grabbing minidump binary from tooltool 00:55: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')]} 00:55:47 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 0x145f220>, '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 0x13cb2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13cb740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:55:47 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 00:55:47 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 00:55:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:55:47 INFO - Return code: 0 00:55:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:55:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:55:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:55:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:55:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:55:47 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/4ed4osCfS3SsX-H5LVtlbA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost'] in /builds/slave/test/build 00:55:47 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/4ed4osCfS3SsX-H5LVtlbA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost 00:55:47 INFO - Using env: {'DISPLAY': ':0', 00:55:47 INFO - 'HOME': '/home/cltbld', 00:55:47 INFO - 'LANG': 'en_US.UTF-8', 00:55:47 INFO - 'LANGUAGE': 'en_US:en', 00:55:47 INFO - 'LOGNAME': 'cltbld', 00:55:47 INFO - 'MAIL': '/var/mail/cltbld', 00:55:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:55:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:55:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:55:47 INFO - 'MOZ_NO_REMOTE': '1', 00:55:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:55:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:55:47 INFO - 'NO_EM_RESTART': '1', 00:55:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:55:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:55:47 INFO - 'PWD': '/builds/slave/test', 00:55:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:55:47 INFO - 'SHELL': '/bin/bash', 00:55:47 INFO - 'SHLVL': '1', 00:55:47 INFO - 'TERM': 'linux', 00:55:47 INFO - 'TMOUT': '86400', 00:55:47 INFO - 'USER': 'cltbld', 00:55:47 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1448528054.765993-1090591871', 00:55:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:55:47 INFO - '_': '/tools/buildbot/bin/python'} 00:55:47 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/4ed4osCfS3SsX-H5LVtlbA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost'] with output_timeout 3600 00:55:47 INFO - mozversion INFO | application_buildid: 20151126002712 00:55:47 INFO - mozversion INFO | application_changeset: f9798fa516433f4b42b0e2fba402ed39523989e5 00:55:47 INFO - mozversion INFO | application_display_name: Nightly 00:55:47 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:55:47 INFO - mozversion INFO | application_name: Firefox 00:55:47 INFO - mozversion INFO | application_remotingname: firefox 00:55:47 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 00:55:47 INFO - mozversion INFO | application_vendor: Mozilla 00:55:47 INFO - mozversion INFO | application_version: 45.0a1 00:55:47 INFO - mozversion INFO | platform_buildid: 20151126002712 00:55:47 INFO - mozversion INFO | platform_changeset: f9798fa516433f4b42b0e2fba402ed39523989e5 00:55:47 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 00:55:47 INFO - mozversion INFO | platform_version: 45.0a1 00:55:47 INFO - 2015-11-26 00:55:47,290 DEBUG : using testdate: 1448528147 00:55:47 INFO - 2015-11-26 00:55:47,290 DEBUG : actual date: 1448528147 00:55:47 INFO - 2015-11-26 00:55:47,299 INFO : starting webserver on 'localhost:42989' 00:55:47 INFO - 2015-11-26 00:55:47,300 INFO : Starting test suite talos-linux64-ix-035 00:55:47 INFO - 2015-11-26 00:55:47,300 INFO : Starting test dromaeo_css 00:55:47 INFO - 2015-11-26 00:55:47,300 DEBUG : operating with platform_type : linux_ 00:55:47 INFO - 2015-11-26 00:55:47,301 INFO : Initialising browser for dromaeo_css test... 00:55:47 INFO - 2015-11-26 00:55:47,315 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1tia2A/profile http://localhost:42989/getInfo.html 00:55:51 INFO - 2015-11-26 00:55:51,371 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 00:55:51 INFO - 2015-11-26 00:55:51,371 DEBUG : BROWSER_OUTPUT: colorDepth:24 00:55:51 INFO - 2015-11-26 00:55:51,371 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 00:55:51 INFO - 2015-11-26 00:55:51,371 DEBUG : BROWSER_OUTPUT: __metrics 00:55:51 INFO - 2015-11-26 00:55:51,516 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] 00:55:52 INFO - 2015-11-26 00:55:52,684 INFO : Browser initialized. 00:55:52 INFO - 2015-11-26 00:55:52,685 INFO : Running cycle 1/1 for dromaeo_css test... 00:55:52 INFO - 2015-11-26 00:55:52,685 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1tia2A/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 00:56:04 INFO - 2015-11-26 00:56:04,548 DEBUG : BROWSER_OUTPUT: RSS: Main: 139026432 00:56:04 INFO - 2015-11-26 00:56:04,548 DEBUG : BROWSER_OUTPUT: 00:56:55 INFO - 2015-11-26 00:56:55,716 DEBUG : BROWSER_OUTPUT: 1448528215715 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] 00:59:07 INFO - 2015-11-26 00:59:07,737 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42989/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42989/tests/dromaeo/cssquery-ext.html) 00:59:08 INFO - 2015-11-26 00:59:08,793 DEBUG : BROWSER_OUTPUT: RSS: Main: 234643456 00:59:08 INFO - 2015-11-26 00:59:08,793 DEBUG : BROWSER_OUTPUT: 01:02:11 INFO - 2015-11-26 01:02:11,226 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42989/tests/dromaeo/cssquery-ext.html (next: http://localhost:42989/tests/dromaeo/cssquery-jquery.html) 01:02:11 INFO - 2015-11-26 01:02:11,798 DEBUG : BROWSER_OUTPUT: RSS: Main: 221761536 01:02:11 INFO - 2015-11-26 01:02:11,798 DEBUG : BROWSER_OUTPUT: 01:05:13 INFO - 2015-11-26 01:05:13,780 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42989/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42989/tests/dromaeo/cssquery-mootools.html) 01:05:14 INFO - 2015-11-26 01:05:14,348 DEBUG : BROWSER_OUTPUT: RSS: Main: 214331392 01:05:14 INFO - 2015-11-26 01:05:14,348 DEBUG : BROWSER_OUTPUT: 01:08:16 INFO - 2015-11-26 01:08:16,254 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42989/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42989/tests/dromaeo/cssquery-prototype.html) 01:08:16 INFO - 2015-11-26 01:08:16,844 DEBUG : BROWSER_OUTPUT: RSS: Main: 200822784 01:08:16 INFO - 2015-11-26 01:08:16,844 DEBUG : BROWSER_OUTPUT: 01:11:19 INFO - 2015-11-26 01:11:19,631 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42989/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42989/tests/dromaeo/cssquery-yui.html) 01:11:20 INFO - 2015-11-26 01:11:20,232 DEBUG : BROWSER_OUTPUT: RSS: Main: 194334720 01:11:20 INFO - 2015-11-26 01:11:20,232 DEBUG : BROWSER_OUTPUT: 01:14:22 INFO - 2015-11-26 01:14:22,702 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42989/tests/dromaeo/cssquery-yui.html (next: http://localhost:42989/tests/dromaeo/cssquery-dojo.html) 01:14:22 INFO - 2015-11-26 01:14:22,952 DEBUG : BROWSER_OUTPUT: RSS: Main: 251793408 01:14:22 INFO - 2015-11-26 01:14:22,953 DEBUG : BROWSER_OUTPUT: 01:14:22 INFO - 2015-11-26 01:14:22,954 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:14:22 INFO - 2015-11-26 01:14:22,954 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:14:22 INFO - 2015-11-26 01:14:22,954 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:14:22 INFO - 2015-11-26 01:14:22,954 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:14:22 INFO - 2015-11-26 01:14:22,956 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2619.6856377234735;2709.701932787394;2710.3495161161313;2725.945481090378;2735.9863200684;4514.841980530682;4623.1909415852215;4638.304254361839;4648.535146485346;4692.2726977318525;4556.635469162467;4571.085782843428;4633.814647414099;4651.906961860761;4660.836870709526;4275;4282.8715138545895;4289.206496798102;4318.309070548705;4333.090051089275;4125.690573207022;4372.868813935587;4378.430803995492;4427.2916333386665;4434;4260.978695106535;4309.31051031835;4324.22164010478;4337.154254920292;4359.607635312837;4281.079567892887;4320.049589090395;4321.114171594815;4322.524522302576;4364.105358401552;4293;4297.828086876521;4299.742015479082;4327.848525301631;4344.478662560513;4366.56334366564;4478.0596074824325;4493.393391892086;4508.211063063951;4588.265877459624;4953.108440480712;4959.156943319645;4960.280759289883;4960.578350840183;4964.453910069889;4982.701037937699;4989.351384320015;4991.251312303184;5036.622253331015;5039.974800126012;4431.667624928144;4539.773011349419;4543.159515489645;4631.58315751584;4676.555727205944;5015.6489045767175;5106.565941894906;5109.182530795055;5115.71863547501;5143.665661731976;4935.605151587864;4941.407031156213;4947.158982972904;4949.381327334083;4989.12690279207;4720.598749106364;4809.398825146856;4812.975935120372;5029.522195391505;5030.119729047402;4832.903341933212;4879.609631229493;4902.338184345139;4903.166461701519;4938.506149385104;4889.119958407449;4910.754462276944;4913.21388577833;4915.090708218991;4949.257611358325;3959.8416063357718;4130.545639979599;4132.2561938850695;4139.110091330378;4170.645495132948;3570.553680789901;3619.9502144377834;3651.2332410193626;3659.2681463707363;3684.5762737285017;4284.143171365739;4285.721428107163;4286.764227967429;4292.306468294994;4327.17783621111;4976.8755781105765;4977.9751101244265;4995.475475075137;4996.950030499648;5022.497750225021;4073.9592604074173;4206.579342065769;4212.641925436372;4265.274903266452;4386.627136693417;4388.846390376321;4396.340548917688;4411.911761764747;4425.557444255549;4450.732956022584;4733.077049975222;4733.763311834464;4735.857924262209;4736.550027747358;4785.090832741768;4763.642726795573;4799.3760811094335;4881.194602890483;4881.609471242221;4983.900321993612;4704.553067458586;4714.198586240279;4716.952830471651;4724.03157352735;4735.384400027974;4895.63282753802;4900.534449227318;4903.068417000758;4909.705417674951;4951.925721114114;4802.423709154924;4889.9022019560125;4909.386326709161;4912.287718280758;5015.774290156879;4784.736839473862;4833.4441539223435;4837.7581120943105;4853.975730121468;4885.780139893643;4829.396325459317;4836.371271734652;4836.395450568679;4838.104950584153;4884.0476107158765;4560.6351491879905;4593.150267200445;4629.328747331685;4669.019505903662;4748.762561871824;4852.17513022794;4906.950930490792;4907.4111106666;4941.950580494293;4946.777395017161;4712.7407992559365;4772.737499437564;4787.712737235777;4795.808167673254;4796.232602783538 01:14:22 INFO - 2015-11-26 01:14:22,959 DEBUG : BROWSER_OUTPUT: |1;ext.html;482.599442462756;500.7471227030349;568.5224411494344;580.0400337441536;580.3471095018105;21629.242976495825;22108.88945555272;36706.81646591767;37325.25349493008;37361.25277494455;40039.39940900889;40563.18873622526;40689.18621627573;40748.185036299255;40748.185036299255;6387.45706614936;6514.869702605945;7804.6878124875075;7937.563434011127;7977.481463704869;10271.332363396392;10529.2103092268;10553.6306229282;10554.261201715883;10558.155347572214;10166.64416745414;10268.28122031458;10291.433971131622;10294.073533381994;10295.794084118314;6502.5448218624715;6621.9006714899315;6624.3375662433855;6632.93367066328;10212.64255751049;9845.55694993727;10087.949560252226;10102.747431314203;10106.595736170544;10110.696679099565;36862.44706329407;37381.252374952346;37453.438198426775;37454.81272593619;37511.43732844009;2487.1543675150538;2637.037481319324;2639.4457163995585;2854.2864283929016;3100.147459448647;26390.208293751217;26484.205473835817;26695;26797.866010670015;27199.864000680067;3384.881529146468;3493.388656985043;3530.9646903531147;3599.9200239928177;3628.727845411605;220168;220715;220962;221491;222173;29121.27196820054;53062;53323.733381332844;53373;53466;32983.83508082444;33141.50287745686;33156.83421582876;33174.3365132696;62297.37702623006;12724.427400766988;13010.414531346112;13027.283499407435;13063.542776002794;13117.212967221998;9755.365901216399;9791.853122203172;9809.068138526829;9809.264305176997;9813.656522021694;18049.187786549635;18121.63756724858;18163.36428225032;18166.727499087523;18186.63626727458;6932.618705971119;7173.6413179340825;7176.425885929113;7210.819729506804;7247.20280769115;784.3803395317749;805.2430715127879;875.3085062800317;922.8464419475655;995.5569771451779;26177.73822261791;27174.3239747697;27475.86262068677;27555.17334479969;29449.85275073611;929.8000929800126;956.0821611253136;961.5576834655997;968.5689868008668;998.1116806042628;12303.630891073282;12648.367581620882;12651.240925544313;12662;13025.674358141123;263491;268086;268227;268404;268638;37427.81286093552;37535.62464375321;37538.81230593829;37551;37551.248975020346;1087.0868470484832;1166.381817636637;1175.0893057880212;1195.5158160944832;1196.2284326609288;23829.285121446384;25369;26778.732212678402;26893.193204203122;26894.462110758068;37887;38189.618103818604;38289;38319;38326;251352;257490;258093;314642;320444;26464.206073817815;26561.33596660099;26575.27946087588;26634;26796.258243214128;33630.159246019044;33970.49044264387;34375.31249375048;34384.312313753086;34649.30701386009;31236.37527249488;32566.674333256364;33166.17084572905;33240;33325.83337083299;27249.72750272472;27474;27502.449951000468;27513.587296190974;27737.722622773515;32016.039518814472;32380.190495236864;32645;32788;32868.83565582157;28577.42845143127;29106.56340154857;29387.41225175527;29473.263168420963;29496.705032949394;21258;21333.253336133163;21365.14539418468;21399.823009734613;21406 01:14:22 INFO - 2015-11-26 01:14:22,961 DEBUG : BROWSER_OUTPUT: |2;jquery.html;320.50161998092966;323.15333825377513;330.4695962979418;335.2674406421967;339.19779720959934;11037.889621103786;11352.829707554394;14925.179115148663;15316.617084572892;15337.23313834308;13857.099288546238;14063.226522541281;14071.648208794786;14073.507427240049;14448.277586120677;4525.705829121097;4881.755912204384;5033.043721692885;5033.421156566987;5616.691081990489;3482.721382289423;3558.5195998540125;5577.442255774431;5652.547796176316;5789.8263052108505;5702;5715.257016587838;5719.799807006755;5735.369109397963;5747.885042299152;5532.3637781655025;5597.468240517185;5600.215969764236;5604;5604.271444712182;4932.7040377577105;4933.703977761345;4939.975300123477;4950.306957025983;4951.603871690256;18411.53971150732;18875.811241887543;18884.339048133388;18965.33621323247;19536.70694939577;1832.3128826689992;1856.2574970011967;1891.5649400637792;1956.3152896486258;1988.5625162464235;8248.175182481704;8591.226789588967;8660.437071590326;8892.244159246471;10217.897821021843;1594.457884319337;1633.4038076102256;1672.6738286034229;1811.70106932356;1821.1895706410653;54931.45068549303;56672.71663641697;56949.71525142389;57366.7131664339;57385;9705.757356066155;9892.25808064398;9934.80130397388;9944.850827237597;10019.098281154731;12170.756584868253;12176.39118044112;12177.086718496148;12179.634610961686;12189.939050304693;6436.3241859605005;6564.606123632598;6600.075989361493;6815.386615204656;6962.825929351706;5953.404659534012;6032.366601506867;6047.455728984412;6066.514678825683;6091.0558863376245;3979.3633018716864;4170.374443833389;4198.85304014358;4221.704480686384;4244.575542445731;1469.0965056490181;1494.6548106703835;1495.3046833222604;1502.3765137468047;1650.8715983211746;765.8583162115027;796.733094413378;799.4523751230425;904.3443503459939;921.576075005505;13698.931505342609;15524.14617196065;15677.529674109795;15748;15867.603309917344;635.640862912453;719.8236432074175;815.9388045896582;826.5619221812449;860.0152825015323;8505.277051450696;8673.306135509145;8934.463932164092;8999.550022498848;9104.998450170477;474765;496087;501203;502756;507337;70509.64745176242;71309.64345178241;71489.2851071493;72615;75584.24415755882;1013.2299452416216;1018.6943916824923;1021.9693409197736;1030.4538594544904;1036.1348274190984;13682.726345473235;13911.234882081582;14166.362513686703;14257.42970281177;14280.714385712019;29662.703372965992;30277.243068923453;32497.675023249463;33382.332353352314;33450.66549334476;42811.57188428076;43223.56776432321;43574;45454.77272613616;46291.3056304149;8962;9088.772780680272;9111.271098312252;9257.074292570689;9292.674756383494;16306.836931630532;16474.835251647808;16487.83512164863;16649.750253746446;16750.497485075466;10118.544665489924;13295.268760218281;13322.800157997444;13569.86430135686;13585.116967397484;12607.43266552989;12756.553520627105;12922;13105.27920964318;13181.340932953506;12826.935865320615;12858.67853303675;13056.477740890257;13154.34228288601;13857.792133118213;8529.275011623833;8763.91236087631;8804.64781408762;8814.382993190415;8821.2060914518;12466.626001219978;12572.057095717675;12609.747805044031;12694.365281736062;13120.737585248433 01:14:22 INFO - 2015-11-26 01:14:22,962 DEBUG : BROWSER_OUTPUT: |3;mootools.html;867.7179916527131;1532.655152590667;1588.833172516886;1605.6307049378643;1655.8840881138326;5525.668459892404;5700.800471983482;6750.662466876655;6939.201991770948;6954.791356259308;6734.730610775563;6752.797416077513;6784.253732089466;6803.455723542117;6812.352826481489;1700.2603867317694;1729.688656041912;2048.795120487947;2084.3538503064024;2087.9791202087936;1752.2640490993813;2059.8455115866295;2111.6515774897125;2113.6406810842195;2116.3121985354746;2022.3629556689668;2052.1381019971573;2052.5894821035777;2052.733144691188;2053.3634573282256;1995.9401217963411;2021.4441028717074;2024.6355655982065;2025.1595587831032;2025.4430031741315;2018.2633338831367;2028.6754119340983;2058.259026750369;2060.577581595769;2062.0720675695848;6908.3437073477935;6929.203141638725;6978.302169783032;6997.300269972962;7002.544834585787;3954.4266081418323;4010.2981978154;4030.496187976503;4030.818613162385;4033.616806403387;2647.1396796041363;2648.2717252755456;2697.932551686204;2704.2157774245447;2718.293243756618;832.2883934236202;845.2984023260678;857.8541647919868;865.6796985115485;875.5534677314552;9216.216621587173;9238;9260.861087083698;9269.165775080275;9272.814543709088;3820.4651348810635;3858.2090671412293;3901.1612503311358;3911.843526258918;3920.157166209279;7960.4825686330205;7962.402819788539;7962.920370796218;7963;7963.681452741941;4010.8997275068355;4016.116454380032;4019.4975628046495;4057.6145266199665;4059.9797001014804;3663.853445862189;3665.908352291214;3666.138457462494;3666.3034023535442;3668.2663467306647;2678.424138810165;3346.397648423307;3353.782004169721;3396.1679388549965;3396.5075064115563;811.6631597886928;999.860019597257;1027.6300531808542;1029.3978022856713;1042.1089968077335;772.4091070331201;775.83707421441;776.0454640791858;817.5871185051511;863.447393668053;6354.650494222769;6385.425311721968;6422.74309027643;6427.100205971168;6427.807165785034;963.2149797914817;971.1842052675786;997.6332424578229;997.6508222122344;1043.1758910460803;4881.414230292387;4925.950740492621;5012.122878496249;5014.323066385991;5015.473375295542;8003.799905002305;8272;8274.420790544604;8277.130901255401;8294.29498492635;7910.16943220965;8066.15305392937;8166.75499734997;8173.019237691515;8176.6320515576945;6025.096235564701;6043.123747056652;6062.575619706667;6084.056971169476;6091.48222401092;6065.3934606539;6138.478229350555;6151.108089326933;6153.6923153841235;6162;7287.672054757655;7292.48952573336;7293.562386256842;7304.525205861814;7310.049693539806;7331.266873312626;7606.657700403384;7618.6190690466365;7755.379569634303;7767.844643107219;5890.793822216202;5962.135490353788;5985.850353741017;6001.129836173817;6022.759089636365;5246.449122842047;6480.384363485461;6517.8696426072165;6527.706253218712;6531.314212007861;4938.456769755396;6076.54425918049;6205.906911396423;6249.0626406039455;6296.150019747459;6155.2921414037955;6179.567430280017;6229.750809967551;6261.186045814015;6272.529560283088;6158.568900177123;6183.196184495987;6188.319284878749;6189.907151392823;6192.473639740672;5727.8854422912145;5731;5823;5833.67914764692;5847.853803654943;5911.96540605401;5950.137230101697;5954.315253745702;5955.940440595538;5967.1049342597225 01:14:22 INFO - 2015-11-26 01:14:22,963 DEBUG : BROWSER_OUTPUT: |4;prototype.html;299.7407242735034;302.50238357901253;306.1351681499763;308.94902341113715;310.52024621959083;5418.376886658036;5463.972680136599;5533.142362933751;5539.889202215963;5545.972270138654;5416.187571864222;5427.185922111676;5428.022955867942;5430.67415955042;5444.156155795858;3941.664958478518;4237.194932962742;4240.915181696364;4247.8300867965245;4251.107267473826;4036.8183431745642;4119.114390406062;4160.979195104021;4182.811773470201;4192.727472714279;4134;4147.585241475858;4148.8133034013545;4156.625903668669;4160.084781348099;3936.153726948691;4019.5980401959864;4089.0799570096788;4150.501939767232;4158.168366326731;3696.9260614787822;3707.9629203707887;3717.9442308365396;3722.4788529605876;3727.7949712765785;5233.084210263189;5233.738313084368;5237.214417837316;5239.423663397023;5252.1596544552685;4836.2503811908855;4844.733539655317;4848.830290939835;4850.781714822806;4852.150873597142;5556.083246264361;5686.772529098831;5703.686297253649;5706.629069110536;5710.571707121982;4014.6186112319283;4019.1760689058965;4021.055052062763;4022.4770779798732;4030.234255491447;5993.910091348634;6006.279246490405;6006.969965150146;6008.3390827009;6008.519318454513;4136.565660605654;4137.2552940471005;4141.79291035447;4144.44050053239;4149.439825623563;4106.199291138199;4211.557786432441;4211.642010429086;4215.3044747616295;4228.809703563347;4792.976035119802;4803.063402636452;4808.326834243208;4813.807447702053;4817.8313759018265;5671.688057156896;5681.119426488901;5681.971590142023;5687.800926967537;5692.943070569324;1466.1569597481491;1484.4136566056347;1485.9405623775144;1486.5837565481681;1487.4124720735465;1002.5137808163036;1013.7364285285731;1019.4342140112309;1032;1044.8432735089798;4988.276699878497;5007;5007.924881126786;5020.497950205024;5026.321446604735;5900.4984576310635;5918.911216331759;5926.051831706906;5926.525877929756;5926.970365148147;5001.7499125043605;5014.974925125424;5015.824446144367;5017.247412888096;5020.673656212408;2774.639296891391;2994.6705862355125;3064.4483992881496;3163.4463968805367;3193.9041828745176;5596.2165296858475;5644.689542075225;5650.63270887391;5651.943480565224;5653.575981801299;6129.957907155795;6132.570720049643;6134.7852825151795;6136.140940268366;6136.969315153396;5638.097904335369;5641.464060914206;5650.23721797552;5651.039323315046;5651.067573850269;5816.651000939957;5917;5975.043992961106;5981.581289309706;5998.190244316961;5838.416158384298;5849.444302791228;5851.385604511465;5859.296884373732;5860.824175274749;5666.206731057573;5667.093265077568;5667.149927510742;5669.85825354353;5672.376038635664;4028.818703158306;4075.3886916962692;4077.89805254871;4081.326581114202;4082.1427500225286;5683.147527870852;5869.8553782012095;5877.764889404376;5978.163057171912;5980.401959804159;5605.859853503532;5651.689157096399;5659.094544872801;5659.26429564154;5751.252337196138;5558.333000040021;5721.799737009351;5743.167240750151;5743.798967036134;5746.741396637245;5431.6740995540395;5560.443955604407;5621.550275977994;5627.803026894039;5630.634008789416;5770.798022069207;5779.566532509994;5779.768809247583;5780.364159942487;5781.392953739965;5626.662400255997;5628.043232650377;5629.718514074362;5631.831045068655;5633.324001119728 01:14:22 INFO - 2015-11-26 01:14:22,965 DEBUG : BROWSER_OUTPUT: |5;yui.html;520.6407578770647;587.4301927130682;614.1984709953509;623.0902881792582;626.9341719119492;11489.655310340693;11725.120615953794;11748.941255293723;11760.882391176086;11778;11926;12108.636740897766;12109.757804843897;12126.090543209251;12137.271763694185;287.9568064790288;291.0946954970052;749.4491548711707;767.9155292917775;771.2249189564479;286.0930849208005;764.4916130773029;778.8286576953061;779.3920741821388;779.7894568466511;792.8374683189933;812.9430939834214;813.3899575318511;813.4753084260678;813.7477382011596;296.3613413094784;296.7892796114761;794.1542257495748;799.6721344248859;801.5911884938694;596.0612036043206;597.7250464786204;597.9760809567612;598.592956789383;599.1462166412888;11436.42817859112;11457.026152777024;11463.598774042952;11467;11473.885261147365;11133.28546314405;11470.02504787094;11628.476718547601;11679.182457227997;12551.686207844785;9196.540172991323;9288.72133835986;9315.860262096074;9518.476483793458;9607.807843843153;3316.4196265653413;3336;3340.6964334466707;3363.865445382182;3441.174118211636;41911;42688.78655606702;42847.57152428467;42866.57133428626;42955.14089718188;9648.565814538362;9668.178204852666;9703.466309352913;9811.803763924681;9966.651167209113;16130.354785808671;16260.268287927072;16304.836951630332;16306.918465407596;16309.347626094823;5713.514351280188;5828.184054232411;5919.644821310735;6071.574989750763;6097.3292937776805;3570.303790760777;3574.249407624428;3607.2424790793702;3612.259486805199;3613.060604242916;2692.8788204530842;2726.386563023304;2732.988794146179;2737.931551711223;2740.1642499037584;457.489898762877;460.44516357788785;462.72236658004925;472.54635549872506;473.13652584034276;550.5705549671263;577.8587290102099;578.8089930322983;599.1133122978017;603.836964019721;7067.71729130829;7219.927800722031;7319.1217053952805;7375.37309328713;7801.531908085533;322.19933465338613;429.7786639880464;486.5353587324097;572.6920510343323;628.7956414165415;3376.7805092668896;3436.8453419596176;3455.6544345565244;3723.162288485069;3837.654611085016;49491;50265.497345026815;50533;50834.74582627137;50873;42668.359974600404;43529.78235108804;44032.339514907304;44110;44155;40314.19371612551;40329.39505907414;41682.37476437856;42026.789866051084;42158.367624485654;7206.675699593426;7310.122785265802;7459.664315105725;7463.328300452985;7567.583782891994;32186.83906580452;32602.34795304128;33080.33839323248;33247.168820779676;33262;37550.81224593859;38814.4177837327;39373.80313098416;40870.38694419526;40907;9312.767180820263;9523.523823808644;9883.209343252667;9937;10097.343672661253;10705.89294107049;11062.557497700323;11105.888941110485;11109.388983605979;11150;9340.71977840666;9561.9043809561;9596.376235544667;9624.951875240578;10291.125254353465;9992.400455972665;10052;10098.8485172721;10131.594736210469;10448.791024179625;10018.499075046073;10140.138088262285;10165.44090075053;10439;10568.947155264175;8248.340132789242;8413.158684131538;8441.32469402434;8456;8557.229849313591;8383.538905360263;8514.574271286287;8622.698205562776;8751.081136480578;8963.641454341754 01:14:22 INFO - 2015-11-26 01:14:22,965 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:14:22 INFO - 2015-11-26 01:14:22,965 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:14:22 INFO - 2015-11-26 01:14:22,965 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,884 01:14:22 INFO - 2015-11-26 01:14:22,965 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:14:22 INFO - 2015-11-26 01:14:22,965 DEBUG : BROWSER_OUTPUT: __startTimestamp1448529262953__endTimestamp 01:14:22 INFO - 2015-11-26 01:14:22,966 DEBUG : BROWSER_OUTPUT: 01:14:22 INFO - 2015-11-26 01:14:22,966 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:14:22 INFO - 2015-11-26 01:14:22,966 DEBUG : BROWSER_OUTPUT: Number of tests: 6 01:14:22 INFO - 2015-11-26 01:14:22,966 DEBUG : BROWSER_OUTPUT: 01:14:22 INFO - 2015-11-26 01:14:22,966 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4579.52 Median:4716.95 stddev:467.16 (9.9%) stddev-sans-first:442.57 01:14:22 INFO - 2015-11-26 01:14:22,967 DEBUG : BROWSER_OUTPUT: Values: 2619.7 2709.7 2710.3 2725.9 2736.0 4514.8 4623.2 4638.3 4648.5 4692.3 4556.6 4571.1 4633.8 4651.9 4660.8 4275.0 4282.9 4289.2 4318.3 4333.1 4125.7 4372.9 4378.4 4427.3 4434.0 4261.0 4309.3 4324.2 4337.2 4359.6 4281.1 4320.0 4321.1 4322.5 4364.1 4293.0 4297.8 4299.7 4327.8 4344.5 4366.6 4478.1 4493.4 4508.2 4588.3 4953.1 4959.2 4960.3 4960.6 4964.5 4982.7 4989.4 4991.3 5036.6 5040.0 4431.7 4539.8 4543.2 4631.6 4676.6 5015.6 5106.6 5109.2 5115.7 5143.7 4935.6 4941.4 4947.2 4949.4 4989.1 4720.6 4809.4 4813.0 5029.5 5030.1 4832.9 4879.6 4902.3 4903.2 4938.5 4889.1 4910.8 4913.2 4915.1 4949.3 3959.8 4130.5 4132.3 4139.1 4170.6 3570.6 3620.0 3651.2 3659.3 3684.6 4284.1 4285.7 4286.8 4292.3 4327.2 4976.9 4978.0 4995.5 4997.0 5022.5 4074.0 4206.6 4212.6 4265.3 4386.6 4388.8 4396.3 4411.9 4425.6 4450.7 4733.1 4733.8 4735.9 4736.6 4785.1 4763.6 4799.4 4881.2 4881.6 4983.9 4704.6 4714.2 4717.0 4724.0 4735.4 4895.6 4900.5 4903.1 4909.7 4951.9 4802.4 4889.9 4909.4 4912.3 5015.8 4784.7 4833.4 4837.8 4854.0 4885.8 4829.4 4836.4 4836.4 4838.1 4884.0 4560.6 4593.2 4629.3 4669.0 4748.8 4852.2 4907.0 4907.4 4942.0 4946.8 4712.7 4772.7 4787.7 4795.8 4796.2 01:14:22 INFO - 2015-11-26 01:14:22,967 DEBUG : BROWSER_OUTPUT: 01:14:22 INFO - 2015-11-26 01:14:22,967 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40035.41 Median:17168.26 stddev:67419.97 (392.7%) stddev-sans-first:67543.70 01:14:22 INFO - 2015-11-26 01:14:22,968 DEBUG : BROWSER_OUTPUT: Values: 482.6 500.7 568.5 580.0 580.3 21629.2 22108.9 36706.8 37325.3 37361.3 40039.4 40563.2 40689.2 40748.2 40748.2 6387.5 6514.9 7804.7 7937.6 7977.5 10271.3 10529.2 10553.6 10554.3 10558.2 10166.6 10268.3 10291.4 10294.1 10295.8 6502.5 6621.9 6624.3 6632.9 10212.6 9845.6 10087.9 10102.7 10106.6 10110.7 36862.4 37381.3 37453.4 37454.8 37511.4 2487.2 2637.0 2639.4 2854.3 3100.1 26390.2 26484.2 26695.0 26797.9 27199.9 3384.9 3493.4 3531.0 3599.9 3628.7 220168.0 220715.0 220962.0 221491.0 222173.0 29121.3 53062.0 53323.7 53373.0 53466.0 32983.8 33141.5 33156.8 33174.3 62297.4 12724.4 13010.4 13027.3 13063.5 13117.2 9755.4 9791.9 9809.1 9809.3 9813.7 18049.2 18121.6 18163.4 18166.7 18186.6 6932.6 7173.6 7176.4 7210.8 7247.2 784.4 805.2 875.3 922.8 995.6 26177.7 27174.3 27475.9 27555.2 29449.9 929.8 956.1 961.6 968.6 998.1 12303.6 12648.4 12651.2 12662.0 13025.7 263491.0 268086.0 268227.0 268404.0 268638.0 37427.8 37535.6 37538.8 37551.0 37551.2 1087.1 1166.4 1175.1 1195.5 1196.2 23829.3 25369.0 26778.7 26893.2 26894.5 37887.0 38189.6 38289.0 38319.0 38326.0 251352.0 257490.0 258093.0 314642.0 320444.0 26464.2 26561.3 26575.3 26634.0 26796.3 33630.2 33970.5 34375.3 34384.3 34649.3 31236.4 32566.7 33166.2 33240.0 33325.8 27249.7 27474.0 27502.4 27513.6 27737.7 32016.0 32380.2 32645.0 32788.0 32868.8 28577.4 29106.6 29387.4 29473.3 29496.7 21258.0 21333.3 21365.1 21399.8 21406.0 01:14:22 INFO - 2015-11-26 01:14:22,968 DEBUG : BROWSER_OUTPUT: 01:14:22 INFO - 2015-11-26 01:14:22,968 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26510.35 Median:4184.61 stddev:81127.46 (1938.7%) stddev-sans-first:81331.21 01:14:22 INFO - 2015-11-26 01:14:22,968 DEBUG : BROWSER_OUTPUT: Values: 320.5 323.2 330.5 335.3 339.2 11037.9 11352.8 14925.2 15316.6 15337.2 13857.1 14063.2 14071.6 14073.5 14448.3 4525.7 4881.8 5033.0 5033.4 5616.7 3482.7 3558.5 5577.4 5652.5 5789.8 5702.0 5715.3 5719.8 5735.4 5747.9 5532.4 5597.5 5600.2 5604.0 5604.3 4932.7 4933.7 4940.0 4950.3 4951.6 18411.5 18875.8 18884.3 18965.3 19536.7 1832.3 1856.3 1891.6 1956.3 1988.6 8248.2 8591.2 8660.4 8892.2 10217.9 1594.5 1633.4 1672.7 1811.7 1821.2 54931.5 56672.7 56949.7 57366.7 57385.0 9705.8 9892.3 9934.8 9944.9 10019.1 12170.8 12176.4 12177.1 12179.6 12189.9 6436.3 6564.6 6600.1 6815.4 6962.8 5953.4 6032.4 6047.5 6066.5 6091.1 3979.4 4170.4 4198.9 4221.7 4244.6 1469.1 1494.7 1495.3 1502.4 1650.9 765.9 796.7 799.5 904.3 921.6 13698.9 15524.1 15677.5 15748.0 15867.6 635.6 719.8 815.9 826.6 860.0 8505.3 8673.3 8934.5 8999.6 9105.0 474765.0 496087.0 501203.0 502756.0 507337.0 70509.6 71309.6 71489.3 72615.0 75584.2 1013.2 1018.7 1022.0 1030.5 1036.1 13682.7 13911.2 14166.4 14257.4 14280.7 29662.7 30277.2 32497.7 33382.3 33450.7 42811.6 43223.6 43574.0 45454.8 46291.3 8962.0 9088.8 9111.3 9257.1 9292.7 16306.8 16474.8 16487.8 16649.8 16750.5 10118.5 13295.3 13322.8 13569.9 13585.1 12607.4 12756.6 12922.0 13105.3 13181.3 12826.9 12858.7 13056.5 13154.3 13857.8 8529.3 8763.9 8804.6 8814.4 8821.2 12466.6 12572.1 12609.7 12694.4 13120.7 01:14:22 INFO - 2015-11-26 01:14:22,968 DEBUG : BROWSER_OUTPUT: 01:14:22 INFO - 2015-11-26 01:14:22,968 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4753.58 Median:6070.97 stddev:2460.51 (40.5%) stddev-sans-first:2450.07 01:14:22 INFO - 2015-11-26 01:14:22,969 DEBUG : BROWSER_OUTPUT: Values: 867.7 1532.7 1588.8 1605.6 1655.9 5525.7 5700.8 6750.7 6939.2 6954.8 6734.7 6752.8 6784.3 6803.5 6812.4 1700.3 1729.7 2048.8 2084.4 2088.0 1752.3 2059.8 2111.7 2113.6 2116.3 2022.4 2052.1 2052.6 2052.7 2053.4 1995.9 2021.4 2024.6 2025.2 2025.4 2018.3 2028.7 2058.3 2060.6 2062.1 6908.3 6929.2 6978.3 6997.3 7002.5 3954.4 4010.3 4030.5 4030.8 4033.6 2647.1 2648.3 2697.9 2704.2 2718.3 832.3 845.3 857.9 865.7 875.6 9216.2 9238.0 9260.9 9269.2 9272.8 3820.5 3858.2 3901.2 3911.8 3920.2 7960.5 7962.4 7962.9 7963.0 7963.7 4010.9 4016.1 4019.5 4057.6 4060.0 3663.9 3665.9 3666.1 3666.3 3668.3 2678.4 3346.4 3353.8 3396.2 3396.5 811.7 999.9 1027.6 1029.4 1042.1 772.4 775.8 776.0 817.6 863.4 6354.7 6385.4 6422.7 6427.1 6427.8 963.2 971.2 997.6 997.7 1043.2 4881.4 4926.0 5012.1 5014.3 5015.5 8003.8 8272.0 8274.4 8277.1 8294.3 7910.2 8066.2 8166.8 8173.0 8176.6 6025.1 6043.1 6062.6 6084.1 6091.5 6065.4 6138.5 6151.1 6153.7 6162.0 7287.7 7292.5 7293.6 7304.5 7310.0 7331.3 7606.7 7618.6 7755.4 7767.8 5890.8 5962.1 5985.9 6001.1 6022.8 5246.4 6480.4 6517.9 6527.7 6531.3 4938.5 6076.5 6205.9 6249.1 6296.2 6155.3 6179.6 6229.8 6261.2 6272.5 6158.6 6183.2 6188.3 6189.9 6192.5 5727.9 5731.0 5823.0 5833.7 5847.9 5912.0 5950.1 5954.3 5955.9 5967.1 01:14:22 INFO - 2015-11-26 01:14:22,970 DEBUG : BROWSER_OUTPUT: 01:14:22 INFO - 2015-11-26 01:14:22,970 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4743.51 Median:5417.28 stddev:1400.22 (25.8%) stddev-sans-first:1363.84 01:14:22 INFO - 2015-11-26 01:14:22,970 DEBUG : BROWSER_OUTPUT: Values: 299.7 302.5 306.1 308.9 310.5 5418.4 5464.0 5533.1 5539.9 5546.0 5416.2 5427.2 5428.0 5430.7 5444.2 3941.7 4237.2 4240.9 4247.8 4251.1 4036.8 4119.1 4161.0 4182.8 4192.7 4134.0 4147.6 4148.8 4156.6 4160.1 3936.2 4019.6 4089.1 4150.5 4158.2 3696.9 3708.0 3717.9 3722.5 3727.8 5233.1 5233.7 5237.2 5239.4 5252.2 4836.3 4844.7 4848.8 4850.8 4852.2 5556.1 5686.8 5703.7 5706.6 5710.6 4014.6 4019.2 4021.1 4022.5 4030.2 5993.9 6006.3 6007.0 6008.3 6008.5 4136.6 4137.3 4141.8 4144.4 4149.4 4106.2 4211.6 4211.6 4215.3 4228.8 4793.0 4803.1 4808.3 4813.8 4817.8 5671.7 5681.1 5682.0 5687.8 5692.9 1466.2 1484.4 1485.9 1486.6 1487.4 1002.5 1013.7 1019.4 1032.0 1044.8 4988.3 5007.0 5007.9 5020.5 5026.3 5900.5 5918.9 5926.1 5926.5 5927.0 5001.7 5015.0 5015.8 5017.2 5020.7 2774.6 2994.7 3064.4 3163.4 3193.9 5596.2 5644.7 5650.6 5651.9 5653.6 6130.0 6132.6 6134.8 6136.1 6137.0 5638.1 5641.5 5650.2 5651.0 5651.1 5816.7 5917.0 5975.0 5981.6 5998.2 5838.4 5849.4 5851.4 5859.3 5860.8 5666.2 5667.1 5667.1 5669.9 5672.4 4028.8 4075.4 4077.9 4081.3 4082.1 5683.1 5869.9 5877.8 5978.2 5980.4 5605.9 5651.7 5659.1 5659.3 5751.3 5558.3 5721.8 5743.2 5743.8 5746.7 5431.7 5560.4 5621.6 5627.8 5630.6 5770.8 5779.6 5779.8 5780.4 5781.4 5626.7 5628.0 5629.7 5631.8 5633.3 01:14:22 INFO - 2015-11-26 01:14:22,970 DEBUG : BROWSER_OUTPUT: 01:14:22 INFO - 2015-11-26 01:14:22,970 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12223.18 Median:44071.17 stddev:14079.37 (31.9%) stddev-sans-first:14091.44 01:14:22 INFO - 2015-11-26 01:14:22,970 DEBUG : BROWSER_OUTPUT: Values: 520.6 587.4 614.2 623.1 626.9 11489.7 11725.1 11748.9 11760.9 11778.0 11926.0 12108.6 12109.8 12126.1 12137.3 288.0 291.1 749.4 767.9 771.2 286.1 764.5 778.8 779.4 779.8 792.8 812.9 813.4 813.5 813.7 296.4 296.8 794.2 799.7 801.6 596.1 597.7 598.0 598.6 599.1 11436.4 11457.0 11463.6 11467.0 11473.9 11133.3 11470.0 11628.5 11679.2 12551.7 9196.5 9288.7 9315.9 9518.5 9607.8 3316.4 3336.0 3340.7 3363.9 3441.2 41911.0 42688.8 42847.6 42866.6 42955.1 9648.6 9668.2 9703.5 9811.8 9966.7 16130.4 16260.3 16304.8 16306.9 16309.3 5713.5 5828.2 5919.6 6071.6 6097.3 3570.3 3574.2 3607.2 3612.3 3613.1 2692.9 2726.4 2733.0 2737.9 2740.2 457.5 460.4 462.7 472.5 473.1 550.6 577.9 578.8 599.1 603.8 7067.7 7219.9 7319.1 7375.4 7801.5 322.2 429.8 486.5 572.7 628.8 3376.8 3436.8 3455.7 3723.2 3837.7 49491.0 50265.5 50533.0 50834.7 50873.0 42668.4 43529.8 44032.3 44110.0 44155.0 40314.2 40329.4 41682.4 42026.8 42158.4 7206.7 7310.1 7459.7 7463.3 7567.6 32186.8 32602.3 33080.3 33247.2 33262.0 37550.8 38814.4 39373.8 40870.4 40907.0 9312.8 9523.5 9883.2 9937.0 10097.3 10705.9 11062.6 11105.9 11109.4 11150.0 9340.7 9561.9 9596.4 9625.0 10291.1 9992.4 10052.0 10098.8 10131.6 10448.8 10018.5 10140.1 10165.4 10439.0 10568.9 8248.3 8413.2 8441.3 8456.0 8557.2 8383.5 8514.6 8622.7 8751.1 8963.6 01:14:22 INFO - 2015-11-26 01:14:22,970 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:14:22 INFO - 2015-11-26 01:14:22,970 DEBUG : BROWSER_OUTPUT: 01:14:23 INFO - 2015-11-26 01:14:23,677 INFO : Browser exited with error code: 0 01:14:23 INFO - 2015-11-26 01:14:23,696 INFO : Completed test dromaeo_css (00:18:36) 01:14:23 INFO - 2015-11-26 01:14:23,696 INFO : Starting test kraken 01:14:23 INFO - 2015-11-26 01:14:23,696 DEBUG : operating with platform_type : linux_ 01:14:23 INFO - 2015-11-26 01:14:23,696 INFO : Initialising browser for kraken test... 01:14:23 INFO - 2015-11-26 01:14:23,702 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSnmcOG/profile http://localhost:42989/getInfo.html 01:14:27 INFO - 2015-11-26 01:14:27,582 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:14:27 INFO - 2015-11-26 01:14:27,583 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:14:27 INFO - 2015-11-26 01:14:27,583 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:14:27 INFO - 2015-11-26 01:14:27,583 DEBUG : BROWSER_OUTPUT: __metrics 01:14:27 INFO - 2015-11-26 01:14:27,732 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:14:28 INFO - 2015-11-26 01:14:28,971 INFO : Browser initialized. 01:14:28 INFO - 2015-11-26 01:14:28,972 INFO : Running cycle 1/1 for kraken test... 01:14:28 INFO - 2015-11-26 01:14:28,972 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSnmcOG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:14:40 INFO - 2015-11-26 01:14:40,919 DEBUG : BROWSER_OUTPUT: RSS: Main: 139055104 01:14:40 INFO - 2015-11-26 01:14:40,919 DEBUG : BROWSER_OUTPUT: 01:14:43 INFO - 2015-11-26 01:14:43,518 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42989/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42989/tests/kraken/driver.html?testName=audio-beat-detection) 01:14:44 INFO - 2015-11-26 01:14:44,101 DEBUG : BROWSER_OUTPUT: RSS: Main: 176209920 01:14:44 INFO - 2015-11-26 01:14:44,101 DEBUG : BROWSER_OUTPUT: 01:14:46 INFO - 2015-11-26 01:14:46,823 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42989/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42989/tests/kraken/driver.html?testName=audio-dft) 01:14:47 INFO - 2015-11-26 01:14:47,396 DEBUG : BROWSER_OUTPUT: RSS: Main: 164839424 01:14:47 INFO - 2015-11-26 01:14:47,396 DEBUG : BROWSER_OUTPUT: 01:14:50 INFO - 2015-11-26 01:14:50,400 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42989/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42989/tests/kraken/driver.html?testName=audio-fft) 01:14:50 INFO - 2015-11-26 01:14:50,973 DEBUG : BROWSER_OUTPUT: RSS: Main: 153157632 01:14:50 INFO - 2015-11-26 01:14:50,973 DEBUG : BROWSER_OUTPUT: 01:14:52 INFO - 2015-11-26 01:14:52,990 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42989/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42989/tests/kraken/driver.html?testName=audio-oscillator) 01:14:53 INFO - 2015-11-26 01:14:53,571 DEBUG : BROWSER_OUTPUT: RSS: Main: 154537984 01:14:53 INFO - 2015-11-26 01:14:53,572 DEBUG : BROWSER_OUTPUT: 01:14:55 INFO - 2015-11-26 01:14:55,830 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42989/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42989/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:14:56 INFO - 2015-11-26 01:14:56,396 DEBUG : BROWSER_OUTPUT: RSS: Main: 153604096 01:14:56 INFO - 2015-11-26 01:14:56,397 DEBUG : BROWSER_OUTPUT: 01:14:59 INFO - 2015-11-26 01:14:59,360 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42989/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42989/tests/kraken/driver.html?testName=imaging-darkroom) 01:14:59 INFO - 2015-11-26 01:14:59,941 DEBUG : BROWSER_OUTPUT: RSS: Main: 154497024 01:14:59 INFO - 2015-11-26 01:14:59,942 DEBUG : BROWSER_OUTPUT: 01:15:03 INFO - 2015-11-26 01:15:03,375 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42989/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42989/tests/kraken/driver.html?testName=imaging-desaturate) 01:15:03 INFO - 2015-11-26 01:15:03,956 DEBUG : BROWSER_OUTPUT: RSS: Main: 155684864 01:15:03 INFO - 2015-11-26 01:15:03,957 DEBUG : BROWSER_OUTPUT: 01:15:06 INFO - 2015-11-26 01:15:06,815 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42989/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42989/tests/kraken/driver.html?testName=json-parse-financial) 01:15:07 INFO - 2015-11-26 01:15:07,388 DEBUG : BROWSER_OUTPUT: RSS: Main: 155131904 01:15:07 INFO - 2015-11-26 01:15:07,388 DEBUG : BROWSER_OUTPUT: 01:15:09 INFO - 2015-11-26 01:15:09,138 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42989/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42989/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:15:09 INFO - 2015-11-26 01:15:09,703 DEBUG : BROWSER_OUTPUT: RSS: Main: 166973440 01:15:09 INFO - 2015-11-26 01:15:09,703 DEBUG : BROWSER_OUTPUT: 01:15:11 INFO - 2015-11-26 01:15:11,573 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42989/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42989/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:15:12 INFO - 2015-11-26 01:15:12,167 DEBUG : BROWSER_OUTPUT: RSS: Main: 166043648 01:15:12 INFO - 2015-11-26 01:15:12,167 DEBUG : BROWSER_OUTPUT: 01:15:14 INFO - 2015-11-26 01:15:14,303 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42989/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42989/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:15:14 INFO - 2015-11-26 01:15:14,877 DEBUG : BROWSER_OUTPUT: RSS: Main: 174739456 01:15:14 INFO - 2015-11-26 01:15:14,877 DEBUG : BROWSER_OUTPUT: 01:15:17 INFO - 2015-11-26 01:15:17,484 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42989/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42989/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:15:18 INFO - 2015-11-26 01:15:18,069 DEBUG : BROWSER_OUTPUT: RSS: Main: 181596160 01:15:18 INFO - 2015-11-26 01:15:18,069 DEBUG : BROWSER_OUTPUT: 01:15:20 INFO - 2015-11-26 01:15:20,648 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42989/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42989/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:15:21 INFO - 2015-11-26 01:15:21,221 DEBUG : BROWSER_OUTPUT: RSS: Main: 179023872 01:15:21 INFO - 2015-11-26 01:15:21,221 DEBUG : BROWSER_OUTPUT: 01:15:22 INFO - 2015-11-26 01:15:22,955 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42989/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42989/tests/kraken/driver.html?testName=ai-astar) 01:15:23 INFO - 2015-11-26 01:15:23,213 DEBUG : BROWSER_OUTPUT: RSS: Main: 236695552 01:15:23 INFO - 2015-11-26 01:15:23,213 DEBUG : BROWSER_OUTPUT: 01:15:23 INFO - 2015-11-26 01:15:23,213 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:15:23 INFO - 2015-11-26 01:15:23,213 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:15:23 INFO - 2015-11-26 01:15:23,214 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:15:23 INFO - 2015-11-26 01:15:23,214 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:15:23 INFO - 2015-11-26 01:15:23,214 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;113;107;113;112;112;101;111;112;105 01:15:23 INFO - 2015-11-26 01:15:23,214 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;130;156;165;132;155;169;134;174;129 01:15:23 INFO - 2015-11-26 01:15:23,215 DEBUG : BROWSER_OUTPUT: |2;audio-dft;165;163;163;162;162;163;163;165;164;162 01:15:23 INFO - 2015-11-26 01:15:23,215 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;72;87;91;71;73;73;111;91;71 01:15:23 INFO - 2015-11-26 01:15:23,215 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;94;130;94;94;95;135;95;94;129 01:15:23 INFO - 2015-11-26 01:15:23,215 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;109;110;110;110;109;109;109 01:15:23 INFO - 2015-11-26 01:15:23,215 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;148;146;148;147;148;147;147;146 01:15:23 INFO - 2015-11-26 01:15:23,216 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;96;96;95;96;95;95 01:15:23 INFO - 2015-11-26 01:15:23,216 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;70;70;71;72;70;71;70;71;71;67 01:15:23 INFO - 2015-11-26 01:15:23,216 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;70;68;69;69;69;70;69;70;69 01:15:23 INFO - 2015-11-26 01:15:23,217 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;83;83;85;84;86;93;85;83;85 01:15:23 INFO - 2015-11-26 01:15:23,217 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;126;119;148;120;132;135;130;132;130 01:15:23 INFO - 2015-11-26 01:15:23,217 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;153;135;148;146;146;137;148;150;137;136 01:15:23 INFO - 2015-11-26 01:15:23,217 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;67;68;68;68;69;67;68;67;67 01:15:23 INFO - 2015-11-26 01:15:23,217 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:15:23 INFO - 2015-11-26 01:15:23,217 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:15:23 INFO - 2015-11-26 01:15:23,217 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,973 01:15:23 INFO - 2015-11-26 01:15:23,218 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:15:23 INFO - 2015-11-26 01:15:23,218 DEBUG : BROWSER_OUTPUT: __startTimestamp1448529323207__endTimestamp 01:15:23 INFO - 2015-11-26 01:15:23,218 DEBUG : BROWSER_OUTPUT: 01:15:23 INFO - 2015-11-26 01:15:23,218 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:15:23 INFO - 2015-11-26 01:15:23,218 DEBUG : BROWSER_OUTPUT: Number of tests: 14 01:15:23 INFO - 2015-11-26 01:15:23,218 DEBUG : BROWSER_OUTPUT: 01:15:23 INFO - 2015-11-26 01:15:23,218 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.70 Median:112.00 stddev:4.03 (3.6%) stddev-sans-first:4.25 01:15:23 INFO - 2015-11-26 01:15:23,218 DEBUG : BROWSER_OUTPUT: Values: 111.0 113.0 107.0 113.0 112.0 112.0 101.0 111.0 112.0 105.0 01:15:23 INFO - 2015-11-26 01:15:23,219 DEBUG : BROWSER_OUTPUT: 01:15:23 INFO - 2015-11-26 01:15:23,219 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.40 Median:155.50 stddev:17.13 (11.0%) stddev-sans-first:18.17 01:15:23 INFO - 2015-11-26 01:15:23,219 DEBUG : BROWSER_OUTPUT: Values: 150.0 130.0 156.0 165.0 132.0 155.0 169.0 134.0 174.0 129.0 01:15:23 INFO - 2015-11-26 01:15:23,219 DEBUG : BROWSER_OUTPUT: 01:15:23 INFO - 2015-11-26 01:15:23,219 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.20 Median:163.00 stddev:1.14 (0.7%) stddev-sans-first:1.00 01:15:23 INFO - 2015-11-26 01:15:23,220 DEBUG : BROWSER_OUTPUT: Values: 165.0 163.0 163.0 162.0 162.0 163.0 163.0 165.0 164.0 162.0 01:15:23 INFO - 2015-11-26 01:15:23,220 DEBUG : BROWSER_OUTPUT: 01:15:23 INFO - 2015-11-26 01:15:23,221 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.10 Median:73.00 stddev:13.52 (18.5%) stddev-sans-first:13.84 01:15:23 INFO - 2015-11-26 01:15:23,221 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 87.0 91.0 71.0 73.0 73.0 111.0 91.0 71.0 01:15:23 INFO - 2015-11-26 01:15:23,221 DEBUG : BROWSER_OUTPUT: 01:15:23 INFO - 2015-11-26 01:15:23,221 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.50 Median:94.00 stddev:17.90 (19.0%) stddev-sans-first:18.57 01:15:23 INFO - 2015-11-26 01:15:23,221 DEBUG : BROWSER_OUTPUT: Values: 95.0 94.0 130.0 94.0 94.0 95.0 135.0 95.0 94.0 129.0 01:15:23 INFO - 2015-11-26 01:15:23,221 DEBUG : BROWSER_OUTPUT: 01:15:23 INFO - 2015-11-26 01:15:23,221 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 01:15:23 INFO - 2015-11-26 01:15:23,221 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 109.0 110.0 110.0 110.0 109.0 109.0 109.0 01:15:23 INFO - 2015-11-26 01:15:23,221 DEBUG : BROWSER_OUTPUT: 01:15:23 INFO - 2015-11-26 01:15:23,222 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 01:15:23 INFO - 2015-11-26 01:15:23,222 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 148.0 146.0 148.0 147.0 148.0 147.0 147.0 146.0 01:15:23 INFO - 2015-11-26 01:15:23,222 DEBUG : BROWSER_OUTPUT: 01:15:23 INFO - 2015-11-26 01:15:23,222 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 01:15:23 INFO - 2015-11-26 01:15:23,222 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 95.0 95.0 01:15:23 INFO - 2015-11-26 01:15:23,222 DEBUG : BROWSER_OUTPUT: 01:15:23 INFO - 2015-11-26 01:15:23,222 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:70.30 Median:71.00 stddev:1.34 (1.9%) stddev-sans-first:1.41 01:15:23 INFO - 2015-11-26 01:15:23,222 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 71.0 72.0 70.0 71.0 70.0 71.0 71.0 67.0 01:15:23 INFO - 2015-11-26 01:15:23,222 DEBUG : BROWSER_OUTPUT: 01:15:23 INFO - 2015-11-26 01:15:23,223 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:69.00 stddev:0.63 (0.9%) stddev-sans-first:0.67 01:15:23 INFO - 2015-11-26 01:15:23,223 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 68.0 69.0 69.0 69.0 70.0 69.0 70.0 69.0 01:15:23 INFO - 2015-11-26 01:15:23,223 DEBUG : BROWSER_OUTPUT: 01:15:23 INFO - 2015-11-26 01:15:23,223 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:85.00 stddev:3.02 (3.6%) stddev-sans-first:3.11 01:15:23 INFO - 2015-11-26 01:15:23,223 DEBUG : BROWSER_OUTPUT: Values: 83.0 83.0 83.0 85.0 84.0 86.0 93.0 85.0 83.0 85.0 01:15:23 INFO - 2015-11-26 01:15:23,223 DEBUG : BROWSER_OUTPUT: 01:15:23 INFO - 2015-11-26 01:15:23,223 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:129.40 Median:131.00 stddev:8.53 (6.5%) stddev-sans-first:8.61 01:15:23 INFO - 2015-11-26 01:15:23,223 DEBUG : BROWSER_OUTPUT: Values: 122.0 126.0 119.0 148.0 120.0 132.0 135.0 130.0 132.0 130.0 01:15:23 INFO - 2015-11-26 01:15:23,223 DEBUG : BROWSER_OUTPUT: 01:15:23 INFO - 2015-11-26 01:15:23,224 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.60 Median:147.00 stddev:6.65 (4.5%) stddev-sans-first:6.13 01:15:23 INFO - 2015-11-26 01:15:23,224 DEBUG : BROWSER_OUTPUT: Values: 153.0 135.0 148.0 146.0 146.0 137.0 148.0 150.0 137.0 136.0 01:15:23 INFO - 2015-11-26 01:15:23,224 DEBUG : BROWSER_OUTPUT: 01:15:23 INFO - 2015-11-26 01:15:23,224 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 01:15:23 INFO - 2015-11-26 01:15:23,224 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 68.0 68.0 68.0 69.0 67.0 68.0 67.0 67.0 01:15:23 INFO - 2015-11-26 01:15:23,224 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:15:23 INFO - 2015-11-26 01:15:23,224 DEBUG : BROWSER_OUTPUT: 01:15:24 INFO - 2015-11-26 01:15:24,113 INFO : Browser exited with error code: 0 01:15:24 INFO - 2015-11-26 01:15:24,170 INFO : Completed test kraken (00:01:00) 01:15:24 INFO - 2015-11-26 01:15:24,170 INFO : Starting test v8_7 01:15:24 INFO - 2015-11-26 01:15:24,170 DEBUG : operating with platform_type : linux_ 01:15:24 INFO - 2015-11-26 01:15:24,170 INFO : Initialising browser for v8_7 test... 01:15:24 INFO - 2015-11-26 01:15:24,176 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWqilrh/profile http://localhost:42989/getInfo.html 01:15:28 INFO - 2015-11-26 01:15:28,322 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:15:28 INFO - 2015-11-26 01:15:28,322 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:15:28 INFO - 2015-11-26 01:15:28,322 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:15:28 INFO - 2015-11-26 01:15:28,322 DEBUG : BROWSER_OUTPUT: __metrics 01:15:28 INFO - 2015-11-26 01:15:28,499 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:15:29 INFO - 2015-11-26 01:15:29,646 INFO : Browser initialized. 01:15:29 INFO - 2015-11-26 01:15:29,646 INFO : Running cycle 1/1 for v8_7 test... 01:15:29 INFO - 2015-11-26 01:15:29,646 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWqilrh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:15:41 INFO - 2015-11-26 01:15:41,580 DEBUG : BROWSER_OUTPUT: RSS: Main: 139096064 01:15:41 INFO - 2015-11-26 01:15:41,581 DEBUG : BROWSER_OUTPUT: 01:16:03 INFO - 2015-11-26 01:16:03,002 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42989/tests/v8_7/run.html (next: http://localhost:42989/tests/v8_7/run.html) 01:16:03 INFO - 2015-11-26 01:16:03,252 DEBUG : BROWSER_OUTPUT: RSS: Main: 441679872 01:16:03 INFO - 2015-11-26 01:16:03,253 DEBUG : BROWSER_OUTPUT: 01:16:03 INFO - 2015-11-26 01:16:03,253 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:16:03 INFO - 2015-11-26 01:16:03,254 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:16:03 INFO - 2015-11-26 01:16:03,254 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:16:03 INFO - 2015-11-26 01:16:03,254 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:16:03 INFO - 2015-11-26 01:16:03,255 DEBUG : BROWSER_OUTPUT: |0;Richards;165.42597187758477 01:16:03 INFO - 2015-11-26 01:16:03,255 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;192.64110961279138 01:16:03 INFO - 2015-11-26 01:16:03,255 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.7695125387433 01:16:03 INFO - 2015-11-26 01:16:03,255 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5218.75 01:16:03 INFO - 2015-11-26 01:16:03,255 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1988.0715705765408 01:16:03 INFO - 2015-11-26 01:16:03,255 DEBUG : BROWSER_OUTPUT: |5;Earley;797.4481658692185 01:16:03 INFO - 2015-11-26 01:16:03,255 DEBUG : BROWSER_OUTPUT: |6;Boyer;11788.235294117647 01:16:03 INFO - 2015-11-26 01:16:03,256 DEBUG : BROWSER_OUTPUT: |7;RegExp;27081.08108108108 01:16:03 INFO - 2015-11-26 01:16:03,256 DEBUG : BROWSER_OUTPUT: |8;Splay;617.283950617284 01:16:03 INFO - 2015-11-26 01:16:03,256 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4859.223300970873 01:16:03 INFO - 2015-11-26 01:16:03,256 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:16:03 INFO - 2015-11-26 01:16:03,256 DEBUG : BROWSER_OUTPUT: __startTimestamp1448529363252__endTimestamp 01:16:03 INFO - 2015-11-26 01:16:03,256 DEBUG : BROWSER_OUTPUT: 01:16:03 INFO - 2015-11-26 01:16:03,257 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:16:03 INFO - 2015-11-26 01:16:03,257 DEBUG : BROWSER_OUTPUT: Number of tests: 10 01:16:03 INFO - 2015-11-26 01:16:03,257 DEBUG : BROWSER_OUTPUT: 01:16:03 INFO - 2015-11-26 01:16:03,257 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.43 Median:165.43 stddev:0.00 (0.0%) 01:16:03 INFO - 2015-11-26 01:16:03,257 DEBUG : BROWSER_OUTPUT: Values: 165.4 01:16:03 INFO - 2015-11-26 01:16:03,259 DEBUG : BROWSER_OUTPUT: 01:16:03 INFO - 2015-11-26 01:16:03,259 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:192.64 Median:192.64 stddev:0.00 (0.0%) 01:16:03 INFO - 2015-11-26 01:16:03,259 DEBUG : BROWSER_OUTPUT: Values: 192.6 01:16:03 INFO - 2015-11-26 01:16:03,259 DEBUG : BROWSER_OUTPUT: 01:16:03 INFO - 2015-11-26 01:16:03,259 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.77 Median:281.77 stddev:0.00 (0.0%) 01:16:03 INFO - 2015-11-26 01:16:03,259 DEBUG : BROWSER_OUTPUT: Values: 281.8 01:16:03 INFO - 2015-11-26 01:16:03,259 DEBUG : BROWSER_OUTPUT: 01:16:03 INFO - 2015-11-26 01:16:03,260 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5218.75 Median:5218.75 stddev:0.00 (0.0%) 01:16:03 INFO - 2015-11-26 01:16:03,260 DEBUG : BROWSER_OUTPUT: Values: 5218.8 01:16:03 INFO - 2015-11-26 01:16:03,260 DEBUG : BROWSER_OUTPUT: 01:16:03 INFO - 2015-11-26 01:16:03,260 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1988.07 Median:1988.07 stddev:0.00 (0.0%) 01:16:03 INFO - 2015-11-26 01:16:03,260 DEBUG : BROWSER_OUTPUT: Values: 1988.1 01:16:03 INFO - 2015-11-26 01:16:03,260 DEBUG : BROWSER_OUTPUT: 01:16:03 INFO - 2015-11-26 01:16:03,260 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:797.45 Median:797.45 stddev:0.00 (0.0%) 01:16:03 INFO - 2015-11-26 01:16:03,261 DEBUG : BROWSER_OUTPUT: Values: 797.4 01:16:03 INFO - 2015-11-26 01:16:03,261 DEBUG : BROWSER_OUTPUT: 01:16:03 INFO - 2015-11-26 01:16:03,261 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11788.24 Median:11788.24 stddev:0.00 (0.0%) 01:16:03 INFO - 2015-11-26 01:16:03,261 DEBUG : BROWSER_OUTPUT: Values: 11788.2 01:16:03 INFO - 2015-11-26 01:16:03,261 DEBUG : BROWSER_OUTPUT: 01:16:03 INFO - 2015-11-26 01:16:03,261 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27081.08 Median:27081.08 stddev:0.00 (0.0%) 01:16:03 INFO - 2015-11-26 01:16:03,261 DEBUG : BROWSER_OUTPUT: Values: 27081.1 01:16:03 INFO - 2015-11-26 01:16:03,261 DEBUG : BROWSER_OUTPUT: 01:16:03 INFO - 2015-11-26 01:16:03,262 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:617.28 Median:617.28 stddev:0.00 (0.0%) 01:16:03 INFO - 2015-11-26 01:16:03,262 DEBUG : BROWSER_OUTPUT: Values: 617.3 01:16:03 INFO - 2015-11-26 01:16:03,262 DEBUG : BROWSER_OUTPUT: 01:16:03 INFO - 2015-11-26 01:16:03,262 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4859.22 Median:4859.22 stddev:0.00 (0.0%) 01:16:03 INFO - 2015-11-26 01:16:03,262 DEBUG : BROWSER_OUTPUT: Values: 4859.2 01:16:03 INFO - 2015-11-26 01:16:03,262 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:16:03 INFO - 2015-11-26 01:16:03,262 DEBUG : BROWSER_OUTPUT: 01:16:04 INFO - 2015-11-26 01:16:04,129 INFO : Browser exited with error code: 0 01:16:04 INFO - 2015-11-26 01:16:04,141 INFO : Completed test v8_7 (00:00:39) 01:16:04 INFO - 2015-11-26 01:16:04,261 INFO : Completed test suite (00:20:16) 01:16:04 INFO - 2015-11-26 01:16:04,262 DEBUG : Working with test: dromaeo_css 01:16:04 INFO - 2015-11-26 01:16:04,262 DEBUG : Generating results file: dromaeo_css 01:16:04 INFO - 2015-11-26 01:16:04,263 DEBUG : Working with test: kraken 01:16:04 INFO - 2015-11-26 01:16:04,263 DEBUG : Generating results file: kraken 01:16:04 INFO - 2015-11-26 01:16:04,263 INFO : javascript benchmark 01:16:04 INFO - 2015-11-26 01:16:04,263 DEBUG : Working with test: v8_7 01:16:04 INFO - 2015-11-26 01:16:04,264 DEBUG : Generating results file: v8_7 01:16:04 INFO - 2015-11-26 01:16:04,264 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:16:04 INFO - 2015-11-26 01:16:04,324 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 01:16:04 INFO - 2015-11-26 01:16:04,324 DEBUG : process_Request line: dromaeo_css 6168.52 graph.html#tests=[[72,132,35]] 01:16:04 INFO - 2015-11-26 01:16:04,324 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:16:04 INFO - 2015-11-26 01:16:04,454 DEBUG : process_Request line: kraken 1526.30 graph.html#tests=[[232,132,35]] 01:16:04 INFO - 2015-11-26 01:16:04,455 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:16:04 INFO - 2015-11-26 01:16:04,501 DEBUG : process_Request line: v8_7 19688.35 graph.html#tests=[[230,132,35]] 01:16:04 INFO - 2015-11-26 01:16:04,502 INFO : javascript benchmark 01:16:04 INFO - 2015-11-26 01:16:04,506 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2619.6856377234735, 2709.701932787394, 2710.3495161161313, 2725.945481090378, 2735.9863200684, 4514.841980530682, 4623.1909415852215, 4638.304254361839, 4648.535146485346, 4692.2726977318525, 4556.635469162467, 4571.085782843428, 4633.814647414099, 4651.906961860761, 4660.836870709526, 4275.0, 4282.8715138545895, 4289.206496798102, 4318.309070548705, 4333.090051089275, 4125.690573207022, 4372.868813935587, 4378.430803995492, 4427.2916333386665, 4434.0, 4260.978695106535, 4309.31051031835, 4324.22164010478, 4337.154254920292, 4359.607635312837, 4281.079567892887, 4320.049589090395, 4321.114171594815, 4322.524522302576, 4364.105358401552, 4293.0, 4297.828086876521, 4299.742015479082, 4327.848525301631, 4344.478662560513, 4366.56334366564, 4478.0596074824325, 4493.393391892086, 4508.211063063951, 4588.265877459624, 4953.108440480712, 4959.156943319645, 4960.280759289883, 4960.578350840183, 4964.453910069889, 4982.701037937699, 4989.351384320015, 4991.251312303184, 5036.622253331015, 5039.974800126012, 4431.667624928144, 4539.773011349419, 4543.159515489645, 4631.58315751584, 4676.555727205944, 5015.6489045767175, 5106.565941894906, 5109.182530795055, 5115.71863547501, 5143.665661731976, 4935.605151587864, 4941.407031156213, 4947.158982972904, 4949.381327334083, 4989.12690279207, 4720.598749106364, 4809.398825146856, 4812.975935120372, 5029.522195391505, 5030.119729047402, 4832.903341933212, 4879.609631229493, 4902.338184345139, 4903.166461701519, 4938.506149385104, 4889.119958407449, 4910.754462276944, 4913.21388577833, 4915.090708218991, 4949.257611358325, 3959.8416063357718, 4130.545639979599, 4132.2561938850695, 4139.110091330378, 4170.645495132948, 3570.553680789901, 3619.9502144377834, 3651.2332410193626, 3659.2681463707363, 3684.5762737285017, 4284.143171365739, 4285.721428107163, 4286.764227967429, 4292.306468294994, 4327.17783621111, 4976.8755781105765, 4977.9751101244265, 4995.475475075137, 4996.950030499648, 5022.497750225021, 4073.9592604074173, 4206.579342065769, 4212.641925436372, 4265.274903266452, 4386.627136693417, 4388.846390376321, 4396.340548917688, 4411.911761764747, 4425.557444255549, 4450.732956022584, 4733.077049975222, 4733.763311834464, 4735.857924262209, 4736.550027747358, 4785.090832741768, 4763.642726795573, 4799.3760811094335, 4881.194602890483, 4881.609471242221, 4983.900321993612, 4704.553067458586, 4714.198586240279, 4716.952830471651, 4724.03157352735, 4735.384400027974, 4895.63282753802, 4900.534449227318, 4903.068417000758, 4909.705417674951, 4951.925721114114, 4802.423709154924, 4889.9022019560125, 4909.386326709161, 4912.287718280758, 5015.774290156879, 4784.736839473862, 4833.4441539223435, 4837.7581120943105, 4853.975730121468, 4885.780139893643, 4829.396325459317, 4836.371271734652, 4836.395450568679, 4838.104950584153, 4884.0476107158765, 4560.6351491879905, 4593.150267200445, 4629.328747331685, 4669.019505903662, 4748.762561871824, 4852.17513022794, 4906.950930490792, 4907.4111106666, 4941.950580494293, 4946.777395017161, 4712.7407992559365, 4772.737499437564, 4787.712737235777, 4795.808167673254, 4796.232602783538], "unit": "ms", "name": "dojo.html", "value": 4551.259449221252}, {"lowerIsBetter": false, "replicates": [482.599442462756, 500.7471227030349, 568.5224411494344, 580.0400337441536, 580.3471095018105, 21629.242976495825, 22108.88945555272, 36706.81646591767, 37325.25349493008, 37361.25277494455, 40039.39940900889, 40563.18873622526, 40689.18621627573, 40748.185036299255, 40748.185036299255, 6387.45706614936, 6514.869702605945, 7804.6878124875075, 7937.563434011127, 7977.481463704869, 10271.332363396392, 10529.2103092268, 10553.6306229282, 10554.261201715883, 10558.155347572214, 10166.64416745414, 10268.28122031458, 10291.433971131622, 10294.073533381994, 10295.794084118314, 6502.5448218624715, 6621.9006714899315, 6624.3375662433855, 6632.93367066328, 10212.64255751049, 9845.55694993727, 10087.949560252226, 10102.747431314203, 10106.595736170544, 10110.696679099565, 36862.44706329407, 37381.252374952346, 37453.438198426775, 37454.81272593619, 37511.43732844009, 2487.1543675150538, 2637.037481319324, 2639.4457163995585, 2854.2864283929016, 3100.147459448647, 26390.208293751217, 26484.205473835817, 26695.0, 26797.866010670015, 27199.864000680067, 3384.881529146468, 3493.388656985043, 3530.9646903531147, 3599.9200239928177, 3628.727845411605, 220168.0, 220715.0, 220962.0, 221491.0, 222173.0, 29121.27196820054, 53062.0, 53323.733381332844, 53373.0, 53466.0, 32983.83508082444, 33141.50287745686, 33156.83421582876, 33174.3365132696, 62297.37702623006, 12724.427400766988, 13010.414531346112, 13027.283499407435, 13063.542776002794, 13117.212967221998, 9755.365901216399, 9791.853122203172, 9809.068138526829, 9809.264305176997, 9813.656522021694, 18049.187786549635, 18121.63756724858, 18163.36428225032, 18166.727499087523, 18186.63626727458, 6932.618705971119, 7173.6413179340825, 7176.425885929113, 7210.819729506804, 7247.20280769115, 784.3803395317749, 805.2430715127879, 875.3085062800317, 922.8464419475655, 995.5569771451779, 26177.73822261791, 27174.3239747697, 27475.86262068677, 27555.17334479969, 29449.85275073611, 929.8000929800126, 956.0821611253136, 961.5576834655997, 968.5689868008668, 998.1116806042628, 12303.630891073282, 12648.367581620882, 12651.240925544313, 12662.0, 13025.674358141123, 263491.0, 268086.0, 268227.0, 268404.0, 268638.0, 37427.81286093552, 37535.62464375321, 37538.81230593829, 37551.0, 37551.248975020346, 1087.0868470484832, 1166.381817636637, 1175.0893057880212, 1195.5158160944832, 1196.2284326609288, 23829.285121446384, 25369.0, 26778.732212678402, 26893.193204203122, 26894.462110758068, 37887.0, 38189.618103818604, 38289.0, 38319.0, 38326.0, 251352.0, 257490.0, 258093.0, 314642.0, 320444.0, 26464.206073817815, 26561.33596660099, 26575.27946087588, 26634.0, 26796.258243214128, 33630.159246019044, 33970.49044264387, 34375.31249375048, 34384.312313753086, 34649.30701386009, 31236.37527249488, 32566.674333256364, 33166.17084572905, 33240.0, 33325.83337083299, 27249.72750272472, 27474.0, 27502.449951000468, 27513.587296190974, 27737.722622773515, 32016.039518814472, 32380.190495236864, 32645.0, 32788.0, 32868.83565582157, 28577.42845143127, 29106.56340154857, 29387.41225175527, 29473.263168420963, 29496.705032949394, 21258.0, 21333.253336133163, 21365.14539418468, 21399.823009734613, 21406.0], "unit": "ms", "name": "ext.html", "value": 16283.91708886563}, {"lowerIsBetter": false, "replicates": [320.50161998092966, 323.15333825377513, 330.4695962979418, 335.2674406421967, 339.19779720959934, 11037.889621103786, 11352.829707554394, 14925.179115148663, 15316.617084572892, 15337.23313834308, 13857.099288546238, 14063.226522541281, 14071.648208794786, 14073.507427240049, 14448.277586120677, 4525.705829121097, 4881.755912204384, 5033.043721692885, 5033.421156566987, 5616.691081990489, 3482.721382289423, 3558.5195998540125, 5577.442255774431, 5652.547796176316, 5789.8263052108505, 5702.0, 5715.257016587838, 5719.799807006755, 5735.369109397963, 5747.885042299152, 5532.3637781655025, 5597.468240517185, 5600.215969764236, 5604.0, 5604.271444712182, 4932.7040377577105, 4933.703977761345, 4939.975300123477, 4950.306957025983, 4951.603871690256, 18411.53971150732, 18875.811241887543, 18884.339048133388, 18965.33621323247, 19536.70694939577, 1832.3128826689992, 1856.2574970011967, 1891.5649400637792, 1956.3152896486258, 1988.5625162464235, 8248.175182481704, 8591.226789588967, 8660.437071590326, 8892.244159246471, 10217.897821021843, 1594.457884319337, 1633.4038076102256, 1672.6738286034229, 1811.70106932356, 1821.1895706410653, 54931.45068549303, 56672.71663641697, 56949.71525142389, 57366.7131664339, 57385.0, 9705.757356066155, 9892.25808064398, 9934.80130397388, 9944.850827237597, 10019.098281154731, 12170.756584868253, 12176.39118044112, 12177.086718496148, 12179.634610961686, 12189.939050304693, 6436.3241859605005, 6564.606123632598, 6600.075989361493, 6815.386615204656, 6962.825929351706, 5953.404659534012, 6032.366601506867, 6047.455728984412, 6066.514678825683, 6091.0558863376245, 3979.3633018716864, 4170.374443833389, 4198.85304014358, 4221.704480686384, 4244.575542445731, 1469.0965056490181, 1494.6548106703835, 1495.3046833222604, 1502.3765137468047, 1650.8715983211746, 765.8583162115027, 796.733094413378, 799.4523751230425, 904.3443503459939, 921.576075005505, 13698.931505342609, 15524.14617196065, 15677.529674109795, 15748.0, 15867.603309917344, 635.640862912453, 719.8236432074175, 815.9388045896582, 826.5619221812449, 860.0152825015323, 8505.277051450696, 8673.306135509145, 8934.463932164092, 8999.550022498848, 9104.998450170477, 474765.0, 496087.0, 501203.0, 502756.0, 507337.0, 70509.64745176242, 71309.64345178241, 71489.2851071493, 72615.0, 75584.24415755882, 1013.2299452416216, 1018.6943916824923, 1021.9693409197736, 1030.4538594544904, 1036.1348274190984, 13682.726345473235, 13911.234882081582, 14166.362513686703, 14257.42970281177, 14280.714385712019, 29662.703372965992, 30277.243068923453, 32497.675023249463, 33382.332353352314, 33450.66549334476, 42811.57188428076, 43223.56776432321, 43574.0, 45454.77272613616, 46291.3056304149, 8962.0, 9088.772780680272, 9111.271098312252, 9257.074292570689, 9292.674756383494, 16306.836931630532, 16474.835251647808, 16487.83512164863, 16649.750253746446, 16750.497485075466, 10118.544665489924, 13295.268760218281, 13322.800157997444, 13569.86430135686, 13585.116967397484, 12607.43266552989, 12756.553520627105, 12922.0, 13105.27920964318, 13181.340932953506, 12826.935865320615, 12858.67853303675, 13056.477740890257, 13154.34228288601, 13857.792133118213, 8529.275011623833, 8763.91236087631, 8804.64781408762, 8814.382993190415, 8821.2060914518, 12466.626001219978, 12572.057095717675, 12609.747805044031, 12694.365281736062, 13120.737585248433], "unit": "ms", "name": "jquery.html", "value": 8114.190759986682}, {"lowerIsBetter": false, "replicates": [867.7179916527131, 1532.655152590667, 1588.833172516886, 1605.6307049378643, 1655.8840881138326, 5525.668459892404, 5700.800471983482, 6750.662466876655, 6939.201991770948, 6954.791356259308, 6734.730610775563, 6752.797416077513, 6784.253732089466, 6803.455723542117, 6812.352826481489, 1700.2603867317694, 1729.688656041912, 2048.795120487947, 2084.3538503064024, 2087.9791202087936, 1752.2640490993813, 2059.8455115866295, 2111.6515774897125, 2113.6406810842195, 2116.3121985354746, 2022.3629556689668, 2052.1381019971573, 2052.5894821035777, 2052.733144691188, 2053.3634573282256, 1995.9401217963411, 2021.4441028717074, 2024.6355655982065, 2025.1595587831032, 2025.4430031741315, 2018.2633338831367, 2028.6754119340983, 2058.259026750369, 2060.577581595769, 2062.0720675695848, 6908.3437073477935, 6929.203141638725, 6978.302169783032, 6997.300269972962, 7002.544834585787, 3954.4266081418323, 4010.2981978154, 4030.496187976503, 4030.818613162385, 4033.616806403387, 2647.1396796041363, 2648.2717252755456, 2697.932551686204, 2704.2157774245447, 2718.293243756618, 832.2883934236202, 845.2984023260678, 857.8541647919868, 865.6796985115485, 875.5534677314552, 9216.216621587173, 9238.0, 9260.861087083698, 9269.165775080275, 9272.814543709088, 3820.4651348810635, 3858.2090671412293, 3901.1612503311358, 3911.843526258918, 3920.157166209279, 7960.4825686330205, 7962.402819788539, 7962.920370796218, 7963.0, 7963.681452741941, 4010.8997275068355, 4016.116454380032, 4019.4975628046495, 4057.6145266199665, 4059.9797001014804, 3663.853445862189, 3665.908352291214, 3666.138457462494, 3666.3034023535442, 3668.2663467306647, 2678.424138810165, 3346.397648423307, 3353.782004169721, 3396.1679388549965, 3396.5075064115563, 811.6631597886928, 999.860019597257, 1027.6300531808542, 1029.3978022856713, 1042.1089968077335, 772.4091070331201, 775.83707421441, 776.0454640791858, 817.5871185051511, 863.447393668053, 6354.650494222769, 6385.425311721968, 6422.74309027643, 6427.100205971168, 6427.807165785034, 963.2149797914817, 971.1842052675786, 997.6332424578229, 997.6508222122344, 1043.1758910460803, 4881.414230292387, 4925.950740492621, 5012.122878496249, 5014.323066385991, 5015.473375295542, 8003.799905002305, 8272.0, 8274.420790544604, 8277.130901255401, 8294.29498492635, 7910.16943220965, 8066.15305392937, 8166.75499734997, 8173.019237691515, 8176.6320515576945, 6025.096235564701, 6043.123747056652, 6062.575619706667, 6084.056971169476, 6091.48222401092, 6065.3934606539, 6138.478229350555, 6151.108089326933, 6153.6923153841235, 6162.0, 7287.672054757655, 7292.48952573336, 7293.562386256842, 7304.525205861814, 7310.049693539806, 7331.266873312626, 7606.657700403384, 7618.6190690466365, 7755.379569634303, 7767.844643107219, 5890.793822216202, 5962.135490353788, 5985.850353741017, 6001.129836173817, 6022.759089636365, 5246.449122842047, 6480.384363485461, 6517.8696426072165, 6527.706253218712, 6531.314212007861, 4938.456769755396, 6076.54425918049, 6205.906911396423, 6249.0626406039455, 6296.150019747459, 6155.2921414037955, 6179.567430280017, 6229.750809967551, 6261.186045814015, 6272.529560283088, 6158.568900177123, 6183.196184495987, 6188.319284878749, 6189.907151392823, 6192.473639740672, 5727.8854422912145, 5731.0, 5823.0, 5833.67914764692, 5847.853803654943, 5911.96540605401, 5950.137230101697, 5954.315253745702, 5955.940440595538, 5967.1049342597225], "unit": "ms", "name": "mootools.html", "value": 3896.921483490835}, {"lowerIsBetter": false, "replicates": [299.7407242735034, 302.50238357901253, 306.1351681499763, 308.94902341113715, 310.52024621959083, 5418.376886658036, 5463.972680136599, 5533.142362933751, 5539.889202215963, 5545.972270138654, 5416.187571864222, 5427.185922111676, 5428.022955867942, 5430.67415955042, 5444.156155795858, 3941.664958478518, 4237.194932962742, 4240.915181696364, 4247.8300867965245, 4251.107267473826, 4036.8183431745642, 4119.114390406062, 4160.979195104021, 4182.811773470201, 4192.727472714279, 4134.0, 4147.585241475858, 4148.8133034013545, 4156.625903668669, 4160.084781348099, 3936.153726948691, 4019.5980401959864, 4089.0799570096788, 4150.501939767232, 4158.168366326731, 3696.9260614787822, 3707.9629203707887, 3717.9442308365396, 3722.4788529605876, 3727.7949712765785, 5233.084210263189, 5233.738313084368, 5237.214417837316, 5239.423663397023, 5252.1596544552685, 4836.2503811908855, 4844.733539655317, 4848.830290939835, 4850.781714822806, 4852.150873597142, 5556.083246264361, 5686.772529098831, 5703.686297253649, 5706.629069110536, 5710.571707121982, 4014.6186112319283, 4019.1760689058965, 4021.055052062763, 4022.4770779798732, 4030.234255491447, 5993.910091348634, 6006.279246490405, 6006.969965150146, 6008.3390827009, 6008.519318454513, 4136.565660605654, 4137.2552940471005, 4141.79291035447, 4144.44050053239, 4149.439825623563, 4106.199291138199, 4211.557786432441, 4211.642010429086, 4215.3044747616295, 4228.809703563347, 4792.976035119802, 4803.063402636452, 4808.326834243208, 4813.807447702053, 4817.8313759018265, 5671.688057156896, 5681.119426488901, 5681.971590142023, 5687.800926967537, 5692.943070569324, 1466.1569597481491, 1484.4136566056347, 1485.9405623775144, 1486.5837565481681, 1487.4124720735465, 1002.5137808163036, 1013.7364285285731, 1019.4342140112309, 1032.0, 1044.8432735089798, 4988.276699878497, 5007.0, 5007.924881126786, 5020.497950205024, 5026.321446604735, 5900.4984576310635, 5918.911216331759, 5926.051831706906, 5926.525877929756, 5926.970365148147, 5001.7499125043605, 5014.974925125424, 5015.824446144367, 5017.247412888096, 5020.673656212408, 2774.639296891391, 2994.6705862355125, 3064.4483992881496, 3163.4463968805367, 3193.9041828745176, 5596.2165296858475, 5644.689542075225, 5650.63270887391, 5651.943480565224, 5653.575981801299, 6129.957907155795, 6132.570720049643, 6134.7852825151795, 6136.140940268366, 6136.969315153396, 5638.097904335369, 5641.464060914206, 5650.23721797552, 5651.039323315046, 5651.067573850269, 5816.651000939957, 5917.0, 5975.043992961106, 5981.581289309706, 5998.190244316961, 5838.416158384298, 5849.444302791228, 5851.385604511465, 5859.296884373732, 5860.824175274749, 5666.206731057573, 5667.093265077568, 5667.149927510742, 5669.85825354353, 5672.376038635664, 4028.818703158306, 4075.3886916962692, 4077.89805254871, 4081.326581114202, 4082.1427500225286, 5683.147527870852, 5869.8553782012095, 5877.764889404376, 5978.163057171912, 5980.401959804159, 5605.859853503532, 5651.689157096399, 5659.094544872801, 5659.26429564154, 5751.252337196138, 5558.333000040021, 5721.799737009351, 5743.167240750151, 5743.798967036134, 5746.741396637245, 5431.6740995540395, 5560.443955604407, 5621.550275977994, 5627.803026894039, 5630.634008789416, 5770.798022069207, 5779.566532509994, 5779.768809247583, 5780.364159942487, 5781.392953739965, 5626.662400255997, 5628.043232650377, 5629.718514074362, 5631.831045068655, 5633.324001119728], "unit": "ms", "name": "prototype.html", "value": 4293.865774483969}, {"lowerIsBetter": false, "replicates": [520.6407578770647, 587.4301927130682, 614.1984709953509, 623.0902881792582, 626.9341719119492, 11489.655310340693, 11725.120615953794, 11748.941255293723, 11760.882391176086, 11778.0, 11926.0, 12108.636740897766, 12109.757804843897, 12126.090543209251, 12137.271763694185, 287.9568064790288, 291.0946954970052, 749.4491548711707, 767.9155292917775, 771.2249189564479, 286.0930849208005, 764.4916130773029, 778.8286576953061, 779.3920741821388, 779.7894568466511, 792.8374683189933, 812.9430939834214, 813.3899575318511, 813.4753084260678, 813.7477382011596, 296.3613413094784, 296.7892796114761, 794.1542257495748, 799.6721344248859, 801.5911884938694, 596.0612036043206, 597.7250464786204, 597.9760809567612, 598.592956789383, 599.1462166412888, 11436.42817859112, 11457.026152777024, 11463.598774042952, 11467.0, 11473.885261147365, 11133.28546314405, 11470.02504787094, 11628.476718547601, 11679.182457227997, 12551.686207844785, 9196.540172991323, 9288.72133835986, 9315.860262096074, 9518.476483793458, 9607.807843843153, 3316.4196265653413, 3336.0, 3340.6964334466707, 3363.865445382182, 3441.174118211636, 41911.0, 42688.78655606702, 42847.57152428467, 42866.57133428626, 42955.14089718188, 9648.565814538362, 9668.178204852666, 9703.466309352913, 9811.803763924681, 9966.651167209113, 16130.354785808671, 16260.268287927072, 16304.836951630332, 16306.918465407596, 16309.347626094823, 5713.514351280188, 5828.184054232411, 5919.644821310735, 6071.574989750763, 6097.3292937776805, 3570.303790760777, 3574.249407624428, 3607.2424790793702, 3612.259486805199, 3613.060604242916, 2692.8788204530842, 2726.386563023304, 2732.988794146179, 2737.931551711223, 2740.1642499037584, 457.489898762877, 460.44516357788785, 462.72236658004925, 472.54635549872506, 473.13652584034276, 550.5705549671263, 577.8587290102099, 578.8089930322983, 599.1133122978017, 603.836964019721, 7067.71729130829, 7219.927800722031, 7319.1217053952805, 7375.37309328713, 7801.531908085533, 322.19933465338613, 429.7786639880464, 486.5353587324097, 572.6920510343323, 628.7956414165415, 3376.7805092668896, 3436.8453419596176, 3455.6544345565244, 3723.162288485069, 3837.654611085016, 49491.0, 50265.497345026815, 50533.0, 50834.74582627137, 50873.0, 42668.359974600404, 43529.78235108804, 44032.339514907304, 44110.0, 44155.0, 40314.19371612551, 40329.39505907414, 41682.37476437856, 42026.789866051084, 42158.367624485654, 7206.675699593426, 7310.122785265802, 7459.664315105725, 7463.328300452985, 7567.583782891994, 32186.83906580452, 32602.34795304128, 33080.33839323248, 33247.168820779676, 33262.0, 37550.81224593859, 38814.4177837327, 39373.80313098416, 40870.38694419526, 40907.0, 9312.767180820263, 9523.523823808644, 9883.209343252667, 9937.0, 10097.343672661253, 10705.89294107049, 11062.557497700323, 11105.888941110485, 11109.388983605979, 11150.0, 9340.71977840666, 9561.9043809561, 9596.376235544667, 9624.951875240578, 10291.125254353465, 9992.400455972665, 10052.0, 10098.8485172721, 10131.594736210469, 10448.791024179625, 10018.499075046073, 10140.138088262285, 10165.44090075053, 10439.0, 10568.947155264175, 8248.340132789242, 8413.158684131538, 8441.32469402434, 8456.0, 8557.229849313591, 8383.538905360263, 8514.574271286287, 8622.698205562776, 8751.081136480578, 8963.641454341754], "unit": "ms", "name": "yui.html", "value": 5474.384228525592}], "name": "dromaeo_css", "value": 6168.5207465205185}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 107.0, 113.0, 112.0, 112.0, 101.0, 111.0, 112.0, 105.0], "unit": "ms", "name": "ai-astar", "value": 109.7}, {"lowerIsBetter": true, "replicates": [150.0, 130.0, 156.0, 165.0, 132.0, 155.0, 169.0, 134.0, 174.0, 129.0], "unit": "ms", "name": "audio-beat-detection", "value": 149.4}, {"lowerIsBetter": true, "replicates": [165.0, 163.0, 163.0, 162.0, 162.0, 163.0, 163.0, 165.0, 164.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 163.2}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 87.0, 91.0, 71.0, 73.0, 73.0, 111.0, 91.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 81.1}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 130.0, 94.0, 94.0, 95.0, 135.0, 95.0, 94.0, 129.0], "unit": "ms", "name": "audio-oscillator", "value": 105.5}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 110.0, 110.0, 110.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 148.0, 146.0, 148.0, 147.0, 148.0, 147.0, 147.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 71.0, 72.0, 70.0, 71.0, 70.0, 71.0, 71.0, 67.0], "unit": "ms", "name": "json-parse-financial", "value": 70.3}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 68.0, 69.0, 69.0, 69.0, 70.0, 69.0, 70.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.2}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 83.0, 85.0, 84.0, 86.0, 93.0, 85.0, 83.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.0}, {"lowerIsBetter": true, "replicates": [122.0, 126.0, 119.0, 148.0, 120.0, 132.0, 135.0, 130.0, 132.0, 130.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 129.4}, {"lowerIsBetter": true, "replicates": [153.0, 135.0, 148.0, 146.0, 146.0, 137.0, 148.0, 150.0, 137.0, 136.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 143.6}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 68.0, 68.0, 68.0, 69.0, 67.0, 68.0, 67.0, 67.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.7}], "name": "kraken", "value": 1526.3000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.42597187758477], "unit": "score", "name": "Richards", "value": 213.40059000000002}, {"lowerIsBetter": false, "replicates": [192.64110961279138], "unit": "score", "name": "DeltaBlue", "value": 343.2185379999999}, {"lowerIsBetter": false, "replicates": [281.7695125387433], "unit": "score", "name": "Encrypt", "value": 944.6763689999997}, {"lowerIsBetter": false, "replicates": [5218.75], "unit": "score", "name": "Decrypt", "value": 51.00474251497002}, {"lowerIsBetter": false, "replicates": [1988.0715705765408], "unit": "score", "name": "RayTrace", "value": 372.21446699999984}, {"lowerIsBetter": false, "replicates": [797.4481658692185], "unit": "score", "name": "Earley", "value": 835.7446020000003}, {"lowerIsBetter": false, "replicates": [11788.235294117647], "unit": "score", "name": "Boyer", "value": 56.536282435129706}, {"lowerIsBetter": false, "replicates": [27081.08108108108], "unit": "score", "name": "RegExp", "value": 33.63916666666665}, {"lowerIsBetter": false, "replicates": [617.283950617284], "unit": "score", "name": "Splay", "value": 132.01541999999998}, {"lowerIsBetter": false, "replicates": [4859.223300970873], "unit": "score", "name": "NavierStokes", "value": 305.39860139860156}], "name": "v8_7", "value": 19688.346710748927}]} 01:16:04 INFO - RETURN: dromaeo_css: 6168.52 01:16:04 INFO - RETURN: kraken: 1526.30 01:16:04 INFO - RETURN: v8_7: 19688.35 01:16:04 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19688.35"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1526.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6168.52"}}} 01:16:04 INFO - Return code: 0 01:16:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:16:04 INFO - # TBPL SUCCESS # 01:16:04 INFO - Running post-action listener: _resource_record_post_action 01:16:04 INFO - Running post-run listener: _resource_record_post_run 01:16:05 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 0; Write bytes: 522301440; Read time: 0; Write time: 496020 01:16:05 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 246239232; Read time: 0; Write time: 261636 01:16:05 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 0; Write bytes: 276062208; Read time: 0; Write time: 234384 01:16:05 INFO - Running post-run listener: _upload_blobber_files 01:16:05 INFO - Blob upload gear active. 01:16:05 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 01:16:05 INFO - Copying logs to upload dir... 01:16:05 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1262.765468 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2015-11-26 01:16:04.576402) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-26 01:16:04.580464) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1448528054.765993-1090591871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/4ed4osCfS3SsX-H5LVtlbA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009208 build_url: 'https://queue.taskcluster.net/v1/task/4ed4osCfS3SsX-H5LVtlbA/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-26 01:16:04.631006) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 01:16:04.631324) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1448528054.765993-1090591871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004509 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 01:16:04.680929) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-26 01:16:04.681259) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-26 01:16:04.681561) ========= ========= Total master_lag: 0.22 =========