builder: b2g-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-053 starttime: 1448529873.3 results: success (0) buildid: 20151126003310 builduid: b160ecd471eb44e3905f5a780ae04003 revision: 201e1c425b3affae859d9df7db17afd3ebce415f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-26 01:24:33.297297) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-26 01:24:33.297709) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-26 01:24:33.297981) ========= 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=919420d7ee4ef147bef0346300000385-1448515401.719044-1576458985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.007947 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-26 01:24:33.325701) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-26 01:24:33.326181) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-26 01:24:33.357991) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 01:24:33.358390) ========= 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=919420d7ee4ef147bef0346300000385-1448515401.719044-1576458985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004660 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 01:24:33.411205) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-26 01:24:33.411521) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-26 01:24:33.411974) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 01:24:33.412272) ========= 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=919420d7ee4ef147bef0346300000385-1448515401.719044-1576458985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-26 01:24:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.2M=0s 2015-11-26 01:24:34 (47.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.184264 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 01:24:33.609334) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 01:24:33.609666) ========= 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=919420d7ee4ef147bef0346300000385-1448515401.719044-1576458985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021111 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 01:24:33.659235) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 01:24:33.659586) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 201e1c425b3affae859d9df7db17afd3ebce415f --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 201e1c425b3affae859d9df7db17afd3ebce415f --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=919420d7ee4ef147bef0346300000385-1448515401.719044-1576458985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-26 01:24:34,668 truncating revision to first 12 chars 2015-11-26 01:24:34,668 Setting DEBUG logging. 2015-11-26 01:24:34,668 attempt 1/10 2015-11-26 01:24:34,668 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/201e1c425b3a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-26 01:24:34,922 unpacking tar archive at: b2g-inbound-201e1c425b3a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.560722 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 01:24:34.232840) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-26 01:24:34.233136) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-26 01:24:34.247444) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-26 01:24:34.247790) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-26 01:24:34.248207) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2015-11-26 01:24:34.248530) ========= /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=919420d7ee4ef147bef0346300000385-1448515401.719044-1576458985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:24:35 INFO - MultiFileLogger online at 20151126 01:24:35 in /builds/slave/test 01:24:35 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 01:24:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:24:35 INFO - {'append_to_log': False, 01:24:35 INFO - 'base_work_dir': '/builds/slave/test', 01:24:35 INFO - 'blob_upload_branch': 'B2G-Inbound-Non-PGO', 01:24:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:24:35 INFO - 'branch': 'B2G-Inbound-Non-PGO', 01:24:35 INFO - 'buildbot_json_path': 'buildprops.json', 01:24:35 INFO - 'config_files': ('talos/linux_config.py',), 01:24:35 INFO - 'default_actions': ('clobber', 01:24:35 INFO - 'read-buildbot-config', 01:24:35 INFO - 'download-and-extract', 01:24:35 INFO - 'populate-webroot', 01:24:35 INFO - 'create-virtualenv', 01:24:35 INFO - 'install', 01:24:35 INFO - 'run-tests'), 01:24:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:24:35 INFO - 'download_minidump_stackwalk': True, 01:24:35 INFO - 'download_symbols': 'ondemand', 01:24:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:24:35 INFO - 'tooltool.py': '/tools/tooltool.py', 01:24:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:24:35 INFO - '/tools/misc-python/virtualenv.py')}, 01:24:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:24:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:24:35 INFO - 'installer_path': 'installer.exe', 01:24:35 INFO - 'log_level': 'info', 01:24:35 INFO - 'log_name': 'talos', 01:24:35 INFO - 'log_to_console': True, 01:24:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:24:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:24:35 INFO - 'opt_config_files': (), 01:24:35 INFO - 'pip_index': False, 01:24:35 INFO - 'sps_profile': False, 01:24:35 INFO - 'sps_profile_interval': 0, 01:24:35 INFO - 'suite': 'dromaeojs', 01:24:35 INFO - 'system_bits': '64', 01:24:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:24:35 INFO - 'title': 'talos-linux64-ix-053', 01:24:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:24:35 INFO - 'use_talos_json': True, 01:24:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:24:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:24:35 INFO - 'work_dir': 'build'} 01:24:35 INFO - ##### 01:24:35 INFO - ##### Running clobber step. 01:24:35 INFO - ##### 01:24:35 INFO - Running pre-action listener: _resource_record_pre_action 01:24:35 INFO - Running main action method: clobber 01:24:35 INFO - rmtree: /builds/slave/test/build 01:24:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:24:35 INFO - Running post-action listener: _resource_record_post_action 01:24:35 INFO - ##### 01:24:35 INFO - ##### Running read-buildbot-config step. 01:24:35 INFO - ##### 01:24:35 INFO - Running pre-action listener: _resource_record_pre_action 01:24:35 INFO - Running main action method: read_buildbot_config 01:24:35 INFO - Using buildbot properties: 01:24:35 INFO - { 01:24:35 INFO - "properties": { 01:24:35 INFO - "buildnumber": 290, 01:24:35 INFO - "product": "firefox", 01:24:35 INFO - "script_repo_revision": "production", 01:24:35 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 01:24:35 INFO - "repository": "", 01:24:35 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound talos dromaeojs", 01:24:35 INFO - "buildid": "20151126003310", 01:24:35 INFO - "slavename": "talos-linux64-ix-053", 01:24:35 INFO - "pgo_build": "False", 01:24:35 INFO - "basedir": "/builds/slave/test", 01:24:35 INFO - "project": "", 01:24:35 INFO - "platform": "ubuntu64_hw", 01:24:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:24:35 INFO - "slavebuilddir": "test", 01:24:35 INFO - "scheduler": "tests-b2g-inbound-linux64-talos", 01:24:35 INFO - "branch": "b2g-inbound", 01:24:35 INFO - "repo_path": "integration/b2g-inbound", 01:24:35 INFO - "stage_platform": "linux64", 01:24:35 INFO - "builduid": "b160ecd471eb44e3905f5a780ae04003", 01:24:35 INFO - "revision": "201e1c425b3affae859d9df7db17afd3ebce415f" 01:24:35 INFO - }, 01:24:35 INFO - "sourcestamp": { 01:24:35 INFO - "repository": "", 01:24:35 INFO - "hasPatch": false, 01:24:35 INFO - "project": "", 01:24:35 INFO - "branch": "b2g-inbound-linux64-talos", 01:24:35 INFO - "changes": [ 01:24:35 INFO - { 01:24:35 INFO - "category": null, 01:24:35 INFO - "files": [ 01:24:35 INFO - { 01:24:35 INFO - "url": null, 01:24:35 INFO - "name": "https://queue.taskcluster.net/v1/task/dGxf8I1AQLawHhmPzJYFAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 01:24:35 INFO - } 01:24:35 INFO - ], 01:24:35 INFO - "repository": "", 01:24:35 INFO - "rev": "201e1c425b3affae859d9df7db17afd3ebce415f", 01:24:35 INFO - "who": "btian@mozilla.com", 01:24:35 INFO - "when": 1448529868, 01:24:35 INFO - "number": 6709516, 01:24:35 INFO - "comments": "Bug 1227440 - Reject pin reply by cancelling bond to trigger BondStateChangedNotification, in order to inform gaia setting app, r=shuang", 01:24:35 INFO - "project": "", 01:24:35 INFO - "at": "Thu 26 Nov 2015 01:24:28", 01:24:35 INFO - "branch": "b2g-inbound-linux64-talos", 01:24:35 INFO - "revlink": "", 01:24:35 INFO - "properties": [ 01:24:35 INFO - [ 01:24:35 INFO - "buildid", 01:24:35 INFO - "20151126003310", 01:24:35 INFO - "Change" 01:24:35 INFO - ], 01:24:35 INFO - [ 01:24:35 INFO - "builduid", 01:24:35 INFO - "b160ecd471eb44e3905f5a780ae04003", 01:24:35 INFO - "Change" 01:24:35 INFO - ], 01:24:35 INFO - [ 01:24:35 INFO - "pgo_build", 01:24:35 INFO - "False", 01:24:35 INFO - "Change" 01:24:35 INFO - ] 01:24:35 INFO - ], 01:24:35 INFO - "revision": "201e1c425b3affae859d9df7db17afd3ebce415f" 01:24:35 INFO - } 01:24:35 INFO - ], 01:24:35 INFO - "revision": "201e1c425b3affae859d9df7db17afd3ebce415f" 01:24:35 INFO - } 01:24:35 INFO - } 01:24:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/dGxf8I1AQLawHhmPzJYFAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 01:24:35 INFO - Running post-action listener: _resource_record_post_action 01:24:35 INFO - ##### 01:24:35 INFO - ##### Running download-and-extract step. 01:24:35 INFO - ##### 01:24:35 INFO - Running pre-action listener: _resource_record_pre_action 01:24:35 INFO - Running main action method: download_and_extract 01:24:35 INFO - mkdir: /builds/slave/test/build/tests 01:24:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:35 INFO - https://queue.taskcluster.net/v1/task/dGxf8I1AQLawHhmPzJYFAw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:24:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGxf8I1AQLawHhmPzJYFAw/artifacts/public/build/test_packages.json 01:24:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGxf8I1AQLawHhmPzJYFAw/artifacts/public/build/test_packages.json 01:24:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGxf8I1AQLawHhmPzJYFAw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 01:24:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGxf8I1AQLawHhmPzJYFAw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 01:24:37 INFO - Downloaded 1302 bytes. 01:24:37 INFO - Reading from file /builds/slave/test/build/test_packages.json 01:24:37 INFO - Using the following test package requirements: 01:24:37 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 01:24:37 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:24:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:24:37 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:24:37 INFO - u'jsshell-linux-x86_64.zip'], 01:24:37 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:24:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:24:37 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 01:24:37 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:24:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:24:37 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:24:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:24:37 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:24:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:24:37 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 01:24:37 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:24:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:24:37 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:24:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:37 INFO - https://queue.taskcluster.net/v1/task/dGxf8I1AQLawHhmPzJYFAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:24:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGxf8I1AQLawHhmPzJYFAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:24:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGxf8I1AQLawHhmPzJYFAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:24:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGxf8I1AQLawHhmPzJYFAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:24:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGxf8I1AQLawHhmPzJYFAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:24:38 INFO - Downloaded 21508050 bytes. 01:24:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 01:24:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:24:38 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 01:24:39 INFO - Return code: 0 01:24:39 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:24: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')]} 01:24:39 INFO - https://queue.taskcluster.net/v1/task/dGxf8I1AQLawHhmPzJYFAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:24:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGxf8I1AQLawHhmPzJYFAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:24:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGxf8I1AQLawHhmPzJYFAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:24:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGxf8I1AQLawHhmPzJYFAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:24:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGxf8I1AQLawHhmPzJYFAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:24:43 INFO - Downloaded 21508050 bytes. 01:24: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 01:24:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:24: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 01:24:44 INFO - Return code: 0 01:24: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')]} 01:24:44 INFO - https://queue.taskcluster.net/v1/task/dGxf8I1AQLawHhmPzJYFAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:24:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGxf8I1AQLawHhmPzJYFAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 01:24:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGxf8I1AQLawHhmPzJYFAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 01:24:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGxf8I1AQLawHhmPzJYFAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 01:24:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGxf8I1AQLawHhmPzJYFAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:24:45 INFO - Downloaded 11131717 bytes. 01:24:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 01:24:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 01:24:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 01:24:45 INFO - Return code: 0 01:24:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:45 INFO - https://queue.taskcluster.net/v1/task/dGxf8I1AQLawHhmPzJYFAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:24:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGxf8I1AQLawHhmPzJYFAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:24:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGxf8I1AQLawHhmPzJYFAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:24:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGxf8I1AQLawHhmPzJYFAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:24:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGxf8I1AQLawHhmPzJYFAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:24:47 INFO - Downloaded 56842279 bytes. 01:24:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dGxf8I1AQLawHhmPzJYFAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:24:47 INFO - mkdir: /builds/slave/test/properties 01:24:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:24:47 INFO - Writing to file /builds/slave/test/properties/build_url 01:24:47 INFO - Contents: 01:24:47 INFO - build_url:https://queue.taskcluster.net/v1/task/dGxf8I1AQLawHhmPzJYFAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:24:47 INFO - Running post-action listener: _resource_record_post_action 01:24:47 INFO - Running post-action listener: set_extra_try_arguments 01:24:47 INFO - ##### 01:24:47 INFO - ##### Running populate-webroot step. 01:24:47 INFO - ##### 01:24:47 INFO - Running pre-action listener: _resource_record_pre_action 01:24:47 INFO - Running main action method: populate_webroot 01:24:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:24:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:24:47 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 01:24:47 INFO - '../fennec_ids.txt'], 01:24:47 INFO - 'tests': ['tcheck2']}, 01:24:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:24:47 INFO - '--tppagecycles', 01:24:47 INFO - '7'], 01:24:47 INFO - 'tests': ['tsvgm']}}, 01:24:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:24:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:24:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:24:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:24:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:24:47 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:24:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:24:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:47 INFO - 'talos_options': ['--e10s'], 01:24:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:24:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:47 INFO - 'tests': ['damp', 'tps']}, 01:24:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:47 INFO - 'talos_options': ['--e10s'], 01:24:47 INFO - 'tests': ['damp', 'tps']}, 01:24:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:24:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:24:47 INFO - 'other': {'tests': ['a11yr', 01:24:47 INFO - 'ts_paint', 01:24:47 INFO - 'tpaint', 01:24:47 INFO - 'sessionrestore', 01:24:47 INFO - 'sessionrestore_no_auto_restore']}, 01:24:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:24:47 INFO - 'tests': ['a11yr', 01:24:47 INFO - 'ts_paint', 01:24:47 INFO - 'tpaint', 01:24:47 INFO - 'sessionrestore', 01:24:47 INFO - 'sessionrestore_no_auto_restore']}, 01:24:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:24:47 INFO - 'tests': ['a11yr', 01:24:47 INFO - 'ts_paint', 01:24:47 INFO - 'tpaint', 01:24:47 INFO - 'sessionrestore', 01:24:47 INFO - 'sessionrestore_no_auto_restore']}, 01:24:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:24:47 INFO - 'tests': ['a11yr', 01:24:47 INFO - 'ts_paint', 01:24:47 INFO - 'tpaint', 01:24:47 INFO - 'sessionrestore', 01:24:47 INFO - 'sessionrestore_no_auto_restore']}, 01:24:47 INFO - 'other_l64': {'tests': ['a11yr', 01:24:47 INFO - 'ts_paint', 01:24:47 INFO - 'tpaint', 01:24:47 INFO - 'sessionrestore', 01:24:47 INFO - 'sessionrestore_no_auto_restore']}, 01:24:47 INFO - 'other_nol64': {'tests': ['a11yr', 01:24:47 INFO - 'ts_paint', 01:24:47 INFO - 'tpaint', 01:24:47 INFO - 'sessionrestore', 01:24:47 INFO - 'sessionrestore_no_auto_restore']}, 01:24:47 INFO - 'svgr': {'tests': ['tsvgx', 01:24:47 INFO - 'tsvgr_opacity', 01:24:47 INFO - 'tart', 01:24:47 INFO - 'tscrollx', 01:24:47 INFO - 'cart']}, 01:24:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:24:47 INFO - 'tests': ['tsvgx', 01:24:47 INFO - 'tsvgr_opacity', 01:24:47 INFO - 'tart', 01:24:47 INFO - 'tscrollx', 01:24:47 INFO - 'cart']}, 01:24:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:47 INFO - 'tests': ['tp5o']}, 01:24:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:47 INFO - 'talos_options': ['--e10s'], 01:24:47 INFO - 'tests': ['tp5o']}, 01:24:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:47 INFO - 'talos_options': ['--xperf_path', 01:24:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:24:47 INFO - 'tests': ['tp5n']}, 01:24:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:47 INFO - 'talos_options': ['--e10s', 01:24:47 INFO - '--xperf_path', 01:24:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:24:47 INFO - 'tests': ['tp5n']}}, 01:24:47 INFO - 'talos.zip': {'path': '', 01:24:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:24:47 INFO - Running post-action listener: _resource_record_post_action 01:24:47 INFO - ##### 01:24:47 INFO - ##### Running create-virtualenv step. 01:24:47 INFO - ##### 01:24:47 INFO - Running pre-action listener: _resource_record_pre_action 01:24:47 INFO - Running main action method: create_virtualenv 01:24:47 INFO - Creating virtualenv /builds/slave/test/build/venv 01:24:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 01:24:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:24:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:24:47 INFO - Using real prefix '/usr' 01:24:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:24:47 INFO - Installing distribute.............................................................................................................................................................................................done. 01:24:49 INFO - Installing pip.................done. 01:24:49 INFO - Return code: 0 01:24:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:24:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0xf06030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1137210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c9220>, '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 0x11352b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1135740>, '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': '919420d7ee4ef147bef0346300000385-1448515401.719044-1576458985', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:24:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:24:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:24:49 INFO - Using env: {'DISPLAY': ':0', 01:24:49 INFO - 'HOME': '/home/cltbld', 01:24:49 INFO - 'LANG': 'en_US.UTF-8', 01:24:49 INFO - 'LANGUAGE': 'en_US:en', 01:24:49 INFO - 'LOGNAME': 'cltbld', 01:24:49 INFO - 'MAIL': '/var/mail/cltbld', 01:24:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:49 INFO - 'MOZ_NO_REMOTE': '1', 01:24:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:49 INFO - 'NO_EM_RESTART': '1', 01:24:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:49 INFO - 'PWD': '/builds/slave/test', 01:24:49 INFO - 'SHELL': '/bin/bash', 01:24:49 INFO - 'SHLVL': '1', 01:24:49 INFO - 'TERM': 'linux', 01:24:49 INFO - 'TMOUT': '86400', 01:24:49 INFO - 'USER': 'cltbld', 01:24:49 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1448515401.719044-1576458985', 01:24:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:49 INFO - '_': '/tools/buildbot/bin/python'} 01:24:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 01:24:49 INFO - Cleaning up... 01:24:49 INFO - Return code: 0 01:24:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:24:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0xf06030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1137210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c9220>, '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 0x11352b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1135740>, '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': '919420d7ee4ef147bef0346300000385-1448515401.719044-1576458985', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:24:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 01:24:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 01:24:49 INFO - Using env: {'DISPLAY': ':0', 01:24:49 INFO - 'HOME': '/home/cltbld', 01:24:49 INFO - 'LANG': 'en_US.UTF-8', 01:24:49 INFO - 'LANGUAGE': 'en_US:en', 01:24:49 INFO - 'LOGNAME': 'cltbld', 01:24:49 INFO - 'MAIL': '/var/mail/cltbld', 01:24:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:49 INFO - 'MOZ_NO_REMOTE': '1', 01:24:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:49 INFO - 'NO_EM_RESTART': '1', 01:24:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:49 INFO - 'PWD': '/builds/slave/test', 01:24:49 INFO - 'SHELL': '/bin/bash', 01:24:49 INFO - 'SHLVL': '1', 01:24:49 INFO - 'TERM': 'linux', 01:24:49 INFO - 'TMOUT': '86400', 01:24:49 INFO - 'USER': 'cltbld', 01:24:49 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1448515401.719044-1576458985', 01:24:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:49 INFO - '_': '/tools/buildbot/bin/python'} 01:24:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:50 INFO - Downloading/unpacking psutil>=0.7.1 01:24:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:51 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 01:24:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 01:24:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:24:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:24:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:24:51 INFO - Installing collected packages: psutil 01:24:51 INFO - Running setup.py install for psutil 01:24:51 INFO - building 'psutil._psutil_linux' extension 01:24:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 01:24:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 01:24:52 INFO - building 'psutil._psutil_posix' extension 01:24:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 01:24:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 01:24:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:24:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:24:52 INFO - Successfully installed psutil 01:24:52 INFO - Cleaning up... 01:24:52 INFO - Return code: 0 01:24:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:24: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')]} 01:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24: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')]} 01:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24: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', '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 0xf06030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1137210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c9220>, '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 0x11352b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1135740>, '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': '919420d7ee4ef147bef0346300000385-1448515401.719044-1576458985', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:24: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 01:24: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 mozsystemmonitor==0.0.0 01:24:52 INFO - Using env: {'DISPLAY': ':0', 01:24:52 INFO - 'HOME': '/home/cltbld', 01:24:52 INFO - 'LANG': 'en_US.UTF-8', 01:24:52 INFO - 'LANGUAGE': 'en_US:en', 01:24:52 INFO - 'LOGNAME': 'cltbld', 01:24:52 INFO - 'MAIL': '/var/mail/cltbld', 01:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:52 INFO - 'MOZ_NO_REMOTE': '1', 01:24:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:52 INFO - 'NO_EM_RESTART': '1', 01:24:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:52 INFO - 'PWD': '/builds/slave/test', 01:24:52 INFO - 'SHELL': '/bin/bash', 01:24:52 INFO - 'SHLVL': '1', 01:24:52 INFO - 'TERM': 'linux', 01:24:52 INFO - 'TMOUT': '86400', 01:24:52 INFO - 'USER': 'cltbld', 01:24:52 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1448515401.719044-1576458985', 01:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:52 INFO - '_': '/tools/buildbot/bin/python'} 01:24:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:24:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 01:24:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:24:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:24:54 INFO - Installing collected packages: mozsystemmonitor 01:24:54 INFO - Running setup.py install for mozsystemmonitor 01:24:54 INFO - Successfully installed mozsystemmonitor 01:24:54 INFO - Cleaning up... 01:24:54 INFO - Return code: 0 01:24:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:54 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 0xf06030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1137210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c9220>, '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 0x11352b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1135740>, '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': '919420d7ee4ef147bef0346300000385-1448515401.719044-1576458985', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:24:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:24:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:24:54 INFO - Using env: {'DISPLAY': ':0', 01:24:54 INFO - 'HOME': '/home/cltbld', 01:24:54 INFO - 'LANG': 'en_US.UTF-8', 01:24:54 INFO - 'LANGUAGE': 'en_US:en', 01:24:54 INFO - 'LOGNAME': 'cltbld', 01:24:54 INFO - 'MAIL': '/var/mail/cltbld', 01:24:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:54 INFO - 'MOZ_NO_REMOTE': '1', 01:24:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:54 INFO - 'NO_EM_RESTART': '1', 01:24:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:54 INFO - 'PWD': '/builds/slave/test', 01:24:54 INFO - 'SHELL': '/bin/bash', 01:24:54 INFO - 'SHLVL': '1', 01:24:54 INFO - 'TERM': 'linux', 01:24:54 INFO - 'TMOUT': '86400', 01:24:54 INFO - 'USER': 'cltbld', 01:24:54 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1448515401.719044-1576458985', 01:24:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:54 INFO - '_': '/tools/buildbot/bin/python'} 01:24:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:54 INFO - Downloading/unpacking blobuploader==1.2.4 01:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:56 INFO - Downloading blobuploader-1.2.4.tar.gz 01:24:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 01:24:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:24:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 01:24:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:24:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:57 INFO - Downloading docopt-0.6.1.tar.gz 01:24:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 01:24:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:24:57 INFO - Installing collected packages: blobuploader, requests, docopt 01:24:57 INFO - Running setup.py install for blobuploader 01:24:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:24:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:24:57 INFO - Running setup.py install for requests 01:24:57 INFO - Running setup.py install for docopt 01:24:57 INFO - Successfully installed blobuploader requests docopt 01:24:57 INFO - Cleaning up... 01:24:57 INFO - Return code: 0 01:24:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:24: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')]} 01:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24: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')]} 01:24:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:57 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 0xf06030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1137210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c9220>, '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 0x11352b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1135740>, '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': '919420d7ee4ef147bef0346300000385-1448515401.719044-1576458985', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:24:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:24:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:24:57 INFO - Using env: {'DISPLAY': ':0', 01:24:57 INFO - 'HOME': '/home/cltbld', 01:24:57 INFO - 'LANG': 'en_US.UTF-8', 01:24:57 INFO - 'LANGUAGE': 'en_US:en', 01:24:57 INFO - 'LOGNAME': 'cltbld', 01:24:57 INFO - 'MAIL': '/var/mail/cltbld', 01:24:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:57 INFO - 'MOZ_NO_REMOTE': '1', 01:24:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:57 INFO - 'NO_EM_RESTART': '1', 01:24:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:57 INFO - 'PWD': '/builds/slave/test', 01:24:57 INFO - 'SHELL': '/bin/bash', 01:24:57 INFO - 'SHLVL': '1', 01:24:57 INFO - 'TERM': 'linux', 01:24:57 INFO - 'TMOUT': '86400', 01:24:57 INFO - 'USER': 'cltbld', 01:24:57 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1448515401.719044-1576458985', 01:24:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:57 INFO - '_': '/tools/buildbot/bin/python'} 01:24:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:24:57 INFO - Running setup.py (path:/tmp/pip-A2ld2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:24:57 INFO - Running setup.py (path:/tmp/pip-XepONw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:24:58 INFO - Running setup.py (path:/tmp/pip-lTJCC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:24:58 INFO - Running setup.py (path:/tmp/pip-M7LBe2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:24:58 INFO - Running setup.py (path:/tmp/pip-0ww_yb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:24:58 INFO - Running setup.py (path:/tmp/pip-06xdBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:24:58 INFO - Running setup.py (path:/tmp/pip-_HgKSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:24:58 INFO - Running setup.py (path:/tmp/pip-m0RUpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:24:58 INFO - Running setup.py (path:/tmp/pip-Defq5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:24:58 INFO - Running setup.py (path:/tmp/pip-IoAZWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:24:58 INFO - Running setup.py (path:/tmp/pip-yT8x1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:24:58 INFO - Running setup.py (path:/tmp/pip-qzzSxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:24:58 INFO - Running setup.py (path:/tmp/pip-woMMEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:24:58 INFO - Running setup.py (path:/tmp/pip-gx4c1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:24:58 INFO - Running setup.py (path:/tmp/pip-V4E1bh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:24:58 INFO - Running setup.py (path:/tmp/pip-hqTQda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:24:59 INFO - Running setup.py (path:/tmp/pip-j4e7O4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:24:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:24:59 INFO - Running setup.py install for manifestparser 01:24:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:24:59 INFO - Running setup.py install for mozcrash 01:24:59 INFO - Running setup.py install for mozdebug 01:24:59 INFO - Running setup.py install for mozdevice 01:24:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:24:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:24:59 INFO - Running setup.py install for mozfile 01:24:59 INFO - Running setup.py install for mozhttpd 01:24:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:24:59 INFO - Running setup.py install for mozinfo 01:24:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:24:59 INFO - Running setup.py install for mozInstall 01:24:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:24:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:24:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:24:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:24:59 INFO - Running setup.py install for mozleak 01:25:00 INFO - Running setup.py install for mozlog 01:25:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:25:00 INFO - Running setup.py install for moznetwork 01:25:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:25:00 INFO - Running setup.py install for mozprocess 01:25:00 INFO - Running setup.py install for mozprofile 01:25:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:25:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:25:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:25:00 INFO - Running setup.py install for mozrunner 01:25:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:25:00 INFO - Running setup.py install for mozscreenshot 01:25:00 INFO - Running setup.py install for moztest 01:25:00 INFO - Running setup.py install for mozversion 01:25:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:25:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:25:00 INFO - Cleaning up... 01:25:00 INFO - Return code: 0 01:25:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:25:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:00 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 0xf06030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1137210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c9220>, '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 0x11352b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1135740>, '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': '919420d7ee4ef147bef0346300000385-1448515401.719044-1576458985', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:25:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:25:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:25:00 INFO - Using env: {'DISPLAY': ':0', 01:25:00 INFO - 'HOME': '/home/cltbld', 01:25:00 INFO - 'LANG': 'en_US.UTF-8', 01:25:00 INFO - 'LANGUAGE': 'en_US:en', 01:25:00 INFO - 'LOGNAME': 'cltbld', 01:25:00 INFO - 'MAIL': '/var/mail/cltbld', 01:25:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:00 INFO - 'MOZ_NO_REMOTE': '1', 01:25:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:00 INFO - 'NO_EM_RESTART': '1', 01:25:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:00 INFO - 'PWD': '/builds/slave/test', 01:25:00 INFO - 'SHELL': '/bin/bash', 01:25:00 INFO - 'SHLVL': '1', 01:25:00 INFO - 'TERM': 'linux', 01:25:00 INFO - 'TMOUT': '86400', 01:25:00 INFO - 'USER': 'cltbld', 01:25:00 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1448515401.719044-1576458985', 01:25:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:00 INFO - '_': '/tools/buildbot/bin/python'} 01:25:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:25:01 INFO - Running setup.py (path:/tmp/pip-TCieVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 01:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:25:01 INFO - Running setup.py (path:/tmp/pip-ItiLGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:25:01 INFO - Running setup.py (path:/tmp/pip-ls16Hz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:25:01 INFO - Running setup.py (path:/tmp/pip-bB1enK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:25:01 INFO - Running setup.py (path:/tmp/pip-EXCdQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 01:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:25:01 INFO - Running setup.py (path:/tmp/pip-Zi01ZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 01:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:25:01 INFO - Running setup.py (path:/tmp/pip-DcIb2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 01:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:25:01 INFO - Running setup.py (path:/tmp/pip-q7yRgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 01:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:25:01 INFO - Running setup.py (path:/tmp/pip-cpvHJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 01:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:25:01 INFO - Running setup.py (path:/tmp/pip-gNa0ef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:25:01 INFO - Running setup.py (path:/tmp/pip-4SQe6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 01:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:25:01 INFO - Running setup.py (path:/tmp/pip-Fvcp00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:25:02 INFO - Running setup.py (path:/tmp/pip-5qfViq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 01:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:25:02 INFO - Running setup.py (path:/tmp/pip-BXY3P6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:25:02 INFO - Running setup.py (path:/tmp/pip-IJYBD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 01:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:25:02 INFO - Running setup.py (path:/tmp/pip-wrwKMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 01:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:25:02 INFO - Running setup.py (path:/tmp/pip-yc9rwP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 01:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:25:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:04 INFO - Downloading blessings-1.5.1.tar.gz 01:25:04 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 01:25:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:25:04 INFO - Installing collected packages: blessings 01:25:04 INFO - Running setup.py install for blessings 01:25:04 INFO - Successfully installed blessings 01:25:04 INFO - Cleaning up... 01:25:04 INFO - Return code: 0 01:25:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:25:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:25:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:25:04 INFO - Reading from file tmpfile_stdout 01:25:04 INFO - Current package versions: 01:25:04 INFO - argparse == 1.2.1 01:25:04 INFO - blessings == 1.5.1 01:25:04 INFO - blobuploader == 1.2.4 01:25:04 INFO - docopt == 0.6.1 01:25:04 INFO - manifestparser == 1.1 01:25:04 INFO - mozInstall == 1.12 01:25:04 INFO - mozcrash == 0.16 01:25:04 INFO - mozdebug == 0.1 01:25:04 INFO - mozdevice == 0.47 01:25:04 INFO - mozfile == 1.2 01:25:04 INFO - mozhttpd == 0.7 01:25:04 INFO - mozinfo == 0.9 01:25:04 INFO - mozleak == 0.1 01:25:04 INFO - mozlog == 3.1 01:25:04 INFO - moznetwork == 0.27 01:25:04 INFO - mozprocess == 0.22 01:25:04 INFO - mozprofile == 0.27 01:25:04 INFO - mozrunner == 6.11 01:25:04 INFO - mozscreenshot == 0.1 01:25:04 INFO - mozsystemmonitor == 0.0 01:25:04 INFO - moztest == 0.7 01:25:04 INFO - mozversion == 1.4 01:25:04 INFO - psutil == 3.1.1 01:25:04 INFO - requests == 1.2.3 01:25:04 INFO - wsgiref == 0.1.2 01:25:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:25:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0xf06030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1137210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c9220>, '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 0x11352b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1135740>, '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': '919420d7ee4ef147bef0346300000385-1448515401.719044-1576458985', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:25:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 01:25: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/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:25:04 INFO - Using env: {'DISPLAY': ':0', 01:25:04 INFO - 'HOME': '/home/cltbld', 01:25:04 INFO - 'LANG': 'en_US.UTF-8', 01:25:04 INFO - 'LANGUAGE': 'en_US:en', 01:25:04 INFO - 'LOGNAME': 'cltbld', 01:25:04 INFO - 'MAIL': '/var/mail/cltbld', 01:25:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:04 INFO - 'MOZ_NO_REMOTE': '1', 01:25:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:04 INFO - 'NO_EM_RESTART': '1', 01:25:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:04 INFO - 'PWD': '/builds/slave/test', 01:25:04 INFO - 'SHELL': '/bin/bash', 01:25:04 INFO - 'SHLVL': '1', 01:25:04 INFO - 'TERM': 'linux', 01:25:04 INFO - 'TMOUT': '86400', 01:25:04 INFO - 'USER': 'cltbld', 01:25:04 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1448515401.719044-1576458985', 01:25:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:04 INFO - '_': '/tools/buildbot/bin/python'} 01:25:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 01:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 01:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 01:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 01:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 01:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 01:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 01:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:25:04 INFO - Cleaning up... 01:25:04 INFO - Return code: 0 01:25:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:25:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf06030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1137210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c9220>, '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 0x11352b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1135740>, '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': '919420d7ee4ef147bef0346300000385-1448515401.719044-1576458985', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:25:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:25:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:25:04 INFO - Using env: {'DISPLAY': ':0', 01:25:04 INFO - 'HOME': '/home/cltbld', 01:25:04 INFO - 'LANG': 'en_US.UTF-8', 01:25:04 INFO - 'LANGUAGE': 'en_US:en', 01:25:04 INFO - 'LOGNAME': 'cltbld', 01:25:04 INFO - 'MAIL': '/var/mail/cltbld', 01:25:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:04 INFO - 'MOZ_NO_REMOTE': '1', 01:25:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:04 INFO - 'NO_EM_RESTART': '1', 01:25:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:04 INFO - 'PWD': '/builds/slave/test', 01:25:04 INFO - 'SHELL': '/bin/bash', 01:25:04 INFO - 'SHLVL': '1', 01:25:04 INFO - 'TERM': 'linux', 01:25:04 INFO - 'TMOUT': '86400', 01:25:04 INFO - 'USER': 'cltbld', 01:25:04 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1448515401.719044-1576458985', 01:25:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:04 INFO - '_': '/tools/buildbot/bin/python'} 01:25:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:04 INFO - Downloading/unpacking jsonschema 01:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:25:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 01:25:06 INFO - Downloading/unpacking functools32 (from jsonschema) 01:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:06 INFO - Downloading functools32-3.2.3-2.tar.gz 01:25:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 01:25:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:25:06 INFO - warning: no files found matching '*.txt' 01:25:06 INFO - no previously-included directories found matching 'build' 01:25:06 INFO - no previously-included directories found matching 'dist' 01:25:06 INFO - no previously-included directories found matching '.git*' 01:25:06 INFO - Installing collected packages: jsonschema, functools32 01:25:06 INFO - Running setup.py install for functools32 01:25:07 INFO - warning: no files found matching '*.txt' 01:25:07 INFO - no previously-included directories found matching 'build' 01:25:07 INFO - no previously-included directories found matching 'dist' 01:25:07 INFO - no previously-included directories found matching '.git*' 01:25:07 INFO - Successfully installed jsonschema functools32 01:25:07 INFO - Cleaning up... 01:25:07 INFO - Return code: 0 01:25:07 INFO - Running post-action listener: _resource_record_post_action 01:25:07 INFO - Running post-action listener: _start_resource_monitoring 01:25:07 INFO - Starting resource monitoring. 01:25:07 INFO - ##### 01:25:07 INFO - ##### Running install step. 01:25:07 INFO - ##### 01:25:07 INFO - Running pre-action listener: _resource_record_pre_action 01:25:07 INFO - Running main action method: install 01:25:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:25:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:25:07 INFO - Reading from file tmpfile_stdout 01:25:07 INFO - Detecting whether we're running mozinstall >=1.0... 01:25:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:25:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:25:07 INFO - Reading from file tmpfile_stdout 01:25:07 INFO - Output received: 01:25:07 INFO - Usage: mozinstall [options] installer 01:25:07 INFO - Options: 01:25:07 INFO - -h, --help show this help message and exit 01:25:07 INFO - -d DEST, --destination=DEST 01:25:07 INFO - Directory to install application into. [default: 01:25:07 INFO - "/builds/slave/test"] 01:25:07 INFO - --app=APP Application being installed. [default: firefox] 01:25:07 INFO - mkdir: /builds/slave/test/build/application 01:25:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:25:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:25:21 INFO - Reading from file tmpfile_stdout 01:25:21 INFO - Output received: 01:25:21 INFO - /builds/slave/test/build/application/firefox/firefox 01:25:21 INFO - Running post-action listener: _resource_record_post_action 01:25:21 INFO - ##### 01:25:21 INFO - ##### Running run-tests step. 01:25:21 INFO - ##### 01:25:21 INFO - Running pre-action listener: _resource_record_pre_action 01:25:21 INFO - Running main action method: run_tests 01:25:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:25:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:25:21 INFO - Python 2.7.3 01:25:21 INFO - Return code: 0 01:25:21 INFO - grabbing minidump binary from tooltool 01:25:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:21 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 0x11c9220>, '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 0x11352b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1135740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:25:21 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 01:25:21 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 01:25:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:25:21 INFO - Return code: 0 01:25:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:25:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:25:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:25:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:25:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:25:21 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/dGxf8I1AQLawHhmPzJYFAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost'] in /builds/slave/test/build 01:25:21 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/dGxf8I1AQLawHhmPzJYFAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --webServer localhost 01:25:21 INFO - Using env: {'DISPLAY': ':0', 01:25:21 INFO - 'HOME': '/home/cltbld', 01:25:21 INFO - 'LANG': 'en_US.UTF-8', 01:25:21 INFO - 'LANGUAGE': 'en_US:en', 01:25:21 INFO - 'LOGNAME': 'cltbld', 01:25:21 INFO - 'MAIL': '/var/mail/cltbld', 01:25:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:25:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:25:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:21 INFO - 'MOZ_NO_REMOTE': '1', 01:25:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:25:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:21 INFO - 'NO_EM_RESTART': '1', 01:25:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:21 INFO - 'PWD': '/builds/slave/test', 01:25:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:25:21 INFO - 'SHELL': '/bin/bash', 01:25:21 INFO - 'SHLVL': '1', 01:25:21 INFO - 'TERM': 'linux', 01:25:21 INFO - 'TMOUT': '86400', 01:25:21 INFO - 'USER': 'cltbld', 01:25:21 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1448515401.719044-1576458985', 01:25:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:21 INFO - '_': '/tools/buildbot/bin/python'} 01:25:21 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/dGxf8I1AQLawHhmPzJYFAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost'] with output_timeout 3600 01:25:21 INFO - mozversion INFO | application_buildid: 20151126003310 01:25:21 INFO - mozversion INFO | application_changeset: 201e1c425b3affae859d9df7db17afd3ebce415f 01:25:21 INFO - mozversion INFO | application_display_name: Nightly 01:25:21 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:25:21 INFO - mozversion INFO | application_name: Firefox 01:25:21 INFO - mozversion INFO | application_remotingname: firefox 01:25:21 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 01:25:21 INFO - mozversion INFO | application_vendor: Mozilla 01:25:21 INFO - mozversion INFO | application_version: 45.0a1 01:25:21 INFO - mozversion INFO | platform_buildid: 20151126003310 01:25:21 INFO - mozversion INFO | platform_changeset: 201e1c425b3affae859d9df7db17afd3ebce415f 01:25:21 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 01:25:21 INFO - mozversion INFO | platform_version: 45.0a1 01:25:21 INFO - 2015-11-26 01:25:21,957 DEBUG : using testdate: 1448529921 01:25:21 INFO - 2015-11-26 01:25:21,958 DEBUG : actual date: 1448529921 01:25:21 INFO - 2015-11-26 01:25:21,970 INFO : starting webserver on 'localhost:58661' 01:25:21 INFO - 2015-11-26 01:25:21,971 INFO : Starting test suite talos-linux64-ix-053 01:25:21 INFO - 2015-11-26 01:25:21,971 INFO : Starting test dromaeo_css 01:25:21 INFO - 2015-11-26 01:25:21,971 DEBUG : operating with platform_type : linux_ 01:25:21 INFO - 2015-11-26 01:25:21,972 INFO : Initialising browser for dromaeo_css test... 01:25:21 INFO - 2015-11-26 01:25:21,988 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppd1kG1/profile http://localhost:58661/getInfo.html 01:25:25 INFO - 2015-11-26 01:25:25,570 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:25:25 INFO - 2015-11-26 01:25:25,571 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:25:25 INFO - 2015-11-26 01:25:25,571 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:25:25 INFO - 2015-11-26 01:25:25,571 DEBUG : BROWSER_OUTPUT: __metrics 01:25:25 INFO - 2015-11-26 01:25:25,687 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:25:26 INFO - 2015-11-26 01:25:26,858 INFO : Browser initialized. 01:25:26 INFO - 2015-11-26 01:25:26,858 INFO : Running cycle 1/1 for dromaeo_css test... 01:25:26 INFO - 2015-11-26 01:25:26,859 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppd1kG1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:25:38 INFO - 2015-11-26 01:25:38,734 DEBUG : BROWSER_OUTPUT: RSS: Main: 139694080 01:25:38 INFO - 2015-11-26 01:25:38,734 DEBUG : BROWSER_OUTPUT: 01:26:29 INFO - 2015-11-26 01:26:29,954 DEBUG : BROWSER_OUTPUT: 1448529989952 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 01:28:41 INFO - 2015-11-26 01:28:41,648 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58661/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58661/tests/dromaeo/cssquery-ext.html) 01:28:42 INFO - 2015-11-26 01:28:42,899 DEBUG : BROWSER_OUTPUT: RSS: Main: 270503936 01:28:42 INFO - 2015-11-26 01:28:42,899 DEBUG : BROWSER_OUTPUT: 01:31:45 INFO - 2015-11-26 01:31:45,377 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58661/tests/dromaeo/cssquery-ext.html (next: http://localhost:58661/tests/dromaeo/cssquery-jquery.html) 01:31:45 INFO - 2015-11-26 01:31:45,950 DEBUG : BROWSER_OUTPUT: RSS: Main: 219496448 01:31:45 INFO - 2015-11-26 01:31:45,951 DEBUG : BROWSER_OUTPUT: 01:34:47 INFO - 2015-11-26 01:34:47,927 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58661/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58661/tests/dromaeo/cssquery-mootools.html) 01:34:48 INFO - 2015-11-26 01:34:48,513 DEBUG : BROWSER_OUTPUT: RSS: Main: 213188608 01:34:48 INFO - 2015-11-26 01:34:48,513 DEBUG : BROWSER_OUTPUT: 01:37:50 INFO - 2015-11-26 01:37:50,408 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58661/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58661/tests/dromaeo/cssquery-prototype.html) 01:37:50 INFO - 2015-11-26 01:37:50,994 DEBUG : BROWSER_OUTPUT: RSS: Main: 199950336 01:37:50 INFO - 2015-11-26 01:37:50,994 DEBUG : BROWSER_OUTPUT: 01:40:53 INFO - 2015-11-26 01:40:53,791 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58661/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58661/tests/dromaeo/cssquery-yui.html) 01:40:54 INFO - 2015-11-26 01:40:54,372 DEBUG : BROWSER_OUTPUT: RSS: Main: 204578816 01:40:54 INFO - 2015-11-26 01:40:54,372 DEBUG : BROWSER_OUTPUT: 01:43:57 INFO - 2015-11-26 01:43:57,082 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58661/tests/dromaeo/cssquery-yui.html (next: http://localhost:58661/tests/dromaeo/cssquery-dojo.html) 01:43:57 INFO - 2015-11-26 01:43:57,328 DEBUG : BROWSER_OUTPUT: RSS: Main: 271609856 01:43:57 INFO - 2015-11-26 01:43:57,329 DEBUG : BROWSER_OUTPUT: 01:43:57 INFO - 2015-11-26 01:43:57,330 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:43:57 INFO - 2015-11-26 01:43:57,330 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:43:57 INFO - 2015-11-26 01:43:57,330 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:43:57 INFO - 2015-11-26 01:43:57,330 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:43:57 INFO - 2015-11-26 01:43:57,332 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2581.0837152810755;2663.547196976514;2664.054260737437;2672.19834049785;2678.906238281659;4343.913121737563;4483.977580112103;4507.977460112699;4573.542645735429;4594.678372513921;4444.244478438665;4455.598996090352;4503.594676479116;4604.4014278143795;4613.446386433633;4164.479440069991;4171.457710497639;4202.3696445533105;4264.381664658623;4271.273883439822;4164.375343698439;4256.21260066887;4284.928767808048;4286.892827679302;4329.978350108245;4016.2369149861433;4197.349410841324;4207.579242075799;4248.235317642823;4284.228838809028;4078.3882417637296;4175.832966681329;4183;4187.225363307767;4200.012996945716;4187.811548480326;4190.685698572619;4193.370994350841;4225.04936389313;4238.830446782125;4342.652587792969;4462.286034234539;4504.36938828561;4514.980304778579;4550.3402006709175;4696.201645720235;4775.42694876617;4781.163296423112;4789.880252993668;4809.5430934061205;4888.608911287124;4936.111499930011;4938.851834444972;4939.061578300111;4940.036692844897;4584.358189853423;4586.656000799887;4586.678932474695;4603.654725895572;4627.3521706961055;4731.195696731564;4852.126617208936;4855.587275081658;4964.429090654548;5097.388313402415;4812.278158276216;4823.493533179036;4825.879353016203;4831.130396528659;4868.732219727949;4894.486078961658;4911.803527858917;4915.705057696549;4917.409910810726;4961.03259864323;4597.42532183477;4737.313089601988;4739.597134243559;4752.881177970509;4862.124817532878;4770.475247722748;4776.355192049098;4793.1372352976105;4798.640101992364;4839.322494850724;4034.899127521777;4037.818298176589;4041.474608300902;4041.474608300902;4073.429719839225;3407.352603005421;3485.703715184238;3524.9823750881596;3576.445650924111;3594.029612004744;4178.707490475698;4261.169072030986;4271.700980931305;4305.117450922553;4310.719803212781;4906.975465122723;4928.383952005999;4928.753562321869;4931.2849636803185;4976.303317535548;4013.3177359848896;4116.156187981456;4124.876253712393;4246.4691913510815;4257.127288905767;4239.936400953989;4275.679324050709;4299.6560275178535;4337.37108119321;4337.587929146726;4633.027064316531;4634.281686338623;4647.117047760915;4675.158471475167;4678.251479763221;4582.473015603115;4706.670533062653;4857.198562237191;4868.9756551217015;4879;4522.728636281834;4523.705959112647;4600;4634.536546345474;4646.395968524071;4831.178699621143;4852.878678033077;4871.853844384674;4874.8537543873745;4916.06594746997;4909.0672772173175;4914.36113305268;4920.434150072644;4926.3842019747535;4968.22992436173;4521.321801729767;4629.490756016903;4642.883927901695;4642.883927901695;4649.023705021983;4596.609288210406;4628.259478483426;4680.531946805292;4712.222483290218;4720.834770783006;4589.5639914208095;4625.768711564476;4632.536746325341;4645.419322584677;4680.461746899014;4484.618807401407;4754.976225118852;4760.16697078003;4770.7137571744415;4810.302506136661;4541.704789188692;4558.407407037064;4584.014436896084;4651.069786042737;4657.278121891112 01:43:57 INFO - 2015-11-26 01:43:57,335 DEBUG : BROWSER_OUTPUT: |1;ext.html;481.0139214610048;492.28126934675373;556.3351794605447;585.6369051188263;587.6004317064397;21491.46271343217;21898.562028759436;36193.81903090481;36895.81552092243;37104.81447592758;39758.801205994;40462.79768601153;40502.392464113065;40571.391429128584;40612.39081413774;6387.201599800025;7841.529508229496;7940.563269020202;7944.483608565425;7949.205079492062;6542.803715888531;6626.370494802986;6632.834179145536;6638.900416493757;9321.627134914595;9992.500374981259;10242.795144097114;10261.076503114718;10261.076503114718;10266.743331416737;10048.44733539655;10128.89871101287;10186.185105191567;10192.439415832127;10193.949030254838;6676.232233293136;6882.621455819928;6887.449004079712;6888.138982627172;6890.862182756367;31508;32206.677933220602;32386.838065809756;32387.190320241945;32430.837845810856;1836.412348048625;2480.1443501991785;2568.4734629400928;2679.2230253226735;3032.3328867649084;26685.86513078949;28162.155135345973;28377.716222837713;28501.287467813265;28723.712762872314;3386;3390.847411866447;3454.7754395964434;3462.497937799005;3472.409690352621;227722.86138569366;228320.15918965213;228405;228904;229359.1192264218;53346.73326633342;53876.46123538793;53917.73041134848;53978;53981;55886;56407;56708;56723.71638141783;56756.71621641865;12226.083043771574;12558.246505209716;12566.120371573903;12580.559680411141;12585.937070314772;9506.667266645634;9586.760330991641;9589.856152157723;9593.232541396672;9596.040395960488;17995.640087198182;18130.728039079426;18147.818521814876;18155.54611134732;18156;7012.088428504262;7137.785866424016;7323.780286591411;7336.413086953031;7337.0828646419195;814.5438554409432;834.641104325146;861.7845538615346;882.4248716041834;912.466207268742;26314.736852631613;26335.005254847492;26359.73640263611;26508.60237096445;26531.86734066317;674.6019848289533;860.4579115157411;893.0801274687083;933.3606479561522;940.5485367023867;13568.457261709618;14423.350949207312;14625.341859616343;14643.633909152357;15101.244937753288;242069;245349;277344;282847;288804;39260.607393926264;39261.803690981935;39470.80264598659;39617.80191099026;39667.40498892519;774.3959711425098;774.8295375017375;1103.189155970361;1208.4380762945273;1213.0538180219444;24489;25167;27587.448251034464;27878.76972837044;28354.43291134207;39809.80095099622;40076.398854017796;40124.3981340286;40155.59844401519;40175.397369040074;224804;225033;225716;226141;226416;27136.321591960357;27580.448391031667;27580.862095689394;27581.724182758717;27587;27231.59152612673;27714.584281236203;27725.306867327672;27754.722452775215;27801;31505.21236969094;31806.84096579595;31968.200794980312;32273.51589726203;32725.836370817993;30598.080629537675;32548.51177232296;33778.66221337755;34096.65903340935;35205.47191792074;31217.219569510944;31922.20194495156;32047.359052818345;32266.83866580652;32285.192870178435;27966;29135.923348602457;29299.820108930995;29525.557116643697;29890.402191955603;22416;22751.259294794967;22942;23077.19229826948;23285.76714232836 01:43:57 INFO - 2015-11-26 01:43:57,336 DEBUG : BROWSER_OUTPUT: |2;jquery.html;323.80733463589155;330.93712194683025;333.01427773789584;334.87776961409094;336.4818180002796;10894.782104357908;11134.610288639898;14742.262886855668;15291.923540382297;15989.920050399745;13077.084604077718;13199.934000329986;13206.141600795941;13244.337783110854;13603.659908502268;4831.299461578078;4935;4995.450500444967;5003.1994880819075;5008.874778130539;3440.3807314683345;3559.181388280697;3564.8930532084078;3566.1084728817796;5017.247412888059;3545.3618348697223;5605.439456054402;5798.420157984189;5807.41925807418;5807.970960145193;5348.598855085846;5365.141577347645;5367.651102678314;5379.515843574078;5741.052726300156;5048.368953880765;5182.870428239286;5207.531322181022;5208.166693329087;5212.218167274901;18366.081695915153;18599.349022784274;18684.252629894923;18690.71963920542;19328.1302341395;1836.4857839804877;1942.1648691062837;1954.1890115602007;1954.739193220379;2011.8591698581106;12283.078769092353;12510.74978500425;12639.988800895906;12946.223226606433;13132.803007954888;1735.6355165415277;1752.7283271093002;1761.7005109131478;1787.7407775872555;1792.659394715;49954;51560.74219628915;52920;52975.47024529744;53599.73200134013;9107.134822191882;9270.490123043297;9471.857922131036;9481.24150067993;9567.37812042215;11815.409229538489;11860.525578976743;11873.881261187451;11884.643460696192;11886;6619.86760264792;6661.600303981777;6729.394354508117;6744.831379215559;6821.1814582250445;6296.685165741695;6307.400796924285;6336.968315158395;6372.299047104908;6429.839254018687;5598;5680.914786278209;5703.9429605704245;5714.514266287412;5727.742251598688;1385.4458216713394;1443.076431084107;1574.0791636892545;1622.862056725168;1671.8411750883647;810.4934415990007;851.638053827121;851.7061613743249;895.5880295064213;919.4069824962861;12862.935685321514;15410;16145.677086458205;16496.34014639425;16601.169941502878;829.3986859526915;850.4259624753266;854.2781349759443;855.3371137368465;862.7239283429368;9218.308626853013;9594.088561586637;9657.951710241405;9706.70879873605;9809.362391444532;513094;521205;521629;522556;525944;60296.39703602908;62025.37974620196;62368;63014.68492657507;64524.354756452776;1043.7703705184847;1061.7611037516497;1071.6677829872765;1074.3446497636435;1075.5375188668947;13876.098053626481;14231.217283049531;14315;14370.871116802282;14612.707745844811;30890.227744306572;31125.844370778002;31343.529847051857;31525.527117092803;31999.36001280008;38488.6151138485;38713.612863871;38937.2212555753;40200.396994045695;40390.79804600958;8382.916170838458;8731.432456890281;8962.372633915824;8984.550772461482;8984.730458086267;10712.89287107119;15592.14243216634;15993.600159996093;16234.837651623333;16500.669986600442;11773.234739741889;11878.524859005543;11893.345865977455;12365.629031129081;12485.625431237077;11992.220505667105;12057.51769929228;12128.211666241667;12350.44423000985;12494.500219991462;11439.942800285946;11475;12351.135420520477;12589.055820813292;13077.738445231233;8397.076321604742;8413.200745929127;8520.275776558814;8701.260392866678;8715.08491608372;8953.820923581623;8962.103789620985;9805.656802011896;12131.332776697014;12263.877361226274 01:43:57 INFO - 2015-11-26 01:43:57,338 DEBUG : BROWSER_OUTPUT: |3;mootools.html;902.855543113102;1472.5729538433852;1524.8398918113598;1533.3253368517849;1564.913929733865;5125.256837758523;6311.715972781224;6445.90331145032;6463.74145034198;6463.773767918124;6632.535722499427;6744.561603495769;6748.39264466198;6753.864922701543;6770.661466926646;1664.1013852519686;1693.7544056111856;1694.2799310293137;1993.2226431691652;2041.6325061488926;1669.1654172913543;1675.5392267126515;2001.7097520859468;2035.9796402036013;2040.9387718368473;1981.8315443187346;1983.1175127068461;1984.4145976936766;1985.176151896961;1987.6422243996076;1944.513871532117;1970.339936121401;1989.8507611929163;1991.0442987366;1992.2429476798868;1985.4341512668964;1991.6415045291842;2002.7196192533056;2034.4201902457728;2063.7626672932506;6663.300353462865;6718.05947167397;6725.93274067258;6731.9663401683165;6741.561798483083;3858.305505009097;3914.1388894443176;3924.725269231155;3933.2920074386598;3937.3897045957638;2607.504574130909;2613.738626137371;2642.828216165962;2643.4845205184997;2715.3075965628836;792.3344390711773;796.5937371940353;830.4104086098877;854.1159899503983;857.9485230886104;8816.118388161196;8816.603252853636;8822.338324625614;8822.647094116228;8823.382363234576;3619.2399596085115;3621.27574485104;3668.706503479715;3723.9813800930824;3724.571674257495;7790.766277011699;7790.961045194737;7797.649105790253;7798.805029874298;7808.219178082147;3836.731428799957;3838.4626152338697;3843.7117216208894;3866.6520013198383;3869.9806500967316;3479.7912125272564;3480.3909315869623;3482.7562070655317;3483.9477407838904;3487.3897068013503;3167.6040494938134;3167.651558328582;3181.9363612727616;3203.6796320368244;3222.2749881276527;822.4900561651694;857.3826844671827;953.8839557717487;963.643451922793;971.455984648599;710.6233696141054;747.7233423633181;748.2704363245792;748.4947660329256;767.6008475592772;6096.451319381188;6124.5100391968535;6185.165002724664;6185.41238582334;6186.257649082049;970.6020531582018;978.554757585297;983.1986930651497;1000.5997600959674;1002.0630710285906;4667.6265898728025;4686.835960741426;4776.355192049098;4789.521047895252;4790.281457781361;7928.7621371358955;8216.178382161735;8221.054578723404;8228.25945664893;8231.09457959624;7844.764657060183;8019.839603207904;8071.394645401501;8084.231997960184;8119.147489513634;6219.813405597839;6222.12890195373;6222.471089957314;6226.533010024266;6266.342034086355;5847.152162936265;5902.439268269508;5924.289085309791;5945.078512830518;5993.041113421831;7242.094738157731;7357.227491113356;7381.298776616213;7420.777376678709;7437.888431673638;7413.184549699637;7504.699812007459;7533.962330188314;7626.237376262329;7630.656620452204;5488.231647569423;5511.972440137934;5549.278593782782;5591.804286849941;5620.4098569649595;6045.879082418415;6090.208272924491;6096.786612468542;6098.817035488943;6099.969500152648;4810.855674329776;4883.047805677858;5195.506426889439;5660;5727.770889164387;5701.030824759884;5711.942880571141;5733.942660573341;5749.223854779551;5765.221695071112;5776.884462310814;5800.4489573490455;5811.535077193899;5840;5841.766329346949;5404.405515393225;5405.297311349656;5434.375046869661;5455.509004189642;5459.235707001102;5581.6930068846605;5593.468620481048;5597.888042239051;5615.326160860723;5618.438156184349 01:43:57 INFO - 2015-11-26 01:43:57,341 DEBUG : BROWSER_OUTPUT: |4;prototype.html;295.9067893613512;300.75338222657416;306.71169101045007;307.66618219232146;307.9384123175363;5222.556082732967;5238.5547228485575;5298.337707786527;5319.627626066177;5329.9733501332485;5196.532312091911;5205.869853253671;5209.453007434212;5222.529972302492;5224.4775522447735;3837.501124853779;4085.632293093621;4086.38704194371;4090.6931980101463;4091.0386059276193;3936.1340505088833;3969.6427321541055;4032.7378720383226;4038.838446462138;4043.8382464701376;3995.2808494470983;4007.238624661305;4014.0566966762785;4022.798860057;4036.091879327157;3812.866549670748;3892.2020985698146;3939.7636141831294;4043.1105156865588;4052.5947405259385;3530.947035794465;3534.964650353489;3559.6440355964455;3563.7861728296125;3572.7677700949357;5006.524380183913;5006.8497945061345;5007.799688012475;5022.221555658879;5027.195648696191;4638.582527572535;4643.721376717374;4651.395318608593;4651.604613607848;4651.697639653412;5333.200019997032;5477.1510415885605;5481.561475081984;5485.835424937259;5505.091659876116;3822.7132965027454;3823.1971286029966;3823.7896915669626;3823.9044023899623;3827.5598306194865;5716.1711551825165;5770.336411312711;5773.769049238025;5787.421257874221;5799.88400231993;3911.5697273299916;3912.4326972588815;3913.784741839226;3914.0606254499285;3920.725549211528;3891.4520717559976;3976.6421022108148;3978.7015973801504;3979.6418322350546;3980.0845805464905;4536.682432229778;4541.477730061019;4547.477040140427;4551.977240113778;4552.3171524270965;5462.378058531927;5470.64440811346;5477.178423236467;5477.67133971963;5481.643693159932;1379.0553470872485;1399.8670126337981;1400.5378225185664;1400.9299535023208;1401.3903951781008;914.4193437167446;923.3582660051334;933.2767105493161;936.9297302702324;939.6899023322287;4829.613630909519;4833.347498087784;4833.613310935117;4836.5888899443235;4839.2983017462275;5667.574931880125;5679.659220446786;5679.716014199356;5687.1753595729215;5687.800926967537;4831.710097394168;4832.51674832521;4834.830780922651;4835.492273311322;4842.539958703917;2848.2025032990796;2906.2007947814095;3046.497327940909;3068.4476794176817;3077.322988942429;5373.838784836461;5459.754311056012;5463.617546771768;5468.152436372368;5468.7265636718;5913.201717768046;5922.822315330547;5923.200367950358;5923.733431995571;5925.1704761332585;5455.563554915597;5460.180972854024;5464.535514481234;5464.863378415492;5473.06957817164;5611.663300202001;5757.481826635623;5765.654060756368;5772.076467765305;5778.855528611818;5615.578831587729;5619.100943848965;5621.634593751393;5624.353199382123;5627.606067575231;5436.374816896107;5466.835994920159;5475.178723191553;5479.726013699379;5485.286912701324;3938.932060668172;3972.483577134954;3978.124812541236;3982.880513584597;3983.6016398359934;5630.85922851932;5766.798162064308;5767.884642307215;5770.451807078321;5776.711164441677;5530.585206109477;5539.529140023144;5547.112462006221;5549.472800083986;5569.916451253153;5536.861578460571;5541.251930989426;5548.889022219614;5552.194931734956;5555.333359996826;5248.737563121752;5392.056390131633;5405.702686352131;5409.945900541102;5427.565794736491;5599;5601.495865372136;5601.663900166003;5609.607327487037;5609.803656872153;5209.374875015023;5319.893602128013;5322.414534401135;5473.480019398151;5474.343078830566 01:43:57 INFO - 2015-11-26 01:43:57,341 DEBUG : BROWSER_OUTPUT: |5;yui.html;571.8227349521649;721.206672660074;740.9851802963942;742.1984257002438;761.779084065621;8579.828403431944;8740.475571465717;10701.250912436122;10944.5622175113;10955.068819150372;11311.886881131186;11677.357745324003;11701.122415818805;11718.531258749661;11781.469833857476;350.88245437778374;354.8137227955318;762.5653377574785;774.9690012399498;780.1301548773134;761.8362052158785;778.9026371703537;781.6951388958311;781.9687212511493;782.026377160436;801.6633014134078;808.9514629122242;816.873384625384;817.5094943034192;818.423011776696;814.5316443045273;814.633414963266;815;815.2051749544206;815.5392203405057;599.8470390050553;600.321636550695;600.5615900392694;600.975960961561;601.2424345324922;10865.782684346348;10982.615608453665;10984.340939543654;10989.560417583287;10992.17558683094;10943.23397362185;11249;11534.538618455252;11557.133215008907;11711.824322635168;8790.824183516357;8831.293496520262;8904.287656987426;8931.106889311082;8955.417897836685;3054.8930787422332;3108.689131086896;3164.3671265746943;3164.5727826743323;3176.126565194567;37101.95939223342;40965.590344096476;41259.381109283386;41397.58602413998;41409.378859317134;9041.81916361669;9193.310501712265;9574.425534467955;9585.089416505421;9643.807123857483;15968.680626387408;16017.119058451664;16042.75935860963;16063.116528590806;16065.27706253198;6141.7543298267565;6249.78125765596;6282;6305.673111911975;6368.10846481493;3506.3513250048823;3597.8380972856285;3647.2340808430527;3657.5428071491065;3695.2978934002454;2603.7526434988645;2630.4213073123883;2630.631711560383;2632.3945492536823;2640.524705553019;446.1968456777787;448.1686471595209;453.8729155836371;462.49125961442144;467.71469403663735;499.33089659855966;511.15659162382366;535.2533216163508;538.5530010091614;541.7941182350681;6799.32006799326;7001.474889383317;7538.585377804164;7824.843503129906;8144.14486478923;354.5585745746562;423.5652716062817;438.9209942210369;447.47421779409063;543.1933578635723;3349.4975753636663;3547.485614585922;3579.964200358015;3610.891673249807;3724.1806802503406;45885.31172032422;47011;52040.73979630153;53642.19536706952;53678.19482707763;43671.344929826075;44402;44595.55404445914;44596.3310550342;44904.77547612241;41463.58536414597;41783.58216417858;42195;42196.36705449421;42316.15367692691;7602.201768814195;7616.9238307616215;7791.493552919269;8015.358771298165;8032.437729358889;30914.381712366077;31193.68806311908;31198.68801311958;31877;31882.840585796923;39321.60678393294;39407.60592394154;39462.605373945895;41248.38127428031;41688;9157.58413923605;9420.021795423037;9527.523623818919;9568.56941437623;9788.510574471391;10739.194560407845;10877.129829613454;10911.236213464981;10915.945420272848;10930.125589952944;9905.257105716955;10231.13035392;10250.897491024994;10256.58973641046;10353.275270730977;9154.725358239264;9558.091981261769;9747.9025209747;9848.015198480094;9873;9516.33385662997;10327.690169294632;10576.576936922436;10576.947115264375;10606.363618182933;7616.23837616234;7736.535807851547;8130.5111119976145;8260.360199360606;8302.916970830456;8004.279614834692;8200.917990820015;8967;9008.603891237033;9077.934048943003 01:43:57 INFO - 2015-11-26 01:43:57,341 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:43:57 INFO - 2015-11-26 01:43:57,342 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:43:57 INFO - 2015-11-26 01:43:57,342 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1067 01:43:57 INFO - 2015-11-26 01:43:57,342 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:43:57 INFO - 2015-11-26 01:43:57,342 DEBUG : BROWSER_OUTPUT: __startTimestamp1448531037329__endTimestamp 01:43:57 INFO - 2015-11-26 01:43:57,342 DEBUG : BROWSER_OUTPUT: 01:43:57 INFO - 2015-11-26 01:43:57,342 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:43:57 INFO - 2015-11-26 01:43:57,342 DEBUG : BROWSER_OUTPUT: Number of tests: 6 01:43:57 INFO - 2015-11-26 01:43:57,342 DEBUG : BROWSER_OUTPUT: 01:43:57 INFO - 2015-11-26 01:43:57,343 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4483.00 Median:4600.00 stddev:459.79 (10.0%) stddev-sans-first:436.33 01:43:57 INFO - 2015-11-26 01:43:57,343 DEBUG : BROWSER_OUTPUT: Values: 2581.1 2663.5 2664.1 2672.2 2678.9 4343.9 4484.0 4508.0 4573.5 4594.7 4444.2 4455.6 4503.6 4604.4 4613.4 4164.5 4171.5 4202.4 4264.4 4271.3 4164.4 4256.2 4284.9 4286.9 4330.0 4016.2 4197.3 4207.6 4248.2 4284.2 4078.4 4175.8 4183.0 4187.2 4200.0 4187.8 4190.7 4193.4 4225.0 4238.8 4342.7 4462.3 4504.4 4515.0 4550.3 4696.2 4775.4 4781.2 4789.9 4809.5 4888.6 4936.1 4938.9 4939.1 4940.0 4584.4 4586.7 4586.7 4603.7 4627.4 4731.2 4852.1 4855.6 4964.4 5097.4 4812.3 4823.5 4825.9 4831.1 4868.7 4894.5 4911.8 4915.7 4917.4 4961.0 4597.4 4737.3 4739.6 4752.9 4862.1 4770.5 4776.4 4793.1 4798.6 4839.3 4034.9 4037.8 4041.5 4041.5 4073.4 3407.4 3485.7 3525.0 3576.4 3594.0 4178.7 4261.2 4271.7 4305.1 4310.7 4907.0 4928.4 4928.8 4931.3 4976.3 4013.3 4116.2 4124.9 4246.5 4257.1 4239.9 4275.7 4299.7 4337.4 4337.6 4633.0 4634.3 4647.1 4675.2 4678.3 4582.5 4706.7 4857.2 4869.0 4879.0 4522.7 4523.7 4600.0 4634.5 4646.4 4831.2 4852.9 4871.9 4874.9 4916.1 4909.1 4914.4 4920.4 4926.4 4968.2 4521.3 4629.5 4642.9 4642.9 4649.0 4596.6 4628.3 4680.5 4712.2 4720.8 4589.6 4625.8 4632.5 4645.4 4680.5 4484.6 4755.0 4760.2 4770.7 4810.3 4541.7 4558.4 4584.0 4651.1 4657.3 01:43:57 INFO - 2015-11-26 01:43:57,343 DEBUG : BROWSER_OUTPUT: 01:43:57 INFO - 2015-11-26 01:43:57,343 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39258.39 Median:32007.78 stddev:62951.53 (196.7%) stddev-sans-first:63060.79 01:43:57 INFO - 2015-11-26 01:43:57,343 DEBUG : BROWSER_OUTPUT: Values: 481.0 492.3 556.3 585.6 587.6 21491.5 21898.6 36193.8 36895.8 37104.8 39758.8 40462.8 40502.4 40571.4 40612.4 6387.2 7841.5 7940.6 7944.5 7949.2 6542.8 6626.4 6632.8 6638.9 9321.6 9992.5 10242.8 10261.1 10261.1 10266.7 10048.4 10128.9 10186.2 10192.4 10193.9 6676.2 6882.6 6887.4 6888.1 6890.9 31508.0 32206.7 32386.8 32387.2 32430.8 1836.4 2480.1 2568.5 2679.2 3032.3 26685.9 28162.2 28377.7 28501.3 28723.7 3386.0 3390.8 3454.8 3462.5 3472.4 227722.9 228320.2 228405.0 228904.0 229359.1 53346.7 53876.5 53917.7 53978.0 53981.0 55886.0 56407.0 56708.0 56723.7 56756.7 12226.1 12558.2 12566.1 12580.6 12585.9 9506.7 9586.8 9589.9 9593.2 9596.0 17995.6 18130.7 18147.8 18155.5 18156.0 7012.1 7137.8 7323.8 7336.4 7337.1 814.5 834.6 861.8 882.4 912.5 26314.7 26335.0 26359.7 26508.6 26531.9 674.6 860.5 893.1 933.4 940.5 13568.5 14423.4 14625.3 14643.6 15101.2 242069.0 245349.0 277344.0 282847.0 288804.0 39260.6 39261.8 39470.8 39617.8 39667.4 774.4 774.8 1103.2 1208.4 1213.1 24489.0 25167.0 27587.4 27878.8 28354.4 39809.8 40076.4 40124.4 40155.6 40175.4 224804.0 225033.0 225716.0 226141.0 226416.0 27136.3 27580.4 27580.9 27581.7 27587.0 27231.6 27714.6 27725.3 27754.7 27801.0 31505.2 31806.8 31968.2 32273.5 32725.8 30598.1 32548.5 33778.7 34096.7 35205.5 31217.2 31922.2 32047.4 32266.8 32285.2 27966.0 29135.9 29299.8 29525.6 29890.4 22416.0 22751.3 22942.0 23077.2 23285.8 01:43:57 INFO - 2015-11-26 01:43:57,343 DEBUG : BROWSER_OUTPUT: 01:43:57 INFO - 2015-11-26 01:43:57,343 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26563.10 Median:3565.50 stddev:84881.69 (2380.6%) stddev-sans-first:85096.93 01:43:57 INFO - 2015-11-26 01:43:57,345 DEBUG : BROWSER_OUTPUT: Values: 323.8 330.9 333.0 334.9 336.5 10894.8 11134.6 14742.3 15291.9 15989.9 13077.1 13199.9 13206.1 13244.3 13603.7 4831.3 4935.0 4995.5 5003.2 5008.9 3440.4 3559.2 3564.9 3566.1 5017.2 3545.4 5605.4 5798.4 5807.4 5808.0 5348.6 5365.1 5367.7 5379.5 5741.1 5048.4 5182.9 5207.5 5208.2 5212.2 18366.1 18599.3 18684.3 18690.7 19328.1 1836.5 1942.2 1954.2 1954.7 2011.9 12283.1 12510.7 12640.0 12946.2 13132.8 1735.6 1752.7 1761.7 1787.7 1792.7 49954.0 51560.7 52920.0 52975.5 53599.7 9107.1 9270.5 9471.9 9481.2 9567.4 11815.4 11860.5 11873.9 11884.6 11886.0 6619.9 6661.6 6729.4 6744.8 6821.2 6296.7 6307.4 6337.0 6372.3 6429.8 5598.0 5680.9 5703.9 5714.5 5727.7 1385.4 1443.1 1574.1 1622.9 1671.8 810.5 851.6 851.7 895.6 919.4 12862.9 15410.0 16145.7 16496.3 16601.2 829.4 850.4 854.3 855.3 862.7 9218.3 9594.1 9658.0 9706.7 9809.4 513094.0 521205.0 521629.0 522556.0 525944.0 60296.4 62025.4 62368.0 63014.7 64524.4 1043.8 1061.8 1071.7 1074.3 1075.5 13876.1 14231.2 14315.0 14370.9 14612.7 30890.2 31125.8 31343.5 31525.5 31999.4 38488.6 38713.6 38937.2 40200.4 40390.8 8382.9 8731.4 8962.4 8984.6 8984.7 10712.9 15592.1 15993.6 16234.8 16500.7 11773.2 11878.5 11893.3 12365.6 12485.6 11992.2 12057.5 12128.2 12350.4 12494.5 11439.9 11475.0 12351.1 12589.1 13077.7 8397.1 8413.2 8520.3 8701.3 8715.1 8953.8 8962.1 9805.7 12131.3 12263.9 01:43:57 INFO - 2015-11-26 01:43:57,345 DEBUG : BROWSER_OUTPUT: 01:43:57 INFO - 2015-11-26 01:43:57,345 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4587.69 Median:5757.22 stddev:2399.74 (41.7%) stddev-sans-first:2390.48 01:43:57 INFO - 2015-11-26 01:43:57,346 DEBUG : BROWSER_OUTPUT: Values: 902.9 1472.6 1524.8 1533.3 1564.9 5125.3 6311.7 6445.9 6463.7 6463.8 6632.5 6744.6 6748.4 6753.9 6770.7 1664.1 1693.8 1694.3 1993.2 2041.6 1669.2 1675.5 2001.7 2036.0 2040.9 1981.8 1983.1 1984.4 1985.2 1987.6 1944.5 1970.3 1989.9 1991.0 1992.2 1985.4 1991.6 2002.7 2034.4 2063.8 6663.3 6718.1 6725.9 6732.0 6741.6 3858.3 3914.1 3924.7 3933.3 3937.4 2607.5 2613.7 2642.8 2643.5 2715.3 792.3 796.6 830.4 854.1 857.9 8816.1 8816.6 8822.3 8822.6 8823.4 3619.2 3621.3 3668.7 3724.0 3724.6 7790.8 7791.0 7797.6 7798.8 7808.2 3836.7 3838.5 3843.7 3866.7 3870.0 3479.8 3480.4 3482.8 3483.9 3487.4 3167.6 3167.7 3181.9 3203.7 3222.3 822.5 857.4 953.9 963.6 971.5 710.6 747.7 748.3 748.5 767.6 6096.5 6124.5 6185.2 6185.4 6186.3 970.6 978.6 983.2 1000.6 1002.1 4667.6 4686.8 4776.4 4789.5 4790.3 7928.8 8216.2 8221.1 8228.3 8231.1 7844.8 8019.8 8071.4 8084.2 8119.1 6219.8 6222.1 6222.5 6226.5 6266.3 5847.2 5902.4 5924.3 5945.1 5993.0 7242.1 7357.2 7381.3 7420.8 7437.9 7413.2 7504.7 7534.0 7626.2 7630.7 5488.2 5512.0 5549.3 5591.8 5620.4 6045.9 6090.2 6096.8 6098.8 6100.0 4810.9 4883.0 5195.5 5660.0 5727.8 5701.0 5711.9 5733.9 5749.2 5765.2 5776.9 5800.4 5811.5 5840.0 5841.8 5404.4 5405.3 5434.4 5455.5 5459.2 5581.7 5593.5 5597.9 5615.3 5618.4 01:43:57 INFO - 2015-11-26 01:43:57,346 DEBUG : BROWSER_OUTPUT: 01:43:57 INFO - 2015-11-26 01:43:57,346 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4567.70 Median:5223.52 stddev:1357.48 (26.0%) stddev-sans-first:1322.88 01:43:57 INFO - 2015-11-26 01:43:57,346 DEBUG : BROWSER_OUTPUT: Values: 295.9 300.8 306.7 307.7 307.9 5222.6 5238.6 5298.3 5319.6 5330.0 5196.5 5205.9 5209.5 5222.5 5224.5 3837.5 4085.6 4086.4 4090.7 4091.0 3936.1 3969.6 4032.7 4038.8 4043.8 3995.3 4007.2 4014.1 4022.8 4036.1 3812.9 3892.2 3939.8 4043.1 4052.6 3530.9 3535.0 3559.6 3563.8 3572.8 5006.5 5006.8 5007.8 5022.2 5027.2 4638.6 4643.7 4651.4 4651.6 4651.7 5333.2 5477.2 5481.6 5485.8 5505.1 3822.7 3823.2 3823.8 3823.9 3827.6 5716.2 5770.3 5773.8 5787.4 5799.9 3911.6 3912.4 3913.8 3914.1 3920.7 3891.5 3976.6 3978.7 3979.6 3980.1 4536.7 4541.5 4547.5 4552.0 4552.3 5462.4 5470.6 5477.2 5477.7 5481.6 1379.1 1399.9 1400.5 1400.9 1401.4 914.4 923.4 933.3 936.9 939.7 4829.6 4833.3 4833.6 4836.6 4839.3 5667.6 5679.7 5679.7 5687.2 5687.8 4831.7 4832.5 4834.8 4835.5 4842.5 2848.2 2906.2 3046.5 3068.4 3077.3 5373.8 5459.8 5463.6 5468.2 5468.7 5913.2 5922.8 5923.2 5923.7 5925.2 5455.6 5460.2 5464.5 5464.9 5473.1 5611.7 5757.5 5765.7 5772.1 5778.9 5615.6 5619.1 5621.6 5624.4 5627.6 5436.4 5466.8 5475.2 5479.7 5485.3 3938.9 3972.5 3978.1 3982.9 3983.6 5630.9 5766.8 5767.9 5770.5 5776.7 5530.6 5539.5 5547.1 5549.5 5569.9 5536.9 5541.3 5548.9 5552.2 5555.3 5248.7 5392.1 5405.7 5409.9 5427.6 5599.0 5601.5 5601.7 5609.6 5609.8 5209.4 5319.9 5322.4 5473.5 5474.3 01:43:57 INFO - 2015-11-26 01:43:57,347 DEBUG : BROWSER_OUTPUT: 01:43:57 INFO - 2015-11-26 01:43:57,347 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12073.91 Median:23173.90 stddev:14037.75 (60.6%) stddev-sans-first:14050.55 01:43:57 INFO - 2015-11-26 01:43:57,347 DEBUG : BROWSER_OUTPUT: Values: 571.8 721.2 741.0 742.2 761.8 8579.8 8740.5 10701.3 10944.6 10955.1 11311.9 11677.4 11701.1 11718.5 11781.5 350.9 354.8 762.6 775.0 780.1 761.8 778.9 781.7 782.0 782.0 801.7 809.0 816.9 817.5 818.4 814.5 814.6 815.0 815.2 815.5 599.8 600.3 600.6 601.0 601.2 10865.8 10982.6 10984.3 10989.6 10992.2 10943.2 11249.0 11534.5 11557.1 11711.8 8790.8 8831.3 8904.3 8931.1 8955.4 3054.9 3108.7 3164.4 3164.6 3176.1 37102.0 40965.6 41259.4 41397.6 41409.4 9041.8 9193.3 9574.4 9585.1 9643.8 15968.7 16017.1 16042.8 16063.1 16065.3 6141.8 6249.8 6282.0 6305.7 6368.1 3506.4 3597.8 3647.2 3657.5 3695.3 2603.8 2630.4 2630.6 2632.4 2640.5 446.2 448.2 453.9 462.5 467.7 499.3 511.2 535.3 538.6 541.8 6799.3 7001.5 7538.6 7824.8 8144.1 354.6 423.6 438.9 447.5 543.2 3349.5 3547.5 3580.0 3610.9 3724.2 45885.3 47011.0 52040.7 53642.2 53678.2 43671.3 44402.0 44595.6 44596.3 44904.8 41463.6 41783.6 42195.0 42196.4 42316.2 7602.2 7616.9 7791.5 8015.4 8032.4 30914.4 31193.7 31198.7 31877.0 31882.8 39321.6 39407.6 39462.6 41248.4 41688.0 9157.6 9420.0 9527.5 9568.6 9788.5 10739.2 10877.1 10911.2 10915.9 10930.1 9905.3 10231.1 10250.9 10256.6 10353.3 9154.7 9558.1 9747.9 9848.0 9873.0 9516.3 10327.7 10576.6 10576.9 10606.4 7616.2 7736.5 8130.5 8260.4 8302.9 8004.3 8200.9 8967.0 9008.6 9077.9 01:43:57 INFO - 2015-11-26 01:43:57,347 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:43:57 INFO - 2015-11-26 01:43:57,347 DEBUG : BROWSER_OUTPUT: 01:43:58 INFO - 2015-11-26 01:43:58,068 INFO : Browser exited with error code: 0 01:43:58 INFO - 2015-11-26 01:43:58,089 INFO : Completed test dromaeo_css (00:18:36) 01:43:58 INFO - 2015-11-26 01:43:58,089 INFO : Starting test kraken 01:43:58 INFO - 2015-11-26 01:43:58,089 DEBUG : operating with platform_type : linux_ 01:43:58 INFO - 2015-11-26 01:43:58,089 INFO : Initialising browser for kraken test... 01:43:58 INFO - 2015-11-26 01:43:58,095 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsJKIff/profile http://localhost:58661/getInfo.html 01:44:01 INFO - 2015-11-26 01:44:01,629 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:44:01 INFO - 2015-11-26 01:44:01,629 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:44:01 INFO - 2015-11-26 01:44:01,629 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:44:01 INFO - 2015-11-26 01:44:01,629 DEBUG : BROWSER_OUTPUT: __metrics 01:44:01 INFO - 2015-11-26 01:44:01,746 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:44:02 INFO - 2015-11-26 01:44:02,765 INFO : Browser initialized. 01:44:02 INFO - 2015-11-26 01:44:02,766 INFO : Running cycle 1/1 for kraken test... 01:44:02 INFO - 2015-11-26 01:44:02,766 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsJKIff/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:44:14 INFO - 2015-11-26 01:44:14,620 DEBUG : BROWSER_OUTPUT: RSS: Main: 139186176 01:44:14 INFO - 2015-11-26 01:44:14,621 DEBUG : BROWSER_OUTPUT: 01:44:17 INFO - 2015-11-26 01:44:17,204 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58661/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58661/tests/kraken/driver.html?testName=audio-beat-detection) 01:44:17 INFO - 2015-11-26 01:44:17,790 DEBUG : BROWSER_OUTPUT: RSS: Main: 176668672 01:44:17 INFO - 2015-11-26 01:44:17,790 DEBUG : BROWSER_OUTPUT: 01:44:20 INFO - 2015-11-26 01:44:20,538 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58661/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58661/tests/kraken/driver.html?testName=audio-dft) 01:44:21 INFO - 2015-11-26 01:44:21,120 DEBUG : BROWSER_OUTPUT: RSS: Main: 167383040 01:44:21 INFO - 2015-11-26 01:44:21,120 DEBUG : BROWSER_OUTPUT: 01:44:24 INFO - 2015-11-26 01:44:24,087 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58661/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58661/tests/kraken/driver.html?testName=audio-fft) 01:44:24 INFO - 2015-11-26 01:44:24,656 DEBUG : BROWSER_OUTPUT: RSS: Main: 150835200 01:44:24 INFO - 2015-11-26 01:44:24,656 DEBUG : BROWSER_OUTPUT: 01:44:26 INFO - 2015-11-26 01:44:26,673 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58661/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58661/tests/kraken/driver.html?testName=audio-oscillator) 01:44:27 INFO - 2015-11-26 01:44:27,246 DEBUG : BROWSER_OUTPUT: RSS: Main: 153321472 01:44:27 INFO - 2015-11-26 01:44:27,246 DEBUG : BROWSER_OUTPUT: 01:44:29 INFO - 2015-11-26 01:44:29,499 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58661/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58661/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:44:30 INFO - 2015-11-26 01:44:30,067 DEBUG : BROWSER_OUTPUT: RSS: Main: 155619328 01:44:30 INFO - 2015-11-26 01:44:30,067 DEBUG : BROWSER_OUTPUT: 01:44:33 INFO - 2015-11-26 01:44:33,031 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58661/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58661/tests/kraken/driver.html?testName=imaging-darkroom) 01:44:33 INFO - 2015-11-26 01:44:33,613 DEBUG : BROWSER_OUTPUT: RSS: Main: 155201536 01:44:33 INFO - 2015-11-26 01:44:33,613 DEBUG : BROWSER_OUTPUT: 01:44:37 INFO - 2015-11-26 01:44:37,014 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58661/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58661/tests/kraken/driver.html?testName=imaging-desaturate) 01:44:37 INFO - 2015-11-26 01:44:37,596 DEBUG : BROWSER_OUTPUT: RSS: Main: 155484160 01:44:37 INFO - 2015-11-26 01:44:37,596 DEBUG : BROWSER_OUTPUT: 01:44:40 INFO - 2015-11-26 01:44:40,405 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58661/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58661/tests/kraken/driver.html?testName=json-parse-financial) 01:44:40 INFO - 2015-11-26 01:44:40,978 DEBUG : BROWSER_OUTPUT: RSS: Main: 154079232 01:44:40 INFO - 2015-11-26 01:44:40,978 DEBUG : BROWSER_OUTPUT: 01:44:42 INFO - 2015-11-26 01:44:42,727 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58661/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58661/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:44:43 INFO - 2015-11-26 01:44:43,294 DEBUG : BROWSER_OUTPUT: RSS: Main: 163799040 01:44:43 INFO - 2015-11-26 01:44:43,294 DEBUG : BROWSER_OUTPUT: 01:44:45 INFO - 2015-11-26 01:44:45,168 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58661/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58661/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:44:45 INFO - 2015-11-26 01:44:45,761 DEBUG : BROWSER_OUTPUT: RSS: Main: 164347904 01:44:45 INFO - 2015-11-26 01:44:45,761 DEBUG : BROWSER_OUTPUT: 01:44:47 INFO - 2015-11-26 01:44:47,879 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58661/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58661/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:44:48 INFO - 2015-11-26 01:44:48,460 DEBUG : BROWSER_OUTPUT: RSS: Main: 172724224 01:44:48 INFO - 2015-11-26 01:44:48,460 DEBUG : BROWSER_OUTPUT: 01:44:51 INFO - 2015-11-26 01:44:50,999 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58661/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58661/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:44:51 INFO - 2015-11-26 01:44:51,581 DEBUG : BROWSER_OUTPUT: RSS: Main: 177942528 01:44:51 INFO - 2015-11-26 01:44:51,581 DEBUG : BROWSER_OUTPUT: 01:44:54 INFO - 2015-11-26 01:44:54,136 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58661/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58661/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:44:54 INFO - 2015-11-26 01:44:54,709 DEBUG : BROWSER_OUTPUT: RSS: Main: 174800896 01:44:54 INFO - 2015-11-26 01:44:54,709 DEBUG : BROWSER_OUTPUT: 01:44:56 INFO - 2015-11-26 01:44:56,483 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58661/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58661/tests/kraken/driver.html?testName=ai-astar) 01:44:56 INFO - 2015-11-26 01:44:56,733 DEBUG : BROWSER_OUTPUT: RSS: Main: 233742336 01:44:56 INFO - 2015-11-26 01:44:56,733 DEBUG : BROWSER_OUTPUT: 01:44:56 INFO - 2015-11-26 01:44:56,737 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:44:56 INFO - 2015-11-26 01:44:56,737 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:44:56 INFO - 2015-11-26 01:44:56,737 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:44:56 INFO - 2015-11-26 01:44:56,737 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:44:56 INFO - 2015-11-26 01:44:56,737 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;114;106;112;113;113;101;111;112;103 01:44:56 INFO - 2015-11-26 01:44:56,737 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;133;158;162;131;161;160;137;171;130 01:44:56 INFO - 2015-11-26 01:44:56,737 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;164;160;161;161;160;162;163;164 01:44:56 INFO - 2015-11-26 01:44:56,738 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;72;78;91;71;72;71;102;93;74 01:44:56 INFO - 2015-11-26 01:44:56,738 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;130;96;94;94;137;94;95;137 01:44:56 INFO - 2015-11-26 01:44:56,738 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;109;110;110;109;110;110;109 01:44:56 INFO - 2015-11-26 01:44:56,738 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;145;146;147;146;146;146;146;146 01:44:56 INFO - 2015-11-26 01:44:56,738 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;95;96;95;95;96;95;96;95 01:44:56 INFO - 2015-11-26 01:44:56,738 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;73;71;71;71;73;71;81;70;70 01:44:56 INFO - 2015-11-26 01:44:56,738 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;68;69;70;70;73;69;69;69 01:44:56 INFO - 2015-11-26 01:44:56,738 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;84;85;85;84;89;87;84;84;83 01:44:56 INFO - 2015-11-26 01:44:56,739 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;129;127;127;117;127;122;130;122;121;120 01:44:56 INFO - 2015-11-26 01:44:56,739 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;147;142;137;146;163;137;138;145;154;133 01:44:56 INFO - 2015-11-26 01:44:56,739 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;74;70;69;68;70;68;68;68;67 01:44:56 INFO - 2015-11-26 01:44:56,739 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:44:56 INFO - 2015-11-26 01:44:56,739 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:44:56 INFO - 2015-11-26 01:44:56,739 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,976 01:44:56 INFO - 2015-11-26 01:44:56,739 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:44:56 INFO - 2015-11-26 01:44:56,739 DEBUG : BROWSER_OUTPUT: __startTimestamp1448531096734__endTimestamp 01:44:56 INFO - 2015-11-26 01:44:56,739 DEBUG : BROWSER_OUTPUT: 01:44:56 INFO - 2015-11-26 01:44:56,743 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:44:56 INFO - 2015-11-26 01:44:56,743 DEBUG : BROWSER_OUTPUT: Number of tests: 14 01:44:56 INFO - 2015-11-26 01:44:56,743 DEBUG : BROWSER_OUTPUT: 01:44:56 INFO - 2015-11-26 01:44:56,743 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.70 Median:112.00 stddev:4.62 (4.1%) stddev-sans-first:4.82 01:44:56 INFO - 2015-11-26 01:44:56,743 DEBUG : BROWSER_OUTPUT: Values: 112.0 114.0 106.0 112.0 113.0 113.0 101.0 111.0 112.0 103.0 01:44:56 INFO - 2015-11-26 01:44:56,743 DEBUG : BROWSER_OUTPUT: 01:44:56 INFO - 2015-11-26 01:44:56,743 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.60 Median:159.00 stddev:15.26 (9.6%) stddev-sans-first:16.14 01:44:56 INFO - 2015-11-26 01:44:56,743 DEBUG : BROWSER_OUTPUT: Values: 153.0 133.0 158.0 162.0 131.0 161.0 160.0 137.0 171.0 130.0 01:44:56 INFO - 2015-11-26 01:44:56,743 DEBUG : BROWSER_OUTPUT: 01:44:56 INFO - 2015-11-26 01:44:56,743 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.45 (0.9%) stddev-sans-first:1.54 01:44:56 INFO - 2015-11-26 01:44:56,743 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 164.0 160.0 161.0 161.0 160.0 162.0 163.0 164.0 01:44:56 INFO - 2015-11-26 01:44:56,743 DEBUG : BROWSER_OUTPUT: 01:44:56 INFO - 2015-11-26 01:44:56,744 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.50 Median:73.00 stddev:11.46 (15.7%) stddev-sans-first:11.74 01:44:56 INFO - 2015-11-26 01:44:56,744 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 78.0 91.0 71.0 72.0 71.0 102.0 93.0 74.0 01:44:56 INFO - 2015-11-26 01:44:56,744 DEBUG : BROWSER_OUTPUT: 01:44:56 INFO - 2015-11-26 01:44:56,744 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.70 Median:94.50 stddev:19.40 (20.5%) stddev-sans-first:20.11 01:44:56 INFO - 2015-11-26 01:44:56,744 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 130.0 96.0 94.0 94.0 137.0 94.0 95.0 137.0 01:44:56 INFO - 2015-11-26 01:44:56,744 DEBUG : BROWSER_OUTPUT: 01:44:56 INFO - 2015-11-26 01:44:56,744 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 01:44:56 INFO - 2015-11-26 01:44:56,744 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 109.0 110.0 110.0 109.0 110.0 110.0 109.0 01:44:56 INFO - 2015-11-26 01:44:56,744 DEBUG : BROWSER_OUTPUT: 01:44:56 INFO - 2015-11-26 01:44:56,744 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 01:44:56 INFO - 2015-11-26 01:44:56,744 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 145.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 01:44:56 INFO - 2015-11-26 01:44:56,744 DEBUG : BROWSER_OUTPUT: 01:44:56 INFO - 2015-11-26 01:44:56,744 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 01:44:56 INFO - 2015-11-26 01:44:56,744 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 95.0 96.0 95.0 95.0 96.0 95.0 96.0 95.0 01:44:56 INFO - 2015-11-26 01:44:56,744 DEBUG : BROWSER_OUTPUT: 01:44:56 INFO - 2015-11-26 01:44:56,744 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.30 Median:71.50 stddev:3.23 (4.5%) stddev-sans-first:3.43 01:44:56 INFO - 2015-11-26 01:44:56,745 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 71.0 71.0 71.0 73.0 71.0 81.0 70.0 70.0 01:44:56 INFO - 2015-11-26 01:44:56,745 DEBUG : BROWSER_OUTPUT: 01:44:56 INFO - 2015-11-26 01:44:56,745 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.30 Median:69.00 stddev:1.49 (2.2%) stddev-sans-first:1.51 01:44:56 INFO - 2015-11-26 01:44:56,745 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 69.0 70.0 70.0 73.0 69.0 69.0 69.0 01:44:56 INFO - 2015-11-26 01:44:56,745 DEBUG : BROWSER_OUTPUT: 01:44:56 INFO - 2015-11-26 01:44:56,745 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:84.50 stddev:1.87 (2.2%) stddev-sans-first:1.87 01:44:56 INFO - 2015-11-26 01:44:56,745 DEBUG : BROWSER_OUTPUT: Values: 83.0 84.0 85.0 85.0 84.0 89.0 87.0 84.0 84.0 83.0 01:44:56 INFO - 2015-11-26 01:44:56,745 DEBUG : BROWSER_OUTPUT: 01:44:56 INFO - 2015-11-26 01:44:56,745 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.20 Median:127.00 stddev:4.34 (3.4%) stddev-sans-first:4.24 01:44:56 INFO - 2015-11-26 01:44:56,745 DEBUG : BROWSER_OUTPUT: Values: 129.0 127.0 127.0 117.0 127.0 122.0 130.0 122.0 121.0 120.0 01:44:56 INFO - 2015-11-26 01:44:56,745 DEBUG : BROWSER_OUTPUT: 01:44:56 INFO - 2015-11-26 01:44:56,745 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.20 Median:145.50 stddev:9.03 (6.2%) stddev-sans-first:9.52 01:44:56 INFO - 2015-11-26 01:44:56,745 DEBUG : BROWSER_OUTPUT: Values: 147.0 142.0 137.0 146.0 163.0 137.0 138.0 145.0 154.0 133.0 01:44:56 INFO - 2015-11-26 01:44:56,745 DEBUG : BROWSER_OUTPUT: 01:44:56 INFO - 2015-11-26 01:44:56,745 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:68.50 stddev:2.08 (3.0%) stddev-sans-first:2.09 01:44:56 INFO - 2015-11-26 01:44:56,745 DEBUG : BROWSER_OUTPUT: Values: 67.0 74.0 70.0 69.0 68.0 70.0 68.0 68.0 68.0 67.0 01:44:56 INFO - 2015-11-26 01:44:56,746 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:44:56 INFO - 2015-11-26 01:44:56,746 DEBUG : BROWSER_OUTPUT: 01:44:57 INFO - 2015-11-26 01:44:57,652 INFO : Browser exited with error code: 0 01:44:57 INFO - 2015-11-26 01:44:57,705 INFO : Completed test kraken (00:00:59) 01:44:57 INFO - 2015-11-26 01:44:57,705 INFO : Starting test v8_7 01:44:57 INFO - 2015-11-26 01:44:57,705 DEBUG : operating with platform_type : linux_ 01:44:57 INFO - 2015-11-26 01:44:57,705 INFO : Initialising browser for v8_7 test... 01:44:57 INFO - 2015-11-26 01:44:57,712 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYgphua/profile http://localhost:58661/getInfo.html 01:45:01 INFO - 2015-11-26 01:45:01,382 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:45:01 INFO - 2015-11-26 01:45:01,382 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:45:01 INFO - 2015-11-26 01:45:01,382 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:45:01 INFO - 2015-11-26 01:45:01,382 DEBUG : BROWSER_OUTPUT: __metrics 01:45:01 INFO - 2015-11-26 01:45:01,499 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:45:02 INFO - 2015-11-26 01:45:02,532 INFO : Browser initialized. 01:45:02 INFO - 2015-11-26 01:45:02,533 INFO : Running cycle 1/1 for v8_7 test... 01:45:02 INFO - 2015-11-26 01:45:02,533 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYgphua/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:45:14 INFO - 2015-11-26 01:45:14,436 DEBUG : BROWSER_OUTPUT: RSS: Main: 139538432 01:45:14 INFO - 2015-11-26 01:45:14,436 DEBUG : BROWSER_OUTPUT: 01:45:35 INFO - 2015-11-26 01:45:35,895 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58661/tests/v8_7/run.html (next: http://localhost:58661/tests/v8_7/run.html) 01:45:36 INFO - 2015-11-26 01:45:36,145 DEBUG : BROWSER_OUTPUT: RSS: Main: 449052672 01:45:36 INFO - 2015-11-26 01:45:36,145 DEBUG : BROWSER_OUTPUT: 01:45:36 INFO - 2015-11-26 01:45:36,145 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:45:36 INFO - 2015-11-26 01:45:36,145 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:45:36 INFO - 2015-11-26 01:45:36,145 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:45:36 INFO - 2015-11-26 01:45:36,146 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:45:36 INFO - 2015-11-26 01:45:36,146 DEBUG : BROWSER_OUTPUT: |0;Richards;165.12549537648613 01:45:36 INFO - 2015-11-26 01:45:36,146 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;192.27071716977505 01:45:36 INFO - 2015-11-26 01:45:36,146 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.2387025228722 01:45:36 INFO - 2015-11-26 01:45:36,146 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5202.072538860104 01:45:36 INFO - 2015-11-26 01:45:36,146 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1984.126984126984 01:45:36 INFO - 2015-11-26 01:45:36,146 DEBUG : BROWSER_OUTPUT: |5;Earley;796.1783439490446 01:45:36 INFO - 2015-11-26 01:45:36,147 DEBUG : BROWSER_OUTPUT: |6;Boyer;12575 01:45:36 INFO - 2015-11-26 01:45:36,147 DEBUG : BROWSER_OUTPUT: |7;RegExp;26789.473684210527 01:45:36 INFO - 2015-11-26 01:45:36,147 DEBUG : BROWSER_OUTPUT: |8;Splay;630.119722747322 01:45:36 INFO - 2015-11-26 01:45:36,147 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 01:45:36 INFO - 2015-11-26 01:45:36,147 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:45:36 INFO - 2015-11-26 01:45:36,148 DEBUG : BROWSER_OUTPUT: __startTimestamp1448531136144__endTimestamp 01:45:36 INFO - 2015-11-26 01:45:36,148 DEBUG : BROWSER_OUTPUT: 01:45:36 INFO - 2015-11-26 01:45:36,148 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:45:36 INFO - 2015-11-26 01:45:36,148 DEBUG : BROWSER_OUTPUT: Number of tests: 10 01:45:36 INFO - 2015-11-26 01:45:36,148 DEBUG : BROWSER_OUTPUT: 01:45:36 INFO - 2015-11-26 01:45:36,148 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.13 Median:165.13 stddev:0.00 (0.0%) 01:45:36 INFO - 2015-11-26 01:45:36,148 DEBUG : BROWSER_OUTPUT: Values: 165.1 01:45:36 INFO - 2015-11-26 01:45:36,148 DEBUG : BROWSER_OUTPUT: 01:45:36 INFO - 2015-11-26 01:45:36,148 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:192.27 Median:192.27 stddev:0.00 (0.0%) 01:45:36 INFO - 2015-11-26 01:45:36,148 DEBUG : BROWSER_OUTPUT: Values: 192.3 01:45:36 INFO - 2015-11-26 01:45:36,148 DEBUG : BROWSER_OUTPUT: 01:45:36 INFO - 2015-11-26 01:45:36,149 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.24 Median:277.24 stddev:0.00 (0.0%) 01:45:36 INFO - 2015-11-26 01:45:36,149 DEBUG : BROWSER_OUTPUT: Values: 277.2 01:45:36 INFO - 2015-11-26 01:45:36,149 DEBUG : BROWSER_OUTPUT: 01:45:36 INFO - 2015-11-26 01:45:36,149 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5202.07 Median:5202.07 stddev:0.00 (0.0%) 01:45:36 INFO - 2015-11-26 01:45:36,149 DEBUG : BROWSER_OUTPUT: Values: 5202.1 01:45:36 INFO - 2015-11-26 01:45:36,149 DEBUG : BROWSER_OUTPUT: 01:45:36 INFO - 2015-11-26 01:45:36,149 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1984.13 Median:1984.13 stddev:0.00 (0.0%) 01:45:36 INFO - 2015-11-26 01:45:36,149 DEBUG : BROWSER_OUTPUT: Values: 1984.1 01:45:36 INFO - 2015-11-26 01:45:36,149 DEBUG : BROWSER_OUTPUT: 01:45:36 INFO - 2015-11-26 01:45:36,149 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:796.18 Median:796.18 stddev:0.00 (0.0%) 01:45:36 INFO - 2015-11-26 01:45:36,149 DEBUG : BROWSER_OUTPUT: Values: 796.2 01:45:36 INFO - 2015-11-26 01:45:36,149 DEBUG : BROWSER_OUTPUT: 01:45:36 INFO - 2015-11-26 01:45:36,150 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12575.00 Median:12575.00 stddev:0.00 (0.0%) 01:45:36 INFO - 2015-11-26 01:45:36,150 DEBUG : BROWSER_OUTPUT: Values: 12575.0 01:45:36 INFO - 2015-11-26 01:45:36,150 DEBUG : BROWSER_OUTPUT: 01:45:36 INFO - 2015-11-26 01:45:36,150 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26789.47 Median:26789.47 stddev:0.00 (0.0%) 01:45:36 INFO - 2015-11-26 01:45:36,150 DEBUG : BROWSER_OUTPUT: Values: 26789.5 01:45:36 INFO - 2015-11-26 01:45:36,151 DEBUG : BROWSER_OUTPUT: 01:45:36 INFO - 2015-11-26 01:45:36,151 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:630.12 Median:630.12 stddev:0.00 (0.0%) 01:45:36 INFO - 2015-11-26 01:45:36,151 DEBUG : BROWSER_OUTPUT: Values: 630.1 01:45:36 INFO - 2015-11-26 01:45:36,151 DEBUG : BROWSER_OUTPUT: 01:45:36 INFO - 2015-11-26 01:45:36,152 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 01:45:36 INFO - 2015-11-26 01:45:36,152 DEBUG : BROWSER_OUTPUT: Values: 4840.6 01:45:36 INFO - 2015-11-26 01:45:36,152 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:45:36 INFO - 2015-11-26 01:45:36,152 DEBUG : BROWSER_OUTPUT: 01:45:37 INFO - 2015-11-26 01:45:37,000 INFO : Browser exited with error code: 0 01:45:37 INFO - 2015-11-26 01:45:37,016 INFO : Completed test v8_7 (00:00:39) 01:45:37 INFO - 2015-11-26 01:45:37,120 INFO : Completed test suite (00:20:15) 01:45:37 INFO - 2015-11-26 01:45:37,120 DEBUG : Working with test: dromaeo_css 01:45:37 INFO - 2015-11-26 01:45:37,120 DEBUG : Generating results file: dromaeo_css 01:45:37 INFO - 2015-11-26 01:45:37,121 DEBUG : Working with test: kraken 01:45:37 INFO - 2015-11-26 01:45:37,121 DEBUG : Generating results file: kraken 01:45:37 INFO - 2015-11-26 01:45:37,122 INFO : javascript benchmark 01:45:37 INFO - 2015-11-26 01:45:37,122 DEBUG : Working with test: v8_7 01:45:37 INFO - 2015-11-26 01:45:37,122 DEBUG : Generating results file: v8_7 01:45:37 INFO - 2015-11-26 01:45:37,122 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:45:37 INFO - 2015-11-26 01:45:37,188 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,203,35]] 01:45:37 INFO - 2015-11-26 01:45:37,188 DEBUG : process_Request line: dromaeo_css 6049.70 graph.html#tests=[[72,203,35]] 01:45:37 INFO - 2015-11-26 01:45:37,188 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:45:37 INFO - 2015-11-26 01:45:37,337 DEBUG : process_Request line: kraken 1522.20 graph.html#tests=[[232,203,35]] 01:45:37 INFO - 2015-11-26 01:45:37,337 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:45:37 INFO - 2015-11-26 01:45:37,370 DEBUG : process_Request line: v8_7 19603.65 graph.html#tests=[[230,203,35]] 01:45:37 INFO - 2015-11-26 01:45:37,372 INFO : javascript benchmark 01:45:37 INFO - 2015-11-26 01:45:37,376 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2581.0837152810755, 2663.547196976514, 2664.054260737437, 2672.19834049785, 2678.906238281659, 4343.913121737563, 4483.977580112103, 4507.977460112699, 4573.542645735429, 4594.678372513921, 4444.244478438665, 4455.598996090352, 4503.594676479116, 4604.4014278143795, 4613.446386433633, 4164.479440069991, 4171.457710497639, 4202.3696445533105, 4264.381664658623, 4271.273883439822, 4164.375343698439, 4256.21260066887, 4284.928767808048, 4286.892827679302, 4329.978350108245, 4016.2369149861433, 4197.349410841324, 4207.579242075799, 4248.235317642823, 4284.228838809028, 4078.3882417637296, 4175.832966681329, 4183.0, 4187.225363307767, 4200.012996945716, 4187.811548480326, 4190.685698572619, 4193.370994350841, 4225.04936389313, 4238.830446782125, 4342.652587792969, 4462.286034234539, 4504.36938828561, 4514.980304778579, 4550.3402006709175, 4696.201645720235, 4775.42694876617, 4781.163296423112, 4789.880252993668, 4809.5430934061205, 4888.608911287124, 4936.111499930011, 4938.851834444972, 4939.061578300111, 4940.036692844897, 4584.358189853423, 4586.656000799887, 4586.678932474695, 4603.654725895572, 4627.3521706961055, 4731.195696731564, 4852.126617208936, 4855.587275081658, 4964.429090654548, 5097.388313402415, 4812.278158276216, 4823.493533179036, 4825.879353016203, 4831.130396528659, 4868.732219727949, 4894.486078961658, 4911.803527858917, 4915.705057696549, 4917.409910810726, 4961.03259864323, 4597.42532183477, 4737.313089601988, 4739.597134243559, 4752.881177970509, 4862.124817532878, 4770.475247722748, 4776.355192049098, 4793.1372352976105, 4798.640101992364, 4839.322494850724, 4034.899127521777, 4037.818298176589, 4041.474608300902, 4041.474608300902, 4073.429719839225, 3407.352603005421, 3485.703715184238, 3524.9823750881596, 3576.445650924111, 3594.029612004744, 4178.707490475698, 4261.169072030986, 4271.700980931305, 4305.117450922553, 4310.719803212781, 4906.975465122723, 4928.383952005999, 4928.753562321869, 4931.2849636803185, 4976.303317535548, 4013.3177359848896, 4116.156187981456, 4124.876253712393, 4246.4691913510815, 4257.127288905767, 4239.936400953989, 4275.679324050709, 4299.6560275178535, 4337.37108119321, 4337.587929146726, 4633.027064316531, 4634.281686338623, 4647.117047760915, 4675.158471475167, 4678.251479763221, 4582.473015603115, 4706.670533062653, 4857.198562237191, 4868.9756551217015, 4879.0, 4522.728636281834, 4523.705959112647, 4600.0, 4634.536546345474, 4646.395968524071, 4831.178699621143, 4852.878678033077, 4871.853844384674, 4874.8537543873745, 4916.06594746997, 4909.0672772173175, 4914.36113305268, 4920.434150072644, 4926.3842019747535, 4968.22992436173, 4521.321801729767, 4629.490756016903, 4642.883927901695, 4642.883927901695, 4649.023705021983, 4596.609288210406, 4628.259478483426, 4680.531946805292, 4712.222483290218, 4720.834770783006, 4589.5639914208095, 4625.768711564476, 4632.536746325341, 4645.419322584677, 4680.461746899014, 4484.618807401407, 4754.976225118852, 4760.16697078003, 4770.7137571744415, 4810.302506136661, 4541.704789188692, 4558.407407037064, 4584.014436896084, 4651.069786042737, 4657.278121891112], "unit": "ms", "name": "dojo.html", "value": 4455.189379335792}, {"lowerIsBetter": false, "replicates": [481.0139214610048, 492.28126934675373, 556.3351794605447, 585.6369051188263, 587.6004317064397, 21491.46271343217, 21898.562028759436, 36193.81903090481, 36895.81552092243, 37104.81447592758, 39758.801205994, 40462.79768601153, 40502.392464113065, 40571.391429128584, 40612.39081413774, 6387.201599800025, 7841.529508229496, 7940.563269020202, 7944.483608565425, 7949.205079492062, 6542.803715888531, 6626.370494802986, 6632.834179145536, 6638.900416493757, 9321.627134914595, 9992.500374981259, 10242.795144097114, 10261.076503114718, 10261.076503114718, 10266.743331416737, 10048.44733539655, 10128.89871101287, 10186.185105191567, 10192.439415832127, 10193.949030254838, 6676.232233293136, 6882.621455819928, 6887.449004079712, 6888.138982627172, 6890.862182756367, 31508.0, 32206.677933220602, 32386.838065809756, 32387.190320241945, 32430.837845810856, 1836.412348048625, 2480.1443501991785, 2568.4734629400928, 2679.2230253226735, 3032.3328867649084, 26685.86513078949, 28162.155135345973, 28377.716222837713, 28501.287467813265, 28723.712762872314, 3386.0, 3390.847411866447, 3454.7754395964434, 3462.497937799005, 3472.409690352621, 227722.86138569366, 228320.15918965213, 228405.0, 228904.0, 229359.1192264218, 53346.73326633342, 53876.46123538793, 53917.73041134848, 53978.0, 53981.0, 55886.0, 56407.0, 56708.0, 56723.71638141783, 56756.71621641865, 12226.083043771574, 12558.246505209716, 12566.120371573903, 12580.559680411141, 12585.937070314772, 9506.667266645634, 9586.760330991641, 9589.856152157723, 9593.232541396672, 9596.040395960488, 17995.640087198182, 18130.728039079426, 18147.818521814876, 18155.54611134732, 18156.0, 7012.088428504262, 7137.785866424016, 7323.780286591411, 7336.413086953031, 7337.0828646419195, 814.5438554409432, 834.641104325146, 861.7845538615346, 882.4248716041834, 912.466207268742, 26314.736852631613, 26335.005254847492, 26359.73640263611, 26508.60237096445, 26531.86734066317, 674.6019848289533, 860.4579115157411, 893.0801274687083, 933.3606479561522, 940.5485367023867, 13568.457261709618, 14423.350949207312, 14625.341859616343, 14643.633909152357, 15101.244937753288, 242069.0, 245349.0, 277344.0, 282847.0, 288804.0, 39260.607393926264, 39261.803690981935, 39470.80264598659, 39617.80191099026, 39667.40498892519, 774.3959711425098, 774.8295375017375, 1103.189155970361, 1208.4380762945273, 1213.0538180219444, 24489.0, 25167.0, 27587.448251034464, 27878.76972837044, 28354.43291134207, 39809.80095099622, 40076.398854017796, 40124.3981340286, 40155.59844401519, 40175.397369040074, 224804.0, 225033.0, 225716.0, 226141.0, 226416.0, 27136.321591960357, 27580.448391031667, 27580.862095689394, 27581.724182758717, 27587.0, 27231.59152612673, 27714.584281236203, 27725.306867327672, 27754.722452775215, 27801.0, 31505.21236969094, 31806.84096579595, 31968.200794980312, 32273.51589726203, 32725.836370817993, 30598.080629537675, 32548.51177232296, 33778.66221337755, 34096.65903340935, 35205.47191792074, 31217.219569510944, 31922.20194495156, 32047.359052818345, 32266.83866580652, 32285.192870178435, 27966.0, 29135.923348602457, 29299.820108930995, 29525.557116643697, 29890.402191955603, 22416.0, 22751.259294794967, 22942.0, 23077.19229826948, 23285.76714232836], "unit": "ms", "name": "ext.html", "value": 16101.770182413193}, {"lowerIsBetter": false, "replicates": [323.80733463589155, 330.93712194683025, 333.01427773789584, 334.87776961409094, 336.4818180002796, 10894.782104357908, 11134.610288639898, 14742.262886855668, 15291.923540382297, 15989.920050399745, 13077.084604077718, 13199.934000329986, 13206.141600795941, 13244.337783110854, 13603.659908502268, 4831.299461578078, 4935.0, 4995.450500444967, 5003.1994880819075, 5008.874778130539, 3440.3807314683345, 3559.181388280697, 3564.8930532084078, 3566.1084728817796, 5017.247412888059, 3545.3618348697223, 5605.439456054402, 5798.420157984189, 5807.41925807418, 5807.970960145193, 5348.598855085846, 5365.141577347645, 5367.651102678314, 5379.515843574078, 5741.052726300156, 5048.368953880765, 5182.870428239286, 5207.531322181022, 5208.166693329087, 5212.218167274901, 18366.081695915153, 18599.349022784274, 18684.252629894923, 18690.71963920542, 19328.1302341395, 1836.4857839804877, 1942.1648691062837, 1954.1890115602007, 1954.739193220379, 2011.8591698581106, 12283.078769092353, 12510.74978500425, 12639.988800895906, 12946.223226606433, 13132.803007954888, 1735.6355165415277, 1752.7283271093002, 1761.7005109131478, 1787.7407775872555, 1792.659394715, 49954.0, 51560.74219628915, 52920.0, 52975.47024529744, 53599.73200134013, 9107.134822191882, 9270.490123043297, 9471.857922131036, 9481.24150067993, 9567.37812042215, 11815.409229538489, 11860.525578976743, 11873.881261187451, 11884.643460696192, 11886.0, 6619.86760264792, 6661.600303981777, 6729.394354508117, 6744.831379215559, 6821.1814582250445, 6296.685165741695, 6307.400796924285, 6336.968315158395, 6372.299047104908, 6429.839254018687, 5598.0, 5680.914786278209, 5703.9429605704245, 5714.514266287412, 5727.742251598688, 1385.4458216713394, 1443.076431084107, 1574.0791636892545, 1622.862056725168, 1671.8411750883647, 810.4934415990007, 851.638053827121, 851.7061613743249, 895.5880295064213, 919.4069824962861, 12862.935685321514, 15410.0, 16145.677086458205, 16496.34014639425, 16601.169941502878, 829.3986859526915, 850.4259624753266, 854.2781349759443, 855.3371137368465, 862.7239283429368, 9218.308626853013, 9594.088561586637, 9657.951710241405, 9706.70879873605, 9809.362391444532, 513094.0, 521205.0, 521629.0, 522556.0, 525944.0, 60296.39703602908, 62025.37974620196, 62368.0, 63014.68492657507, 64524.354756452776, 1043.7703705184847, 1061.7611037516497, 1071.6677829872765, 1074.3446497636435, 1075.5375188668947, 13876.098053626481, 14231.217283049531, 14315.0, 14370.871116802282, 14612.707745844811, 30890.227744306572, 31125.844370778002, 31343.529847051857, 31525.527117092803, 31999.36001280008, 38488.6151138485, 38713.612863871, 38937.2212555753, 40200.396994045695, 40390.79804600958, 8382.916170838458, 8731.432456890281, 8962.372633915824, 8984.550772461482, 8984.730458086267, 10712.89287107119, 15592.14243216634, 15993.600159996093, 16234.837651623333, 16500.669986600442, 11773.234739741889, 11878.524859005543, 11893.345865977455, 12365.629031129081, 12485.625431237077, 11992.220505667105, 12057.51769929228, 12128.211666241667, 12350.44423000985, 12494.500219991462, 11439.942800285946, 11475.0, 12351.135420520477, 12589.055820813292, 13077.738445231233, 8397.076321604742, 8413.200745929127, 8520.275776558814, 8701.260392866678, 8715.08491608372, 8953.820923581623, 8962.103789620985, 9805.656802011896, 12131.332776697014, 12263.877361226274], "unit": "ms", "name": "jquery.html", "value": 8061.858524824765}, {"lowerIsBetter": false, "replicates": [902.855543113102, 1472.5729538433852, 1524.8398918113598, 1533.3253368517849, 1564.913929733865, 5125.256837758523, 6311.715972781224, 6445.90331145032, 6463.74145034198, 6463.773767918124, 6632.535722499427, 6744.561603495769, 6748.39264466198, 6753.864922701543, 6770.661466926646, 1664.1013852519686, 1693.7544056111856, 1694.2799310293137, 1993.2226431691652, 2041.6325061488926, 1669.1654172913543, 1675.5392267126515, 2001.7097520859468, 2035.9796402036013, 2040.9387718368473, 1981.8315443187346, 1983.1175127068461, 1984.4145976936766, 1985.176151896961, 1987.6422243996076, 1944.513871532117, 1970.339936121401, 1989.8507611929163, 1991.0442987366, 1992.2429476798868, 1985.4341512668964, 1991.6415045291842, 2002.7196192533056, 2034.4201902457728, 2063.7626672932506, 6663.300353462865, 6718.05947167397, 6725.93274067258, 6731.9663401683165, 6741.561798483083, 3858.305505009097, 3914.1388894443176, 3924.725269231155, 3933.2920074386598, 3937.3897045957638, 2607.504574130909, 2613.738626137371, 2642.828216165962, 2643.4845205184997, 2715.3075965628836, 792.3344390711773, 796.5937371940353, 830.4104086098877, 854.1159899503983, 857.9485230886104, 8816.118388161196, 8816.603252853636, 8822.338324625614, 8822.647094116228, 8823.382363234576, 3619.2399596085115, 3621.27574485104, 3668.706503479715, 3723.9813800930824, 3724.571674257495, 7790.766277011699, 7790.961045194737, 7797.649105790253, 7798.805029874298, 7808.219178082147, 3836.731428799957, 3838.4626152338697, 3843.7117216208894, 3866.6520013198383, 3869.9806500967316, 3479.7912125272564, 3480.3909315869623, 3482.7562070655317, 3483.9477407838904, 3487.3897068013503, 3167.6040494938134, 3167.651558328582, 3181.9363612727616, 3203.6796320368244, 3222.2749881276527, 822.4900561651694, 857.3826844671827, 953.8839557717487, 963.643451922793, 971.455984648599, 710.6233696141054, 747.7233423633181, 748.2704363245792, 748.4947660329256, 767.6008475592772, 6096.451319381188, 6124.5100391968535, 6185.165002724664, 6185.41238582334, 6186.257649082049, 970.6020531582018, 978.554757585297, 983.1986930651497, 1000.5997600959674, 1002.0630710285906, 4667.6265898728025, 4686.835960741426, 4776.355192049098, 4789.521047895252, 4790.281457781361, 7928.7621371358955, 8216.178382161735, 8221.054578723404, 8228.25945664893, 8231.09457959624, 7844.764657060183, 8019.839603207904, 8071.394645401501, 8084.231997960184, 8119.147489513634, 6219.813405597839, 6222.12890195373, 6222.471089957314, 6226.533010024266, 6266.342034086355, 5847.152162936265, 5902.439268269508, 5924.289085309791, 5945.078512830518, 5993.041113421831, 7242.094738157731, 7357.227491113356, 7381.298776616213, 7420.777376678709, 7437.888431673638, 7413.184549699637, 7504.699812007459, 7533.962330188314, 7626.237376262329, 7630.656620452204, 5488.231647569423, 5511.972440137934, 5549.278593782782, 5591.804286849941, 5620.4098569649595, 6045.879082418415, 6090.208272924491, 6096.786612468542, 6098.817035488943, 6099.969500152648, 4810.855674329776, 4883.047805677858, 5195.506426889439, 5660.0, 5727.770889164387, 5701.030824759884, 5711.942880571141, 5733.942660573341, 5749.223854779551, 5765.221695071112, 5776.884462310814, 5800.4489573490455, 5811.535077193899, 5840.0, 5841.766329346949, 5404.405515393225, 5405.297311349656, 5434.375046869661, 5455.509004189642, 5459.235707001102, 5581.6930068846605, 5593.468620481048, 5597.888042239051, 5615.326160860723, 5618.438156184349], "unit": "ms", "name": "mootools.html", "value": 3750.420513012124}, {"lowerIsBetter": false, "replicates": [295.9067893613512, 300.75338222657416, 306.71169101045007, 307.66618219232146, 307.9384123175363, 5222.556082732967, 5238.5547228485575, 5298.337707786527, 5319.627626066177, 5329.9733501332485, 5196.532312091911, 5205.869853253671, 5209.453007434212, 5222.529972302492, 5224.4775522447735, 3837.501124853779, 4085.632293093621, 4086.38704194371, 4090.6931980101463, 4091.0386059276193, 3936.1340505088833, 3969.6427321541055, 4032.7378720383226, 4038.838446462138, 4043.8382464701376, 3995.2808494470983, 4007.238624661305, 4014.0566966762785, 4022.798860057, 4036.091879327157, 3812.866549670748, 3892.2020985698146, 3939.7636141831294, 4043.1105156865588, 4052.5947405259385, 3530.947035794465, 3534.964650353489, 3559.6440355964455, 3563.7861728296125, 3572.7677700949357, 5006.524380183913, 5006.8497945061345, 5007.799688012475, 5022.221555658879, 5027.195648696191, 4638.582527572535, 4643.721376717374, 4651.395318608593, 4651.604613607848, 4651.697639653412, 5333.200019997032, 5477.1510415885605, 5481.561475081984, 5485.835424937259, 5505.091659876116, 3822.7132965027454, 3823.1971286029966, 3823.7896915669626, 3823.9044023899623, 3827.5598306194865, 5716.1711551825165, 5770.336411312711, 5773.769049238025, 5787.421257874221, 5799.88400231993, 3911.5697273299916, 3912.4326972588815, 3913.784741839226, 3914.0606254499285, 3920.725549211528, 3891.4520717559976, 3976.6421022108148, 3978.7015973801504, 3979.6418322350546, 3980.0845805464905, 4536.682432229778, 4541.477730061019, 4547.477040140427, 4551.977240113778, 4552.3171524270965, 5462.378058531927, 5470.64440811346, 5477.178423236467, 5477.67133971963, 5481.643693159932, 1379.0553470872485, 1399.8670126337981, 1400.5378225185664, 1400.9299535023208, 1401.3903951781008, 914.4193437167446, 923.3582660051334, 933.2767105493161, 936.9297302702324, 939.6899023322287, 4829.613630909519, 4833.347498087784, 4833.613310935117, 4836.5888899443235, 4839.2983017462275, 5667.574931880125, 5679.659220446786, 5679.716014199356, 5687.1753595729215, 5687.800926967537, 4831.710097394168, 4832.51674832521, 4834.830780922651, 4835.492273311322, 4842.539958703917, 2848.2025032990796, 2906.2007947814095, 3046.497327940909, 3068.4476794176817, 3077.322988942429, 5373.838784836461, 5459.754311056012, 5463.617546771768, 5468.152436372368, 5468.7265636718, 5913.201717768046, 5922.822315330547, 5923.200367950358, 5923.733431995571, 5925.1704761332585, 5455.563554915597, 5460.180972854024, 5464.535514481234, 5464.863378415492, 5473.06957817164, 5611.663300202001, 5757.481826635623, 5765.654060756368, 5772.076467765305, 5778.855528611818, 5615.578831587729, 5619.100943848965, 5621.634593751393, 5624.353199382123, 5627.606067575231, 5436.374816896107, 5466.835994920159, 5475.178723191553, 5479.726013699379, 5485.286912701324, 3938.932060668172, 3972.483577134954, 3978.124812541236, 3982.880513584597, 3983.6016398359934, 5630.85922851932, 5766.798162064308, 5767.884642307215, 5770.451807078321, 5776.711164441677, 5530.585206109477, 5539.529140023144, 5547.112462006221, 5549.472800083986, 5569.916451253153, 5536.861578460571, 5541.251930989426, 5548.889022219614, 5552.194931734956, 5555.333359996826, 5248.737563121752, 5392.056390131633, 5405.702686352131, 5409.945900541102, 5427.565794736491, 5599.0, 5601.495865372136, 5601.663900166003, 5609.607327487037, 5609.803656872153, 5209.374875015023, 5319.893602128013, 5322.414534401135, 5473.480019398151, 5474.343078830566], "unit": "ms", "name": "prototype.html", "value": 4130.58751774391}, {"lowerIsBetter": false, "replicates": [571.8227349521649, 721.206672660074, 740.9851802963942, 742.1984257002438, 761.779084065621, 8579.828403431944, 8740.475571465717, 10701.250912436122, 10944.5622175113, 10955.068819150372, 11311.886881131186, 11677.357745324003, 11701.122415818805, 11718.531258749661, 11781.469833857476, 350.88245437778374, 354.8137227955318, 762.5653377574785, 774.9690012399498, 780.1301548773134, 761.8362052158785, 778.9026371703537, 781.6951388958311, 781.9687212511493, 782.026377160436, 801.6633014134078, 808.9514629122242, 816.873384625384, 817.5094943034192, 818.423011776696, 814.5316443045273, 814.633414963266, 815.0, 815.2051749544206, 815.5392203405057, 599.8470390050553, 600.321636550695, 600.5615900392694, 600.975960961561, 601.2424345324922, 10865.782684346348, 10982.615608453665, 10984.340939543654, 10989.560417583287, 10992.17558683094, 10943.23397362185, 11249.0, 11534.538618455252, 11557.133215008907, 11711.824322635168, 8790.824183516357, 8831.293496520262, 8904.287656987426, 8931.106889311082, 8955.417897836685, 3054.8930787422332, 3108.689131086896, 3164.3671265746943, 3164.5727826743323, 3176.126565194567, 37101.95939223342, 40965.590344096476, 41259.381109283386, 41397.58602413998, 41409.378859317134, 9041.81916361669, 9193.310501712265, 9574.425534467955, 9585.089416505421, 9643.807123857483, 15968.680626387408, 16017.119058451664, 16042.75935860963, 16063.116528590806, 16065.27706253198, 6141.7543298267565, 6249.78125765596, 6282.0, 6305.673111911975, 6368.10846481493, 3506.3513250048823, 3597.8380972856285, 3647.2340808430527, 3657.5428071491065, 3695.2978934002454, 2603.7526434988645, 2630.4213073123883, 2630.631711560383, 2632.3945492536823, 2640.524705553019, 446.1968456777787, 448.1686471595209, 453.8729155836371, 462.49125961442144, 467.71469403663735, 499.33089659855966, 511.15659162382366, 535.2533216163508, 538.5530010091614, 541.7941182350681, 6799.32006799326, 7001.474889383317, 7538.585377804164, 7824.843503129906, 8144.14486478923, 354.5585745746562, 423.5652716062817, 438.9209942210369, 447.47421779409063, 543.1933578635723, 3349.4975753636663, 3547.485614585922, 3579.964200358015, 3610.891673249807, 3724.1806802503406, 45885.31172032422, 47011.0, 52040.73979630153, 53642.19536706952, 53678.19482707763, 43671.344929826075, 44402.0, 44595.55404445914, 44596.3310550342, 44904.77547612241, 41463.58536414597, 41783.58216417858, 42195.0, 42196.36705449421, 42316.15367692691, 7602.201768814195, 7616.9238307616215, 7791.493552919269, 8015.358771298165, 8032.437729358889, 30914.381712366077, 31193.68806311908, 31198.68801311958, 31877.0, 31882.840585796923, 39321.60678393294, 39407.60592394154, 39462.605373945895, 41248.38127428031, 41688.0, 9157.58413923605, 9420.021795423037, 9527.523623818919, 9568.56941437623, 9788.510574471391, 10739.194560407845, 10877.129829613454, 10911.236213464981, 10915.945420272848, 10930.125589952944, 9905.257105716955, 10231.13035392, 10250.897491024994, 10256.58973641046, 10353.275270730977, 9154.725358239264, 9558.091981261769, 9747.9025209747, 9848.015198480094, 9873.0, 9516.33385662997, 10327.690169294632, 10576.576936922436, 10576.947115264375, 10606.363618182933, 7616.23837616234, 7736.535807851547, 8130.5111119976145, 8260.360199360606, 8302.916970830456, 8004.279614834692, 8200.917990820015, 8967.0, 9008.603891237033, 9077.934048943003], "unit": "ms", "name": "yui.html", "value": 5471.272959455564}], "name": "dromaeo_css", "value": 6049.700015990022}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 114.0, 106.0, 112.0, 113.0, 113.0, 101.0, 111.0, 112.0, 103.0], "unit": "ms", "name": "ai-astar", "value": 109.7}, {"lowerIsBetter": true, "replicates": [153.0, 133.0, 158.0, 162.0, 131.0, 161.0, 160.0, 137.0, 171.0, 130.0], "unit": "ms", "name": "audio-beat-detection", "value": 149.6}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 164.0, 160.0, 161.0, 161.0, 160.0, 162.0, 163.0, 164.0], "unit": "ms", "name": "audio-dft", "value": 161.9}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 78.0, 91.0, 71.0, 72.0, 71.0, 102.0, 93.0, 74.0], "unit": "ms", "name": "audio-fft", "value": 79.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 130.0, 96.0, 94.0, 94.0, 137.0, 94.0, 95.0, 137.0], "unit": "ms", "name": "audio-oscillator", "value": 106.7}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 110.0, 110.0, 109.0, 110.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 145.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 71.0, 71.0, 71.0, 73.0, 71.0, 81.0, 70.0, 70.0], "unit": "ms", "name": "json-parse-financial", "value": 72.3}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 69.0, 70.0, 70.0, 73.0, 69.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.3}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 85.0, 85.0, 84.0, 89.0, 87.0, 84.0, 84.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.8}, {"lowerIsBetter": true, "replicates": [129.0, 127.0, 127.0, 117.0, 127.0, 122.0, 130.0, 122.0, 121.0, 120.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.2}, {"lowerIsBetter": true, "replicates": [147.0, 142.0, 137.0, 146.0, 163.0, 137.0, 138.0, 145.0, 154.0, 133.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.2}, {"lowerIsBetter": true, "replicates": [67.0, 74.0, 70.0, 69.0, 68.0, 70.0, 68.0, 68.0, 68.0, 67.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.9}], "name": "kraken", "value": 1522.2000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.12549537648613], "unit": "score", "name": "Richards", "value": 213.78891199999993}, {"lowerIsBetter": false, "replicates": [192.27071716977505], "unit": "score", "name": "DeltaBlue", "value": 343.87971799999985}, {"lowerIsBetter": false, "replicates": [277.2387025228722], "unit": "score", "name": "Encrypt", "value": 960.114867}, {"lowerIsBetter": false, "replicates": [5202.072538860104], "unit": "score", "name": "Decrypt", "value": 51.16825996015938}, {"lowerIsBetter": false, "replicates": [1984.126984126984], "unit": "score", "name": "RayTrace", "value": 372.9544560000001}, {"lowerIsBetter": false, "replicates": [796.1783439490446], "unit": "score", "name": "Earley", "value": 837.077528}, {"lowerIsBetter": false, "replicates": [12575.0], "unit": "score", "name": "Boyer", "value": 52.99904572564615}, {"lowerIsBetter": false, "replicates": [26789.473684210527], "unit": "score", "name": "RegExp", "value": 34.0053339882122}, {"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", "value": 19603.65065519659}]} 01:45:37 INFO - RETURN: dromaeo_css: 6049.70 01:45:37 INFO - RETURN: kraken: 1522.20 01:45:37 INFO - RETURN: v8_7: 19603.65 01:45:37 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,203,35]]", "result": "19603.65"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,203,35]]", "result": "1522.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,203,35]]", "result": "6049.70"}}} 01:45:37 INFO - Return code: 0 01:45:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:45:37 INFO - # TBPL SUCCESS # 01:45:37 INFO - Running post-action listener: _resource_record_post_action 01:45:37 INFO - Running post-run listener: _resource_record_post_run 01:45:38 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 4096; Write bytes: 514347008; Read time: 12; Write time: 528304 01:45:38 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 178274304; Read time: 0; Write time: 287000 01:45:38 INFO - run-tests - Wall time: 1216s; CPU: 13.0%; Read bytes: 0; Write bytes: 273960960; Read time: 0; Write time: 175796 01:45:38 INFO - Running post-run listener: _upload_blobber_files 01:45:38 INFO - Blob upload gear active. 01:45:38 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 01:45:38 INFO - Copying logs to upload dir... 01:45:38 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1263.408089 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2015-11-26 01:45:37.670662) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-26 01:45:37.675217) ========= 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=919420d7ee4ef147bef0346300000385-1448515401.719044-1576458985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/dGxf8I1AQLawHhmPzJYFAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010149 build_url: 'https://queue.taskcluster.net/v1/task/dGxf8I1AQLawHhmPzJYFAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-26 01:45:37.731568) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 01:45:37.731943) ========= 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=919420d7ee4ef147bef0346300000385-1448515401.719044-1576458985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004554 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 01:45:37.781694) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-26 01:45:37.782047) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-26 01:45:37.782422) ========= ========= Total master_lag: 0.23 =========