builder: b2g-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-027 starttime: 1448439097.59 results: success (0) buildid: 20151124225831 builduid: efcce5dd894b4eec8489a6c6fe6ff6e4 revision: 9145ebe2c0c3e20a1c3aacdb4b2a0016b8498878 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-25 00:11:37.600753) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-25 00:11:37.601297) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 00:11:37.601626) ========= 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=447a3abc0420b6a47dd38cba000001bf-1448435975.744649-1135962262 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006568 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 00:11:37.626042) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 00:11:37.626347) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 00:11:37.642121) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 00:11:37.642492) ========= 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=447a3abc0420b6a47dd38cba000001bf-1448435975.744649-1135962262 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004856 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 00:11:37.696412) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-25 00:11:37.696694) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-25 00:11:37.697029) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 00:11:37.697401) ========= 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=447a3abc0420b6a47dd38cba000001bf-1448435975.744649-1135962262 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-25 00:11:37-- 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% 64.5M=0s 2015-11-25 00:11:38 (64.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.162769 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 00:11:37.875767) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 00:11:37.876187) ========= 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=447a3abc0420b6a47dd38cba000001bf-1448435975.744649-1135962262 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015799 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 00:11:37.926933) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 00:11:37.927289) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 9145ebe2c0c3e20a1c3aacdb4b2a0016b8498878 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 9145ebe2c0c3e20a1c3aacdb4b2a0016b8498878 --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=447a3abc0420b6a47dd38cba000001bf-1448435975.744649-1135962262 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-25 00:11:38,238 truncating revision to first 12 chars 2015-11-25 00:11:38,238 Setting DEBUG logging. 2015-11-25 00:11:38,238 attempt 1/10 2015-11-25 00:11:38,238 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/9145ebe2c0c3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-25 00:11:38,495 unpacking tar archive at: b2g-inbound-9145ebe2c0c3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.532998 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 00:11:38.472794) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 00:11:38.475593) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 00:11:38.487667) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-25 00:11:38.487976) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-25 00:11:38.488395) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-11-25 00:11:38.489175) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-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', 'B2G-Inbound-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound-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=447a3abc0420b6a47dd38cba000001bf-1448435975.744649-1135962262 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:11:38 INFO - MultiFileLogger online at 20151125 00:11:38 in /builds/slave/test 00:11:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-Non-PGO 00:11:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:11:38 INFO - {'append_to_log': False, 00:11:38 INFO - 'base_work_dir': '/builds/slave/test', 00:11:38 INFO - 'blob_upload_branch': 'B2G-Inbound-Non-PGO', 00:11:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:11:38 INFO - 'branch': 'B2G-Inbound-Non-PGO', 00:11:38 INFO - 'buildbot_json_path': 'buildprops.json', 00:11:38 INFO - 'config_files': ('talos/linux_config.py',), 00:11:38 INFO - 'default_actions': ('clobber', 00:11:38 INFO - 'read-buildbot-config', 00:11:38 INFO - 'download-and-extract', 00:11:38 INFO - 'populate-webroot', 00:11:38 INFO - 'create-virtualenv', 00:11:38 INFO - 'install', 00:11:38 INFO - 'run-tests'), 00:11:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:11:38 INFO - 'download_minidump_stackwalk': True, 00:11:38 INFO - 'download_symbols': 'ondemand', 00:11:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:11:38 INFO - 'tooltool.py': '/tools/tooltool.py', 00:11:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:11:38 INFO - '/tools/misc-python/virtualenv.py')}, 00:11:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:11:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:11:38 INFO - 'installer_path': 'installer.exe', 00:11:38 INFO - 'log_level': 'info', 00:11:38 INFO - 'log_name': 'talos', 00:11:38 INFO - 'log_to_console': True, 00:11:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:11:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:11:38 INFO - 'opt_config_files': (), 00:11:38 INFO - 'pip_index': False, 00:11:38 INFO - 'sps_profile': False, 00:11:38 INFO - 'sps_profile_interval': 0, 00:11:38 INFO - 'suite': 'dromaeojs', 00:11:38 INFO - 'system_bits': '64', 00:11:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:11:38 INFO - 'title': 'talos-linux64-ix-027', 00:11:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:11:38 INFO - 'use_talos_json': True, 00:11:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:11:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:11:38 INFO - 'work_dir': 'build'} 00:11:38 INFO - ##### 00:11:38 INFO - ##### Running clobber step. 00:11:38 INFO - ##### 00:11:38 INFO - Running pre-action listener: _resource_record_pre_action 00:11:38 INFO - Running main action method: clobber 00:11:38 INFO - rmtree: /builds/slave/test/build 00:11:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:11:39 INFO - Running post-action listener: _resource_record_post_action 00:11:39 INFO - ##### 00:11:39 INFO - ##### Running read-buildbot-config step. 00:11:39 INFO - ##### 00:11:39 INFO - Running pre-action listener: _resource_record_pre_action 00:11:39 INFO - Running main action method: read_buildbot_config 00:11:39 INFO - Using buildbot properties: 00:11:39 INFO - { 00:11:39 INFO - "properties": { 00:11:39 INFO - "buildnumber": 773, 00:11:39 INFO - "product": "firefox", 00:11:39 INFO - "script_repo_revision": "production", 00:11:39 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 00:11:39 INFO - "repository": "", 00:11:39 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound talos dromaeojs", 00:11:39 INFO - "buildid": "20151124225831", 00:11:39 INFO - "slavename": "talos-linux64-ix-027", 00:11:39 INFO - "pgo_build": "False", 00:11:39 INFO - "basedir": "/builds/slave/test", 00:11:39 INFO - "project": "", 00:11:39 INFO - "platform": "ubuntu64_hw", 00:11:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 00:11:39 INFO - "slavebuilddir": "test", 00:11:39 INFO - "scheduler": "tests-b2g-inbound-linux64-talos", 00:11:39 INFO - "branch": "b2g-inbound", 00:11:39 INFO - "repo_path": "integration/b2g-inbound", 00:11:39 INFO - "stage_platform": "linux64", 00:11:39 INFO - "builduid": "efcce5dd894b4eec8489a6c6fe6ff6e4", 00:11:39 INFO - "revision": "9145ebe2c0c3e20a1c3aacdb4b2a0016b8498878" 00:11:39 INFO - }, 00:11:39 INFO - "sourcestamp": { 00:11:39 INFO - "repository": "", 00:11:39 INFO - "hasPatch": false, 00:11:39 INFO - "project": "", 00:11:39 INFO - "branch": "b2g-inbound-linux64-talos", 00:11:39 INFO - "changes": [ 00:11:39 INFO - { 00:11:39 INFO - "category": null, 00:11:39 INFO - "files": [ 00:11:39 INFO - { 00:11:39 INFO - "url": null, 00:11:39 INFO - "name": "https://queue.taskcluster.net/v1/task/2a_0r62hQOmwB67mG3BWZw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 00:11:39 INFO - } 00:11:39 INFO - ], 00:11:39 INFO - "repository": "", 00:11:39 INFO - "rev": "9145ebe2c0c3e20a1c3aacdb4b2a0016b8498878", 00:11:39 INFO - "who": "yhuang@mozilla.com", 00:11:39 INFO - "when": 1448439036, 00:11:39 INFO - "number": 6704390, 00:11:39 INFO - "comments": "Bug 1225422 - Update the PrivilegedPackageRoot certificate. r=keeler", 00:11:39 INFO - "project": "", 00:11:39 INFO - "at": "Wed 25 Nov 2015 00:10:36", 00:11:39 INFO - "branch": "b2g-inbound-linux64-talos", 00:11:39 INFO - "revlink": "", 00:11:39 INFO - "properties": [ 00:11:39 INFO - [ 00:11:39 INFO - "buildid", 00:11:39 INFO - "20151124225831", 00:11:39 INFO - "Change" 00:11:39 INFO - ], 00:11:39 INFO - [ 00:11:39 INFO - "builduid", 00:11:39 INFO - "efcce5dd894b4eec8489a6c6fe6ff6e4", 00:11:39 INFO - "Change" 00:11:39 INFO - ], 00:11:39 INFO - [ 00:11:39 INFO - "pgo_build", 00:11:39 INFO - "False", 00:11:39 INFO - "Change" 00:11:39 INFO - ] 00:11:39 INFO - ], 00:11:39 INFO - "revision": "9145ebe2c0c3e20a1c3aacdb4b2a0016b8498878" 00:11:39 INFO - } 00:11:39 INFO - ], 00:11:39 INFO - "revision": "9145ebe2c0c3e20a1c3aacdb4b2a0016b8498878" 00:11:39 INFO - } 00:11:39 INFO - } 00:11:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/2a_0r62hQOmwB67mG3BWZw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 00:11:39 INFO - Running post-action listener: _resource_record_post_action 00:11:39 INFO - ##### 00:11:39 INFO - ##### Running download-and-extract step. 00:11:39 INFO - ##### 00:11:39 INFO - Running pre-action listener: _resource_record_pre_action 00:11:39 INFO - Running main action method: download_and_extract 00:11:39 INFO - mkdir: /builds/slave/test/build/tests 00:11:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:11:39 INFO - https://queue.taskcluster.net/v1/task/2a_0r62hQOmwB67mG3BWZw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 00:11:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2a_0r62hQOmwB67mG3BWZw/artifacts/public/build/test_packages.json 00:11:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2a_0r62hQOmwB67mG3BWZw/artifacts/public/build/test_packages.json 00:11:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2a_0r62hQOmwB67mG3BWZw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 00:11:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2a_0r62hQOmwB67mG3BWZw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 00:11:41 INFO - Downloaded 1302 bytes. 00:11:41 INFO - Reading from file /builds/slave/test/build/test_packages.json 00:11:41 INFO - Using the following test package requirements: 00:11:41 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:11:41 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:11:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:11:41 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:11:41 INFO - u'jsshell-linux-x86_64.zip'], 00:11:41 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:11:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:11:41 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:11:41 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:11:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:11:41 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:11:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:11:41 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:11:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:11:41 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:11:41 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:11:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:11:41 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:11:41 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:11:41 INFO - https://queue.taskcluster.net/v1/task/2a_0r62hQOmwB67mG3BWZw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:11:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2a_0r62hQOmwB67mG3BWZw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:11:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2a_0r62hQOmwB67mG3BWZw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:11:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2a_0r62hQOmwB67mG3BWZw/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:11:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2a_0r62hQOmwB67mG3BWZw/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:11:43 INFO - Downloaded 21345618 bytes. 00:11:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 00:11:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:11:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 00:11:44 INFO - Return code: 0 00:11:44 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:11:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:11:44 INFO - https://queue.taskcluster.net/v1/task/2a_0r62hQOmwB67mG3BWZw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:11:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2a_0r62hQOmwB67mG3BWZw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:11:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2a_0r62hQOmwB67mG3BWZw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:11:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2a_0r62hQOmwB67mG3BWZw/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:11:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2a_0r62hQOmwB67mG3BWZw/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:11:46 INFO - Downloaded 21345618 bytes. 00:11:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 00:11:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:11:46 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 00:11:47 INFO - Return code: 0 00:11: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:11:47 INFO - https://queue.taskcluster.net/v1/task/2a_0r62hQOmwB67mG3BWZw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:11:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2a_0r62hQOmwB67mG3BWZw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:11:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2a_0r62hQOmwB67mG3BWZw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:11:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2a_0r62hQOmwB67mG3BWZw/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:11:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2a_0r62hQOmwB67mG3BWZw/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:11:48 INFO - Downloaded 11131717 bytes. 00:11:48 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:11:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:11:48 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:11:48 INFO - Return code: 0 00:11:48 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:11:48 INFO - https://queue.taskcluster.net/v1/task/2a_0r62hQOmwB67mG3BWZw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:11:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2a_0r62hQOmwB67mG3BWZw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:11:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2a_0r62hQOmwB67mG3BWZw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:11:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2a_0r62hQOmwB67mG3BWZw/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:11:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2a_0r62hQOmwB67mG3BWZw/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:11:50 INFO - Downloaded 56846495 bytes. 00:11:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/2a_0r62hQOmwB67mG3BWZw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:11:50 INFO - mkdir: /builds/slave/test/properties 00:11:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:11:50 INFO - Writing to file /builds/slave/test/properties/build_url 00:11:50 INFO - Contents: 00:11:50 INFO - build_url:https://queue.taskcluster.net/v1/task/2a_0r62hQOmwB67mG3BWZw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:11:50 INFO - Running post-action listener: _resource_record_post_action 00:11:50 INFO - Running post-action listener: set_extra_try_arguments 00:11:50 INFO - ##### 00:11:50 INFO - ##### Running populate-webroot step. 00:11:50 INFO - ##### 00:11:50 INFO - Running pre-action listener: _resource_record_pre_action 00:11:50 INFO - Running main action method: populate_webroot 00:11:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:11:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:11:50 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 00:11:50 INFO - '../fennec_ids.txt'], 00:11:50 INFO - 'tests': ['tcheck2']}, 00:11:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:11:50 INFO - '--tppagecycles', 00:11:50 INFO - '7'], 00:11:50 INFO - 'tests': ['tsvgm']}}, 00:11:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 00:11:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 00:11:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:11:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:11:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 00:11:50 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:11:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:11:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:11:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:11:50 INFO - 'talos_options': ['--e10s'], 00:11:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:11:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:11:50 INFO - 'tests': ['damp', 'tps']}, 00:11:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:11:50 INFO - 'talos_options': ['--e10s'], 00:11:50 INFO - 'tests': ['damp', 'tps']}, 00:11:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 00:11:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:11:50 INFO - 'other': {'tests': ['a11yr', 00:11:50 INFO - 'ts_paint', 00:11:50 INFO - 'tpaint', 00:11:50 INFO - 'sessionrestore', 00:11:50 INFO - 'sessionrestore_no_auto_restore']}, 00:11:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 00:11:50 INFO - 'tests': ['a11yr', 00:11:50 INFO - 'ts_paint', 00:11:50 INFO - 'tpaint', 00:11:50 INFO - 'sessionrestore', 00:11:50 INFO - 'sessionrestore_no_auto_restore']}, 00:11:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 00:11:50 INFO - 'tests': ['a11yr', 00:11:50 INFO - 'ts_paint', 00:11:50 INFO - 'tpaint', 00:11:50 INFO - 'sessionrestore', 00:11:50 INFO - 'sessionrestore_no_auto_restore']}, 00:11:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 00:11:50 INFO - 'tests': ['a11yr', 00:11:50 INFO - 'ts_paint', 00:11:50 INFO - 'tpaint', 00:11:50 INFO - 'sessionrestore', 00:11:50 INFO - 'sessionrestore_no_auto_restore']}, 00:11:50 INFO - 'other_l64': {'tests': ['a11yr', 00:11:50 INFO - 'ts_paint', 00:11:50 INFO - 'tpaint', 00:11:50 INFO - 'sessionrestore', 00:11:50 INFO - 'sessionrestore_no_auto_restore']}, 00:11:50 INFO - 'other_nol64': {'tests': ['a11yr', 00:11:50 INFO - 'ts_paint', 00:11:50 INFO - 'tpaint', 00:11:50 INFO - 'sessionrestore', 00:11:50 INFO - 'sessionrestore_no_auto_restore']}, 00:11:50 INFO - 'svgr': {'tests': ['tsvgx', 00:11:50 INFO - 'tsvgr_opacity', 00:11:50 INFO - 'tart', 00:11:50 INFO - 'tscrollx', 00:11:50 INFO - 'cart']}, 00:11:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 00:11:50 INFO - 'tests': ['tsvgx', 00:11:50 INFO - 'tsvgr_opacity', 00:11:50 INFO - 'tart', 00:11:50 INFO - 'tscrollx', 00:11:50 INFO - 'cart']}, 00:11:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:11:50 INFO - 'tests': ['tp5o']}, 00:11:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:11:50 INFO - 'talos_options': ['--e10s'], 00:11:50 INFO - 'tests': ['tp5o']}, 00:11:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:11:50 INFO - 'talos_options': ['--xperf_path', 00:11:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:11:50 INFO - 'tests': ['tp5n']}, 00:11:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:11:50 INFO - 'talos_options': ['--e10s', 00:11:50 INFO - '--xperf_path', 00:11:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:11:50 INFO - 'tests': ['tp5n']}}, 00:11:50 INFO - 'talos.zip': {'path': '', 00:11:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:11:50 INFO - Running post-action listener: _resource_record_post_action 00:11:50 INFO - ##### 00:11:50 INFO - ##### Running create-virtualenv step. 00:11:50 INFO - ##### 00:11:50 INFO - Running pre-action listener: _resource_record_pre_action 00:11:50 INFO - Running main action method: create_virtualenv 00:11:50 INFO - Creating virtualenv /builds/slave/test/build/venv 00:11:50 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:11:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:11:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:11:50 INFO - Using real prefix '/usr' 00:11:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:11:50 INFO - Installing distribute.............................................................................................................................................................................................done. 00:11:52 INFO - Installing pip.................done. 00:11:52 INFO - Return code: 0 00:11:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:11:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:11:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:11:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:11:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:11:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:11:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20de030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230f210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a1220>, '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 0x230d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230d740>, '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': '447a3abc0420b6a47dd38cba000001bf-1448435975.744649-1135962262', '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:11:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 00:11:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:11:52 INFO - Using env: {'DISPLAY': ':0', 00:11:52 INFO - 'HOME': '/home/cltbld', 00:11:52 INFO - 'LANG': 'en_US.UTF-8', 00:11:52 INFO - 'LANGUAGE': 'en_US:en', 00:11:52 INFO - 'LOGNAME': 'cltbld', 00:11:52 INFO - 'MAIL': '/var/mail/cltbld', 00:11:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:11:52 INFO - 'MOZ_NO_REMOTE': '1', 00:11:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:11:52 INFO - 'NO_EM_RESTART': '1', 00:11:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:11:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:11:52 INFO - 'PWD': '/builds/slave/test', 00:11:52 INFO - 'SHELL': '/bin/bash', 00:11:52 INFO - 'SHLVL': '1', 00:11:52 INFO - 'TERM': 'linux', 00:11:52 INFO - 'TMOUT': '86400', 00:11:52 INFO - 'USER': 'cltbld', 00:11:52 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1448435975.744649-1135962262', 00:11:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:11:52 INFO - '_': '/tools/buildbot/bin/python'} 00:11:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:11:53 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:11:53 INFO - Cleaning up... 00:11:53 INFO - Return code: 0 00:11:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 00:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:11:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:11:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:11:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:11:53 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 0x20de030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230f210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a1220>, '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 0x230d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230d740>, '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': '447a3abc0420b6a47dd38cba000001bf-1448435975.744649-1135962262', '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:11:53 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:11:53 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:11:53 INFO - Using env: {'DISPLAY': ':0', 00:11:53 INFO - 'HOME': '/home/cltbld', 00:11:53 INFO - 'LANG': 'en_US.UTF-8', 00:11:53 INFO - 'LANGUAGE': 'en_US:en', 00:11:53 INFO - 'LOGNAME': 'cltbld', 00:11:53 INFO - 'MAIL': '/var/mail/cltbld', 00:11:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:11:53 INFO - 'MOZ_NO_REMOTE': '1', 00:11:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:11:53 INFO - 'NO_EM_RESTART': '1', 00:11:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:11:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:11:53 INFO - 'PWD': '/builds/slave/test', 00:11:53 INFO - 'SHELL': '/bin/bash', 00:11:53 INFO - 'SHLVL': '1', 00:11:53 INFO - 'TERM': 'linux', 00:11:53 INFO - 'TMOUT': '86400', 00:11:53 INFO - 'USER': 'cltbld', 00:11:53 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1448435975.744649-1135962262', 00:11:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:11:53 INFO - '_': '/tools/buildbot/bin/python'} 00:11:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:11:53 INFO - Downloading/unpacking psutil>=0.7.1 00:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:11:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:11:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:11:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:11:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:11:55 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 00:11:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 00:11:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:11:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:11:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:11:55 INFO - Installing collected packages: psutil 00:11:55 INFO - Running setup.py install for psutil 00:11:55 INFO - building 'psutil._psutil_linux' extension 00:11:55 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:11:55 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:11:55 INFO - building 'psutil._psutil_posix' extension 00:11:55 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:11:55 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:11:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:11:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:11:55 INFO - Successfully installed psutil 00:11:55 INFO - Cleaning up... 00:11:55 INFO - Return code: 0 00:11:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 00:11:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:11:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:11:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:11:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:11:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:11:55 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 0x20de030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230f210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a1220>, '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 0x230d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230d740>, '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': '447a3abc0420b6a47dd38cba000001bf-1448435975.744649-1135962262', '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:11:55 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:11:55 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:11:55 INFO - Using env: {'DISPLAY': ':0', 00:11:55 INFO - 'HOME': '/home/cltbld', 00:11:55 INFO - 'LANG': 'en_US.UTF-8', 00:11:55 INFO - 'LANGUAGE': 'en_US:en', 00:11:55 INFO - 'LOGNAME': 'cltbld', 00:11:55 INFO - 'MAIL': '/var/mail/cltbld', 00:11:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:11:55 INFO - 'MOZ_NO_REMOTE': '1', 00:11:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:11:55 INFO - 'NO_EM_RESTART': '1', 00:11:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:11:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:11:55 INFO - 'PWD': '/builds/slave/test', 00:11:55 INFO - 'SHELL': '/bin/bash', 00:11:55 INFO - 'SHLVL': '1', 00:11:55 INFO - 'TERM': 'linux', 00:11:55 INFO - 'TMOUT': '86400', 00:11:55 INFO - 'USER': 'cltbld', 00:11:55 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1448435975.744649-1135962262', 00:11:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:11:55 INFO - '_': '/tools/buildbot/bin/python'} 00:11:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:11:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:11:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:11:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:11:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:11:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:11:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:11:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 00:11:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:11:57 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:11:57 INFO - Installing collected packages: mozsystemmonitor 00:11:57 INFO - Running setup.py install for mozsystemmonitor 00:11:57 INFO - Successfully installed mozsystemmonitor 00:11:57 INFO - Cleaning up... 00:11:57 INFO - Return code: 0 00:11:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:11:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:11:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:11:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:11:57 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 0x20de030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230f210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a1220>, '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 0x230d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230d740>, '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': '447a3abc0420b6a47dd38cba000001bf-1448435975.744649-1135962262', '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:11:57 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:11:57 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:11:57 INFO - Using env: {'DISPLAY': ':0', 00:11:57 INFO - 'HOME': '/home/cltbld', 00:11:57 INFO - 'LANG': 'en_US.UTF-8', 00:11:57 INFO - 'LANGUAGE': 'en_US:en', 00:11:57 INFO - 'LOGNAME': 'cltbld', 00:11:57 INFO - 'MAIL': '/var/mail/cltbld', 00:11:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:11:57 INFO - 'MOZ_NO_REMOTE': '1', 00:11:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:11:57 INFO - 'NO_EM_RESTART': '1', 00:11:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:11:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:11:57 INFO - 'PWD': '/builds/slave/test', 00:11:57 INFO - 'SHELL': '/bin/bash', 00:11:57 INFO - 'SHLVL': '1', 00:11:57 INFO - 'TERM': 'linux', 00:11:57 INFO - 'TMOUT': '86400', 00:11:57 INFO - 'USER': 'cltbld', 00:11:57 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1448435975.744649-1135962262', 00:11:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:11:57 INFO - '_': '/tools/buildbot/bin/python'} 00:11:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:11:58 INFO - Downloading/unpacking blobuploader==1.2.4 00:11:58 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:11:58 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:11:58 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:11:58 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:11:58 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:11:58 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:11:59 INFO - Downloading blobuploader-1.2.4.tar.gz 00:11:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 00:11:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:11:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:11:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:11:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:11:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:11:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:12:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 00:12:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:12:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:12:00 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:12:00 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:12:00 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:12:00 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:12:00 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:12:00 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:12:00 INFO - Downloading docopt-0.6.1.tar.gz 00:12:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 00:12:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:12:00 INFO - Installing collected packages: blobuploader, requests, docopt 00:12:00 INFO - Running setup.py install for blobuploader 00:12:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:12:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:12:00 INFO - Running setup.py install for requests 00:12:00 INFO - Running setup.py install for docopt 00:12:00 INFO - Successfully installed blobuploader requests docopt 00:12:00 INFO - Cleaning up... 00:12:01 INFO - Return code: 0 00:12:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:12:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:12:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:12:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:12:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:12:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:12:01 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 0x20de030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230f210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a1220>, '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 0x230d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230d740>, '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': '447a3abc0420b6a47dd38cba000001bf-1448435975.744649-1135962262', '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:12:01 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:12:01 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:12:01 INFO - Using env: {'DISPLAY': ':0', 00:12:01 INFO - 'HOME': '/home/cltbld', 00:12:01 INFO - 'LANG': 'en_US.UTF-8', 00:12:01 INFO - 'LANGUAGE': 'en_US:en', 00:12:01 INFO - 'LOGNAME': 'cltbld', 00:12:01 INFO - 'MAIL': '/var/mail/cltbld', 00:12:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:12:01 INFO - 'MOZ_NO_REMOTE': '1', 00:12:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:12:01 INFO - 'NO_EM_RESTART': '1', 00:12:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:12:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:12:01 INFO - 'PWD': '/builds/slave/test', 00:12:01 INFO - 'SHELL': '/bin/bash', 00:12:01 INFO - 'SHLVL': '1', 00:12:01 INFO - 'TERM': 'linux', 00:12:01 INFO - 'TMOUT': '86400', 00:12:01 INFO - 'USER': 'cltbld', 00:12:01 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1448435975.744649-1135962262', 00:12:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:12:01 INFO - '_': '/tools/buildbot/bin/python'} 00:12:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:12:01 INFO - Running setup.py (path:/tmp/pip-l5AU4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:12:01 INFO - Running setup.py (path:/tmp/pip-0VtvmU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:12:01 INFO - Running setup.py (path:/tmp/pip-H6MzUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:12:01 INFO - Running setup.py (path:/tmp/pip-GWdEvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:12:01 INFO - Running setup.py (path:/tmp/pip-2KAreF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:12:01 INFO - Running setup.py (path:/tmp/pip-mSa_Ow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:12:01 INFO - Running setup.py (path:/tmp/pip-mmBMFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:12:01 INFO - Running setup.py (path:/tmp/pip-RcNytO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:12:01 INFO - Running setup.py (path:/tmp/pip-sUJoE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:12:01 INFO - Running setup.py (path:/tmp/pip-yv156S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:12:01 INFO - Running setup.py (path:/tmp/pip-z1IFUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:12:02 INFO - Running setup.py (path:/tmp/pip-as5Yvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:12:02 INFO - Running setup.py (path:/tmp/pip-vNHbL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:12:02 INFO - Running setup.py (path:/tmp/pip-s7a99K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:12:02 INFO - Running setup.py (path:/tmp/pip-enxW2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:12:02 INFO - Running setup.py (path:/tmp/pip-mW9S5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:12:02 INFO - Running setup.py (path:/tmp/pip-f2KHle-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:12:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:12:02 INFO - Running setup.py install for manifestparser 00:12:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:12:02 INFO - Running setup.py install for mozcrash 00:12:02 INFO - Running setup.py install for mozdebug 00:12:02 INFO - Running setup.py install for mozdevice 00:12:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:12:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:12:02 INFO - Running setup.py install for mozfile 00:12:02 INFO - Running setup.py install for mozhttpd 00:12:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:12:03 INFO - Running setup.py install for mozinfo 00:12:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:12:03 INFO - Running setup.py install for mozInstall 00:12:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:12:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:12:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:12:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:12:03 INFO - Running setup.py install for mozleak 00:12:03 INFO - Running setup.py install for mozlog 00:12:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:12:03 INFO - Running setup.py install for moznetwork 00:12:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:12:03 INFO - Running setup.py install for mozprocess 00:12:03 INFO - Running setup.py install for mozprofile 00:12:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:12:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:12:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:12:03 INFO - Running setup.py install for mozrunner 00:12:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:12:03 INFO - Running setup.py install for mozscreenshot 00:12:04 INFO - Running setup.py install for moztest 00:12:04 INFO - Running setup.py install for mozversion 00:12:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:12:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:12:04 INFO - Cleaning up... 00:12:04 INFO - Return code: 0 00:12:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:12: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:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:12:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:12: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:12:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:12:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:12:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x20de030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230f210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a1220>, '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 0x230d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230d740>, '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': '447a3abc0420b6a47dd38cba000001bf-1448435975.744649-1135962262', '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:12:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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:12:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/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:12:04 INFO - Using env: {'DISPLAY': ':0', 00:12:04 INFO - 'HOME': '/home/cltbld', 00:12:04 INFO - 'LANG': 'en_US.UTF-8', 00:12:04 INFO - 'LANGUAGE': 'en_US:en', 00:12:04 INFO - 'LOGNAME': 'cltbld', 00:12:04 INFO - 'MAIL': '/var/mail/cltbld', 00:12:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:12:04 INFO - 'MOZ_NO_REMOTE': '1', 00:12:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:12:04 INFO - 'NO_EM_RESTART': '1', 00:12:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:12:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:12:04 INFO - 'PWD': '/builds/slave/test', 00:12:04 INFO - 'SHELL': '/bin/bash', 00:12:04 INFO - 'SHLVL': '1', 00:12:04 INFO - 'TERM': 'linux', 00:12:04 INFO - 'TMOUT': '86400', 00:12:04 INFO - 'USER': 'cltbld', 00:12:04 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1448435975.744649-1135962262', 00:12:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:12:04 INFO - '_': '/tools/buildbot/bin/python'} 00:12:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:12:04 INFO - Running setup.py (path:/tmp/pip-NYUOA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:12:04 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:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:12:04 INFO - Running setup.py (path:/tmp/pip-GTDkTI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:12:04 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:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:12:04 INFO - Running setup.py (path:/tmp/pip-E1dSGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:12:04 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:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:12:04 INFO - Running setup.py (path:/tmp/pip-9_7LOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:12:04 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:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:12:04 INFO - Running setup.py (path:/tmp/pip-w7clY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:12:04 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:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:12:04 INFO - Running setup.py (path:/tmp/pip-fQ3ImD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:12:04 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:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:12:04 INFO - Running setup.py (path:/tmp/pip-l8lrdn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:12:04 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:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:12:04 INFO - Running setup.py (path:/tmp/pip-1h_KFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:12:05 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:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:12:05 INFO - Running setup.py (path:/tmp/pip-FadHuG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:12:05 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:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:12:05 INFO - Running setup.py (path:/tmp/pip-EMVpTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:12:05 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:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:12:05 INFO - Running setup.py (path:/tmp/pip-VkWudB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:12:05 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:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:12:05 INFO - Running setup.py (path:/tmp/pip-l_6uH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:12:05 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:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:12:05 INFO - Running setup.py (path:/tmp/pip-5sZCAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:12:05 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:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:12:05 INFO - Running setup.py (path:/tmp/pip-2gw821-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:12:05 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:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:12:05 INFO - Running setup.py (path:/tmp/pip-Q2O631-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:12:05 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:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:12:05 INFO - Running setup.py (path:/tmp/pip-dNAEJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:12:05 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:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:12:05 INFO - Running setup.py (path:/tmp/pip-tdYRbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:12:05 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:12:05 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:12:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:12:05 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:12:05 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:12:05 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:12:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:12:05 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:12:05 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:12:05 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:12:05 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:12:05 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:12:05 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:12:07 INFO - Downloading blessings-1.5.1.tar.gz 00:12:07 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:12:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:12:07 INFO - Installing collected packages: blessings 00:12:07 INFO - Running setup.py install for blessings 00:12:07 INFO - Successfully installed blessings 00:12:07 INFO - Cleaning up... 00:12:07 INFO - Return code: 0 00:12:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:12:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:12:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:12:07 INFO - Reading from file tmpfile_stdout 00:12:07 INFO - Current package versions: 00:12:07 INFO - argparse == 1.2.1 00:12:07 INFO - blessings == 1.5.1 00:12:07 INFO - blobuploader == 1.2.4 00:12:07 INFO - docopt == 0.6.1 00:12:07 INFO - manifestparser == 1.1 00:12:07 INFO - mozInstall == 1.12 00:12:07 INFO - mozcrash == 0.16 00:12:07 INFO - mozdebug == 0.1 00:12:07 INFO - mozdevice == 0.47 00:12:07 INFO - mozfile == 1.2 00:12:07 INFO - mozhttpd == 0.7 00:12:07 INFO - mozinfo == 0.9 00:12:07 INFO - mozleak == 0.1 00:12:07 INFO - mozlog == 3.1 00:12:07 INFO - moznetwork == 0.27 00:12:07 INFO - mozprocess == 0.22 00:12:07 INFO - mozprofile == 0.27 00:12:07 INFO - mozrunner == 6.11 00:12:07 INFO - mozscreenshot == 0.1 00:12:07 INFO - mozsystemmonitor == 0.0 00:12:07 INFO - moztest == 0.7 00:12:07 INFO - mozversion == 1.4 00:12:07 INFO - psutil == 3.1.1 00:12:07 INFO - requests == 1.2.3 00:12:07 INFO - wsgiref == 0.1.2 00:12:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:12:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:12:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:12:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:12:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:12:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:12:07 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 0x20de030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230f210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a1220>, '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 0x230d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230d740>, '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': '447a3abc0420b6a47dd38cba000001bf-1448435975.744649-1135962262', '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:12:07 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:12:07 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:12:07 INFO - Using env: {'DISPLAY': ':0', 00:12:07 INFO - 'HOME': '/home/cltbld', 00:12:07 INFO - 'LANG': 'en_US.UTF-8', 00:12:07 INFO - 'LANGUAGE': 'en_US:en', 00:12:07 INFO - 'LOGNAME': 'cltbld', 00:12:07 INFO - 'MAIL': '/var/mail/cltbld', 00:12:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:12:07 INFO - 'MOZ_NO_REMOTE': '1', 00:12:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:12:07 INFO - 'NO_EM_RESTART': '1', 00:12:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:12:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:12:07 INFO - 'PWD': '/builds/slave/test', 00:12:07 INFO - 'SHELL': '/bin/bash', 00:12:07 INFO - 'SHLVL': '1', 00:12:07 INFO - 'TERM': 'linux', 00:12:07 INFO - 'TMOUT': '86400', 00:12:07 INFO - 'USER': 'cltbld', 00:12:07 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1448435975.744649-1135962262', 00:12:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:12:07 INFO - '_': '/tools/buildbot/bin/python'} 00:12:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:12:08 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:12:08 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:12:08 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:12:08 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:12:08 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:12:08 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:12:08 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:12:08 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:12:08 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:12:08 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:12:08 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:12:08 INFO - Cleaning up... 00:12:08 INFO - Return code: 0 00:12:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:12:08 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:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:12:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:12:08 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:12:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:12:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:12:08 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 0x20de030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230f210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a1220>, '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 0x230d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230d740>, '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': '447a3abc0420b6a47dd38cba000001bf-1448435975.744649-1135962262', '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:12:08 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:12:08 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:12:08 INFO - Using env: {'DISPLAY': ':0', 00:12:08 INFO - 'HOME': '/home/cltbld', 00:12:08 INFO - 'LANG': 'en_US.UTF-8', 00:12:08 INFO - 'LANGUAGE': 'en_US:en', 00:12:08 INFO - 'LOGNAME': 'cltbld', 00:12:08 INFO - 'MAIL': '/var/mail/cltbld', 00:12:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:12:08 INFO - 'MOZ_NO_REMOTE': '1', 00:12:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:12:08 INFO - 'NO_EM_RESTART': '1', 00:12:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:12:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:12:08 INFO - 'PWD': '/builds/slave/test', 00:12:08 INFO - 'SHELL': '/bin/bash', 00:12:08 INFO - 'SHLVL': '1', 00:12:08 INFO - 'TERM': 'linux', 00:12:08 INFO - 'TMOUT': '86400', 00:12:08 INFO - 'USER': 'cltbld', 00:12:08 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1448435975.744649-1135962262', 00:12:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:12:08 INFO - '_': '/tools/buildbot/bin/python'} 00:12:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:12:08 INFO - Downloading/unpacking jsonschema 00:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:12:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:12:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:12:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:12:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:12:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:12:09 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:12:09 INFO - Downloading/unpacking functools32 (from jsonschema) 00:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:12:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:12:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:12:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:12:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:12:10 INFO - Downloading functools32-3.2.3-2.tar.gz 00:12:10 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:12:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:12:10 INFO - warning: no files found matching '*.txt' 00:12:10 INFO - no previously-included directories found matching 'build' 00:12:10 INFO - no previously-included directories found matching 'dist' 00:12:10 INFO - no previously-included directories found matching '.git*' 00:12:10 INFO - Installing collected packages: jsonschema, functools32 00:12:10 INFO - Running setup.py install for functools32 00:12:10 INFO - warning: no files found matching '*.txt' 00:12:10 INFO - no previously-included directories found matching 'build' 00:12:10 INFO - no previously-included directories found matching 'dist' 00:12:10 INFO - no previously-included directories found matching '.git*' 00:12:10 INFO - Successfully installed jsonschema functools32 00:12:10 INFO - Cleaning up... 00:12:10 INFO - Return code: 0 00:12:10 INFO - Running post-action listener: _resource_record_post_action 00:12:10 INFO - Running post-action listener: _start_resource_monitoring 00:12:10 INFO - Starting resource monitoring. 00:12:10 INFO - ##### 00:12:10 INFO - ##### Running install step. 00:12:10 INFO - ##### 00:12:10 INFO - Running pre-action listener: _resource_record_pre_action 00:12:10 INFO - Running main action method: install 00:12:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:12:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:12:10 INFO - Reading from file tmpfile_stdout 00:12:10 INFO - Detecting whether we're running mozinstall >=1.0... 00:12:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:12:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:12:10 INFO - Reading from file tmpfile_stdout 00:12:10 INFO - Output received: 00:12:10 INFO - Usage: mozinstall [options] installer 00:12:10 INFO - Options: 00:12:10 INFO - -h, --help show this help message and exit 00:12:10 INFO - -d DEST, --destination=DEST 00:12:10 INFO - Directory to install application into. [default: 00:12:10 INFO - "/builds/slave/test"] 00:12:10 INFO - --app=APP Application being installed. [default: firefox] 00:12:10 INFO - mkdir: /builds/slave/test/build/application 00:12:10 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:12:10 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:12:25 INFO - Reading from file tmpfile_stdout 00:12:25 INFO - Output received: 00:12:25 INFO - /builds/slave/test/build/application/firefox/firefox 00:12:25 INFO - Running post-action listener: _resource_record_post_action 00:12:25 INFO - ##### 00:12:25 INFO - ##### Running run-tests step. 00:12:25 INFO - ##### 00:12:25 INFO - Running pre-action listener: _resource_record_pre_action 00:12:25 INFO - Running main action method: run_tests 00:12:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:12:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:12:25 INFO - Python 2.7.3 00:12:25 INFO - Return code: 0 00:12:25 INFO - grabbing minidump binary from tooltool 00:12:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:12:25 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 0x23a1220>, '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 0x230d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230d740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:12:25 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:12:25 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:12:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:12:25 INFO - Return code: 0 00:12:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:12:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:12:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:12:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:12:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:12:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/2a_0r62hQOmwB67mG3BWZw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost'] in /builds/slave/test/build 00:12:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName B2G-Inbound-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/2a_0r62hQOmwB67mG3BWZw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --webServer localhost 00:12:25 INFO - Using env: {'DISPLAY': ':0', 00:12:25 INFO - 'HOME': '/home/cltbld', 00:12:25 INFO - 'LANG': 'en_US.UTF-8', 00:12:25 INFO - 'LANGUAGE': 'en_US:en', 00:12:25 INFO - 'LOGNAME': 'cltbld', 00:12:25 INFO - 'MAIL': '/var/mail/cltbld', 00:12:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:12:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:12:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:12:25 INFO - 'MOZ_NO_REMOTE': '1', 00:12:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:12:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:12:25 INFO - 'NO_EM_RESTART': '1', 00:12:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:12:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:12:25 INFO - 'PWD': '/builds/slave/test', 00:12:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:12:25 INFO - 'SHELL': '/bin/bash', 00:12:25 INFO - 'SHLVL': '1', 00:12:25 INFO - 'TERM': 'linux', 00:12:25 INFO - 'TMOUT': '86400', 00:12:25 INFO - 'USER': 'cltbld', 00:12:25 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1448435975.744649-1135962262', 00:12:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:12:25 INFO - '_': '/tools/buildbot/bin/python'} 00:12:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/2a_0r62hQOmwB67mG3BWZw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost'] with output_timeout 3600 00:12:25 INFO - mozversion INFO | application_buildid: 20151124225831 00:12:25 INFO - mozversion INFO | application_changeset: 9145ebe2c0c3e20a1c3aacdb4b2a0016b8498878 00:12:25 INFO - mozversion INFO | application_display_name: Nightly 00:12:25 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:12:25 INFO - mozversion INFO | application_name: Firefox 00:12:25 INFO - mozversion INFO | application_remotingname: firefox 00:12:25 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 00:12:25 INFO - mozversion INFO | application_vendor: Mozilla 00:12:25 INFO - mozversion INFO | application_version: 45.0a1 00:12:25 INFO - mozversion INFO | platform_buildid: 20151124225831 00:12:25 INFO - mozversion INFO | platform_changeset: 9145ebe2c0c3e20a1c3aacdb4b2a0016b8498878 00:12:25 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 00:12:25 INFO - mozversion INFO | platform_version: 45.0a1 00:12:25 INFO - 2015-11-25 00:12:25,797 DEBUG : using testdate: 1448439145 00:12:25 INFO - 2015-11-25 00:12:25,797 DEBUG : actual date: 1448439145 00:12:25 INFO - 2015-11-25 00:12:25,808 INFO : starting webserver on 'localhost:44450' 00:12:25 INFO - 2015-11-25 00:12:25,809 INFO : Starting test suite talos-linux64-ix-027 00:12:25 INFO - 2015-11-25 00:12:25,809 INFO : Starting test dromaeo_css 00:12:25 INFO - 2015-11-25 00:12:25,809 DEBUG : operating with platform_type : linux_ 00:12:25 INFO - 2015-11-25 00:12:25,810 INFO : Initialising browser for dromaeo_css test... 00:12:25 INFO - 2015-11-25 00:12:25,823 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8WJ6kn/profile http://localhost:44450/getInfo.html 00:12:29 INFO - 2015-11-25 00:12:29,970 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 00:12:29 INFO - 2015-11-25 00:12:29,970 DEBUG : BROWSER_OUTPUT: colorDepth:24 00:12:29 INFO - 2015-11-25 00:12:29,970 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 00:12:29 INFO - 2015-11-25 00:12:29,970 DEBUG : BROWSER_OUTPUT: __metrics 00:12:30 INFO - 2015-11-25 00:12:30,066 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:12:30 INFO - 2015-11-25 00:12:30,740 DEBUG : BROWSER_OUTPUT: console.error: 00:12:30 INFO - 2015-11-25 00:12:30,740 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 00:12:30 INFO - 2015-11-25 00:12:30,741 DEBUG : BROWSER_OUTPUT: Stack: 00:12:30 INFO - 2015-11-25 00:12:30,741 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 00:12:30 INFO - 2015-11-25 00:12:30,741 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 00:12:30 INFO - 2015-11-25 00:12:30,741 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 00:12:30 INFO - 2015-11-25 00:12:30,741 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 00:12:30 INFO - 2015-11-25 00:12:30,741 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 00:12:30 INFO - 2015-11-25 00:12:30,741 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 00:12:30 INFO - 2015-11-25 00:12:30,742 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 00:12:30 INFO - 2015-11-25 00:12:30,742 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 00:12:30 INFO - 2015-11-25 00:12:30,742 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 00:12:30 INFO - 2015-11-25 00:12:30,742 DEBUG : BROWSER_OUTPUT: 00:12:31 INFO - 2015-11-25 00:12:31,443 INFO : Browser initialized. 00:12:31 INFO - 2015-11-25 00:12:31,444 INFO : Running cycle 1/1 for dromaeo_css test... 00:12:31 INFO - 2015-11-25 00:12:31,444 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8WJ6kn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 00:12:43 INFO - 2015-11-25 00:12:43,301 DEBUG : BROWSER_OUTPUT: RSS: Main: 138625024 00:12:43 INFO - 2015-11-25 00:12:43,301 DEBUG : BROWSER_OUTPUT: 00:13:34 INFO - 2015-11-25 00:13:34,484 DEBUG : BROWSER_OUTPUT: 1448439214477 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:15:46 INFO - 2015-11-25 00:15:46,245 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44450/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44450/tests/dromaeo/cssquery-ext.html) 00:15:47 INFO - 2015-11-25 00:15:47,336 DEBUG : BROWSER_OUTPUT: RSS: Main: 226537472 00:15:47 INFO - 2015-11-25 00:15:47,336 DEBUG : BROWSER_OUTPUT: 00:18:49 INFO - 2015-11-25 00:18:49,753 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44450/tests/dromaeo/cssquery-ext.html (next: http://localhost:44450/tests/dromaeo/cssquery-jquery.html) 00:18:50 INFO - 2015-11-25 00:18:50,326 DEBUG : BROWSER_OUTPUT: RSS: Main: 230277120 00:18:50 INFO - 2015-11-25 00:18:50,326 DEBUG : BROWSER_OUTPUT: 00:21:52 INFO - 2015-11-25 00:21:52,351 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44450/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44450/tests/dromaeo/cssquery-mootools.html) 00:21:52 INFO - 2015-11-25 00:21:52,924 DEBUG : BROWSER_OUTPUT: RSS: Main: 213827584 00:21:52 INFO - 2015-11-25 00:21:52,925 DEBUG : BROWSER_OUTPUT: 00:24:54 INFO - 2015-11-25 00:24:54,852 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44450/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44450/tests/dromaeo/cssquery-prototype.html) 00:24:55 INFO - 2015-11-25 00:24:55,446 DEBUG : BROWSER_OUTPUT: RSS: Main: 203829248 00:24:55 INFO - 2015-11-25 00:24:55,446 DEBUG : BROWSER_OUTPUT: 00:27:58 INFO - 2015-11-25 00:27:58,378 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44450/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44450/tests/dromaeo/cssquery-yui.html) 00:27:58 INFO - 2015-11-25 00:27:58,947 DEBUG : BROWSER_OUTPUT: RSS: Main: 204587008 00:27:58 INFO - 2015-11-25 00:27:58,947 DEBUG : BROWSER_OUTPUT: 00:31:01 INFO - 2015-11-25 00:31:01,607 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44450/tests/dromaeo/cssquery-yui.html (next: http://localhost:44450/tests/dromaeo/cssquery-dojo.html) 00:31:01 INFO - 2015-11-25 00:31:01,865 DEBUG : BROWSER_OUTPUT: RSS: Main: 250933248 00:31:01 INFO - 2015-11-25 00:31:01,865 DEBUG : BROWSER_OUTPUT: 00:31:01 INFO - 2015-11-25 00:31:01,865 DEBUG : BROWSER_OUTPUT: __start_tp_report 00:31:01 INFO - 2015-11-25 00:31:01,866 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 00:31:01 INFO - 2015-11-25 00:31:01,866 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 00:31:01 INFO - 2015-11-25 00:31:01,866 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 00:31:01 INFO - 2015-11-25 00:31:01,866 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2599.7790187834034;2706.472237913608;2717.21200851753;2739.8904043838247;2744.931376715582;4483.775811209434;4602.585767280944;4603.447586289646;4662.300654901766;4668;4513.977430112853;4543.068670922461;4581.702189357689;4628.09752098341;4634.930476042854;4257.59552842481;4265.637420819234;4292.484901811771;4310.97844510777;4320.697551171419;4321.783910804463;4340.717853339523;4363.0619416825375;4363.781810909458;4408.889777755549;4122.752634841919;4179.059711564873;4218.367244913257;4225.366195070733;4261.424707664457;4264.893377665552;4271.017665936852;4274.358846173068;4275.657947364234;4317.395564620955;4245.957540424618;4248.362745588156;4259.76571288579;4289.6997210195295;4297.076128632328;4366;4452.821887124511;4455.1535208310315;4490.101979604092;4633.7683115844075;4907.263910413467;4925.113479573675;4925.532074452921;4933.950660493385;4970.15507363749;4953.984433191224;4954.578860796801;4960.305557221992;4960.355153830015;4965.404151501807;4485.3944717463055;4581.702189357681;4608.285715714002;4610.976945115253;4676.415448068991;5020;5022.372203474566;5029.321041659402;5033.823816166417;5037.546620804145;4817.421909370898;4818.542238487338;4823.710577365369;4825.782839772219;4847.660663753503;4653.930191047137;4747.121782470254;4760;4772.5227477252;4958.677685950402;4883.267509873476;4890.828820991248;4902.411710594752;4909.459959404463;4942.505749425029;4878.756062196876;4886.828960986349;4887.975560122248;4901.607871370353;4952.380952380952;3923.352646813301;3981.6814654827544;4011.2579172853116;4018.3972404139613;4096.959030409717;3557.839897204632;3605.8737944172353;3632.945505817415;3641.362761516724;3648.616895226016;4263.253930562139;4273.893152671146;4285.485741711014;4312.396264522969;4314.352847072964;4945.604351651931;4948.208286674115;4948.876278093005;4961.8511444656715;4988.276699878497;4116.0533077392365;4150.481189851269;4214.852480163241;4217.873463796091;4275.615194632498;4381.145676593033;4424.80088396023;4445.711028783118;4446.688731788809;4484;4724.858254252378;4741.502142275081;4752.477227504903;4764.595009424238;4794.017226468565;4671.15919134559;4762.595179409789;4777.116233496814;4817.301491283814;4999.675021123615;4692.48382677912;4696.483386827378;4708.317293992283;4719.622430205644;4760.500147484464;4888.92666609994;4892.8532144035735;4900.632452566143;4901.632377571767;4939.382577177853;4760.309755085563;4821.686590371614;4855.34452848875;4866.270059490963;4956.677815941952;4763.809447622195;4785.401824771903;4787.353707249476;4819.036192761391;4841.443234027991;4765.76171191446;4774.809007639656;4774.973380723161;4777.546133117348;4796.160671882476;4465.6204222640135;4535.047639995506;4582.358469814162;4692.1554120257315;4705.482396936266;4728.1962066448095;4789.544993225638;4798.592119669867;4812.422509298906;4816.831410900601;4749.525047495223;4752;4758;4758.333833263415;4772.904541909073 00:31:01 INFO - 2015-11-25 00:31:01,866 DEBUG : BROWSER_OUTPUT: |1;ext.html;561.9100943848985;567.7672154416688;572.8997425450546;573.197523467146;577.8324285957073;26368.208953731395;36320.273594528124;36739.81630091852;36911.446328305065;36916;40529;41148.17703645925;41218.58781412185;41226.58773412265;41236;6957;7082.362587367136;7854.685812567491;8026.515094707469;8030.357571394275;9742.366746161477;9954.253430992669;9969.45473451616;9977.251706122033;9977.90022099777;9610.567524461381;9663.565139568736;9725.51372431379;9733.367331123489;9737.464439455827;7066.646667666621;7230.13238411394;7237.782866514013;7238.963805180993;9789.853152202688;6972.058772065757;9963.551640176209;10260.743481413025;10262.179025677928;10269.435181065039;38395.42406863899;38901.22197556033;38915.41626875571;38944.805275973726;38967;2728.8635568221707;2758.7642560109543;2803.859807009662;2837.460882432352;2838.1769286906774;28584.857075714695;28591.57112643312;28972.565411518844;29284.853575731984;29294.853525732447;3381.5603971483797;3402.795832250048;3409.727221822273;3449.1032331593965;3482.7387945903906;220524;221120;221871;222921.99999999837;223038;46217.76891115523;55119.448805512235;55342;55368.44631553633;55433;42266.788666056476;42287.78856105761;42488;42507;64576.67711661412;13259.602211933658;13362.866371336357;13450.663733406547;13456.932715336556;13459.461621535225;10115.190784737204;10179.134773544183;10182.287239893285;10188.083072523508;10189.082982531607;19098.33155839567;19316.903415482833;19332.516687082654;19361.903190483958;19447.611047778966;7533.2466753324225;7746.109197442253;7806.375489960789;7807.180246074194;7940.205979402013;828.3704384667576;829.2785276809215;836.7615229659518;870.9722527417708;925.6621333213328;26596.940958711915;26792;26946.730532694815;26947.326316842235;26993.460130797273;842.8735689646479;923.0584803500526;948.4546385828177;1054.9894501055044;1063.1069901282806;14541.127532348093;14643;14704.264786760834;14909.285432175222;14924.850751492564;327456;333271;336508;337003;337113;47811.28283075757;48297;48297;48302.75848620734;48384.75807620939;1191.7973944429468;1248.4194849394894;1259.4206664934234;1268.733565951142;1273.420593629896;26003.479930400907;26666.86666566655;26759.331016724736;27085.593716094667;27115.1865444037;36792.63207367999;37441.06397340088;40598.1880362397;42238.57761422346;43225.35161972636;180569;181044;182637;182639;183288;28101.71898281073;28453;28486.857565712868;28550.286242844097;28562.285942851595;36593.26813463769;40349.39475907805;40379.798101009306;40614.79692601518;40943.795281023406;34944.82527587346;37850;39067.6093239064;39399;39512;34373.484397733555;34421.311573768886;34451.794187203326;34751.65248347484;34874.65125348714;34134.487982679784;34634.48048279227;34777.82611086928;34814.47778283277;34940.65059349374;29648.85175574108;30893.227669307547;31304;31339.529907051867;31489;24531;24560;24604.876975615007;24803.379915502257;24859.254222373358 00:31:01 INFO - 2015-11-25 00:31:01,867 DEBUG : BROWSER_OUTPUT: |2;jquery.html;336.7996042354798;339.6722163112596;340.4671688807017;340.96931276185137;342.5803390846215;12282.631521054383;12677.61967140985;14690.412383504661;14783.039102458333;16727.91636041821;14727.55817325482;15404.922975385136;15981.280842362092;16215.594610134753;16220.513384598451;3903.277893589681;4981.750912454381;5117.539421452068;5127.077126117298;5132.820351287705;5081.187010078388;5117.795288188468;5118.897622047557;5119.846404607849;5127.9743601282125;4954.876128096808;5070.619703522232;5070.771815268322;5072.898542029176;5074.746262686869;5039.72281524516;5071.69569825808;5076.23856421536;5078.085944529983;5079.3650793650795;4424.7123936944;4533.161365147458;4535.614472769786;4541.386912766768;4557.58981691646;19400.835949842913;19922.601547969105;19949.50126246841;20092.1963121475;20342.28801991938;1810.1492298619628;1836.4857839804877;1857;1962.3033822992918;2195.7804219577915;12666.176698514659;12799.360031998456;13110.410031548603;13173.934130329382;13325.333733313393;1689.4847071643144;1760.2782859027736;1791.3372052340587;1804.296324433472;1806.7831860176732;54392.728036359964;56629;57233;57400.42599574034;58381;9528.475933823567;9687.225021998223;9826;9829.262805289633;9860.704178874645;10556;10764.677059688222;10790.676279711464;12279.570215042431;12381.133320667646;6704.161979752531;6798.830029249309;6973.790786276319;7053.788386348418;7059.399951004119;6617.503687223478;6660.70026848793;6662.233843108008;6697.665116744241;6737.764178253836;5741.770329186869;5851.093080572518;5938.584299099108;5974.40255974399;5987.341392446828;1625.2848746551479;1666.6333406650517;1693.8729595280156;1713.0492576620095;1713.092061207562;809.3282575462352;833.3374966901328;834.9707760228484;849.087231226434;872.2629378175432;16547.172641367884;16789.91605041967;16792.748108778378;17071.91464042672;17205.827941720672;760.7223363472293;817.8118834890006;822.5352675738309;874.2699845628971;885.4377470306273;7804.375649948104;8426.368022398345;8624.827503450022;8641.611127499278;8645.827083458296;480662;487598;488734;514937;519658;53533;61480.38519614836;70285.2971470289;71710.64144679243;73530.63234683793;1012.1902478017556;1027.3681685763352;1039.594558122333;1046.1212581431482;1072.2494254022215;14114.858851411765;14181.503647372292;14201.857981420053;14217.360218790385;14247.21640309793;23173.76826231716;23500.74401046638;24784.380390490383;30522.542161867146;31305.373892521566;39762.40356394598;39887.60112398839;41658.375124373764;41956.16087678168;42626.36060459157;8613.913860861312;8676.696315628922;8712.607932643174;8737.563121843756;8936.86594701093;10712;15551.922240388725;15689.921550392175;15821.525354239391;15954.8404515958;13252.536161234311;13363.465461381436;13464.394102265225;13468.326583670581;13575.185488870698;12520.248785072925;12593.433295501907;13175.407106680032;13176.934115329363;13523.391447384694;13049.086563940433;13180.209187448783;13307.334633268492;13589.728205436033;13897.722045559234;8372.288355489607;8694;8728.08355122703;8750.868736968823;8884.51135187545;12964.611061668165;12996.350182491027;13277.070605057554;13318.533851315158;13405.396757146147 00:31:01 INFO - 2015-11-25 00:31:01,868 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1476.1438365747867;1548.4116035906354;1600.2318886934272;1615.523420590926;1629.3401172525132;5831.533477321815;6007.219061522007;6436.871262574751;7064.788056358311;7103.254158313373;6401.679916004193;6668.499862510307;6721.899171512419;6729.394354508093;6737.9326206737915;2027.2093883385492;2064.3497298351044;2065.979340206601;2066.9483262918397;2068.513899233679;1732.8700347473928;1777.4756446848146;1779.2171444564415;1779.3772179737118;2060.3715866660664;1750.4486086882591;2043.1827269092332;2092.121309050195;2094.2984100326407;2095.1514636572215;2007.5282308657454;2062.711220429141;2065.3494149342982;2079.8128168464837;2080.771115177329;2062.896855157251;2094.183268525261;2096.2139197800825;2096.874187548752;2098.674705420647;6721.8655626887185;6723.731050758012;6773.8645227095185;6775.830604234884;6781.050652908597;4148.937765933513;4184.246835569596;4202.8739137825605;4220;4246.002189485468;2742.2321749910056;2764.4885696146275;2826.5194916864184;2827.2931767058235;2829.618001569803;862;903.7198468474794;935.036911980661;936.6206686292063;944.551338114397;9295.2099071579;9330.066993300683;9339.066093390675;9341.065893410672;9344.39261447997;3824.847006119724;3853.325668008087;3896.5518965318784;3926.2147570486018;3930.744501607386;8012.79968000793;8069.354451643854;8086.555239461886;8094.51432914027;8118;4180.28935081037;4192.4759405074365;4195.077083041726;4196.685248606367;4199.0342221289275;3808.1622043150464;3818.8281527331337;3822.445745366906;3825.923481530354;3836.07934095815;3373.1567108222944;3379.1889946413175;3395.6604339565847;3401.200717831308;3405.880794172192;930.4463844012802;931.3247895276006;1068;1083.0577397663926;1093.2347356850237;714.3178264757248;715.0239922505846;716.7204790131852;728.460938905217;789.5183937797939;6313.77901773445;6365.872682546323;6383.138276332728;6384.3934826191435;6385.074164246251;1004.8743907011624;1013.827649299606;1015.5531566110888;1028;1028.6091285311534;4681.368015317957;4717.080169366941;4724.834630787906;4726.220173671374;4729.337892695025;7973.481723687942;8235.29999949999;8339.374546909006;8345.874811877828;8346.165383461726;8251.628676709563;8252.958735206286;8342.207490288412;8342.457740246864;8343.249107580346;6535.901961470582;6571.3757193066585;6573.57271777333;6590.308017658077;6606.108175396356;6103.481204097701;6197.535184861244;6218.098375735583;6239.032949892774;6241.96879015602;7335.669894854851;7441.888371674538;7509.51188172767;7538.434617403607;7572.621368931642;7527.585982771;7621.31408173267;7626.161122276434;7735.419843511647;7787.766367008999;6034.818955431344;6097.75608975636;6103.481204097701;6106;6120.60216085953;6559.245686746085;6566.0479230512265;6584.901226481702;6639.402453779183;6643.1031810704935;6241.469475094668;6244.65654389013;6246.187995560548;6249.7501299325;6257.436830685078;5343.946560534345;5369.919451208313;5507.256520369699;5625.647771665458;5713.800016999385;5838.095095260242;5850.707464626837;5853.385394533512;5863;5891.381404952418;5508;5542.0855558832345;5551.139573366135;5553.139263414178;5556.027695153412;5494.972525137348;5520.558355331484;5528.474794894479;5542.972285138549;5550 00:31:01 INFO - 2015-11-25 00:31:01,869 DEBUG : BROWSER_OUTPUT: |4;prototype.html;303.38413021566214;307.4404583657743;310.92693217093995;315.16638491190815;316.0565711351615;5225.817096401626;5267.473252674736;5364.812231571896;5381.461853814617;5382.91925621116;5200.895982080356;5287.339082614673;5290.232916227154;5290.841274761763;5293.735313234342;3873.477080594112;3957.742746721454;4100.63094321511;4109.363048727452;4110.958890411095;4011.7392369496033;4013.7190396672245;4071.816768245436;4078.4697989261354;4082.2856000199995;4023.074692820653;4028.6575641070544;4031.778252196128;4046.6358027777496;4068.9186216275803;3832.329342365075;3905.082305658168;3964.980175099135;4035.959640403588;4060.8375664973364;3571.2678900825267;3572.9464058039152;3573.8213089345427;3577.6422357764277;3582.1223800168864;5019.071471777733;5030.899382012376;5036.6726162799305;5038.949610503884;5052.646314757969;4648;4658.953410465886;4662.650301227422;4666.603338716213;4668.276417155346;5341.172118321666;5481.342238931354;5484.040292948718;5496.5053145216725;5503.862403439906;3861.7296789224765;3865.2655995361074;3866.5553461352024;3868.78721670308;3870.3420418528635;5716.342620598602;5773.047447171211;5782.277215348124;5795.565332600029;5796.217510636052;3948.190620922704;3955.723099383073;3969.285528604879;3971.225611005884;3972.1261322509004;3756.7370284079852;3782.149016471272;4030.375291829771;4033.7176397651883;4038.131801662598;4175.03565559413;4336.284513055373;4450.666200034945;4455.866324010285;4464.843730469418;5350.571954243729;5410.972945135328;5414.458554144554;5495.945040549624;5526.723663816793;1384.4877395363578;1390.1659004597363;1412.8233970753656;1412.865777751112;1413.4770135050098;948.2935213266161;962.2734835199379;964.4117088575963;971.703630392737;972.9464879431557;4749.097671442415;4760.833370832004;4769.73766442849;4812.8796780080775;4817.229243321122;5632.324121105412;5646.915296270559;5651.858703532444;5654.745536450787;5655.3779084300695;4807.495213002654;4808.591269742111;4814.494478079821;4818.638602104857;4818.7831547580445;2854.6431696037994;2960.644722633298;2994.1766014345794;3034.0594415731193;3037;5393.191021346829;5454.181872719124;5471.261379713767;5481.123020316731;5489.807856724996;5873.20711703923;5933.881322373615;5934.43622855828;5937.198478205473;5941.970290148522;5451.918221226685;5487.890242195133;5498.257735205696;5499.9175012375645;5500.779968801203;5580.748866301107;5775.537956963517;5786.826395208151;5787.94212057874;5797.391273916178;5639.577031722719;5648.915266271091;5649.519790817662;5652.123920792284;5652.547796176378;5485.533729633026;5493.670379777226;5494.725263736717;5496;5498.285222920995;3902.9804850975565;3934.1344904121047;3940.8817735467983;3942.423030787708;3947.289487892207;5615.719214039364;5747.425257474386;5771.480566749013;5771.509421699035;5775.9133612995;5564.221009058654;5564.610477266552;5572.3034620672415;5579.6652200868075;5580.079286917613;5566.304211973504;5571.997040532743;5573.191887176417;5573.27547418833;5576.693281869536;5316.627836051439;5454.10007348783;5458.590605704668;5460.535854452416;5463.863403414787;5585.525230355465;5589.189567512769;5605.5795815313195;5606.103023516218;5607.579431542569;5274.235235890851;5367.651102678314;5395.946040539544;5459.481349271813;5494.945050549443 00:31:01 INFO - 2015-11-25 00:31:01,870 DEBUG : BROWSER_OUTPUT: |5;yui.html;598.8802239552091;633;681.9897701534476;719.3058698356089;724.7535837815142;11343.773124537514;11545.191836571434;11546.538138474472;11576.47905844237;11581.420928953561;11511.36687482188;12997.090203685746;13255.602331930033;13273.07088503805;13300.46798128076;569.1775384569299;746.8954346391496;774.2528460036064;774.5314084978563;774.6359211170741;560.1373884218299;762.5119923249098;777.2810150610691;777.4557809533321;777.6966982876683;797.1988151907325;811.4887620798888;811.5374236685092;812.46377390922;812.8821320908464;595.2499850188772;599.1163034524086;784.7135795434682;807.8505476486839;807.907090684573;592.5141384065068;593.0836857055859;593.2999061107892;593.3117583603;595.0895130450418;11960;12089.576864809778;12280.385980700928;12299.877001230052;12305.75388492234;11027.739313440805;11228.157888158421;11329.206955513117;11333.603323883624;11749.765004699944;9163.354531001576;9264.39781414206;9386.342955993083;9409.10613491724;9436.197923176538;3165.1295893629435;3215.758818088629;3236.5307030480685;3238.2875767331384;3283.4582293921476;38720.80639596784;39061.21877562433;39180.60819391798;39180.80409597962;39231.80384098061;8870.64517419296;9143.771405714777;9169.449833010041;9340.71977840666;9488.28837837165;16159.353625854834;16161;16182.029078255107;16191.676166476604;16199.595010124605;6264.561480696399;6295;6338.524610654219;6381.329960354096;6525.1517302750335;3528.7353448491467;3598.4962105305276;3606.711463082947;3626.927461450809;3654.524911761454;2588.055359793662;2588.5599448093867;2588.961165582518;2590.3006188329045;2592.2093761402575;478.2563114357138;484.2566660176612;496.50845662793574;500.16971826768116;500.689572465074;423.5954663296606;434.50900482454625;435.7755755785773;447.8589244388007;452.58136223993336;7189.5686258824635;7289.198188199294;7334.66993985272;7409.110906691124;7453.105627324648;367.9963200367962;478.77258302306126;492.5173330136486;530.4456842599493;537.4759609380901;3009;3419.466877646557;3733.1227161617;3751.1934933989323;3768.2463507298103;45625;46569.06861862744;46585.301220481044;52970;53280.467195328325;43592.56407435885;45126.54873451289;45210.09579808386;45345;46005.539944600794;39588.80205598954;39679.60320396759;42860.785696071944;43372;43548.78225608852;7460.253974602496;7653.311201991847;7671.923280767121;7834.370430990211;7907.209279072047;31663;32082;32691.673083268863;32982.175445614055;33003;40026.59973400345;42277.36583951305;42405.363919540614;42483.78758106189;42486.15027699367;9418.905810942077;9460.479673617741;9473.857892131762;9566.90433095688;9716.708498745049;10172.389656620626;10301.484925753532;10397.32417392867;10410.843837342598;10824.945875270889;9855.605775768889;10174.949125254327;10233.13018393415;10469;10513.369197848153;9998.900010999796;10087.646932357333;10553.366797992145;10734.624288149877;10737.946310268399;9344.299177561574;9752.268579856682;9925.404475731479;10068.39589624625;10071.395716257048;8658.264047555776;8737.650493980169;8786.868196976922;8953.776155596162;9005.819883602422;8209.343252539902;8781.077986811293;8855.424397414148;8937.167880584595;8974.506402147683 00:31:01 INFO - 2015-11-25 00:31:01,871 DEBUG : BROWSER_OUTPUT: __end_tp_report 00:31:01 INFO - 2015-11-25 00:31:01,871 DEBUG : BROWSER_OUTPUT: __start_cc_report 00:31:01 INFO - 2015-11-25 00:31:01,871 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,895 00:31:01 INFO - 2015-11-25 00:31:01,871 DEBUG : BROWSER_OUTPUT: __end_cc_report 00:31:01 INFO - 2015-11-25 00:31:01,871 DEBUG : BROWSER_OUTPUT: __startTimestamp1448440261859__endTimestamp 00:31:01 INFO - 2015-11-25 00:31:01,871 DEBUG : BROWSER_OUTPUT: 00:31:01 INFO - 2015-11-25 00:31:01,871 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 00:31:01 INFO - 2015-11-25 00:31:01,871 DEBUG : BROWSER_OUTPUT: Number of tests: 6 00:31:01 INFO - 2015-11-25 00:31:01,871 DEBUG : BROWSER_OUTPUT: 00:31:01 INFO - 2015-11-25 00:31:01,871 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4543.86 Median:4696.48 stddev:458.86 (9.8%) stddev-sans-first:434.18 00:31:01 INFO - 2015-11-25 00:31:01,872 DEBUG : BROWSER_OUTPUT: Values: 2599.8 2706.5 2717.2 2739.9 2744.9 4483.8 4602.6 4603.4 4662.3 4668.0 4514.0 4543.1 4581.7 4628.1 4634.9 4257.6 4265.6 4292.5 4311.0 4320.7 4321.8 4340.7 4363.1 4363.8 4408.9 4122.8 4179.1 4218.4 4225.4 4261.4 4264.9 4271.0 4274.4 4275.7 4317.4 4246.0 4248.4 4259.8 4289.7 4297.1 4366.0 4452.8 4455.2 4490.1 4633.8 4907.3 4925.1 4925.5 4934.0 4970.2 4954.0 4954.6 4960.3 4960.4 4965.4 4485.4 4581.7 4608.3 4611.0 4676.4 5020.0 5022.4 5029.3 5033.8 5037.5 4817.4 4818.5 4823.7 4825.8 4847.7 4653.9 4747.1 4760.0 4772.5 4958.7 4883.3 4890.8 4902.4 4909.5 4942.5 4878.8 4886.8 4888.0 4901.6 4952.4 3923.4 3981.7 4011.3 4018.4 4097.0 3557.8 3605.9 3632.9 3641.4 3648.6 4263.3 4273.9 4285.5 4312.4 4314.4 4945.6 4948.2 4948.9 4961.9 4988.3 4116.1 4150.5 4214.9 4217.9 4275.6 4381.1 4424.8 4445.7 4446.7 4484.0 4724.9 4741.5 4752.5 4764.6 4794.0 4671.2 4762.6 4777.1 4817.3 4999.7 4692.5 4696.5 4708.3 4719.6 4760.5 4888.9 4892.9 4900.6 4901.6 4939.4 4760.3 4821.7 4855.3 4866.3 4956.7 4763.8 4785.4 4787.4 4819.0 4841.4 4765.8 4774.8 4775.0 4777.5 4796.2 4465.6 4535.0 4582.4 4692.2 4705.5 4728.2 4789.5 4798.6 4812.4 4816.8 4749.5 4752.0 4758.0 4758.3 4772.9 00:31:01 INFO - 2015-11-25 00:31:01,873 DEBUG : BROWSER_OUTPUT: 00:31:01 INFO - 2015-11-25 00:31:01,873 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40966.62 Median:34764.74 stddev:66570.60 (191.5%) stddev-sans-first:66688.23 00:31:01 INFO - 2015-11-25 00:31:01,873 DEBUG : BROWSER_OUTPUT: Values: 561.9 567.8 572.9 573.2 577.8 26368.2 36320.3 36739.8 36911.4 36916.0 40529.0 41148.2 41218.6 41226.6 41236.0 6957.0 7082.4 7854.7 8026.5 8030.4 9742.4 9954.3 9969.5 9977.3 9977.9 9610.6 9663.6 9725.5 9733.4 9737.5 7066.6 7230.1 7237.8 7239.0 9789.9 6972.1 9963.6 10260.7 10262.2 10269.4 38395.4 38901.2 38915.4 38944.8 38967.0 2728.9 2758.8 2803.9 2837.5 2838.2 28584.9 28591.6 28972.6 29284.9 29294.9 3381.6 3402.8 3409.7 3449.1 3482.7 220524.0 221120.0 221871.0 222922.0 223038.0 46217.8 55119.4 55342.0 55368.4 55433.0 42266.8 42287.8 42488.0 42507.0 64576.7 13259.6 13362.9 13450.7 13456.9 13459.5 10115.2 10179.1 10182.3 10188.1 10189.1 19098.3 19316.9 19332.5 19361.9 19447.6 7533.2 7746.1 7806.4 7807.2 7940.2 828.4 829.3 836.8 871.0 925.7 26596.9 26792.0 26946.7 26947.3 26993.5 842.9 923.1 948.5 1055.0 1063.1 14541.1 14643.0 14704.3 14909.3 14924.9 327456.0 333271.0 336508.0 337003.0 337113.0 47811.3 48297.0 48297.0 48302.8 48384.8 1191.8 1248.4 1259.4 1268.7 1273.4 26003.5 26666.9 26759.3 27085.6 27115.2 36792.6 37441.1 40598.2 42238.6 43225.4 180569.0 181044.0 182637.0 182639.0 183288.0 28101.7 28453.0 28486.9 28550.3 28562.3 36593.3 40349.4 40379.8 40614.8 40943.8 34944.8 37850.0 39067.6 39399.0 39512.0 34373.5 34421.3 34451.8 34751.7 34874.7 34134.5 34634.5 34777.8 34814.5 34940.7 29648.9 30893.2 31304.0 31339.5 31489.0 24531.0 24560.0 24604.9 24803.4 24859.3 00:31:01 INFO - 2015-11-25 00:31:01,873 DEBUG : BROWSER_OUTPUT: 00:31:01 INFO - 2015-11-25 00:31:01,873 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26396.91 Median:21832.84 stddev:81312.74 (372.4%) stddev-sans-first:81517.29 00:31:01 INFO - 2015-11-25 00:31:01,873 DEBUG : BROWSER_OUTPUT: Values: 336.8 339.7 340.5 341.0 342.6 12282.6 12677.6 14690.4 14783.0 16727.9 14727.6 15404.9 15981.3 16215.6 16220.5 3903.3 4981.8 5117.5 5127.1 5132.8 5081.2 5117.8 5118.9 5119.8 5128.0 4954.9 5070.6 5070.8 5072.9 5074.7 5039.7 5071.7 5076.2 5078.1 5079.4 4424.7 4533.2 4535.6 4541.4 4557.6 19400.8 19922.6 19949.5 20092.2 20342.3 1810.1 1836.5 1857.0 1962.3 2195.8 12666.2 12799.4 13110.4 13173.9 13325.3 1689.5 1760.3 1791.3 1804.3 1806.8 54392.7 56629.0 57233.0 57400.4 58381.0 9528.5 9687.2 9826.0 9829.3 9860.7 10556.0 10764.7 10790.7 12279.6 12381.1 6704.2 6798.8 6973.8 7053.8 7059.4 6617.5 6660.7 6662.2 6697.7 6737.8 5741.8 5851.1 5938.6 5974.4 5987.3 1625.3 1666.6 1693.9 1713.0 1713.1 809.3 833.3 835.0 849.1 872.3 16547.2 16789.9 16792.7 17071.9 17205.8 760.7 817.8 822.5 874.3 885.4 7804.4 8426.4 8624.8 8641.6 8645.8 480662.0 487598.0 488734.0 514937.0 519658.0 53533.0 61480.4 70285.3 71710.6 73530.6 1012.2 1027.4 1039.6 1046.1 1072.2 14114.9 14181.5 14201.9 14217.4 14247.2 23173.8 23500.7 24784.4 30522.5 31305.4 39762.4 39887.6 41658.4 41956.2 42626.4 8613.9 8676.7 8712.6 8737.6 8936.9 10712.0 15551.9 15689.9 15821.5 15954.8 13252.5 13363.5 13464.4 13468.3 13575.2 12520.2 12593.4 13175.4 13176.9 13523.4 13049.1 13180.2 13307.3 13589.7 13897.7 8372.3 8694.0 8728.1 8750.9 8884.5 12964.6 12996.4 13277.1 13318.5 13405.4 00:31:01 INFO - 2015-11-25 00:31:01,873 DEBUG : BROWSER_OUTPUT: 00:31:01 INFO - 2015-11-25 00:31:01,873 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4773.20 Median:5852.05 stddev:2460.11 (42.0%) stddev-sans-first:2454.53 00:31:01 INFO - 2015-11-25 00:31:01,873 DEBUG : BROWSER_OUTPUT: Values: 1476.1 1548.4 1600.2 1615.5 1629.3 5831.5 6007.2 6436.9 7064.8 7103.3 6401.7 6668.5 6721.9 6729.4 6737.9 2027.2 2064.3 2066.0 2066.9 2068.5 1732.9 1777.5 1779.2 1779.4 2060.4 1750.4 2043.2 2092.1 2094.3 2095.2 2007.5 2062.7 2065.3 2079.8 2080.8 2062.9 2094.2 2096.2 2096.9 2098.7 6721.9 6723.7 6773.9 6775.8 6781.1 4148.9 4184.2 4202.9 4220.0 4246.0 2742.2 2764.5 2826.5 2827.3 2829.6 862.0 903.7 935.0 936.6 944.6 9295.2 9330.1 9339.1 9341.1 9344.4 3824.8 3853.3 3896.6 3926.2 3930.7 8012.8 8069.4 8086.6 8094.5 8118.0 4180.3 4192.5 4195.1 4196.7 4199.0 3808.2 3818.8 3822.4 3825.9 3836.1 3373.2 3379.2 3395.7 3401.2 3405.9 930.4 931.3 1068.0 1083.1 1093.2 714.3 715.0 716.7 728.5 789.5 6313.8 6365.9 6383.1 6384.4 6385.1 1004.9 1013.8 1015.6 1028.0 1028.6 4681.4 4717.1 4724.8 4726.2 4729.3 7973.5 8235.3 8339.4 8345.9 8346.2 8251.6 8253.0 8342.2 8342.5 8343.2 6535.9 6571.4 6573.6 6590.3 6606.1 6103.5 6197.5 6218.1 6239.0 6242.0 7335.7 7441.9 7509.5 7538.4 7572.6 7527.6 7621.3 7626.2 7735.4 7787.8 6034.8 6097.8 6103.5 6106.0 6120.6 6559.2 6566.0 6584.9 6639.4 6643.1 6241.5 6244.7 6246.2 6249.8 6257.4 5343.9 5369.9 5507.3 5625.6 5713.8 5838.1 5850.7 5853.4 5863.0 5891.4 5508.0 5542.1 5551.1 5553.1 5556.0 5495.0 5520.6 5528.5 5543.0 5550.0 00:31:01 INFO - 2015-11-25 00:31:01,873 DEBUG : BROWSER_OUTPUT: 00:31:01 INFO - 2015-11-25 00:31:01,874 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4573.79 Median:5290.54 stddev:1357.75 (25.7%) stddev-sans-first:1323.19 00:31:01 INFO - 2015-11-25 00:31:01,875 DEBUG : BROWSER_OUTPUT: Values: 303.4 307.4 310.9 315.2 316.1 5225.8 5267.5 5364.8 5381.5 5382.9 5200.9 5287.3 5290.2 5290.8 5293.7 3873.5 3957.7 4100.6 4109.4 4111.0 4011.7 4013.7 4071.8 4078.5 4082.3 4023.1 4028.7 4031.8 4046.6 4068.9 3832.3 3905.1 3965.0 4036.0 4060.8 3571.3 3572.9 3573.8 3577.6 3582.1 5019.1 5030.9 5036.7 5038.9 5052.6 4648.0 4659.0 4662.7 4666.6 4668.3 5341.2 5481.3 5484.0 5496.5 5503.9 3861.7 3865.3 3866.6 3868.8 3870.3 5716.3 5773.0 5782.3 5795.6 5796.2 3948.2 3955.7 3969.3 3971.2 3972.1 3756.7 3782.1 4030.4 4033.7 4038.1 4175.0 4336.3 4450.7 4455.9 4464.8 5350.6 5411.0 5414.5 5495.9 5526.7 1384.5 1390.2 1412.8 1412.9 1413.5 948.3 962.3 964.4 971.7 972.9 4749.1 4760.8 4769.7 4812.9 4817.2 5632.3 5646.9 5651.9 5654.7 5655.4 4807.5 4808.6 4814.5 4818.6 4818.8 2854.6 2960.6 2994.2 3034.1 3037.0 5393.2 5454.2 5471.3 5481.1 5489.8 5873.2 5933.9 5934.4 5937.2 5942.0 5451.9 5487.9 5498.3 5499.9 5500.8 5580.7 5775.5 5786.8 5787.9 5797.4 5639.6 5648.9 5649.5 5652.1 5652.5 5485.5 5493.7 5494.7 5496.0 5498.3 3903.0 3934.1 3940.9 3942.4 3947.3 5615.7 5747.4 5771.5 5771.5 5775.9 5564.2 5564.6 5572.3 5579.7 5580.1 5566.3 5572.0 5573.2 5573.3 5576.7 5316.6 5454.1 5458.6 5460.5 5463.9 5585.5 5589.2 5605.6 5606.1 5607.6 5274.2 5367.7 5395.9 5459.5 5494.9 00:31:01 INFO - 2015-11-25 00:31:01,875 DEBUG : BROWSER_OUTPUT: 00:31:01 INFO - 2015-11-25 00:31:01,875 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12223.41 Median:45815.27 stddev:14015.37 (30.6%) stddev-sans-first:14027.50 00:31:01 INFO - 2015-11-25 00:31:01,876 DEBUG : BROWSER_OUTPUT: Values: 598.9 633.0 682.0 719.3 724.8 11343.8 11545.2 11546.5 11576.5 11581.4 11511.4 12997.1 13255.6 13273.1 13300.5 569.2 746.9 774.3 774.5 774.6 560.1 762.5 777.3 777.5 777.7 797.2 811.5 811.5 812.5 812.9 595.2 599.1 784.7 807.9 807.9 592.5 593.1 593.3 593.3 595.1 11960.0 12089.6 12280.4 12299.9 12305.8 11027.7 11228.2 11329.2 11333.6 11749.8 9163.4 9264.4 9386.3 9409.1 9436.2 3165.1 3215.8 3236.5 3238.3 3283.5 38720.8 39061.2 39180.6 39180.8 39231.8 8870.6 9143.8 9169.4 9340.7 9488.3 16159.4 16161.0 16182.0 16191.7 16199.6 6264.6 6295.0 6338.5 6381.3 6525.2 3528.7 3598.5 3606.7 3626.9 3654.5 2588.1 2588.6 2589.0 2590.3 2592.2 478.3 484.3 496.5 500.2 500.7 423.6 434.5 435.8 447.9 452.6 7189.6 7289.2 7334.7 7409.1 7453.1 368.0 478.8 492.5 530.4 537.5 3009.0 3419.5 3733.1 3751.2 3768.2 45625.0 46569.1 46585.3 52970.0 53280.5 43592.6 45126.5 45210.1 45345.0 46005.5 39588.8 39679.6 42860.8 43372.0 43548.8 7460.3 7653.3 7671.9 7834.4 7907.2 31663.0 32082.0 32691.7 32982.2 33003.0 40026.6 42277.4 42405.4 42483.8 42486.2 9418.9 9460.5 9473.9 9566.9 9716.7 10172.4 10301.5 10397.3 10410.8 10824.9 9855.6 10174.9 10233.1 10469.0 10513.4 9998.9 10087.6 10553.4 10734.6 10737.9 9344.3 9752.3 9925.4 10068.4 10071.4 8658.3 8737.7 8786.9 8953.8 9005.8 8209.3 8781.1 8855.4 8937.2 8974.5 00:31:01 INFO - 2015-11-25 00:31:01,876 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 00:31:01 INFO - 2015-11-25 00:31:01,876 DEBUG : BROWSER_OUTPUT: 00:31:02 INFO - 2015-11-25 00:31:02,589 INFO : Browser exited with error code: 0 00:31:02 INFO - 2015-11-25 00:31:02,608 INFO : Completed test dromaeo_css (00:18:36) 00:31:02 INFO - 2015-11-25 00:31:02,608 INFO : Starting test kraken 00:31:02 INFO - 2015-11-25 00:31:02,608 DEBUG : operating with platform_type : linux_ 00:31:02 INFO - 2015-11-25 00:31:02,608 INFO : Initialising browser for kraken test... 00:31:02 INFO - 2015-11-25 00:31:02,614 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1FMIgO/profile http://localhost:44450/getInfo.html 00:31:06 INFO - 2015-11-25 00:31:06,851 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 00:31:06 INFO - 2015-11-25 00:31:06,851 DEBUG : BROWSER_OUTPUT: colorDepth:24 00:31:06 INFO - 2015-11-25 00:31:06,851 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 00:31:06 INFO - 2015-11-25 00:31:06,851 DEBUG : BROWSER_OUTPUT: __metrics 00:31:06 INFO - 2015-11-25 00:31:06,996 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:31:08 INFO - 2015-11-25 00:31:08,235 INFO : Browser initialized. 00:31:08 INFO - 2015-11-25 00:31:08,235 INFO : Running cycle 1/1 for kraken test... 00:31:08 INFO - 2015-11-25 00:31:08,235 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1FMIgO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 00:31:20 INFO - 2015-11-25 00:31:20,168 DEBUG : BROWSER_OUTPUT: RSS: Main: 139317248 00:31:20 INFO - 2015-11-25 00:31:20,168 DEBUG : BROWSER_OUTPUT: 00:31:22 INFO - 2015-11-25 00:31:22,764 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44450/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44450/tests/kraken/driver.html?testName=audio-beat-detection) 00:31:23 INFO - 2015-11-25 00:31:23,345 DEBUG : BROWSER_OUTPUT: RSS: Main: 177971200 00:31:23 INFO - 2015-11-25 00:31:23,345 DEBUG : BROWSER_OUTPUT: 00:31:26 INFO - 2015-11-25 00:31:26,047 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44450/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44450/tests/kraken/driver.html?testName=audio-dft) 00:31:26 INFO - 2015-11-25 00:31:26,628 DEBUG : BROWSER_OUTPUT: RSS: Main: 165965824 00:31:26 INFO - 2015-11-25 00:31:26,628 DEBUG : BROWSER_OUTPUT: 00:31:29 INFO - 2015-11-25 00:31:29,629 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44450/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44450/tests/kraken/driver.html?testName=audio-fft) 00:31:30 INFO - 2015-11-25 00:31:30,190 DEBUG : BROWSER_OUTPUT: RSS: Main: 151543808 00:31:30 INFO - 2015-11-25 00:31:30,190 DEBUG : BROWSER_OUTPUT: 00:31:32 INFO - 2015-11-25 00:31:32,222 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44450/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44450/tests/kraken/driver.html?testName=audio-oscillator) 00:31:32 INFO - 2015-11-25 00:31:32,791 DEBUG : BROWSER_OUTPUT: RSS: Main: 152973312 00:31:32 INFO - 2015-11-25 00:31:32,791 DEBUG : BROWSER_OUTPUT: 00:31:35 INFO - 2015-11-25 00:31:35,045 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44450/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44450/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:31:35 INFO - 2015-11-25 00:31:35,607 DEBUG : BROWSER_OUTPUT: RSS: Main: 154132480 00:31:35 INFO - 2015-11-25 00:31:35,607 DEBUG : BROWSER_OUTPUT: 00:31:38 INFO - 2015-11-25 00:31:38,566 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44450/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44450/tests/kraken/driver.html?testName=imaging-darkroom) 00:31:39 INFO - 2015-11-25 00:31:39,135 DEBUG : BROWSER_OUTPUT: RSS: Main: 154214400 00:31:39 INFO - 2015-11-25 00:31:39,135 DEBUG : BROWSER_OUTPUT: 00:31:42 INFO - 2015-11-25 00:31:42,543 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44450/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44450/tests/kraken/driver.html?testName=imaging-desaturate) 00:31:43 INFO - 2015-11-25 00:31:43,124 DEBUG : BROWSER_OUTPUT: RSS: Main: 156344320 00:31:43 INFO - 2015-11-25 00:31:43,125 DEBUG : BROWSER_OUTPUT: 00:31:45 INFO - 2015-11-25 00:31:45,962 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44450/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44450/tests/kraken/driver.html?testName=json-parse-financial) 00:31:46 INFO - 2015-11-25 00:31:46,536 DEBUG : BROWSER_OUTPUT: RSS: Main: 155275264 00:31:46 INFO - 2015-11-25 00:31:46,536 DEBUG : BROWSER_OUTPUT: 00:31:48 INFO - 2015-11-25 00:31:48,305 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44450/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44450/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:31:48 INFO - 2015-11-25 00:31:48,871 DEBUG : BROWSER_OUTPUT: RSS: Main: 165761024 00:31:48 INFO - 2015-11-25 00:31:48,871 DEBUG : BROWSER_OUTPUT: 00:31:50 INFO - 2015-11-25 00:31:50,762 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44450/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44450/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:31:51 INFO - 2015-11-25 00:31:51,351 DEBUG : BROWSER_OUTPUT: RSS: Main: 166187008 00:31:51 INFO - 2015-11-25 00:31:51,351 DEBUG : BROWSER_OUTPUT: 00:31:53 INFO - 2015-11-25 00:31:53,493 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44450/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44450/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:31:54 INFO - 2015-11-25 00:31:54,079 DEBUG : BROWSER_OUTPUT: RSS: Main: 173793280 00:31:54 INFO - 2015-11-25 00:31:54,079 DEBUG : BROWSER_OUTPUT: 00:31:56 INFO - 2015-11-25 00:31:56,582 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44450/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44450/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:31:57 INFO - 2015-11-25 00:31:57,167 DEBUG : BROWSER_OUTPUT: RSS: Main: 181542912 00:31:57 INFO - 2015-11-25 00:31:57,168 DEBUG : BROWSER_OUTPUT: 00:31:59 INFO - 2015-11-25 00:31:59,768 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44450/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44450/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:32:00 INFO - 2015-11-25 00:32:00,354 DEBUG : BROWSER_OUTPUT: RSS: Main: 179003392 00:32:00 INFO - 2015-11-25 00:32:00,354 DEBUG : BROWSER_OUTPUT: 00:32:02 INFO - 2015-11-25 00:32:02,116 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44450/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44450/tests/kraken/driver.html?testName=ai-astar) 00:32:02 INFO - 2015-11-25 00:32:02,366 DEBUG : BROWSER_OUTPUT: RSS: Main: 238116864 00:32:02 INFO - 2015-11-25 00:32:02,366 DEBUG : BROWSER_OUTPUT: 00:32:02 INFO - 2015-11-25 00:32:02,367 DEBUG : BROWSER_OUTPUT: __start_tp_report 00:32:02 INFO - 2015-11-25 00:32:02,367 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 00:32:02 INFO - 2015-11-25 00:32:02,367 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 00:32:02 INFO - 2015-11-25 00:32:02,368 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 00:32:02 INFO - 2015-11-25 00:32:02,368 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;113;109;114;114;113;101;112;111;105 00:32:02 INFO - 2015-11-25 00:32:02,368 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;129;153;169;130;156;156;131;170;134 00:32:02 INFO - 2015-11-25 00:32:02,368 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;162;162;160;160;165;163;162;162 00:32:02 INFO - 2015-11-25 00:32:02,368 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;73;89;90;72;72;72;97;91;72 00:32:02 INFO - 2015-11-25 00:32:02,368 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;134;94;96;94;140;95;95;135 00:32:02 INFO - 2015-11-25 00:32:02,368 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;111;110;110;110;110;109;110;110 00:32:02 INFO - 2015-11-25 00:32:02,368 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;146;147;146;147;146;147;149;146 00:32:02 INFO - 2015-11-25 00:32:02,369 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;96;96;96;95;96;95;95 00:32:02 INFO - 2015-11-25 00:32:02,369 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;71;70;72;71;70;70;79;80;69 00:32:02 INFO - 2015-11-25 00:32:02,369 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;68;68;68;69;68;68;68;68 00:32:02 INFO - 2015-11-25 00:32:02,369 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;83;90;84;84;85;85;83;92;84 00:32:02 INFO - 2015-11-25 00:32:02,369 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;130;119;125;125;123;128;121;120;126;124 00:32:02 INFO - 2015-11-25 00:32:02,369 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;149;148;149;148;143;142;149;140;136 00:32:02 INFO - 2015-11-25 00:32:02,369 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;69;71;70;68;69;69;70;69;70 00:32:02 INFO - 2015-11-25 00:32:02,370 DEBUG : BROWSER_OUTPUT: __end_tp_report 00:32:02 INFO - 2015-11-25 00:32:02,370 DEBUG : BROWSER_OUTPUT: __start_cc_report 00:32:02 INFO - 2015-11-25 00:32:02,370 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,978 00:32:02 INFO - 2015-11-25 00:32:02,370 DEBUG : BROWSER_OUTPUT: __end_cc_report 00:32:02 INFO - 2015-11-25 00:32:02,370 DEBUG : BROWSER_OUTPUT: __startTimestamp1448440322366__endTimestamp 00:32:02 INFO - 2015-11-25 00:32:02,370 DEBUG : BROWSER_OUTPUT: 00:32:02 INFO - 2015-11-25 00:32:02,378 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 00:32:02 INFO - 2015-11-25 00:32:02,378 DEBUG : BROWSER_OUTPUT: Number of tests: 14 00:32:02 INFO - 2015-11-25 00:32:02,378 DEBUG : BROWSER_OUTPUT: 00:32:02 INFO - 2015-11-25 00:32:02,378 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.20 Median:112.50 stddev:4.24 (3.8%) stddev-sans-first:4.49 00:32:02 INFO - 2015-11-25 00:32:02,378 DEBUG : BROWSER_OUTPUT: Values: 110.0 113.0 109.0 114.0 114.0 113.0 101.0 112.0 111.0 105.0 00:32:02 INFO - 2015-11-25 00:32:02,378 DEBUG : BROWSER_OUTPUT: 00:32:02 INFO - 2015-11-25 00:32:02,378 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.10 Median:154.50 stddev:15.89 (10.3%) stddev-sans-first:16.76 00:32:02 INFO - 2015-11-25 00:32:02,378 DEBUG : BROWSER_OUTPUT: Values: 153.0 129.0 153.0 169.0 130.0 156.0 156.0 131.0 170.0 134.0 00:32:02 INFO - 2015-11-25 00:32:02,378 DEBUG : BROWSER_OUTPUT: 00:32:02 INFO - 2015-11-25 00:32:02,378 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.57 (1.0%) stddev-sans-first:1.64 00:32:02 INFO - 2015-11-25 00:32:02,378 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 162.0 162.0 160.0 160.0 165.0 163.0 162.0 162.0 00:32:02 INFO - 2015-11-25 00:32:02,378 DEBUG : BROWSER_OUTPUT: 00:32:02 INFO - 2015-11-25 00:32:02,379 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.90 Median:81.00 stddev:10.42 (12.9%) stddev-sans-first:10.54 00:32:02 INFO - 2015-11-25 00:32:02,379 DEBUG : BROWSER_OUTPUT: Values: 71.0 73.0 89.0 90.0 72.0 72.0 72.0 97.0 91.0 72.0 00:32:02 INFO - 2015-11-25 00:32:02,379 DEBUG : BROWSER_OUTPUT: 00:32:02 INFO - 2015-11-25 00:32:02,379 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.10 Median:94.00 stddev:20.24 (21.5%) stddev-sans-first:20.91 00:32:02 INFO - 2015-11-25 00:32:02,379 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 134.0 94.0 96.0 94.0 140.0 95.0 95.0 135.0 00:32:02 INFO - 2015-11-25 00:32:02,379 DEBUG : BROWSER_OUTPUT: 00:32:02 INFO - 2015-11-25 00:32:02,379 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 00:32:02 INFO - 2015-11-25 00:32:02,379 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 111.0 110.0 110.0 110.0 110.0 109.0 110.0 110.0 00:32:02 INFO - 2015-11-25 00:32:02,379 DEBUG : BROWSER_OUTPUT: 00:32:02 INFO - 2015-11-25 00:32:02,379 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 00:32:02 INFO - 2015-11-25 00:32:02,379 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 146.0 147.0 146.0 147.0 146.0 147.0 149.0 146.0 00:32:02 INFO - 2015-11-25 00:32:02,379 DEBUG : BROWSER_OUTPUT: 00:32:02 INFO - 2015-11-25 00:32:02,379 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 00:32:02 INFO - 2015-11-25 00:32:02,379 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 96.0 96.0 96.0 95.0 96.0 95.0 95.0 00:32:02 INFO - 2015-11-25 00:32:02,379 DEBUG : BROWSER_OUTPUT: 00:32:02 INFO - 2015-11-25 00:32:02,379 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.30 Median:71.00 stddev:3.89 (5.5%) stddev-sans-first:4.10 00:32:02 INFO - 2015-11-25 00:32:02,379 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 70.0 72.0 71.0 70.0 70.0 79.0 80.0 69.0 00:32:02 INFO - 2015-11-25 00:32:02,380 DEBUG : BROWSER_OUTPUT: 00:32:02 INFO - 2015-11-25 00:32:02,380 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 00:32:02 INFO - 2015-11-25 00:32:02,380 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 68.0 68.0 69.0 68.0 68.0 68.0 68.0 00:32:02 INFO - 2015-11-25 00:32:02,380 DEBUG : BROWSER_OUTPUT: 00:32:02 INFO - 2015-11-25 00:32:02,380 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:84.50 stddev:3.22 (3.8%) stddev-sans-first:3.21 00:32:02 INFO - 2015-11-25 00:32:02,380 DEBUG : BROWSER_OUTPUT: Values: 82.0 83.0 90.0 84.0 84.0 85.0 85.0 83.0 92.0 84.0 00:32:02 INFO - 2015-11-25 00:32:02,380 DEBUG : BROWSER_OUTPUT: 00:32:02 INFO - 2015-11-25 00:32:02,380 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.10 Median:125.00 stddev:3.48 (2.8%) stddev-sans-first:2.96 00:32:02 INFO - 2015-11-25 00:32:02,380 DEBUG : BROWSER_OUTPUT: Values: 130.0 119.0 125.0 125.0 123.0 128.0 121.0 120.0 126.0 124.0 00:32:02 INFO - 2015-11-25 00:32:02,380 DEBUG : BROWSER_OUTPUT: 00:32:02 INFO - 2015-11-25 00:32:02,380 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.40 Median:148.00 stddev:4.79 (3.2%) stddev-sans-first:4.81 00:32:02 INFO - 2015-11-25 00:32:02,380 DEBUG : BROWSER_OUTPUT: Values: 140.0 149.0 148.0 149.0 148.0 143.0 142.0 149.0 140.0 136.0 00:32:02 INFO - 2015-11-25 00:32:02,380 DEBUG : BROWSER_OUTPUT: 00:32:02 INFO - 2015-11-25 00:32:02,380 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:70.00 stddev:0.85 (1.2%) stddev-sans-first:0.88 00:32:02 INFO - 2015-11-25 00:32:02,380 DEBUG : BROWSER_OUTPUT: Values: 70.0 69.0 71.0 70.0 68.0 69.0 69.0 70.0 69.0 70.0 00:32:02 INFO - 2015-11-25 00:32:02,381 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 00:32:02 INFO - 2015-11-25 00:32:02,381 DEBUG : BROWSER_OUTPUT: 00:32:03 INFO - 2015-11-25 00:32:03,273 INFO : Browser exited with error code: 0 00:32:03 INFO - 2015-11-25 00:32:03,324 INFO : Completed test kraken (00:01:00) 00:32:03 INFO - 2015-11-25 00:32:03,325 INFO : Starting test v8_7 00:32:03 INFO - 2015-11-25 00:32:03,325 DEBUG : operating with platform_type : linux_ 00:32:03 INFO - 2015-11-25 00:32:03,325 INFO : Initialising browser for v8_7 test... 00:32:03 INFO - 2015-11-25 00:32:03,331 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplUFss7/profile http://localhost:44450/getInfo.html 00:32:07 INFO - 2015-11-25 00:32:07,438 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 00:32:07 INFO - 2015-11-25 00:32:07,438 DEBUG : BROWSER_OUTPUT: colorDepth:24 00:32:07 INFO - 2015-11-25 00:32:07,438 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 00:32:07 INFO - 2015-11-25 00:32:07,438 DEBUG : BROWSER_OUTPUT: __metrics 00:32:07 INFO - 2015-11-25 00:32:07,514 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:32:08 INFO - 2015-11-25 00:32:08,801 INFO : Browser initialized. 00:32:08 INFO - 2015-11-25 00:32:08,801 INFO : Running cycle 1/1 for v8_7 test... 00:32:08 INFO - 2015-11-25 00:32:08,802 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplUFss7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 00:32:20 INFO - 2015-11-25 00:32:20,693 DEBUG : BROWSER_OUTPUT: RSS: Main: 138842112 00:32:20 INFO - 2015-11-25 00:32:20,694 DEBUG : BROWSER_OUTPUT: 00:32:42 INFO - 2015-11-25 00:32:42,101 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44450/tests/v8_7/run.html (next: http://localhost:44450/tests/v8_7/run.html) 00:32:42 INFO - 2015-11-25 00:32:42,350 DEBUG : BROWSER_OUTPUT: RSS: Main: 450166784 00:32:42 INFO - 2015-11-25 00:32:42,350 DEBUG : BROWSER_OUTPUT: 00:32:42 INFO - 2015-11-25 00:32:42,351 DEBUG : BROWSER_OUTPUT: __start_tp_report 00:32:42 INFO - 2015-11-25 00:32:42,352 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 00:32:42 INFO - 2015-11-25 00:32:42,352 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 00:32:42 INFO - 2015-11-25 00:32:42,352 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 00:32:42 INFO - 2015-11-25 00:32:42,352 DEBUG : BROWSER_OUTPUT: |0;Richards;166.9449081803005 00:32:42 INFO - 2015-11-25 00:32:42,352 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;192.7153594141453 00:32:42 INFO - 2015-11-25 00:32:42,352 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.72027972027973 00:32:42 INFO - 2015-11-25 00:32:42,352 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5208.333333333333 00:32:42 INFO - 2015-11-25 00:32:42,352 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1996.007984031936 00:32:42 INFO - 2015-11-25 00:32:42,352 DEBUG : BROWSER_OUTPUT: |5;Earley;801.2820512820513 00:32:42 INFO - 2015-11-25 00:32:42,352 DEBUG : BROWSER_OUTPUT: |6;Boyer;12382.716049382716 00:32:42 INFO - 2015-11-25 00:32:42,353 DEBUG : BROWSER_OUTPUT: |7;RegExp;26684.21052631579 00:32:42 INFO - 2015-11-25 00:32:42,353 DEBUG : BROWSER_OUTPUT: |8;Splay;630.119722747322 00:32:42 INFO - 2015-11-25 00:32:42,353 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 00:32:42 INFO - 2015-11-25 00:32:42,353 DEBUG : BROWSER_OUTPUT: __end_tp_report 00:32:42 INFO - 2015-11-25 00:32:42,353 DEBUG : BROWSER_OUTPUT: __startTimestamp1448440362351__endTimestamp 00:32:42 INFO - 2015-11-25 00:32:42,353 DEBUG : BROWSER_OUTPUT: 00:32:42 INFO - 2015-11-25 00:32:42,353 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 00:32:42 INFO - 2015-11-25 00:32:42,354 DEBUG : BROWSER_OUTPUT: Number of tests: 10 00:32:42 INFO - 2015-11-25 00:32:42,354 DEBUG : BROWSER_OUTPUT: 00:32:42 INFO - 2015-11-25 00:32:42,354 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.94 Median:166.94 stddev:0.00 (0.0%) 00:32:42 INFO - 2015-11-25 00:32:42,354 DEBUG : BROWSER_OUTPUT: Values: 166.9 00:32:42 INFO - 2015-11-25 00:32:42,354 DEBUG : BROWSER_OUTPUT: 00:32:42 INFO - 2015-11-25 00:32:42,354 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:192.72 Median:192.72 stddev:0.00 (0.0%) 00:32:42 INFO - 2015-11-25 00:32:42,355 DEBUG : BROWSER_OUTPUT: Values: 192.7 00:32:42 INFO - 2015-11-25 00:32:42,355 DEBUG : BROWSER_OUTPUT: 00:32:42 INFO - 2015-11-25 00:32:42,355 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.72 Median:279.72 stddev:0.00 (0.0%) 00:32:42 INFO - 2015-11-25 00:32:42,355 DEBUG : BROWSER_OUTPUT: Values: 279.7 00:32:42 INFO - 2015-11-25 00:32:42,355 DEBUG : BROWSER_OUTPUT: 00:32:42 INFO - 2015-11-25 00:32:42,355 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5208.33 Median:5208.33 stddev:0.00 (0.0%) 00:32:42 INFO - 2015-11-25 00:32:42,355 DEBUG : BROWSER_OUTPUT: Values: 5208.3 00:32:42 INFO - 2015-11-25 00:32:42,356 DEBUG : BROWSER_OUTPUT: 00:32:42 INFO - 2015-11-25 00:32:42,356 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1996.01 Median:1996.01 stddev:0.00 (0.0%) 00:32:42 INFO - 2015-11-25 00:32:42,356 DEBUG : BROWSER_OUTPUT: Values: 1996.0 00:32:42 INFO - 2015-11-25 00:32:42,356 DEBUG : BROWSER_OUTPUT: 00:32:42 INFO - 2015-11-25 00:32:42,356 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:801.28 Median:801.28 stddev:0.00 (0.0%) 00:32:42 INFO - 2015-11-25 00:32:42,358 DEBUG : BROWSER_OUTPUT: Values: 801.3 00:32:42 INFO - 2015-11-25 00:32:42,358 DEBUG : BROWSER_OUTPUT: 00:32:42 INFO - 2015-11-25 00:32:42,358 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12382.72 Median:12382.72 stddev:0.00 (0.0%) 00:32:42 INFO - 2015-11-25 00:32:42,358 DEBUG : BROWSER_OUTPUT: Values: 12382.7 00:32:42 INFO - 2015-11-25 00:32:42,358 DEBUG : BROWSER_OUTPUT: 00:32:42 INFO - 2015-11-25 00:32:42,358 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26684.21 Median:26684.21 stddev:0.00 (0.0%) 00:32:42 INFO - 2015-11-25 00:32:42,358 DEBUG : BROWSER_OUTPUT: Values: 26684.2 00:32:42 INFO - 2015-11-25 00:32:42,358 DEBUG : BROWSER_OUTPUT: 00:32:42 INFO - 2015-11-25 00:32:42,358 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:630.12 Median:630.12 stddev:0.00 (0.0%) 00:32:42 INFO - 2015-11-25 00:32:42,358 DEBUG : BROWSER_OUTPUT: Values: 630.1 00:32:42 INFO - 2015-11-25 00:32:42,358 DEBUG : BROWSER_OUTPUT: 00:32:42 INFO - 2015-11-25 00:32:42,358 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 00:32:42 INFO - 2015-11-25 00:32:42,358 DEBUG : BROWSER_OUTPUT: Values: 4840.6 00:32:42 INFO - 2015-11-25 00:32:42,358 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 00:32:42 INFO - 2015-11-25 00:32:42,358 DEBUG : BROWSER_OUTPUT: 00:32:43 INFO - 2015-11-25 00:32:43,258 INFO : Browser exited with error code: 0 00:32:43 INFO - 2015-11-25 00:32:43,272 INFO : Completed test v8_7 (00:00:39) 00:32:43 INFO - 2015-11-25 00:32:43,369 INFO : Completed test suite (00:20:17) 00:32:43 INFO - 2015-11-25 00:32:43,369 DEBUG : Working with test: dromaeo_css 00:32:43 INFO - 2015-11-25 00:32:43,369 DEBUG : Generating results file: dromaeo_css 00:32:43 INFO - 2015-11-25 00:32:43,370 DEBUG : Working with test: kraken 00:32:43 INFO - 2015-11-25 00:32:43,370 DEBUG : Generating results file: kraken 00:32:43 INFO - 2015-11-25 00:32:43,371 INFO : javascript benchmark 00:32:43 INFO - 2015-11-25 00:32:43,371 DEBUG : Working with test: v8_7 00:32:43 INFO - 2015-11-25 00:32:43,371 DEBUG : Generating results file: v8_7 00:32:43 INFO - 2015-11-25 00:32:43,371 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:32:43 INFO - 2015-11-25 00:32:43,434 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,203,35]] 00:32:43 INFO - 2015-11-25 00:32:43,434 DEBUG : process_Request line: dromaeo_css 6213.19 graph.html#tests=[[72,203,35]] 00:32:43 INFO - 2015-11-25 00:32:43,435 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:32:43 INFO - 2015-11-25 00:32:43,465 DEBUG : process_Request line: kraken 1522.80 graph.html#tests=[[232,203,35]] 00:32:43 INFO - 2015-11-25 00:32:43,466 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:32:43 INFO - 2015-11-25 00:32:43,499 DEBUG : process_Request line: v8_7 19570.82 graph.html#tests=[[230,203,35]] 00:32:43 INFO - 2015-11-25 00:32:43,503 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2599.7790187834034, 2706.472237913608, 2717.21200851753, 2739.8904043838247, 2744.931376715582, 4483.775811209434, 4602.585767280944, 4603.447586289646, 4662.300654901766, 4668.0, 4513.977430112853, 4543.068670922461, 4581.702189357689, 4628.09752098341, 4634.930476042854, 4257.59552842481, 4265.637420819234, 4292.484901811771, 4310.97844510777, 4320.697551171419, 4321.783910804463, 4340.717853339523, 4363.0619416825375, 4363.781810909458, 4408.889777755549, 4122.752634841919, 4179.059711564873, 4218.367244913257, 4225.366195070733, 4261.424707664457, 4264.893377665552, 4271.017665936852, 4274.358846173068, 4275.657947364234, 4317.395564620955, 4245.957540424618, 4248.362745588156, 4259.76571288579, 4289.6997210195295, 4297.076128632328, 4366.0, 4452.821887124511, 4455.1535208310315, 4490.101979604092, 4633.7683115844075, 4907.263910413467, 4925.113479573675, 4925.532074452921, 4933.950660493385, 4970.15507363749, 4953.984433191224, 4954.578860796801, 4960.305557221992, 4960.355153830015, 4965.404151501807, 4485.3944717463055, 4581.702189357681, 4608.285715714002, 4610.976945115253, 4676.415448068991, 5020.0, 5022.372203474566, 5029.321041659402, 5033.823816166417, 5037.546620804145, 4817.421909370898, 4818.542238487338, 4823.710577365369, 4825.782839772219, 4847.660663753503, 4653.930191047137, 4747.121782470254, 4760.0, 4772.5227477252, 4958.677685950402, 4883.267509873476, 4890.828820991248, 4902.411710594752, 4909.459959404463, 4942.505749425029, 4878.756062196876, 4886.828960986349, 4887.975560122248, 4901.607871370353, 4952.380952380952, 3923.352646813301, 3981.6814654827544, 4011.2579172853116, 4018.3972404139613, 4096.959030409717, 3557.839897204632, 3605.8737944172353, 3632.945505817415, 3641.362761516724, 3648.616895226016, 4263.253930562139, 4273.893152671146, 4285.485741711014, 4312.396264522969, 4314.352847072964, 4945.604351651931, 4948.208286674115, 4948.876278093005, 4961.8511444656715, 4988.276699878497, 4116.0533077392365, 4150.481189851269, 4214.852480163241, 4217.873463796091, 4275.615194632498, 4381.145676593033, 4424.80088396023, 4445.711028783118, 4446.688731788809, 4484.0, 4724.858254252378, 4741.502142275081, 4752.477227504903, 4764.595009424238, 4794.017226468565, 4671.15919134559, 4762.595179409789, 4777.116233496814, 4817.301491283814, 4999.675021123615, 4692.48382677912, 4696.483386827378, 4708.317293992283, 4719.622430205644, 4760.500147484464, 4888.92666609994, 4892.8532144035735, 4900.632452566143, 4901.632377571767, 4939.382577177853, 4760.309755085563, 4821.686590371614, 4855.34452848875, 4866.270059490963, 4956.677815941952, 4763.809447622195, 4785.401824771903, 4787.353707249476, 4819.036192761391, 4841.443234027991, 4765.76171191446, 4774.809007639656, 4774.973380723161, 4777.546133117348, 4796.160671882476, 4465.6204222640135, 4535.047639995506, 4582.358469814162, 4692.1554120257315, 4705.482396936266, 4728.1962066448095, 4789.544993225638, 4798.592119669867, 4812.422509298906, 4816.831410900601, 4749.525047495223, 4752.0, 4758.0, 4758.333833263415, 4772.904541909073], "unit": "ms", "name": "dojo.html", "value": 4516.369089158059}, {"lowerIsBetter": false, "replicates": [561.9100943848985, 567.7672154416688, 572.8997425450546, 573.197523467146, 577.8324285957073, 26368.208953731395, 36320.273594528124, 36739.81630091852, 36911.446328305065, 36916.0, 40529.0, 41148.17703645925, 41218.58781412185, 41226.58773412265, 41236.0, 6957.0, 7082.362587367136, 7854.685812567491, 8026.515094707469, 8030.357571394275, 9742.366746161477, 9954.253430992669, 9969.45473451616, 9977.251706122033, 9977.90022099777, 9610.567524461381, 9663.565139568736, 9725.51372431379, 9733.367331123489, 9737.464439455827, 7066.646667666621, 7230.13238411394, 7237.782866514013, 7238.963805180993, 9789.853152202688, 6972.058772065757, 9963.551640176209, 10260.743481413025, 10262.179025677928, 10269.435181065039, 38395.42406863899, 38901.22197556033, 38915.41626875571, 38944.805275973726, 38967.0, 2728.8635568221707, 2758.7642560109543, 2803.859807009662, 2837.460882432352, 2838.1769286906774, 28584.857075714695, 28591.57112643312, 28972.565411518844, 29284.853575731984, 29294.853525732447, 3381.5603971483797, 3402.795832250048, 3409.727221822273, 3449.1032331593965, 3482.7387945903906, 220524.0, 221120.0, 221871.0, 222921.99999999837, 223038.0, 46217.76891115523, 55119.448805512235, 55342.0, 55368.44631553633, 55433.0, 42266.788666056476, 42287.78856105761, 42488.0, 42507.0, 64576.67711661412, 13259.602211933658, 13362.866371336357, 13450.663733406547, 13456.932715336556, 13459.461621535225, 10115.190784737204, 10179.134773544183, 10182.287239893285, 10188.083072523508, 10189.082982531607, 19098.33155839567, 19316.903415482833, 19332.516687082654, 19361.903190483958, 19447.611047778966, 7533.2466753324225, 7746.109197442253, 7806.375489960789, 7807.180246074194, 7940.205979402013, 828.3704384667576, 829.2785276809215, 836.7615229659518, 870.9722527417708, 925.6621333213328, 26596.940958711915, 26792.0, 26946.730532694815, 26947.326316842235, 26993.460130797273, 842.8735689646479, 923.0584803500526, 948.4546385828177, 1054.9894501055044, 1063.1069901282806, 14541.127532348093, 14643.0, 14704.264786760834, 14909.285432175222, 14924.850751492564, 327456.0, 333271.0, 336508.0, 337003.0, 337113.0, 47811.28283075757, 48297.0, 48297.0, 48302.75848620734, 48384.75807620939, 1191.7973944429468, 1248.4194849394894, 1259.4206664934234, 1268.733565951142, 1273.420593629896, 26003.479930400907, 26666.86666566655, 26759.331016724736, 27085.593716094667, 27115.1865444037, 36792.63207367999, 37441.06397340088, 40598.1880362397, 42238.57761422346, 43225.35161972636, 180569.0, 181044.0, 182637.0, 182639.0, 183288.0, 28101.71898281073, 28453.0, 28486.857565712868, 28550.286242844097, 28562.285942851595, 36593.26813463769, 40349.39475907805, 40379.798101009306, 40614.79692601518, 40943.795281023406, 34944.82527587346, 37850.0, 39067.6093239064, 39399.0, 39512.0, 34373.484397733555, 34421.311573768886, 34451.794187203326, 34751.65248347484, 34874.65125348714, 34134.487982679784, 34634.48048279227, 34777.82611086928, 34814.47778283277, 34940.65059349374, 29648.85175574108, 30893.227669307547, 31304.0, 31339.529907051867, 31489.0, 24531.0, 24560.0, 24604.876975615007, 24803.379915502257, 24859.254222373358], "unit": "ms", "name": "ext.html", "value": 17151.890077212898}, {"lowerIsBetter": false, "replicates": [336.7996042354798, 339.6722163112596, 340.4671688807017, 340.96931276185137, 342.5803390846215, 12282.631521054383, 12677.61967140985, 14690.412383504661, 14783.039102458333, 16727.91636041821, 14727.55817325482, 15404.922975385136, 15981.280842362092, 16215.594610134753, 16220.513384598451, 3903.277893589681, 4981.750912454381, 5117.539421452068, 5127.077126117298, 5132.820351287705, 5081.187010078388, 5117.795288188468, 5118.897622047557, 5119.846404607849, 5127.9743601282125, 4954.876128096808, 5070.619703522232, 5070.771815268322, 5072.898542029176, 5074.746262686869, 5039.72281524516, 5071.69569825808, 5076.23856421536, 5078.085944529983, 5079.3650793650795, 4424.7123936944, 4533.161365147458, 4535.614472769786, 4541.386912766768, 4557.58981691646, 19400.835949842913, 19922.601547969105, 19949.50126246841, 20092.1963121475, 20342.28801991938, 1810.1492298619628, 1836.4857839804877, 1857.0, 1962.3033822992918, 2195.7804219577915, 12666.176698514659, 12799.360031998456, 13110.410031548603, 13173.934130329382, 13325.333733313393, 1689.4847071643144, 1760.2782859027736, 1791.3372052340587, 1804.296324433472, 1806.7831860176732, 54392.728036359964, 56629.0, 57233.0, 57400.42599574034, 58381.0, 9528.475933823567, 9687.225021998223, 9826.0, 9829.262805289633, 9860.704178874645, 10556.0, 10764.677059688222, 10790.676279711464, 12279.570215042431, 12381.133320667646, 6704.161979752531, 6798.830029249309, 6973.790786276319, 7053.788386348418, 7059.399951004119, 6617.503687223478, 6660.70026848793, 6662.233843108008, 6697.665116744241, 6737.764178253836, 5741.770329186869, 5851.093080572518, 5938.584299099108, 5974.40255974399, 5987.341392446828, 1625.2848746551479, 1666.6333406650517, 1693.8729595280156, 1713.0492576620095, 1713.092061207562, 809.3282575462352, 833.3374966901328, 834.9707760228484, 849.087231226434, 872.2629378175432, 16547.172641367884, 16789.91605041967, 16792.748108778378, 17071.91464042672, 17205.827941720672, 760.7223363472293, 817.8118834890006, 822.5352675738309, 874.2699845628971, 885.4377470306273, 7804.375649948104, 8426.368022398345, 8624.827503450022, 8641.611127499278, 8645.827083458296, 480662.0, 487598.0, 488734.0, 514937.0, 519658.0, 53533.0, 61480.38519614836, 70285.2971470289, 71710.64144679243, 73530.63234683793, 1012.1902478017556, 1027.3681685763352, 1039.594558122333, 1046.1212581431482, 1072.2494254022215, 14114.858851411765, 14181.503647372292, 14201.857981420053, 14217.360218790385, 14247.21640309793, 23173.76826231716, 23500.74401046638, 24784.380390490383, 30522.542161867146, 31305.373892521566, 39762.40356394598, 39887.60112398839, 41658.375124373764, 41956.16087678168, 42626.36060459157, 8613.913860861312, 8676.696315628922, 8712.607932643174, 8737.563121843756, 8936.86594701093, 10712.0, 15551.922240388725, 15689.921550392175, 15821.525354239391, 15954.8404515958, 13252.536161234311, 13363.465461381436, 13464.394102265225, 13468.326583670581, 13575.185488870698, 12520.248785072925, 12593.433295501907, 13175.407106680032, 13176.934115329363, 13523.391447384694, 13049.086563940433, 13180.209187448783, 13307.334633268492, 13589.728205436033, 13897.722045559234, 8372.288355489607, 8694.0, 8728.08355122703, 8750.868736968823, 8884.51135187545, 12964.611061668165, 12996.350182491027, 13277.070605057554, 13318.533851315158, 13405.396757146147], "unit": "ms", "name": "jquery.html", "value": 8260.564402875594}, {"lowerIsBetter": false, "replicates": [1476.1438365747867, 1548.4116035906354, 1600.2318886934272, 1615.523420590926, 1629.3401172525132, 5831.533477321815, 6007.219061522007, 6436.871262574751, 7064.788056358311, 7103.254158313373, 6401.679916004193, 6668.499862510307, 6721.899171512419, 6729.394354508093, 6737.9326206737915, 2027.2093883385492, 2064.3497298351044, 2065.979340206601, 2066.9483262918397, 2068.513899233679, 1732.8700347473928, 1777.4756446848146, 1779.2171444564415, 1779.3772179737118, 2060.3715866660664, 1750.4486086882591, 2043.1827269092332, 2092.121309050195, 2094.2984100326407, 2095.1514636572215, 2007.5282308657454, 2062.711220429141, 2065.3494149342982, 2079.8128168464837, 2080.771115177329, 2062.896855157251, 2094.183268525261, 2096.2139197800825, 2096.874187548752, 2098.674705420647, 6721.8655626887185, 6723.731050758012, 6773.8645227095185, 6775.830604234884, 6781.050652908597, 4148.937765933513, 4184.246835569596, 4202.8739137825605, 4220.0, 4246.002189485468, 2742.2321749910056, 2764.4885696146275, 2826.5194916864184, 2827.2931767058235, 2829.618001569803, 862.0, 903.7198468474794, 935.036911980661, 936.6206686292063, 944.551338114397, 9295.2099071579, 9330.066993300683, 9339.066093390675, 9341.065893410672, 9344.39261447997, 3824.847006119724, 3853.325668008087, 3896.5518965318784, 3926.2147570486018, 3930.744501607386, 8012.79968000793, 8069.354451643854, 8086.555239461886, 8094.51432914027, 8118.0, 4180.28935081037, 4192.4759405074365, 4195.077083041726, 4196.685248606367, 4199.0342221289275, 3808.1622043150464, 3818.8281527331337, 3822.445745366906, 3825.923481530354, 3836.07934095815, 3373.1567108222944, 3379.1889946413175, 3395.6604339565847, 3401.200717831308, 3405.880794172192, 930.4463844012802, 931.3247895276006, 1068.0, 1083.0577397663926, 1093.2347356850237, 714.3178264757248, 715.0239922505846, 716.7204790131852, 728.460938905217, 789.5183937797939, 6313.77901773445, 6365.872682546323, 6383.138276332728, 6384.3934826191435, 6385.074164246251, 1004.8743907011624, 1013.827649299606, 1015.5531566110888, 1028.0, 1028.6091285311534, 4681.368015317957, 4717.080169366941, 4724.834630787906, 4726.220173671374, 4729.337892695025, 7973.481723687942, 8235.29999949999, 8339.374546909006, 8345.874811877828, 8346.165383461726, 8251.628676709563, 8252.958735206286, 8342.207490288412, 8342.457740246864, 8343.249107580346, 6535.901961470582, 6571.3757193066585, 6573.57271777333, 6590.308017658077, 6606.108175396356, 6103.481204097701, 6197.535184861244, 6218.098375735583, 6239.032949892774, 6241.96879015602, 7335.669894854851, 7441.888371674538, 7509.51188172767, 7538.434617403607, 7572.621368931642, 7527.585982771, 7621.31408173267, 7626.161122276434, 7735.419843511647, 7787.766367008999, 6034.818955431344, 6097.75608975636, 6103.481204097701, 6106.0, 6120.60216085953, 6559.245686746085, 6566.0479230512265, 6584.901226481702, 6639.402453779183, 6643.1031810704935, 6241.469475094668, 6244.65654389013, 6246.187995560548, 6249.7501299325, 6257.436830685078, 5343.946560534345, 5369.919451208313, 5507.256520369699, 5625.647771665458, 5713.800016999385, 5838.095095260242, 5850.707464626837, 5853.385394533512, 5863.0, 5891.381404952418, 5508.0, 5542.0855558832345, 5551.139573366135, 5553.139263414178, 5556.027695153412, 5494.972525137348, 5520.558355331484, 5528.474794894479, 5542.972285138549, 5550.0], "unit": "ms", "name": "mootools.html", "value": 3922.7064701719896}, {"lowerIsBetter": false, "replicates": [303.38413021566214, 307.4404583657743, 310.92693217093995, 315.16638491190815, 316.0565711351615, 5225.817096401626, 5267.473252674736, 5364.812231571896, 5381.461853814617, 5382.91925621116, 5200.895982080356, 5287.339082614673, 5290.232916227154, 5290.841274761763, 5293.735313234342, 3873.477080594112, 3957.742746721454, 4100.63094321511, 4109.363048727452, 4110.958890411095, 4011.7392369496033, 4013.7190396672245, 4071.816768245436, 4078.4697989261354, 4082.2856000199995, 4023.074692820653, 4028.6575641070544, 4031.778252196128, 4046.6358027777496, 4068.9186216275803, 3832.329342365075, 3905.082305658168, 3964.980175099135, 4035.959640403588, 4060.8375664973364, 3571.2678900825267, 3572.9464058039152, 3573.8213089345427, 3577.6422357764277, 3582.1223800168864, 5019.071471777733, 5030.899382012376, 5036.6726162799305, 5038.949610503884, 5052.646314757969, 4648.0, 4658.953410465886, 4662.650301227422, 4666.603338716213, 4668.276417155346, 5341.172118321666, 5481.342238931354, 5484.040292948718, 5496.5053145216725, 5503.862403439906, 3861.7296789224765, 3865.2655995361074, 3866.5553461352024, 3868.78721670308, 3870.3420418528635, 5716.342620598602, 5773.047447171211, 5782.277215348124, 5795.565332600029, 5796.217510636052, 3948.190620922704, 3955.723099383073, 3969.285528604879, 3971.225611005884, 3972.1261322509004, 3756.7370284079852, 3782.149016471272, 4030.375291829771, 4033.7176397651883, 4038.131801662598, 4175.03565559413, 4336.284513055373, 4450.666200034945, 4455.866324010285, 4464.843730469418, 5350.571954243729, 5410.972945135328, 5414.458554144554, 5495.945040549624, 5526.723663816793, 1384.4877395363578, 1390.1659004597363, 1412.8233970753656, 1412.865777751112, 1413.4770135050098, 948.2935213266161, 962.2734835199379, 964.4117088575963, 971.703630392737, 972.9464879431557, 4749.097671442415, 4760.833370832004, 4769.73766442849, 4812.8796780080775, 4817.229243321122, 5632.324121105412, 5646.915296270559, 5651.858703532444, 5654.745536450787, 5655.3779084300695, 4807.495213002654, 4808.591269742111, 4814.494478079821, 4818.638602104857, 4818.7831547580445, 2854.6431696037994, 2960.644722633298, 2994.1766014345794, 3034.0594415731193, 3037.0, 5393.191021346829, 5454.181872719124, 5471.261379713767, 5481.123020316731, 5489.807856724996, 5873.20711703923, 5933.881322373615, 5934.43622855828, 5937.198478205473, 5941.970290148522, 5451.918221226685, 5487.890242195133, 5498.257735205696, 5499.9175012375645, 5500.779968801203, 5580.748866301107, 5775.537956963517, 5786.826395208151, 5787.94212057874, 5797.391273916178, 5639.577031722719, 5648.915266271091, 5649.519790817662, 5652.123920792284, 5652.547796176378, 5485.533729633026, 5493.670379777226, 5494.725263736717, 5496.0, 5498.285222920995, 3902.9804850975565, 3934.1344904121047, 3940.8817735467983, 3942.423030787708, 3947.289487892207, 5615.719214039364, 5747.425257474386, 5771.480566749013, 5771.509421699035, 5775.9133612995, 5564.221009058654, 5564.610477266552, 5572.3034620672415, 5579.6652200868075, 5580.079286917613, 5566.304211973504, 5571.997040532743, 5573.191887176417, 5573.27547418833, 5576.693281869536, 5316.627836051439, 5454.10007348783, 5458.590605704668, 5460.535854452416, 5463.863403414787, 5585.525230355465, 5589.189567512769, 5605.5795815313195, 5606.103023516218, 5607.579431542569, 5274.235235890851, 5367.651102678314, 5395.946040539544, 5459.481349271813, 5494.945050549443], "unit": "ms", "name": "prototype.html", "value": 4141.399944244139}, {"lowerIsBetter": false, "replicates": [598.8802239552091, 633.0, 681.9897701534476, 719.3058698356089, 724.7535837815142, 11343.773124537514, 11545.191836571434, 11546.538138474472, 11576.47905844237, 11581.420928953561, 11511.36687482188, 12997.090203685746, 13255.602331930033, 13273.07088503805, 13300.46798128076, 569.1775384569299, 746.8954346391496, 774.2528460036064, 774.5314084978563, 774.6359211170741, 560.1373884218299, 762.5119923249098, 777.2810150610691, 777.4557809533321, 777.6966982876683, 797.1988151907325, 811.4887620798888, 811.5374236685092, 812.46377390922, 812.8821320908464, 595.2499850188772, 599.1163034524086, 784.7135795434682, 807.8505476486839, 807.907090684573, 592.5141384065068, 593.0836857055859, 593.2999061107892, 593.3117583603, 595.0895130450418, 11960.0, 12089.576864809778, 12280.385980700928, 12299.877001230052, 12305.75388492234, 11027.739313440805, 11228.157888158421, 11329.206955513117, 11333.603323883624, 11749.765004699944, 9163.354531001576, 9264.39781414206, 9386.342955993083, 9409.10613491724, 9436.197923176538, 3165.1295893629435, 3215.758818088629, 3236.5307030480685, 3238.2875767331384, 3283.4582293921476, 38720.80639596784, 39061.21877562433, 39180.60819391798, 39180.80409597962, 39231.80384098061, 8870.64517419296, 9143.771405714777, 9169.449833010041, 9340.71977840666, 9488.28837837165, 16159.353625854834, 16161.0, 16182.029078255107, 16191.676166476604, 16199.595010124605, 6264.561480696399, 6295.0, 6338.524610654219, 6381.329960354096, 6525.1517302750335, 3528.7353448491467, 3598.4962105305276, 3606.711463082947, 3626.927461450809, 3654.524911761454, 2588.055359793662, 2588.5599448093867, 2588.961165582518, 2590.3006188329045, 2592.2093761402575, 478.2563114357138, 484.2566660176612, 496.50845662793574, 500.16971826768116, 500.689572465074, 423.5954663296606, 434.50900482454625, 435.7755755785773, 447.8589244388007, 452.58136223993336, 7189.5686258824635, 7289.198188199294, 7334.66993985272, 7409.110906691124, 7453.105627324648, 367.9963200367962, 478.77258302306126, 492.5173330136486, 530.4456842599493, 537.4759609380901, 3009.0, 3419.466877646557, 3733.1227161617, 3751.1934933989323, 3768.2463507298103, 45625.0, 46569.06861862744, 46585.301220481044, 52970.0, 53280.467195328325, 43592.56407435885, 45126.54873451289, 45210.09579808386, 45345.0, 46005.539944600794, 39588.80205598954, 39679.60320396759, 42860.785696071944, 43372.0, 43548.78225608852, 7460.253974602496, 7653.311201991847, 7671.923280767121, 7834.370430990211, 7907.209279072047, 31663.0, 32082.0, 32691.673083268863, 32982.175445614055, 33003.0, 40026.59973400345, 42277.36583951305, 42405.363919540614, 42483.78758106189, 42486.15027699367, 9418.905810942077, 9460.479673617741, 9473.857892131762, 9566.90433095688, 9716.708498745049, 10172.389656620626, 10301.484925753532, 10397.32417392867, 10410.843837342598, 10824.945875270889, 9855.605775768889, 10174.949125254327, 10233.13018393415, 10469.0, 10513.369197848153, 9998.900010999796, 10087.646932357333, 10553.366797992145, 10734.624288149877, 10737.946310268399, 9344.299177561574, 9752.268579856682, 9925.404475731479, 10068.39589624625, 10071.395716257048, 8658.264047555776, 8737.650493980169, 8786.868196976922, 8953.776155596162, 9005.819883602422, 8209.343252539902, 8781.077986811293, 8855.424397414148, 8937.167880584595, 8974.506402147683], "unit": "ms", "name": "yui.html", "value": 5533.415013933276}], "name": "dromaeo_css"}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 113.0, 109.0, 114.0, 114.0, 113.0, 101.0, 112.0, 111.0, 105.0], "unit": "ms", "name": "ai-astar", "value": 110.2}, {"lowerIsBetter": true, "replicates": [153.0, 129.0, 153.0, 169.0, 130.0, 156.0, 156.0, 131.0, 170.0, 134.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.1}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 162.0, 162.0, 160.0, 160.0, 165.0, 163.0, 162.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 89.0, 90.0, 72.0, 72.0, 72.0, 97.0, 91.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 79.9}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 134.0, 94.0, 96.0, 94.0, 140.0, 95.0, 95.0, 135.0], "unit": "ms", "name": "audio-oscillator", "value": 107.1}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 111.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 149.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 70.0, 72.0, 71.0, 70.0, 70.0, 79.0, 80.0, 69.0], "unit": "ms", "name": "json-parse-financial", "value": 72.3}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 68.0, 69.0, 68.0, 68.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 90.0, 84.0, 84.0, 85.0, 85.0, 83.0, 92.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.2}, {"lowerIsBetter": true, "replicates": [130.0, 119.0, 125.0, 125.0, 123.0, 128.0, 121.0, 120.0, 126.0, 124.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.1}, {"lowerIsBetter": true, "replicates": [140.0, 149.0, 148.0, 149.0, 148.0, 143.0, 142.0, 149.0, 140.0, 136.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.4}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 71.0, 70.0, 68.0, 69.0, 69.0, 70.0, 69.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.5}], "name": "kraken"}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.9449081803005], "unit": "score", "name": "Richards", "value": 211.45897999999997}, {"lowerIsBetter": false, "replicates": [192.7153594141453], "unit": "score", "name": "DeltaBlue", "value": 343.086302}, {"lowerIsBetter": false, "replicates": [279.72027972027973], "unit": "score", "name": "Encrypt", "value": 951.5970750000004}, {"lowerIsBetter": false, "replicates": [5208.333333333333], "unit": "score", "name": "Decrypt", "value": 51.10675199999996}, {"lowerIsBetter": false, "replicates": [1996.007984031936], "unit": "score", "name": "RayTrace", "value": 370.73448899999994}, {"lowerIsBetter": false, "replicates": [801.2820512820513], "unit": "score", "name": "Earley", "value": 831.745824}, {"lowerIsBetter": false, "replicates": [12382.716049382716], "unit": "score", "name": "Boyer", "value": 53.822036889332054}, {"lowerIsBetter": false, "replicates": [26684.21052631579], "unit": "score", "name": "RegExp", "value": 34.13947731755427}, {"lowerIsBetter": false, "replicates": [630.119722747322], "unit": "score", "name": "Splay", "value": 129.326217}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7"}]} 00:32:43 INFO - RETURN: dromaeo_css: 6213.19 00:32:43 INFO - RETURN: kraken: 1522.80 00:32:43 INFO - RETURN: v8_7: 19570.82 00:32:43 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,203,35]]", "result": "19570.82"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,203,35]]", "result": "1522.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,203,35]]", "result": "6213.19"}}} 00:32:43 INFO - Return code: 0 00:32:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 00:32:43 INFO - # TBPL SUCCESS # 00:32:43 INFO - Running post-action listener: _resource_record_post_action 00:32:43 INFO - Running post-run listener: _resource_record_post_run 00:32:44 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 0; Write bytes: 515747840; Read time: 0; Write time: 728508 00:32:44 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 244244480; Read time: 0; Write time: 491448 00:32:44 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 0; Write bytes: 266207232; Read time: 0; Write time: 236480 00:32:44 INFO - Running post-run listener: _upload_blobber_files 00:32:44 INFO - Blob upload gear active. 00:32:44 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 00:32:44 INFO - Copying logs to upload dir... 00:32:44 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1266.015608 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-11-25 00:32:44.524945) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-25 00:32:44.528559) ========= 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=447a3abc0420b6a47dd38cba000001bf-1448435975.744649-1135962262 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/2a_0r62hQOmwB67mG3BWZw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009951 build_url: 'https://queue.taskcluster.net/v1/task/2a_0r62hQOmwB67mG3BWZw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-25 00:32:44.579941) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 00:32:44.580267) ========= 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=447a3abc0420b6a47dd38cba000001bf-1448435975.744649-1135962262 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004615 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 00:32:44.630205) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-25 00:32:44.630513) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-25 00:32:44.630796) ========= ========= Total master_lag: 0.24 =========