builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-020 starttime: 1447452447.06 results: success (0) buildid: 20151113134833 builduid: d8e99ae82d34487db1be382e82b4ec29 revision: 94e2a6d21337f9b45593027b0a8e98a2157c53ad ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-13 14:07:27.061402) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-13 14:07:27.061841) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-13 14:07:27.062137) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1447452124.806030-2062463427 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006411 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-13 14:07:27.104209) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-13 14:07:27.104511) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-13 14:07:27.130775) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 14:07:27.131174) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1447452124.806030-2062463427 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004381 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 14:07:27.179951) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-13 14:07:27.180261) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-13 14:07:27.180626) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 14:07:27.181222) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1447452124.806030-2062463427 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-13 14:07:27-- 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% 229M=0s 2015-11-13 14:07:27 (229 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.238571 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 14:07:27.432025) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 14:07:27.432356) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1447452124.806030-2062463427 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017345 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 14:07:27.481851) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 14:07:27.482205) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 94e2a6d21337f9b45593027b0a8e98a2157c53ad --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 94e2a6d21337f9b45593027b0a8e98a2157c53ad --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=fc81d3768dcd4b6275e033c4000001b5-1447452124.806030-2062463427 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-13 14:07:27,597 truncating revision to first 12 chars 2015-11-13 14:07:27,597 Setting DEBUG logging. 2015-11-13 14:07:27,597 attempt 1/10 2015-11-13 14:07:27,598 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/94e2a6d21337?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-13 14:07:27,849 unpacking tar archive at: mozilla-inbound-94e2a6d21337/testing/mozharness/ program finished with exit code 0 elapsedTime=0.543638 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 14:07:28.038523) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-13 14:07:28.038865) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-13 14:07:28.047407) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-13 14:07:28.047739) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-13 14:07:28.048159) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 32 secs) (at 2015-11-13 14:07:28.048443) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-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=fc81d3768dcd4b6275e033c4000001b5-1447452124.806030-2062463427 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:07:28 INFO - MultiFileLogger online at 20151113 14:07:28 in /builds/slave/test 14:07:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound-Non-PGO 14:07:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:07:28 INFO - {'append_to_log': False, 14:07:28 INFO - 'base_work_dir': '/builds/slave/test', 14:07:28 INFO - 'blob_upload_branch': 'Mozilla-Inbound-Non-PGO', 14:07:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:07:28 INFO - 'branch': 'Mozilla-Inbound-Non-PGO', 14:07:28 INFO - 'buildbot_json_path': 'buildprops.json', 14:07:28 INFO - 'config_files': ('talos/linux_config.py',), 14:07:28 INFO - 'default_actions': ('clobber', 14:07:28 INFO - 'read-buildbot-config', 14:07:28 INFO - 'download-and-extract', 14:07:28 INFO - 'populate-webroot', 14:07:28 INFO - 'create-virtualenv', 14:07:28 INFO - 'install', 14:07:28 INFO - 'run-tests'), 14:07:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:07:28 INFO - 'download_minidump_stackwalk': True, 14:07:28 INFO - 'download_symbols': 'ondemand', 14:07:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:07:28 INFO - 'tooltool.py': '/tools/tooltool.py', 14:07:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:07:28 INFO - '/tools/misc-python/virtualenv.py')}, 14:07:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:07:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:07:28 INFO - 'installer_path': 'installer.exe', 14:07:28 INFO - 'log_level': 'info', 14:07:28 INFO - 'log_name': 'talos', 14:07:28 INFO - 'log_to_console': True, 14:07:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:07:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:07:28 INFO - 'opt_config_files': (), 14:07:28 INFO - 'pip_index': False, 14:07:28 INFO - 'sps_profile': False, 14:07:28 INFO - 'sps_profile_interval': 0, 14:07:28 INFO - 'suite': 'dromaeojs-e10s', 14:07:28 INFO - 'system_bits': '64', 14:07:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:07:28 INFO - 'title': 'talos-linux64-ix-020', 14:07:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:07:28 INFO - 'use_talos_json': True, 14:07:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:07:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:07:28 INFO - 'work_dir': 'build'} 14:07:28 INFO - ##### 14:07:28 INFO - ##### Running clobber step. 14:07:28 INFO - ##### 14:07:28 INFO - Running pre-action listener: _resource_record_pre_action 14:07:28 INFO - Running main action method: clobber 14:07:28 INFO - rmtree: /builds/slave/test/build 14:07:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:07:29 INFO - Running post-action listener: _resource_record_post_action 14:07:29 INFO - ##### 14:07:29 INFO - ##### Running read-buildbot-config step. 14:07:29 INFO - ##### 14:07:29 INFO - Running pre-action listener: _resource_record_pre_action 14:07:29 INFO - Running main action method: read_buildbot_config 14:07:29 INFO - Using buildbot properties: 14:07:29 INFO - { 14:07:29 INFO - "properties": { 14:07:29 INFO - "buildnumber": 1062, 14:07:29 INFO - "product": "firefox", 14:07:29 INFO - "script_repo_revision": "production", 14:07:29 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 14:07:29 INFO - "repository": "", 14:07:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound talos dromaeojs-e10s", 14:07:29 INFO - "buildid": "20151113134833", 14:07:29 INFO - "slavename": "talos-linux64-ix-020", 14:07:29 INFO - "pgo_build": "False", 14:07:29 INFO - "basedir": "/builds/slave/test", 14:07:29 INFO - "project": "", 14:07:29 INFO - "platform": "ubuntu64_hw", 14:07:29 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:07:29 INFO - "slavebuilddir": "test", 14:07:29 INFO - "scheduler": "tests-mozilla-inbound-linux64-talos", 14:07:29 INFO - "branch": "mozilla-inbound", 14:07:29 INFO - "repo_path": "integration/mozilla-inbound", 14:07:29 INFO - "stage_platform": "linux64", 14:07:29 INFO - "builduid": "d8e99ae82d34487db1be382e82b4ec29", 14:07:29 INFO - "revision": "94e2a6d21337f9b45593027b0a8e98a2157c53ad" 14:07:29 INFO - }, 14:07:29 INFO - "sourcestamp": { 14:07:29 INFO - "repository": "", 14:07:29 INFO - "hasPatch": false, 14:07:29 INFO - "project": "", 14:07:29 INFO - "branch": "mozilla-inbound-linux64-talos", 14:07:29 INFO - "changes": [ 14:07:29 INFO - { 14:07:29 INFO - "category": null, 14:07:29 INFO - "files": [ 14:07:29 INFO - { 14:07:29 INFO - "url": null, 14:07:29 INFO - "name": "https://queue.taskcluster.net/v1/task/wmIpCheHQXi7OKVX1ruotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 14:07:29 INFO - } 14:07:29 INFO - ], 14:07:29 INFO - "repository": "", 14:07:29 INFO - "rev": "94e2a6d21337f9b45593027b0a8e98a2157c53ad", 14:07:29 INFO - "who": "mchang@mozilla.com", 14:07:29 INFO - "when": 1447452435, 14:07:29 INFO - "number": 6660616, 14:07:29 INFO - "comments": "Backout bug 1210261 for multiple talos regressions. r=me", 14:07:29 INFO - "project": "", 14:07:29 INFO - "at": "Fri 13 Nov 2015 14:07:15", 14:07:29 INFO - "branch": "mozilla-inbound-linux64-talos", 14:07:29 INFO - "revlink": "", 14:07:29 INFO - "properties": [ 14:07:29 INFO - [ 14:07:29 INFO - "buildid", 14:07:29 INFO - "20151113134833", 14:07:29 INFO - "Change" 14:07:29 INFO - ], 14:07:29 INFO - [ 14:07:29 INFO - "builduid", 14:07:29 INFO - "d8e99ae82d34487db1be382e82b4ec29", 14:07:29 INFO - "Change" 14:07:29 INFO - ], 14:07:29 INFO - [ 14:07:29 INFO - "pgo_build", 14:07:29 INFO - "False", 14:07:29 INFO - "Change" 14:07:29 INFO - ] 14:07:29 INFO - ], 14:07:29 INFO - "revision": "94e2a6d21337f9b45593027b0a8e98a2157c53ad" 14:07:29 INFO - } 14:07:29 INFO - ], 14:07:29 INFO - "revision": "94e2a6d21337f9b45593027b0a8e98a2157c53ad" 14:07:29 INFO - } 14:07:29 INFO - } 14:07:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/wmIpCheHQXi7OKVX1ruotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 14:07:29 INFO - Running post-action listener: _resource_record_post_action 14:07:29 INFO - ##### 14:07:29 INFO - ##### Running download-and-extract step. 14:07:29 INFO - ##### 14:07:29 INFO - Running pre-action listener: _resource_record_pre_action 14:07:29 INFO - Running main action method: download_and_extract 14:07:29 INFO - mkdir: /builds/slave/test/build/tests 14:07:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:29 INFO - https://queue.taskcluster.net/v1/task/wmIpCheHQXi7OKVX1ruotQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:07:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wmIpCheHQXi7OKVX1ruotQ/artifacts/public/build/test_packages.json 14:07:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wmIpCheHQXi7OKVX1ruotQ/artifacts/public/build/test_packages.json 14:07:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wmIpCheHQXi7OKVX1ruotQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 14:07:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wmIpCheHQXi7OKVX1ruotQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 14:07:33 INFO - Downloaded 1302 bytes. 14:07:33 INFO - Reading from file /builds/slave/test/build/test_packages.json 14:07:33 INFO - Using the following test package requirements: 14:07:33 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 14:07:33 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:07:33 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:07:33 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:07:33 INFO - u'jsshell-linux-x86_64.zip'], 14:07:33 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:07:33 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:07:33 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 14:07:33 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:07:33 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:07:33 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:07:33 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:07:33 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:07:33 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:07:33 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 14:07:33 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:07:33 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:07:33 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:07:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:33 INFO - https://queue.taskcluster.net/v1/task/wmIpCheHQXi7OKVX1ruotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:07:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wmIpCheHQXi7OKVX1ruotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:07:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wmIpCheHQXi7OKVX1ruotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:07:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wmIpCheHQXi7OKVX1ruotQ/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 14:07:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wmIpCheHQXi7OKVX1ruotQ/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 14:07:37 INFO - Downloaded 21277317 bytes. 14:07:37 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 14:07:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:07:37 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 14:07:38 INFO - Return code: 0 14:07:38 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 14:07:38 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')]} 14:07:38 INFO - https://queue.taskcluster.net/v1/task/wmIpCheHQXi7OKVX1ruotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:07:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wmIpCheHQXi7OKVX1ruotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:07:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wmIpCheHQXi7OKVX1ruotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:07:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wmIpCheHQXi7OKVX1ruotQ/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 14:07:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wmIpCheHQXi7OKVX1ruotQ/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 14:07:45 INFO - Downloaded 21277317 bytes. 14:07:45 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 14:07:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:07:45 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 14:07:48 INFO - Return code: 0 14:07:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:48 INFO - https://queue.taskcluster.net/v1/task/wmIpCheHQXi7OKVX1ruotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:07:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wmIpCheHQXi7OKVX1ruotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 14:07:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wmIpCheHQXi7OKVX1ruotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 14:07:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wmIpCheHQXi7OKVX1ruotQ/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 14:07:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wmIpCheHQXi7OKVX1ruotQ/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 14:07:49 INFO - Downloaded 11131693 bytes. 14:07:49 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 14:07:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 14:07:49 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 14:07:49 INFO - Return code: 0 14:07: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')]} 14:07:49 INFO - https://queue.taskcluster.net/v1/task/wmIpCheHQXi7OKVX1ruotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:07:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wmIpCheHQXi7OKVX1ruotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:07:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wmIpCheHQXi7OKVX1ruotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:07:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wmIpCheHQXi7OKVX1ruotQ/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 14:07:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wmIpCheHQXi7OKVX1ruotQ/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 14:07:51 INFO - Downloaded 55616324 bytes. 14:07:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/wmIpCheHQXi7OKVX1ruotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:07:51 INFO - mkdir: /builds/slave/test/properties 14:07:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:07:51 INFO - Writing to file /builds/slave/test/properties/build_url 14:07:51 INFO - Contents: 14:07:51 INFO - build_url:https://queue.taskcluster.net/v1/task/wmIpCheHQXi7OKVX1ruotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:07:51 INFO - Running post-action listener: _resource_record_post_action 14:07:51 INFO - Running post-action listener: set_extra_try_arguments 14:07:51 INFO - ##### 14:07:51 INFO - ##### Running populate-webroot step. 14:07:51 INFO - ##### 14:07:51 INFO - Running pre-action listener: _resource_record_pre_action 14:07:51 INFO - Running main action method: populate_webroot 14:07:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:07:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:07:52 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 14:07:52 INFO - '../fennec_ids.txt'], 14:07:52 INFO - 'tests': ['tcheck2']}, 14:07:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:07:52 INFO - '--tppagecycles', 14:07:52 INFO - '7'], 14:07:52 INFO - 'tests': ['tsvgm']}}, 14:07:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:07:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:07:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:07:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:07:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:07:52 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:07:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:07:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:52 INFO - 'talos_options': ['--e10s'], 14:07:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:07:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:52 INFO - 'tests': ['damp', 'tps']}, 14:07:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:52 INFO - 'talos_options': ['--e10s'], 14:07:52 INFO - 'tests': ['damp', 'tps']}, 14:07:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:07:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:07:52 INFO - 'other': {'tests': ['a11yr', 14:07:52 INFO - 'ts_paint', 14:07:52 INFO - 'tpaint', 14:07:52 INFO - 'sessionrestore', 14:07:52 INFO - 'sessionrestore_no_auto_restore']}, 14:07:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:07:52 INFO - 'tests': ['a11yr', 14:07:52 INFO - 'ts_paint', 14:07:52 INFO - 'tpaint', 14:07:52 INFO - 'sessionrestore', 14:07:52 INFO - 'sessionrestore_no_auto_restore']}, 14:07:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:07:52 INFO - 'tests': ['a11yr', 14:07:52 INFO - 'ts_paint', 14:07:52 INFO - 'tpaint', 14:07:52 INFO - 'sessionrestore', 14:07:52 INFO - 'sessionrestore_no_auto_restore']}, 14:07:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:07:52 INFO - 'tests': ['a11yr', 14:07:52 INFO - 'ts_paint', 14:07:52 INFO - 'tpaint', 14:07:52 INFO - 'sessionrestore', 14:07:52 INFO - 'sessionrestore_no_auto_restore']}, 14:07:52 INFO - 'other_l64': {'tests': ['a11yr', 14:07:52 INFO - 'ts_paint', 14:07:52 INFO - 'tpaint', 14:07:52 INFO - 'sessionrestore', 14:07:52 INFO - 'sessionrestore_no_auto_restore']}, 14:07:52 INFO - 'other_nol64': {'tests': ['a11yr', 14:07:52 INFO - 'ts_paint', 14:07:52 INFO - 'tpaint', 14:07:52 INFO - 'sessionrestore', 14:07:52 INFO - 'sessionrestore_no_auto_restore']}, 14:07:52 INFO - 'svgr': {'tests': ['tsvgx', 14:07:52 INFO - 'tsvgr_opacity', 14:07:52 INFO - 'tart', 14:07:52 INFO - 'tscrollx', 14:07:52 INFO - 'cart']}, 14:07:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:07:52 INFO - 'tests': ['tsvgx', 14:07:52 INFO - 'tsvgr_opacity', 14:07:52 INFO - 'tart', 14:07:52 INFO - 'tscrollx', 14:07:52 INFO - 'cart']}, 14:07:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:52 INFO - 'tests': ['tp5o']}, 14:07:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:52 INFO - 'talos_options': ['--e10s'], 14:07:52 INFO - 'tests': ['tp5o']}, 14:07:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:52 INFO - 'talos_options': ['--xperf_path', 14:07:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:07:52 INFO - 'tests': ['tp5n']}, 14:07:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:52 INFO - 'talos_options': ['--e10s', 14:07:52 INFO - '--xperf_path', 14:07:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:07:52 INFO - 'tests': ['tp5n']}}, 14:07:52 INFO - 'talos.zip': {'path': '', 14:07:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:07:52 INFO - Running post-action listener: _resource_record_post_action 14:07:52 INFO - ##### 14:07:52 INFO - ##### Running create-virtualenv step. 14:07:52 INFO - ##### 14:07:52 INFO - Running pre-action listener: _resource_record_pre_action 14:07:52 INFO - Running main action method: create_virtualenv 14:07:52 INFO - Creating virtualenv /builds/slave/test/build/venv 14:07:52 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 14:07:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:07:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:07:53 INFO - Using real prefix '/usr' 14:07:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:07:57 INFO - Installing distribute.............................................................................................................................................................................................done. 14:08:00 INFO - Installing pip.................done. 14:08:00 INFO - Return code: 0 14:08:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:08: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')]} 14:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08: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')]} 14:08:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08: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', '--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 0x7fd9adc01c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd76c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e889a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f17ac0>, '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 0x1f189a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f18e50>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1447452124.806030-2062463427', '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 14:08:00 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 14:08:00 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 14:08:00 INFO - Using env: {'DISPLAY': ':0', 14:08:00 INFO - 'HOME': '/home/cltbld', 14:08:00 INFO - 'LANG': 'en_US.UTF-8', 14:08:00 INFO - 'LANGUAGE': 'en_US:en', 14:08:00 INFO - 'LOGNAME': 'cltbld', 14:08:00 INFO - 'MAIL': '/var/mail/cltbld', 14:08:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:00 INFO - 'MOZ_NO_REMOTE': '1', 14:08:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:00 INFO - 'NO_EM_RESTART': '1', 14:08:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:00 INFO - 'PWD': '/builds/slave/test', 14:08:00 INFO - 'SHELL': '/bin/bash', 14:08:00 INFO - 'SHLVL': '1', 14:08:00 INFO - 'TERM': 'linux', 14:08:00 INFO - 'TMOUT': '86400', 14:08:00 INFO - 'USER': 'cltbld', 14:08:00 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1447452124.806030-2062463427', 14:08:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:00 INFO - '_': '/tools/buildbot/bin/python'} 14:08:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:02 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:08:02 INFO - Cleaning up... 14:08:02 INFO - Return code: 0 14:08:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:08:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9adc01c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd76c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e889a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f17ac0>, '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 0x1f189a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f18e50>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1447452124.806030-2062463427', '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 14:08:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 14:08:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:08:02 INFO - Using env: {'DISPLAY': ':0', 14:08:02 INFO - 'HOME': '/home/cltbld', 14:08:02 INFO - 'LANG': 'en_US.UTF-8', 14:08:02 INFO - 'LANGUAGE': 'en_US:en', 14:08:02 INFO - 'LOGNAME': 'cltbld', 14:08:02 INFO - 'MAIL': '/var/mail/cltbld', 14:08:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:02 INFO - 'MOZ_NO_REMOTE': '1', 14:08:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:02 INFO - 'NO_EM_RESTART': '1', 14:08:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:02 INFO - 'PWD': '/builds/slave/test', 14:08:02 INFO - 'SHELL': '/bin/bash', 14:08:02 INFO - 'SHLVL': '1', 14:08:02 INFO - 'TERM': 'linux', 14:08:02 INFO - 'TMOUT': '86400', 14:08:02 INFO - 'USER': 'cltbld', 14:08:02 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1447452124.806030-2062463427', 14:08:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:02 INFO - '_': '/tools/buildbot/bin/python'} 14:08:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:02 INFO - Downloading/unpacking psutil>=0.7.1 14:08: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 14:08: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 14:08: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 14:08: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 14:08: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 14:08: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 14:08:03 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 14:08:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 14:08:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:08:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:08:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:08:04 INFO - Installing collected packages: psutil 14:08:04 INFO - Running setup.py install for psutil 14:08:04 INFO - building 'psutil._psutil_linux' extension 14:08:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:08:05 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 14:08:05 INFO - building 'psutil._psutil_posix' extension 14:08:05 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 14:08:05 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 14:08:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:08:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:08:05 INFO - Successfully installed psutil 14:08:05 INFO - Cleaning up... 14:08:05 INFO - Return code: 0 14:08:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:08:05 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')]} 14:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:05 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')]} 14:08:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:05 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 0x7fd9adc01c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd76c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e889a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f17ac0>, '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 0x1f189a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f18e50>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1447452124.806030-2062463427', '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 14:08:05 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 14:08:05 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 14:08:05 INFO - Using env: {'DISPLAY': ':0', 14:08:05 INFO - 'HOME': '/home/cltbld', 14:08:05 INFO - 'LANG': 'en_US.UTF-8', 14:08:05 INFO - 'LANGUAGE': 'en_US:en', 14:08:05 INFO - 'LOGNAME': 'cltbld', 14:08:05 INFO - 'MAIL': '/var/mail/cltbld', 14:08:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:05 INFO - 'MOZ_NO_REMOTE': '1', 14:08:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:05 INFO - 'NO_EM_RESTART': '1', 14:08:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:05 INFO - 'PWD': '/builds/slave/test', 14:08:05 INFO - 'SHELL': '/bin/bash', 14:08:05 INFO - 'SHLVL': '1', 14:08:05 INFO - 'TERM': 'linux', 14:08:05 INFO - 'TMOUT': '86400', 14:08:05 INFO - 'USER': 'cltbld', 14:08:05 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1447452124.806030-2062463427', 14:08:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:05 INFO - '_': '/tools/buildbot/bin/python'} 14:08:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:08: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 14:08: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 14:08: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 14:08: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 14:08: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 14:08: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 14:08:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:08:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 14:08:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:08:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:08:07 INFO - Installing collected packages: mozsystemmonitor 14:08:07 INFO - Running setup.py install for mozsystemmonitor 14:08:07 INFO - Successfully installed mozsystemmonitor 14:08:07 INFO - Cleaning up... 14:08:08 INFO - Return code: 0 14:08:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd9adc01c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd76c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e889a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f17ac0>, '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 0x1f189a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f18e50>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1447452124.806030-2062463427', '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 14:08:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:08:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:08:08 INFO - Using env: {'DISPLAY': ':0', 14:08:08 INFO - 'HOME': '/home/cltbld', 14:08:08 INFO - 'LANG': 'en_US.UTF-8', 14:08:08 INFO - 'LANGUAGE': 'en_US:en', 14:08:08 INFO - 'LOGNAME': 'cltbld', 14:08:08 INFO - 'MAIL': '/var/mail/cltbld', 14:08:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:08 INFO - 'MOZ_NO_REMOTE': '1', 14:08:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:08 INFO - 'NO_EM_RESTART': '1', 14:08:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:08 INFO - 'PWD': '/builds/slave/test', 14:08:08 INFO - 'SHELL': '/bin/bash', 14:08:08 INFO - 'SHLVL': '1', 14:08:08 INFO - 'TERM': 'linux', 14:08:08 INFO - 'TMOUT': '86400', 14:08:08 INFO - 'USER': 'cltbld', 14:08:08 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1447452124.806030-2062463427', 14:08:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:08 INFO - '_': '/tools/buildbot/bin/python'} 14:08:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:08 INFO - Downloading/unpacking blobuploader==1.2.4 14:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:08:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:08:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:08:09 INFO - Downloading blobuploader-1.2.4.tar.gz 14:08:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 14:08:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:08:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:08:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:08:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:08:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 14:08:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:08:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:08:10 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 14:08:10 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 14:08:10 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 14:08:10 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 14:08:10 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 14:08:10 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 14:08:10 INFO - Downloading docopt-0.6.1.tar.gz 14:08:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 14:08:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:08:10 INFO - Installing collected packages: blobuploader, requests, docopt 14:08:10 INFO - Running setup.py install for blobuploader 14:08:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:08:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:08:10 INFO - Running setup.py install for requests 14:08:11 INFO - Running setup.py install for docopt 14:08:11 INFO - Successfully installed blobuploader requests docopt 14:08:11 INFO - Cleaning up... 14:08:11 INFO - Return code: 0 14:08:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:08:11 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')]} 14:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:11 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')]} 14:08:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:11 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 0x7fd9adc01c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd76c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e889a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f17ac0>, '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 0x1f189a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f18e50>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1447452124.806030-2062463427', '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 14:08:11 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 14:08:11 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 14:08:11 INFO - Using env: {'DISPLAY': ':0', 14:08:11 INFO - 'HOME': '/home/cltbld', 14:08:11 INFO - 'LANG': 'en_US.UTF-8', 14:08:11 INFO - 'LANGUAGE': 'en_US:en', 14:08:11 INFO - 'LOGNAME': 'cltbld', 14:08:11 INFO - 'MAIL': '/var/mail/cltbld', 14:08:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:11 INFO - 'MOZ_NO_REMOTE': '1', 14:08:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:11 INFO - 'NO_EM_RESTART': '1', 14:08:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:11 INFO - 'PWD': '/builds/slave/test', 14:08:11 INFO - 'SHELL': '/bin/bash', 14:08:11 INFO - 'SHLVL': '1', 14:08:11 INFO - 'TERM': 'linux', 14:08:11 INFO - 'TMOUT': '86400', 14:08:11 INFO - 'USER': 'cltbld', 14:08:11 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1447452124.806030-2062463427', 14:08:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:11 INFO - '_': '/tools/buildbot/bin/python'} 14:08:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:08:11 INFO - Running setup.py (path:/tmp/pip-h_6ET0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:08:11 INFO - Running setup.py (path:/tmp/pip-Ky8e3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:08:11 INFO - Running setup.py (path:/tmp/pip-ot9H5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:08:11 INFO - Running setup.py (path:/tmp/pip-nRLxGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:08:11 INFO - Running setup.py (path:/tmp/pip-KYcQM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:08:11 INFO - Running setup.py (path:/tmp/pip-csAinx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:08:11 INFO - Running setup.py (path:/tmp/pip-kRZBzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:08:11 INFO - Running setup.py (path:/tmp/pip-q0u_BJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:08:11 INFO - Running setup.py (path:/tmp/pip-bYsEaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:08:11 INFO - Running setup.py (path:/tmp/pip-9RR4eP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:08:12 INFO - Running setup.py (path:/tmp/pip-Bq5WXe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:08:12 INFO - Running setup.py (path:/tmp/pip-2B7Ou_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:08:12 INFO - Running setup.py (path:/tmp/pip-5z9v0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:08:12 INFO - Running setup.py (path:/tmp/pip-vY4JhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:08:12 INFO - Running setup.py (path:/tmp/pip-QEY2Dn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:08:12 INFO - Running setup.py (path:/tmp/pip-aDQgFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:08:12 INFO - Running setup.py (path:/tmp/pip-UCoXPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:08:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:08:12 INFO - Running setup.py install for manifestparser 14:08:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:08:12 INFO - Running setup.py install for mozcrash 14:08:12 INFO - Running setup.py install for mozdebug 14:08:12 INFO - Running setup.py install for mozdevice 14:08:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:08:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:08:12 INFO - Running setup.py install for mozfile 14:08:13 INFO - Running setup.py install for mozhttpd 14:08:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:08:13 INFO - Running setup.py install for mozinfo 14:08:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:08:13 INFO - Running setup.py install for mozInstall 14:08:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:08:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:08:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:08:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:08:13 INFO - Running setup.py install for mozleak 14:08:13 INFO - Running setup.py install for mozlog 14:08:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:08:13 INFO - Running setup.py install for moznetwork 14:08:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:08:13 INFO - Running setup.py install for mozprocess 14:08:13 INFO - Running setup.py install for mozprofile 14:08:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:08:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:08:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:08:13 INFO - Running setup.py install for mozrunner 14:08:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:08:14 INFO - Running setup.py install for mozscreenshot 14:08:14 INFO - Running setup.py install for moztest 14:08:14 INFO - Running setup.py install for mozversion 14:08:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:08:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:08:14 INFO - Cleaning up... 14:08:14 INFO - Return code: 0 14:08:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:08:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x7fd9adc01c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd76c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e889a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f17ac0>, '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 0x1f189a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f18e50>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1447452124.806030-2062463427', '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 14:08:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 14:08:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/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 14:08:14 INFO - Using env: {'DISPLAY': ':0', 14:08:14 INFO - 'HOME': '/home/cltbld', 14:08:14 INFO - 'LANG': 'en_US.UTF-8', 14:08:14 INFO - 'LANGUAGE': 'en_US:en', 14:08:14 INFO - 'LOGNAME': 'cltbld', 14:08:14 INFO - 'MAIL': '/var/mail/cltbld', 14:08:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:14 INFO - 'MOZ_NO_REMOTE': '1', 14:08:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:14 INFO - 'NO_EM_RESTART': '1', 14:08:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:14 INFO - 'PWD': '/builds/slave/test', 14:08:14 INFO - 'SHELL': '/bin/bash', 14:08:14 INFO - 'SHLVL': '1', 14:08:14 INFO - 'TERM': 'linux', 14:08:14 INFO - 'TMOUT': '86400', 14:08:14 INFO - 'USER': 'cltbld', 14:08:14 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1447452124.806030-2062463427', 14:08:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:14 INFO - '_': '/tools/buildbot/bin/python'} 14:08:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:08:14 INFO - Running setup.py (path:/tmp/pip-Y55Mp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:08:14 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)) 14:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:08:14 INFO - Running setup.py (path:/tmp/pip-V8zgkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:08:14 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)) 14:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:08:14 INFO - Running setup.py (path:/tmp/pip-F4RKdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:08:14 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)) 14:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:08:14 INFO - Running setup.py (path:/tmp/pip-rWS9Ng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:08:14 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)) 14:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:08:14 INFO - Running setup.py (path:/tmp/pip-QyI4nW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:08:14 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)) 14:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:08:14 INFO - Running setup.py (path:/tmp/pip-cMFlAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:08:14 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)) 14:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:08:14 INFO - Running setup.py (path:/tmp/pip-So10PV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:08:15 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)) 14:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:08:15 INFO - Running setup.py (path:/tmp/pip-DOGo08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:08:15 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)) 14:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:08:15 INFO - Running setup.py (path:/tmp/pip-32FJl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:08:15 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)) 14:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:08:15 INFO - Running setup.py (path:/tmp/pip-m2HAzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:08:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 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)) 14:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:08:15 INFO - Running setup.py (path:/tmp/pip-KRKA2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:08:15 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)) 14:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:08:15 INFO - Running setup.py (path:/tmp/pip-8KsqOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:08:15 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)) 14:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:08:15 INFO - Running setup.py (path:/tmp/pip-PDXEAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:08:15 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)) 14:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:08:15 INFO - Running setup.py (path:/tmp/pip-furW7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:08:15 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)) 14:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:08:15 INFO - Running setup.py (path:/tmp/pip-2LdOre-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:08:15 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)) 14:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:08:15 INFO - Running setup.py (path:/tmp/pip-2Vv_dS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:08:15 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)) 14:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:08:15 INFO - Running setup.py (path:/tmp/pip-j2eOP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:08:15 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)) 14:08:15 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)) 14:08:15 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)) 14:08:15 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)) 14:08:15 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)) 14:08:15 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)) 14:08:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:08:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:08:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:08:17 INFO - Downloading blessings-1.5.1.tar.gz 14:08:17 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 14:08:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:08:17 INFO - Installing collected packages: blessings 14:08:17 INFO - Running setup.py install for blessings 14:08:17 INFO - Successfully installed blessings 14:08:17 INFO - Cleaning up... 14:08:17 INFO - Return code: 0 14:08:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:08:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:08:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:08:17 INFO - Reading from file tmpfile_stdout 14:08:17 INFO - Current package versions: 14:08:17 INFO - argparse == 1.2.1 14:08:17 INFO - blessings == 1.5.1 14:08:17 INFO - blobuploader == 1.2.4 14:08:17 INFO - docopt == 0.6.1 14:08:17 INFO - manifestparser == 1.1 14:08:17 INFO - mozInstall == 1.12 14:08:17 INFO - mozcrash == 0.16 14:08:17 INFO - mozdebug == 0.1 14:08:17 INFO - mozdevice == 0.47 14:08:17 INFO - mozfile == 1.2 14:08:17 INFO - mozhttpd == 0.7 14:08:17 INFO - mozinfo == 0.9 14:08:17 INFO - mozleak == 0.1 14:08:17 INFO - mozlog == 3.0 14:08:17 INFO - moznetwork == 0.27 14:08:17 INFO - mozprocess == 0.22 14:08:17 INFO - mozprofile == 0.27 14:08:17 INFO - mozrunner == 6.11 14:08:17 INFO - mozscreenshot == 0.1 14:08:17 INFO - mozsystemmonitor == 0.0 14:08:17 INFO - moztest == 0.7 14:08:17 INFO - mozversion == 1.4 14:08:17 INFO - psutil == 3.1.1 14:08:17 INFO - requests == 1.2.3 14:08:17 INFO - wsgiref == 0.1.2 14:08:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:08:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7fd9adc01c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd76c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e889a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f17ac0>, '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 0x1f189a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f18e50>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1447452124.806030-2062463427', '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 14:08:17 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 14:08:17 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 14:08:17 INFO - Using env: {'DISPLAY': ':0', 14:08:17 INFO - 'HOME': '/home/cltbld', 14:08:17 INFO - 'LANG': 'en_US.UTF-8', 14:08:17 INFO - 'LANGUAGE': 'en_US:en', 14:08:17 INFO - 'LOGNAME': 'cltbld', 14:08:17 INFO - 'MAIL': '/var/mail/cltbld', 14:08:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:17 INFO - 'MOZ_NO_REMOTE': '1', 14:08:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:17 INFO - 'NO_EM_RESTART': '1', 14:08:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:17 INFO - 'PWD': '/builds/slave/test', 14:08:17 INFO - 'SHELL': '/bin/bash', 14:08:17 INFO - 'SHLVL': '1', 14:08:17 INFO - 'TERM': 'linux', 14:08:17 INFO - 'TMOUT': '86400', 14:08:17 INFO - 'USER': 'cltbld', 14:08:17 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1447452124.806030-2062463427', 14:08:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:17 INFO - '_': '/tools/buildbot/bin/python'} 14:08:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:18 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)) 14:08:18 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)) 14:08:18 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)) 14:08:18 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)) 14:08:18 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)) 14:08:18 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)) 14:08:18 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)) 14:08:18 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)) 14:08:18 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)) 14:08:18 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)) 14:08:18 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)) 14:08:18 INFO - Cleaning up... 14:08:18 INFO - Return code: 0 14:08:18 INFO - Running post-action listener: _resource_record_post_action 14:08:18 INFO - Running post-action listener: _start_resource_monitoring 14:08:18 INFO - Starting resource monitoring. 14:08:18 INFO - ##### 14:08:18 INFO - ##### Running install step. 14:08:18 INFO - ##### 14:08:18 INFO - Running pre-action listener: _resource_record_pre_action 14:08:18 INFO - Running main action method: install 14:08:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:08:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:08:18 INFO - Reading from file tmpfile_stdout 14:08:18 INFO - Detecting whether we're running mozinstall >=1.0... 14:08:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:08:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:08:18 INFO - Reading from file tmpfile_stdout 14:08:18 INFO - Output received: 14:08:18 INFO - Usage: mozinstall [options] installer 14:08:18 INFO - Options: 14:08:18 INFO - -h, --help show this help message and exit 14:08:18 INFO - -d DEST, --destination=DEST 14:08:18 INFO - Directory to install application into. [default: 14:08:18 INFO - "/builds/slave/test"] 14:08:18 INFO - --app=APP Application being installed. [default: firefox] 14:08:18 INFO - mkdir: /builds/slave/test/build/application 14:08:18 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'] 14:08:18 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 14:08:32 INFO - Reading from file tmpfile_stdout 14:08:32 INFO - Output received: 14:08:32 INFO - /builds/slave/test/build/application/firefox/firefox 14:08:32 INFO - Running post-action listener: _resource_record_post_action 14:08:32 INFO - ##### 14:08:32 INFO - ##### Running run-tests step. 14:08:32 INFO - ##### 14:08:32 INFO - Running pre-action listener: _resource_record_pre_action 14:08:32 INFO - Running main action method: run_tests 14:08:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:08:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:08:32 INFO - Python 2.7.3 14:08:32 INFO - Return code: 0 14:08:32 INFO - grabbing minidump binary from tooltool 14:08:32 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')]} 14:08:32 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 0x1f17ac0>, '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 0x1f189a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f18e50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:08:32 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 14:08:32 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 14:08:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:08:32 INFO - Return code: 0 14:08:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:08:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:08:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:08:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:08:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:08:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/wmIpCheHQXi7OKVX1ruotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost'] in /builds/slave/test/build 14:08:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/wmIpCheHQXi7OKVX1ruotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --webServer localhost 14:08:32 INFO - Using env: {'DISPLAY': ':0', 14:08:32 INFO - 'HOME': '/home/cltbld', 14:08:32 INFO - 'LANG': 'en_US.UTF-8', 14:08:32 INFO - 'LANGUAGE': 'en_US:en', 14:08:32 INFO - 'LOGNAME': 'cltbld', 14:08:32 INFO - 'MAIL': '/var/mail/cltbld', 14:08:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:08:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:08:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:32 INFO - 'MOZ_NO_REMOTE': '1', 14:08:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:08:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:32 INFO - 'NO_EM_RESTART': '1', 14:08:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:32 INFO - 'PWD': '/builds/slave/test', 14:08:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:08:32 INFO - 'SHELL': '/bin/bash', 14:08:32 INFO - 'SHLVL': '1', 14:08:32 INFO - 'TERM': 'linux', 14:08:32 INFO - 'TMOUT': '86400', 14:08:32 INFO - 'USER': 'cltbld', 14:08:32 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1447452124.806030-2062463427', 14:08:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:32 INFO - '_': '/tools/buildbot/bin/python'} 14:08:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/wmIpCheHQXi7OKVX1ruotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost'] with output_timeout 3600 14:08:33 INFO - mozversion INFO | application_buildid: 20151113134833 14:08:33 INFO - mozversion INFO | application_changeset: 94e2a6d21337f9b45593027b0a8e98a2157c53ad 14:08:33 INFO - mozversion INFO | application_display_name: Nightly 14:08:33 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:08:33 INFO - mozversion INFO | application_name: Firefox 14:08:33 INFO - mozversion INFO | application_remotingname: firefox 14:08:33 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 14:08:33 INFO - mozversion INFO | application_vendor: Mozilla 14:08:33 INFO - mozversion INFO | application_version: 45.0a1 14:08:33 INFO - mozversion INFO | platform_buildid: 20151113134833 14:08:33 INFO - mozversion INFO | platform_changeset: 94e2a6d21337f9b45593027b0a8e98a2157c53ad 14:08:33 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 14:08:33 INFO - mozversion INFO | platform_version: 45.0a1 14:08:33 INFO - 2015-11-13 14:08:33,811 DEBUG : using testdate: 1447452513 14:08:33 INFO - 2015-11-13 14:08:33,811 DEBUG : actual date: 1447452513 14:08:33 INFO - 2015-11-13 14:08:33,819 INFO : starting webserver on 'localhost:35795' 14:08:33 INFO - 2015-11-13 14:08:33,820 INFO : Starting test suite talos-linux64-ix-020.e 14:08:33 INFO - 2015-11-13 14:08:33,820 INFO : Starting test dromaeo_css 14:08:33 INFO - 2015-11-13 14:08:33,820 DEBUG : operating with platform_type : linux_ 14:08:33 INFO - 2015-11-13 14:08:33,820 INFO : Initialising browser for dromaeo_css test... 14:08:34 INFO - 2015-11-13 14:08:34,070 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1vDa6O/profile http://localhost:35795/getInfo.html 14:08:45 INFO - 2015-11-13 14:08:45,031 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:08:45 INFO - 2015-11-13 14:08:45,031 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:08:45 INFO - 2015-11-13 14:08:45,031 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:08:45 INFO - 2015-11-13 14:08:45,031 DEBUG : BROWSER_OUTPUT: __metrics 14:08:46 INFO - 2015-11-13 14:08:46,401 INFO : Browser initialized. 14:08:46 INFO - 2015-11-13 14:08:46,402 INFO : Running cycle 1/1 for dromaeo_css test... 14:08:46 INFO - 2015-11-13 14:08:46,402 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1vDa6O/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:08:58 INFO - 2015-11-13 14:08:58,298 DEBUG : BROWSER_OUTPUT: RSS: Main: 141430784 14:08:58 INFO - 2015-11-13 14:08:58,298 DEBUG : BROWSER_OUTPUT: 14:09:47 INFO - 2015-11-13 14:09:47,945 DEBUG : BROWSER_OUTPUT: 1447452587944 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] 14:11:59 INFO - 2015-11-13 14:11:59,823 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35795/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35795/tests/dromaeo/cssquery-ext.html) 14:12:00 INFO - 2015-11-13 14:12:00,989 DEBUG : BROWSER_OUTPUT: RSS: Main: 143798272 14:12:00 INFO - 2015-11-13 14:12:00,990 DEBUG : BROWSER_OUTPUT: 14:15:03 INFO - 2015-11-13 14:15:03,083 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35795/tests/dromaeo/cssquery-ext.html (next: http://localhost:35795/tests/dromaeo/cssquery-jquery.html) 14:15:03 INFO - 2015-11-13 14:15:03,676 DEBUG : BROWSER_OUTPUT: RSS: Main: 143114240 14:15:03 INFO - 2015-11-13 14:15:03,676 DEBUG : BROWSER_OUTPUT: 14:18:05 INFO - 2015-11-13 14:18:05,474 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35795/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35795/tests/dromaeo/cssquery-mootools.html) 14:18:06 INFO - 2015-11-13 14:18:06,067 DEBUG : BROWSER_OUTPUT: RSS: Main: 143032320 14:18:06 INFO - 2015-11-13 14:18:06,067 DEBUG : BROWSER_OUTPUT: 14:21:07 INFO - 2015-11-13 14:21:07,793 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35795/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35795/tests/dromaeo/cssquery-prototype.html) 14:21:08 INFO - 2015-11-13 14:21:08,396 DEBUG : BROWSER_OUTPUT: RSS: Main: 140603392 14:21:08 INFO - 2015-11-13 14:21:08,396 DEBUG : BROWSER_OUTPUT: 14:24:10 INFO - 2015-11-13 14:24:10,962 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35795/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35795/tests/dromaeo/cssquery-yui.html) 14:24:11 INFO - 2015-11-13 14:24:11,584 DEBUG : BROWSER_OUTPUT: RSS: Main: 141271040 14:24:11 INFO - 2015-11-13 14:24:11,584 DEBUG : BROWSER_OUTPUT: 14:27:13 INFO - 2015-11-13 14:27:13,673 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35795/tests/dromaeo/cssquery-yui.html (next: http://localhost:35795/tests/dromaeo/cssquery-dojo.html) 14:27:13 INFO - 2015-11-13 14:27:13,916 DEBUG : BROWSER_OUTPUT: RSS: Main: 144166912 14:27:13 INFO - 2015-11-13 14:27:13,916 DEBUG : BROWSER_OUTPUT: 14:27:13 INFO - 2015-11-13 14:27:13,918 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:27:13 INFO - 2015-11-13 14:27:13,919 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:27:13 INFO - 2015-11-13 14:27:13,919 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:27:13 INFO - 2015-11-13 14:27:13,919 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:27:13 INFO - 2015-11-13 14:27:13,921 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2677.250369896429;2730.549459339209;2755.0908200293916;2755.7657599104077;2770.376665250318;4608.83869064582;4734.550217729319;4758.714477131374;4764.618830493561;4774.11678839415;4722;4734.053189362124;4774.809007639699;4822.300766388871;4828.73441960692;4382.145481631083;4403.075354175611;4462.955370446302;4470.7094038887535;4495.123450927071;4418.624416924566;4479.08178823342;4520.434945631796;4559.817607295704;4586.793594288265;4334.393184954109;4352.869413917556;4447.8443254486265;4483.036147228361;4495.235809912323;4463.129689710508;4467.441569803775;4473.105378924196;4485.50659427466;4510.030343476168;4454.799534020977;4462.642988560908;4467.352233926063;4468.955310446919;4485.3944717463055;4582.541745825424;4593.47175074864;4691;4699.506551812079;4705.670603057787;5043.722595257259;5099.031184075051;5099.515546023122;5115.667481613683;5157.819476318311;4895.461499235082;5112.463191364927;5112.795488180505;5113.207452844815;5114.744262786846;4695.178343789823;4736.9526304736855;4743.5967942724565;4749.715017098916;4799.0641824844515;5213.530782229617;5289.9471005290225;5300.966311569284;5320.201969704575;5321.547668448148;4858.125537403302;4975.154223781966;5079.212722028018;5085.644004919694;5100.69395836251;5040.722760248222;5123.590112790967;5179.637425380262;5197.636165468457;5247.344081989751;5022.547970682656;5033.672811267256;5087.567556757643;5095.923561146586;5135.537801597874;4837.6613637045775;4898.90202195954;4907.754612269372;5038.697678139323;5067.062593420229;4142.420061191436;4197.601227883346;4211.620954114144;4237.385579091015;4244.236037513278;3762.1347090169415;3765.849366025383;3770.8680196193;3799.9430008549894;3820.522434695663;4529.456465224128;4532.818687252473;4534.433195850519;4541.091781643684;4551.52209018055;4991.625628077909;5060;5107.029664363759;5110.28456016158;5119.078565858107;4462.821487140478;4469.754163520973;4470.597646211857;4502.684812063189;4508.526604706524;4509.7970591323465;4514.390557274792;4529.297958816389;4540.659450541157;4560.087982403533;4681.976590117096;4754.762261886961;4794.520547945178;4842.4189097308545;4873.074115918106;4964.627652926118;4969.503049695001;4980.452150263541;4988.376452943382;5015.899682006412;4768.070226305837;4773.618110551078;4792;4799.208130658542;4838.7822547986125;4910.82812101589;4975.278584605285;5031.094403007493;5054.887924656569;5092.8472145835685;5055.848324550269;5117.692938423706;5130.179171332569;5135.255387968649;5169.7673604687125;4839.879003024953;4946.1097002538445;4962.3052772611145;4963.801447942042;4967.379077615298;4875.658703890836;4877.585405240594;4918.532739389752;4937.506249375034;4966.18058020437;4836.758162091811;4868.61051115917;4887.486813884491;4900.901981960412;4916.85249442503;4806.807727690853;4983.202687569971;5000.524950129732;5011.4487406386;5053.646244762831;4831.106245344622;4836.153673107263;4852.393450818648;4870.439899411613;4959.429665588504 14:27:13 INFO - 2015-11-13 14:27:13,924 DEBUG : BROWSER_OUTPUT: |1;ext.html;564.2270089976732;572.3646752105162;573.1517354315613;580.6603137164758;582.1122787748685;36992.260154796924;36997.630023699756;37264.99999999996;37423.438648420226;37461.812690936575;38887.611123888826;39493.605063949355;39637;40079.198416031664;40367.59632403675;7926.8810967835525;8044.356451483896;8141.592920353988;8147;8157.143499932481;7842.3726101912;7985.920140798576;7989.201079892023;7998.480098793589;8013.439059265825;8017.238362355567;8065.1934806519175;8134.105248422668;8135.471194372377;8157.592120393986;7917.683292668286;8057.919420805805;8095.878561821548;8098.635561399751;8108.75673729789;7929.801754956115;8068.273855352988;8071.31393831525;8073.233042860918;8099.595020248964;36615;36863.262734745425;36900.07749806249;37265.81367093174;37320;2880.3807181456086;2967.2581854536365;3167.635721891989;3274.705276525124;3705.907352316187;27890.442191156064;28352.574711379344;28796.71203287961;28820.567691484644;28925.276868078257;2924.985375073132;2925.283305590144;2957.512010518262;2972.9256768580744;3006.699330066998;215432;215765;215858.99999999843;216112;216119.91940040357;49504.50495495071;50619.24071138936;52830.471695283326;52923.47076529262;52941.2058819118;48291;48368;48430;48786.5121348789;48998;14270.571882843531;14380.209088500233;14499.130052196902;14525.346359413852;14526;10882.347059176474;11063.612773552886;11074.394212839254;11106.333619982826;11109.444527773741;17780.91109544444;18408.631827363646;18524.351647692267;18719;18757;7424.443166762514;7588.241175882367;7665.8850117248285;7690.384769218449;7712.7300544481795;819.9754007379788;828.1966492502263;869.4174902815129;930.3534043839602;987.9209663226925;25303.873480632847;26079.087231946793;26602;26750.866245668647;26893.596596051077;916.1082364916559;936.4100616611628;938.5213541094091;946.2902822882838;1063.3194755356578;13909;14032.298385080909;14044.087134336236;14145.929270353583;14370.497032604018;265436;268673;270539;270852;271496;46051.30923036157;46326;46356.3046554302;46432.7678361606;46480;1187;1188.3107797477442;1189.9881001190051;1199.2504684572143;1202.326697049655;25408.237752867444;25436.49127017486;25604.23187304384;25642.871785640953;25834.87082564575;40551.59448405596;41194;41309.38035929403;41311.173776524905;41445;254644;256460;257972;260506;260813;29315.068493150513;29360;29831.850840745657;29867.10398688043;29884.551731723608;35059.298814024085;35795.463068053476;35988;36289.63710362863;36726.63273367339;30827.229319267197;30886;32680.67319326776;34793.826030869684;36277;32614;32963.67036329702;33060;33099.50350744693;33541.83229083839;33084.503732443554;33097.83451082729;33408;33444.66555334415;33502.329953401284;28578.428431431672;29611;30133.849330753204;30214.69785302119;30286.091417257518;23217.3034808956;23841.403964901016;23878;24131.75868241295;24185.51628967446 14:27:13 INFO - 2015-11-13 14:27:13,925 DEBUG : BROWSER_OUTPUT: |2;jquery.html;310.44275525431846;312.5265223186871;325.157980043056;326.6325383943064;332.2043705325745;10922.235443518957;11308.09535237181;14783.186924719135;15029.32368043438;15210.619734506628;10984.670459886196;11069.78232394436;11107.500162492686;11128.666140015792;11293.604723834667;4065.796710164495;4191.580841915815;4212.55768144345;4222.619964203221;4235.449391579091;4063.6952228582973;4115.115250221202;4151.750894946298;4162.167566486714;4183.393407955845;4128.834846606147;4137.834486620532;4288.399624052635;4436.201483732927;4437.35658329542;4322.092360604277;4391.341298805189;4391.912161756779;4403.6256918162;4406.713563618355;3754.399296112636;3990.221906728189;3991.600839916014;4008.8596899108684;4019.0756126091164;10809.513571889205;10872.130229581693;10974.835377469344;11054.060404865597;11088.279261848034;1661;1724.4136993422171;1750.772399588058;1760.0583687727133;1771.7076682347397;9056.637734490612;9318.86021709675;9461.24310055194;9481;9595.184409325217;1586.6292599550488;1610.9033457992557;1649.4062137630444;1650.909199994;1692.323070771689;52659.73670131625;54746.726266368416;54831;55404.16893746638;56066.71966640181;6394.488440924715;6463.7091330890225;6491.610503369813;6632.535722499379;6657.53397262187;7618.428617853683;7653.0051093358625;7763.068431788109;7795.493292935941;7803.804904877424;5263.973680131575;5340.25236466895;5344.064788662046;5376.569874410038;5421.1055175895535;5472.315960504937;5536.2249285100115;5536.640118392372;5539.086050801653;5544.944550554524;2996.445657553316;2996.625421822272;3028.4700177468853;3049;3058.831764252943;1050.1231471721046;1055.9260851740457;1059.5391004912888;1065.5418170186895;1117.234694234452;371.6432225063969;402.48883917424706;454.5499955044482;455.2306601842875;471.0602348315133;10557.9472102639;11397.829032564518;11401.315921044765;11404.315741055398;11516.1362897783;427.8609451928074;431.07749416249254;434.281264507241;443.16684632890605;454.7453426081405;5691.402402747734;6160.414760597736;6169.290531588835;6191.81424557255;6195.504359651217;494558;501862;502132;505321;513486;64897.351026490076;65804.67097664576;67042.66478667673;67385.66307168432;68300.6584967072;487.6562023773302;499.39323721678335;502.30430853268484;503.02915373329097;503.5342308364748;9622.951885240529;10279.94860025695;10418.322809017389;10598.31110977784;10660.786784264426;28790.856045719636;29197;29360.265993349483;30784;30908.845455772578;35993.64006359903;37107.8144609286;37135.25729485449;42183.578164217965;42753;5745.885082298414;5837.854053648693;5852.648841069549;5853.882922341444;5859.531237501075;10600.151987841109;10623.309484883457;10651.360918344924;10718.839217411589;11190.272632278877;8075.83848323042;8281.130481299377;9272.814543709223;9538.666146684833;9582.712518624452;9142;9394.43633381972;9414.011528789653;9567.282453815853;9641;9921.603135874484;10065.748356291151;10118.747031324276;10128.34165779222;10222.13111885498;5976.940230597812;6227.377262273918;6238.157848690369;6245.906311405423;6266.248050234001;9448.196903263299;9718.222542196467;9939.65211217604;9983.700488985342;10009.499525023573 14:27:13 INFO - 2015-11-13 14:27:13,928 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1441.0849110814643;1587.761835724641;1632.8367163283674;1657.4613250693528;1659.9253033613486;6260.968695156518;6419.486441084714;6446.742130314788;6640.169978752656;6695.598264104151;6803.591784492934;7034.2262351141335;7042.295770422955;7078.150621925363;7147.106611673541;2006.277740013594;2041.0407108658906;2044.631966246075;2051.3128102085743;2056.9201169386115;1991.2234228650766;2049.549099198174;2066.8863212523306;2079.854410191287;2088.6553718636483;2034.104993802722;2064.2465500092508;2070.492729281328;2071.326818783901;2071.9171233150655;2079.1995081893506;2104.5790841831617;2104.968425473619;2110.5778844231213;2111.4193596761015;2002.8497862660213;2013.8590298679098;2016.1935225909754;2017.404865564662;2031.5124370151204;6986.056882320923;7026.543274687129;7051.717931282743;7073.257307982639;7082.00851880732;4067.715259931806;4177.498700156001;4181.707280490367;4186.413902053715;4190.245755763961;2674.4651069785928;2815.81697189682;2837.872295746696;2846.245744877609;2850.4156647887135;1699.3967141664778;1709.803372612153;1713.3746182643245;1773.4245646232816;1783.2955982387014;9573.952130239304;9682.854757178648;9733.17268032211;9747.074027967403;9762.072603102693;3704.370257056307;3836.827342769582;3858.575556688762;3892.3188442022533;3894.240623078529;7687.730929417444;7770.922290777133;7810.062792464941;7868.527888326718;7913.287804097658;4254.659627229814;4267.551907049778;4274.358846173037;4284.378765079108;4291.506476755213;3912.041549820255;3921.137349783043;3927.9410808837893;3955.20895820837;3968.027833180889;3060.4185204811015;3068.98465507671;3110.502319628894;3141.8429078545983;3156.021633293686;942.6747772018642;955.5174636808367;956.818204541135;977.5014742481386;980.2060331131806;1136.72718547548;1148.3683973814368;1175.735459521601;1191.0531127753457;1191.8927296543352;6502.707378167994;6555.082288479617;6574.276829548746;6776.69504872282;7081.964590177016;934.065934065934;941.5010044676195;952.7046615549064;964.7250533597891;969.0842154164388;5143.305653736773;5256.474352564789;5281.55106815925;5346.572274218053;5356.250124982505;6752.5273230874345;6776.2546119926765;6854.6229957352825;6883.070785444002;6922.58464492132;7920.128785833554;8252.628631711588;8300.501969881827;8343.791405214919;8356.206160414751;6603.075569420285;6657.167854018247;6709.6980635871505;6717.932820671828;6741.797746067626;6371.808845734636;6439.291677915332;6504.349565043458;6540.084388185753;6542.44389226902;7322;7516.173220945582;7520.661570229244;7530.623468826647;7633.5419874807685;7670.846583068196;7726.18875018115;7876.212378762078;7958.641861116148;7979.122296547491;6109.083637454418;6112.786052488142;6167.074938759042;6174.950258456163;6182.474489668429;6996.685149168198;7027.648617568999;7050.435965122881;7053.576785392893;7057.36483716468;6356.173697419306;6404.615723056631;6411.743530258737;6599.241087275025;6689.632070236184;6527.11883895687;6616.4045235929;6643.534952553468;6648.401643852077;6715.496337774589;6440.710168042543;6462.901306777953;6509.641969691523;6509.772157974448;6529.9020514691365;6015.6691381974415;6066.696665166813;6103.450689437795;6103.908441373472;6106.175666285172;6122.265328160649;6127.417895299939;6179.474744646755;6189.6286222826775;6210.441060304413 14:27:13 INFO - 2015-11-13 14:27:13,929 DEBUG : BROWSER_OUTPUT: |4;prototype.html;304.52798162847586;307.37295916330686;314.00773555564405;314.8819192802699;316.45727577205116;5508.063629183039;5638.548916086714;5655.5475561955045;5663.603547751654;5674.773009079632;5503.284573005513;5540.141278101891;5547.72261386931;5567.220589117527;5567.47109024642;4113.547509773923;4264.701470897038;4306.18182545317;4308.482982042159;4315.568443155675;4249.851255206068;4254.127903779733;4260.637845783112;4265.104328091089;4282.828686852522;4222.324428091506;4226.112516371566;4230.069384735353;4234.597713217239;4235.258829704805;4219.303814870558;4221.577842215785;4228.788560571975;4231.1749208904275;4240.960964563671;3433.6051354094348;3669.9633003669887;3676.8713095041544;3677.5403074615674;3679.1537946272238;5079.873003174913;5203.713795741232;5244.947550524484;5260.2372655965055;5263.473652634744;4826.758662066883;4847.272909063633;4852.320675105488;4852.514748525119;4857.927131093036;5761.798337058183;5833.095870140135;5859.7656093756195;5860.120981852713;5864.354920958691;3865.265599536079;3933.331333673282;3958.6239307265764;3962.286788378091;3963.8414463421427;6085.786997455112;6165.506759459233;6172.07418887166;6173.722182501753;6182.659953702545;3990.3216453203027;4046.575109613448;4089.5092588889524;4095.815688294034;4100.5489396166395;4110.876673699794;4111.814968326433;4113.300738874398;4124.628783409447;4153.792310384529;4608.5621865922685;4849.151398505318;4850.223964165716;4852.975735121302;4859.3682821233015;5761.711914404263;5835.854103647443;5863.501602363762;5868.530517558585;5873.060310350324;1450.3111022264552;1451.122071146962;1451.8330392004843;1474.1523623916078;1474.7492926202572;964.4068897627908;981.8969008254173;990.019880318494;992.0674565908023;1006.2603986070233;5144.176931690911;5151.4333423323405;5154.7938082476285;5159.948400516022;5165.251038599382;5934.228550288435;5985.281766187998;5987.042073268256;6040;6047.78832740852;5118.155504341817;5124.333836601292;5127.359080114986;5140.3831540215415;5141.897162056738;3175.9836852207072;3239.7570182236427;3261.119497735598;3269.395161895057;3271.836408179629;5612.663240205601;5630.155476678449;5671.829845104653;5687.9431205687415;5688.601797874109;6191.690415479208;6264.123022776815;6269.968650156811;6276.748930042839;6293.339199383999;5659.603827732101;5660.603757737002;5689.9146512802345;5751.798687045934;5758.337791154071;6026.126211699367;6055.333913269625;6070.0591408331775;6077.4834139098675;6094.360092190256;5819.476247137778;5964.373740757158;5971.820845374646;5987.730552125077;6021.849453763691;5762.740676669644;5765.1928729977;5766.711664416846;5772.509336706427;5785;4034.2133284009337;4035.435039094588;4041.0503531669447;4058.1477889643506;4066.0851308456545;5827.825165245049;5993.31076926159;6000.69996500182;6002.549808764273;6031.939680603138;5733.569982251264;5739.971300143473;5742.540596752333;5750.741216645345;5751.424857514216;5815.098659707752;5829.125631155191;5861.912071319019;5864.354920958605;5867.970660146672;5513.283273174462;5723.399043100415;5731.8567035824435;5750.367459579526;5760.942390576208;5774.0761478163295;5776.537876969748;5843.065109582616;5875.882482350415;5891.705414729161;5581.023320918905;5687.630304030225;5691.231683722644;5723.284589426322;5741.425857414225 14:27:13 INFO - 2015-11-13 14:27:13,931 DEBUG : BROWSER_OUTPUT: |5;yui.html;628.6416742456798;755.792157156782;771.4252881603206;776.3944123583607;780.3679019993809;11504.827427588583;11732.120090993178;11752.471138798743;13377.59867203983;13389.263590502544;12492.312922789266;12759.617211483646;12809.551665691703;12824.166429182096;12868.09923305369;732.7179036071097;743.5724458436393;752.4807882561015;755.6788364944904;757.2162811490109;741.6180666956494;746.7274444827653;748.4162353364358;749.3892477630714;750.6922161913617;774.6785084190054;780.0327593783724;783.4046124945025;784.3215618489994;787.94484386093;758.2379708393084;770.8920751094852;771.1478815908397;771.7221800151941;778.828657695309;563.276190095725;563.613924461745;564.5540023381565;570.6918264137361;572.6077636818792;11845.822312665317;11930.701732456671;12125.333106679129;12151.878481215163;12163.939180304042;8771.12288771124;8871.866921996176;9007.68876588623;9147.725568232963;9593.280503962162;8396.874046889301;8568.485890846569;8572.785680357978;8717.389782715212;9241.537923103886;2734.6991830898587;2769.4599553087155;2824.1668707731064;2829.39168078862;2848.700886406918;37136.62863371359;37672.99999999972;37968.810155949046;38145.42781858274;38275.808620956996;6238;6302.306746257908;6351.96824015877;6360.936390636127;6384.106225128486;9981.750456238507;9983.35108217978;9984.750381240381;10014.599416023277;10034.949825250827;5574.442555744474;5583.804566840141;5591.7483713233005;5715.685637289906;5864.237649105674;3553.307105114478;3650.7261955353456;3671.0638787109115;3674.52231209941;3674.779513229215;2317.3627252505694;2318.2002209237785;2319.373769082372;2323.93028209154;2328.2898715891815;392.95481019683103;395.7744085871083;395.91289916218386;396.3044856277273;396.3974758367266;465.6158669098008;487.5270987142466;489.559396543114;493.5705935835846;556.8635684257301;7791.376689864911;7943.682252709942;8077.959610201911;8084.272415482635;8369.455985360932;474.27199249152386;522.0837430309782;533.773146412773;550.2736387967844;554.9805756798493;3514.578250609943;3603.3153700796765;3605.4772058051435;3704.5739739929713;3744.1575645479547;54627.453725463034;54797.90404191973;54883.45116548784;55017.1747423789;55143.448565514635;46827.531724683;47035.76482117636;47178.29232561514;47339.5266047342;48143;40591;41494.79252603718;42166.789166053975;42952.140957181306;43254.351184732885;7712.537247765152;7746.65140068687;7862.842743145219;7994.600269986361;8426;30900;30978.69021309758;31559.368812624078;31606.841965790023;31860.522092168172;40221.1955760889;40990.385144222266;41655.7917210412;41907.161856763305;41916.58083419127;6790.151231096113;7092.929070709227;7218.169910460364;7226.313500217471;7264.309890560388;10711.571537138427;10767.6231331903;10778.353298802096;10963.616273430393;11079;10212.285140040423;10499.632512862014;10648.680539583826;10673.092787113183;10692.251542391958;10416.270861039655;10590.576376944837;10647.467626618793;10653.094486968694;10657.25399222047;10113.089821916063;10192;10216.438095904796;10217.438040907822;10222.284440089123;8613.397062205586;8867.73396798097;8972.641094356153;9018.143276388733;9053.456792592202;8858.867116993122;8865.734027979172;8938.553072346487;9122.224610908148;9213.493257870881 14:27:13 INFO - 2015-11-13 14:27:13,931 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:27:13 INFO - 2015-11-13 14:27:13,931 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:27:13 INFO - 2015-11-13 14:27:13,931 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,303 14:27:13 INFO - 2015-11-13 14:27:13,931 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:27:13 INFO - 2015-11-13 14:27:13,931 DEBUG : BROWSER_OUTPUT: __startTimestamp1447453633917__endTimestamp 14:27:13 INFO - 2015-11-13 14:27:13,931 DEBUG : BROWSER_OUTPUT: 14:27:13 INFO - 2015-11-13 14:27:13,931 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:27:13 INFO - 2015-11-13 14:27:13,932 DEBUG : BROWSER_OUTPUT: Number of tests: 6 14:27:13 INFO - 2015-11-13 14:27:13,932 DEBUG : BROWSER_OUTPUT: 14:27:13 INFO - 2015-11-13 14:27:13,932 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4712.99 Median:4828.73 stddev:472.39 (9.8%) stddev-sans-first:446.03 14:27:13 INFO - 2015-11-13 14:27:13,932 DEBUG : BROWSER_OUTPUT: Values: 2677.3 2730.5 2755.1 2755.8 2770.4 4608.8 4734.6 4758.7 4764.6 4774.1 4722.0 4734.1 4774.8 4822.3 4828.7 4382.1 4403.1 4463.0 4470.7 4495.1 4418.6 4479.1 4520.4 4559.8 4586.8 4334.4 4352.9 4447.8 4483.0 4495.2 4463.1 4467.4 4473.1 4485.5 4510.0 4454.8 4462.6 4467.4 4469.0 4485.4 4582.5 4593.5 4691.0 4699.5 4705.7 5043.7 5099.0 5099.5 5115.7 5157.8 4895.5 5112.5 5112.8 5113.2 5114.7 4695.2 4737.0 4743.6 4749.7 4799.1 5213.5 5289.9 5301.0 5320.2 5321.5 4858.1 4975.2 5079.2 5085.6 5100.7 5040.7 5123.6 5179.6 5197.6 5247.3 5022.5 5033.7 5087.6 5095.9 5135.5 4837.7 4898.9 4907.8 5038.7 5067.1 4142.4 4197.6 4211.6 4237.4 4244.2 3762.1 3765.8 3770.9 3799.9 3820.5 4529.5 4532.8 4534.4 4541.1 4551.5 4991.6 5060.0 5107.0 5110.3 5119.1 4462.8 4469.8 4470.6 4502.7 4508.5 4509.8 4514.4 4529.3 4540.7 4560.1 4682.0 4754.8 4794.5 4842.4 4873.1 4964.6 4969.5 4980.5 4988.4 5015.9 4768.1 4773.6 4792.0 4799.2 4838.8 4910.8 4975.3 5031.1 5054.9 5092.8 5055.8 5117.7 5130.2 5135.3 5169.8 4839.9 4946.1 4962.3 4963.8 4967.4 4875.7 4877.6 4918.5 4937.5 4966.2 4836.8 4868.6 4887.5 4900.9 4916.9 4806.8 4983.2 5000.5 5011.4 5053.6 4831.1 4836.2 4852.4 4870.4 4959.4 14:27:13 INFO - 2015-11-13 14:27:13,932 DEBUG : BROWSER_OUTPUT: 14:27:13 INFO - 2015-11-13 14:27:13,932 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40553.13 Median:33473.50 stddev:64764.86 (193.5%) stddev-sans-first:64876.94 14:27:13 INFO - 2015-11-13 14:27:13,932 DEBUG : BROWSER_OUTPUT: Values: 564.2 572.4 573.2 580.7 582.1 36992.3 36997.6 37265.0 37423.4 37461.8 38887.6 39493.6 39637.0 40079.2 40367.6 7926.9 8044.4 8141.6 8147.0 8157.1 7842.4 7985.9 7989.2 7998.5 8013.4 8017.2 8065.2 8134.1 8135.5 8157.6 7917.7 8057.9 8095.9 8098.6 8108.8 7929.8 8068.3 8071.3 8073.2 8099.6 36615.0 36863.3 36900.1 37265.8 37320.0 2880.4 2967.3 3167.6 3274.7 3705.9 27890.4 28352.6 28796.7 28820.6 28925.3 2925.0 2925.3 2957.5 2972.9 3006.7 215432.0 215765.0 215859.0 216112.0 216119.9 49504.5 50619.2 52830.5 52923.5 52941.2 48291.0 48368.0 48430.0 48786.5 48998.0 14270.6 14380.2 14499.1 14525.3 14526.0 10882.3 11063.6 11074.4 11106.3 11109.4 17780.9 18408.6 18524.4 18719.0 18757.0 7424.4 7588.2 7665.9 7690.4 7712.7 820.0 828.2 869.4 930.4 987.9 25303.9 26079.1 26602.0 26750.9 26893.6 916.1 936.4 938.5 946.3 1063.3 13909.0 14032.3 14044.1 14145.9 14370.5 265436.0 268673.0 270539.0 270852.0 271496.0 46051.3 46326.0 46356.3 46432.8 46480.0 1187.0 1188.3 1190.0 1199.3 1202.3 25408.2 25436.5 25604.2 25642.9 25834.9 40551.6 41194.0 41309.4 41311.2 41445.0 254644.0 256460.0 257972.0 260506.0 260813.0 29315.1 29360.0 29831.9 29867.1 29884.6 35059.3 35795.5 35988.0 36289.6 36726.6 30827.2 30886.0 32680.7 34793.8 36277.0 32614.0 32963.7 33060.0 33099.5 33541.8 33084.5 33097.8 33408.0 33444.7 33502.3 28578.4 29611.0 30133.8 30214.7 30286.1 23217.3 23841.4 23878.0 24131.8 24185.5 14:27:13 INFO - 2015-11-13 14:27:13,933 DEBUG : BROWSER_OUTPUT: 14:27:13 INFO - 2015-11-13 14:27:13,933 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24516.83 Median:2376.58 stddev:82448.38 (3469.2%) stddev-sans-first:82659.63 14:27:13 INFO - 2015-11-13 14:27:13,935 DEBUG : BROWSER_OUTPUT: Values: 310.4 312.5 325.2 326.6 332.2 10922.2 11308.1 14783.2 15029.3 15210.6 10984.7 11069.8 11107.5 11128.7 11293.6 4065.8 4191.6 4212.6 4222.6 4235.4 4063.7 4115.1 4151.8 4162.2 4183.4 4128.8 4137.8 4288.4 4436.2 4437.4 4322.1 4391.3 4391.9 4403.6 4406.7 3754.4 3990.2 3991.6 4008.9 4019.1 10809.5 10872.1 10974.8 11054.1 11088.3 1661.0 1724.4 1750.8 1760.1 1771.7 9056.6 9318.9 9461.2 9481.0 9595.2 1586.6 1610.9 1649.4 1650.9 1692.3 52659.7 54746.7 54831.0 55404.2 56066.7 6394.5 6463.7 6491.6 6632.5 6657.5 7618.4 7653.0 7763.1 7795.5 7803.8 5264.0 5340.3 5344.1 5376.6 5421.1 5472.3 5536.2 5536.6 5539.1 5544.9 2996.4 2996.6 3028.5 3049.0 3058.8 1050.1 1055.9 1059.5 1065.5 1117.2 371.6 402.5 454.5 455.2 471.1 10557.9 11397.8 11401.3 11404.3 11516.1 427.9 431.1 434.3 443.2 454.7 5691.4 6160.4 6169.3 6191.8 6195.5 494558.0 501862.0 502132.0 505321.0 513486.0 64897.4 65804.7 67042.7 67385.7 68300.7 487.7 499.4 502.3 503.0 503.5 9623.0 10279.9 10418.3 10598.3 10660.8 28790.9 29197.0 29360.3 30784.0 30908.8 35993.6 37107.8 37135.3 42183.6 42753.0 5745.9 5837.9 5852.6 5853.9 5859.5 10600.2 10623.3 10651.4 10718.8 11190.3 8075.8 8281.1 9272.8 9538.7 9582.7 9142.0 9394.4 9414.0 9567.3 9641.0 9921.6 10065.7 10118.7 10128.3 10222.1 5976.9 6227.4 6238.2 6245.9 6266.2 9448.2 9718.2 9939.7 9983.7 10009.5 14:27:13 INFO - 2015-11-13 14:27:13,935 DEBUG : BROWSER_OUTPUT: 14:27:13 INFO - 2015-11-13 14:27:13,935 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4930.15 Median:6308.57 stddev:2461.31 (39.0%) stddev-sans-first:2454.24 14:27:13 INFO - 2015-11-13 14:27:13,935 DEBUG : BROWSER_OUTPUT: Values: 1441.1 1587.8 1632.8 1657.5 1659.9 6261.0 6419.5 6446.7 6640.2 6695.6 6803.6 7034.2 7042.3 7078.2 7147.1 2006.3 2041.0 2044.6 2051.3 2056.9 1991.2 2049.5 2066.9 2079.9 2088.7 2034.1 2064.2 2070.5 2071.3 2071.9 2079.2 2104.6 2105.0 2110.6 2111.4 2002.8 2013.9 2016.2 2017.4 2031.5 6986.1 7026.5 7051.7 7073.3 7082.0 4067.7 4177.5 4181.7 4186.4 4190.2 2674.5 2815.8 2837.9 2846.2 2850.4 1699.4 1709.8 1713.4 1773.4 1783.3 9574.0 9682.9 9733.2 9747.1 9762.1 3704.4 3836.8 3858.6 3892.3 3894.2 7687.7 7770.9 7810.1 7868.5 7913.3 4254.7 4267.6 4274.4 4284.4 4291.5 3912.0 3921.1 3927.9 3955.2 3968.0 3060.4 3069.0 3110.5 3141.8 3156.0 942.7 955.5 956.8 977.5 980.2 1136.7 1148.4 1175.7 1191.1 1191.9 6502.7 6555.1 6574.3 6776.7 7082.0 934.1 941.5 952.7 964.7 969.1 5143.3 5256.5 5281.6 5346.6 5356.3 6752.5 6776.3 6854.6 6883.1 6922.6 7920.1 8252.6 8300.5 8343.8 8356.2 6603.1 6657.2 6709.7 6717.9 6741.8 6371.8 6439.3 6504.3 6540.1 6542.4 7322.0 7516.2 7520.7 7530.6 7633.5 7670.8 7726.2 7876.2 7958.6 7979.1 6109.1 6112.8 6167.1 6175.0 6182.5 6996.7 7027.6 7050.4 7053.6 7057.4 6356.2 6404.6 6411.7 6599.2 6689.6 6527.1 6616.4 6643.5 6648.4 6715.5 6440.7 6462.9 6509.6 6509.8 6529.9 6015.7 6066.7 6103.5 6103.9 6106.2 6122.3 6127.4 6179.5 6189.6 6210.4 14:27:13 INFO - 2015-11-13 14:27:13,936 DEBUG : BROWSER_OUTPUT: 14:27:13 INFO - 2015-11-13 14:27:13,937 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4808.90 Median:5557.47 stddev:1436.70 (25.9%) stddev-sans-first:1400.38 14:27:13 INFO - 2015-11-13 14:27:13,937 DEBUG : BROWSER_OUTPUT: Values: 304.5 307.4 314.0 314.9 316.5 5508.1 5638.5 5655.5 5663.6 5674.8 5503.3 5540.1 5547.7 5567.2 5567.5 4113.5 4264.7 4306.2 4308.5 4315.6 4249.9 4254.1 4260.6 4265.1 4282.8 4222.3 4226.1 4230.1 4234.6 4235.3 4219.3 4221.6 4228.8 4231.2 4241.0 3433.6 3670.0 3676.9 3677.5 3679.2 5079.9 5203.7 5244.9 5260.2 5263.5 4826.8 4847.3 4852.3 4852.5 4857.9 5761.8 5833.1 5859.8 5860.1 5864.4 3865.3 3933.3 3958.6 3962.3 3963.8 6085.8 6165.5 6172.1 6173.7 6182.7 3990.3 4046.6 4089.5 4095.8 4100.5 4110.9 4111.8 4113.3 4124.6 4153.8 4608.6 4849.2 4850.2 4853.0 4859.4 5761.7 5835.9 5863.5 5868.5 5873.1 1450.3 1451.1 1451.8 1474.2 1474.7 964.4 981.9 990.0 992.1 1006.3 5144.2 5151.4 5154.8 5159.9 5165.3 5934.2 5985.3 5987.0 6040.0 6047.8 5118.2 5124.3 5127.4 5140.4 5141.9 3176.0 3239.8 3261.1 3269.4 3271.8 5612.7 5630.2 5671.8 5687.9 5688.6 6191.7 6264.1 6270.0 6276.7 6293.3 5659.6 5660.6 5689.9 5751.8 5758.3 6026.1 6055.3 6070.1 6077.5 6094.4 5819.5 5964.4 5971.8 5987.7 6021.8 5762.7 5765.2 5766.7 5772.5 5785.0 4034.2 4035.4 4041.1 4058.1 4066.1 5827.8 5993.3 6000.7 6002.5 6031.9 5733.6 5740.0 5742.5 5750.7 5751.4 5815.1 5829.1 5861.9 5864.4 5868.0 5513.3 5723.4 5731.9 5750.4 5760.9 5774.1 5776.5 5843.1 5875.9 5891.7 5581.0 5687.6 5691.2 5723.3 5741.4 14:27:13 INFO - 2015-11-13 14:27:13,938 DEBUG : BROWSER_OUTPUT: 14:27:13 INFO - 2015-11-13 14:27:13,939 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12032.29 Median:491.56 stddev:14529.60 (2955.8%) stddev-sans-first:14545.12 14:27:13 INFO - 2015-11-13 14:27:13,939 DEBUG : BROWSER_OUTPUT: Values: 628.6 755.8 771.4 776.4 780.4 11504.8 11732.1 11752.5 13377.6 13389.3 12492.3 12759.6 12809.6 12824.2 12868.1 732.7 743.6 752.5 755.7 757.2 741.6 746.7 748.4 749.4 750.7 774.7 780.0 783.4 784.3 787.9 758.2 770.9 771.1 771.7 778.8 563.3 563.6 564.6 570.7 572.6 11845.8 11930.7 12125.3 12151.9 12163.9 8771.1 8871.9 9007.7 9147.7 9593.3 8396.9 8568.5 8572.8 8717.4 9241.5 2734.7 2769.5 2824.2 2829.4 2848.7 37136.6 37673.0 37968.8 38145.4 38275.8 6238.0 6302.3 6352.0 6360.9 6384.1 9981.8 9983.4 9984.8 10014.6 10034.9 5574.4 5583.8 5591.7 5715.7 5864.2 3553.3 3650.7 3671.1 3674.5 3674.8 2317.4 2318.2 2319.4 2323.9 2328.3 393.0 395.8 395.9 396.3 396.4 465.6 487.5 489.6 493.6 556.9 7791.4 7943.7 8078.0 8084.3 8369.5 474.3 522.1 533.8 550.3 555.0 3514.6 3603.3 3605.5 3704.6 3744.2 54627.5 54797.9 54883.5 55017.2 55143.4 46827.5 47035.8 47178.3 47339.5 48143.0 40591.0 41494.8 42166.8 42952.1 43254.4 7712.5 7746.7 7862.8 7994.6 8426.0 30900.0 30978.7 31559.4 31606.8 31860.5 40221.2 40990.4 41655.8 41907.2 41916.6 6790.2 7092.9 7218.2 7226.3 7264.3 10711.6 10767.6 10778.4 10963.6 11079.0 10212.3 10499.6 10648.7 10673.1 10692.3 10416.3 10590.6 10647.5 10653.1 10657.3 10113.1 10192.0 10216.4 10217.4 10222.3 8613.4 8867.7 8972.6 9018.1 9053.5 8858.9 8865.7 8938.6 9122.2 9213.5 14:27:13 INFO - 2015-11-13 14:27:13,939 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:27:13 INFO - 2015-11-13 14:27:13,939 DEBUG : BROWSER_OUTPUT: 14:27:14 INFO - 2015-11-13 14:27:14,729 INFO : Browser exited with error code: 0 14:27:14 INFO - 2015-11-13 14:27:14,751 INFO : Completed test dromaeo_css (00:18:40) 14:27:14 INFO - 2015-11-13 14:27:14,751 INFO : Starting test kraken 14:27:14 INFO - 2015-11-13 14:27:14,751 DEBUG : operating with platform_type : linux_ 14:27:14 INFO - 2015-11-13 14:27:14,751 INFO : Initialising browser for kraken test... 14:27:14 INFO - 2015-11-13 14:27:14,757 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJfRUYu/profile http://localhost:35795/getInfo.html 14:27:20 INFO - 2015-11-13 14:27:20,461 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:27:20 INFO - 2015-11-13 14:27:20,461 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:27:20 INFO - 2015-11-13 14:27:20,461 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:27:20 INFO - 2015-11-13 14:27:20,461 DEBUG : BROWSER_OUTPUT: __metrics 14:27:21 INFO - 2015-11-13 14:27:21,701 INFO : Browser initialized. 14:27:21 INFO - 2015-11-13 14:27:21,702 INFO : Running cycle 1/1 for kraken test... 14:27:21 INFO - 2015-11-13 14:27:21,702 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJfRUYu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:27:33 INFO - 2015-11-13 14:27:33,703 DEBUG : BROWSER_OUTPUT: RSS: Main: 141189120 14:27:33 INFO - 2015-11-13 14:27:33,704 DEBUG : BROWSER_OUTPUT: 14:27:36 INFO - 2015-11-13 14:27:36,352 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35795/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35795/tests/kraken/driver.html?testName=audio-beat-detection) 14:27:36 INFO - 2015-11-13 14:27:36,966 DEBUG : BROWSER_OUTPUT: RSS: Main: 140660736 14:27:36 INFO - 2015-11-13 14:27:36,966 DEBUG : BROWSER_OUTPUT: 14:27:39 INFO - 2015-11-13 14:27:39,689 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35795/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35795/tests/kraken/driver.html?testName=audio-dft) 14:27:40 INFO - 2015-11-13 14:27:40,290 DEBUG : BROWSER_OUTPUT: RSS: Main: 141344768 14:27:40 INFO - 2015-11-13 14:27:40,291 DEBUG : BROWSER_OUTPUT: 14:27:43 INFO - 2015-11-13 14:27:43,194 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35795/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35795/tests/kraken/driver.html?testName=audio-fft) 14:27:43 INFO - 2015-11-13 14:27:43,777 DEBUG : BROWSER_OUTPUT: RSS: Main: 137396224 14:27:43 INFO - 2015-11-13 14:27:43,777 DEBUG : BROWSER_OUTPUT: 14:27:45 INFO - 2015-11-13 14:27:45,870 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35795/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35795/tests/kraken/driver.html?testName=audio-oscillator) 14:27:46 INFO - 2015-11-13 14:27:46,459 DEBUG : BROWSER_OUTPUT: RSS: Main: 136818688 14:27:46 INFO - 2015-11-13 14:27:46,459 DEBUG : BROWSER_OUTPUT: 14:27:48 INFO - 2015-11-13 14:27:48,714 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35795/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35795/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:27:49 INFO - 2015-11-13 14:27:49,300 DEBUG : BROWSER_OUTPUT: RSS: Main: 138387456 14:27:49 INFO - 2015-11-13 14:27:49,300 DEBUG : BROWSER_OUTPUT: 14:27:52 INFO - 2015-11-13 14:27:52,392 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35795/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35795/tests/kraken/driver.html?testName=imaging-darkroom) 14:27:52 INFO - 2015-11-13 14:27:52,993 DEBUG : BROWSER_OUTPUT: RSS: Main: 138149888 14:27:52 INFO - 2015-11-13 14:27:52,994 DEBUG : BROWSER_OUTPUT: 14:27:56 INFO - 2015-11-13 14:27:56,500 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35795/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35795/tests/kraken/driver.html?testName=imaging-desaturate) 14:27:57 INFO - 2015-11-13 14:27:57,094 DEBUG : BROWSER_OUTPUT: RSS: Main: 136142848 14:27:57 INFO - 2015-11-13 14:27:57,094 DEBUG : BROWSER_OUTPUT: 14:28:00 INFO - 2015-11-13 14:28:00,037 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35795/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35795/tests/kraken/driver.html?testName=json-parse-financial) 14:28:00 INFO - 2015-11-13 14:28:00,639 DEBUG : BROWSER_OUTPUT: RSS: Main: 136589312 14:28:00 INFO - 2015-11-13 14:28:00,639 DEBUG : BROWSER_OUTPUT: 14:28:02 INFO - 2015-11-13 14:28:02,401 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35795/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35795/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:28:02 INFO - 2015-11-13 14:28:02,987 DEBUG : BROWSER_OUTPUT: RSS: Main: 137834496 14:28:02 INFO - 2015-11-13 14:28:02,987 DEBUG : BROWSER_OUTPUT: 14:28:04 INFO - 2015-11-13 14:28:04,886 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35795/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35795/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:28:05 INFO - 2015-11-13 14:28:05,508 DEBUG : BROWSER_OUTPUT: RSS: Main: 138690560 14:28:05 INFO - 2015-11-13 14:28:05,508 DEBUG : BROWSER_OUTPUT: 14:28:07 INFO - 2015-11-13 14:28:07,632 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35795/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35795/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:28:08 INFO - 2015-11-13 14:28:08,234 DEBUG : BROWSER_OUTPUT: RSS: Main: 138383360 14:28:08 INFO - 2015-11-13 14:28:08,234 DEBUG : BROWSER_OUTPUT: 14:28:10 INFO - 2015-11-13 14:28:10,790 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35795/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35795/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:28:11 INFO - 2015-11-13 14:28:11,392 DEBUG : BROWSER_OUTPUT: RSS: Main: 139423744 14:28:11 INFO - 2015-11-13 14:28:11,392 DEBUG : BROWSER_OUTPUT: 14:28:14 INFO - 2015-11-13 14:28:14,048 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35795/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35795/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:28:14 INFO - 2015-11-13 14:28:14,634 DEBUG : BROWSER_OUTPUT: RSS: Main: 139685888 14:28:14 INFO - 2015-11-13 14:28:14,634 DEBUG : BROWSER_OUTPUT: 14:28:16 INFO - 2015-11-13 14:28:16,429 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35795/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35795/tests/kraken/driver.html?testName=ai-astar) 14:28:16 INFO - 2015-11-13 14:28:16,679 DEBUG : BROWSER_OUTPUT: RSS: Main: 139563008 14:28:16 INFO - 2015-11-13 14:28:16,680 DEBUG : BROWSER_OUTPUT: 14:28:16 INFO - 2015-11-13 14:28:16,681 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:28:16 INFO - 2015-11-13 14:28:16,681 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:28:16 INFO - 2015-11-13 14:28:16,681 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:28:16 INFO - 2015-11-13 14:28:16,681 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:28:16 INFO - 2015-11-13 14:28:16,682 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;108;113;112;115;125;113;111;111;112 14:28:16 INFO - 2015-11-13 14:28:16,682 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;132;157;169;141;157;159;131;169;130 14:28:16 INFO - 2015-11-13 14:28:16,682 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;164;162;163;164;173;164;162;167;163 14:28:16 INFO - 2015-11-13 14:28:16,682 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;74;73;74;125;73;74;72;74 14:28:16 INFO - 2015-11-13 14:28:16,682 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;92;135;91;92;91;126;92;92;126 14:28:16 INFO - 2015-11-13 14:28:16,682 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;109;110;110;111;111;110;110 14:28:16 INFO - 2015-11-13 14:28:16,683 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;149;150;151;149;149;148;151;149;150;148 14:28:16 INFO - 2015-11-13 14:28:16,683 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;103;96;96;96;97;96;97;95;96 14:28:16 INFO - 2015-11-13 14:28:16,683 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;71;70;70;72;70;71;73;71;72 14:28:16 INFO - 2015-11-13 14:28:16,683 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;69;69;70;70;70;69;69;71 14:28:16 INFO - 2015-11-13 14:28:16,683 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;82;84;84;84;84;87;83;84;85 14:28:16 INFO - 2015-11-13 14:28:16,683 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;124;120;128;124;127;123;121;125;132 14:28:16 INFO - 2015-11-13 14:28:16,684 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;151;157;151;152;165;160;150;141;144 14:28:16 INFO - 2015-11-13 14:28:16,684 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;72;70;71;74;70;69;71;70;70 14:28:16 INFO - 2015-11-13 14:28:16,684 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:28:16 INFO - 2015-11-13 14:28:16,684 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:28:16 INFO - 2015-11-13 14:28:16,684 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,764 14:28:16 INFO - 2015-11-13 14:28:16,685 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:28:16 INFO - 2015-11-13 14:28:16,685 DEBUG : BROWSER_OUTPUT: __startTimestamp1447453696680__endTimestamp 14:28:16 INFO - 2015-11-13 14:28:16,685 DEBUG : BROWSER_OUTPUT: 14:28:16 INFO - 2015-11-13 14:28:16,689 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:28:16 INFO - 2015-11-13 14:28:16,689 DEBUG : BROWSER_OUTPUT: Number of tests: 14 14:28:16 INFO - 2015-11-13 14:28:16,689 DEBUG : BROWSER_OUTPUT: 14:28:16 INFO - 2015-11-13 14:28:16,689 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:113.30 Median:113.00 stddev:4.50 (4.0%) stddev-sans-first:4.77 14:28:16 INFO - 2015-11-13 14:28:16,689 DEBUG : BROWSER_OUTPUT: Values: 113.0 108.0 113.0 112.0 115.0 125.0 113.0 111.0 111.0 112.0 14:28:16 INFO - 2015-11-13 14:28:16,689 DEBUG : BROWSER_OUTPUT: 14:28:16 INFO - 2015-11-13 14:28:16,689 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.00 Median:157.00 stddev:15.25 (9.7%) stddev-sans-first:16.06 14:28:16 INFO - 2015-11-13 14:28:16,690 DEBUG : BROWSER_OUTPUT: Values: 155.0 132.0 157.0 169.0 141.0 157.0 159.0 131.0 169.0 130.0 14:28:16 INFO - 2015-11-13 14:28:16,690 DEBUG : BROWSER_OUTPUT: 14:28:16 INFO - 2015-11-13 14:28:16,690 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.60 Median:164.00 stddev:3.27 (2.0%) stddev-sans-first:3.46 14:28:16 INFO - 2015-11-13 14:28:16,690 DEBUG : BROWSER_OUTPUT: Values: 164.0 164.0 162.0 163.0 164.0 173.0 164.0 162.0 167.0 163.0 14:28:16 INFO - 2015-11-13 14:28:16,690 DEBUG : BROWSER_OUTPUT: 14:28:16 INFO - 2015-11-13 14:28:16,690 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.50 Median:73.50 stddev:16.35 (22.2%) stddev-sans-first:17.22 14:28:16 INFO - 2015-11-13 14:28:16,690 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 74.0 73.0 74.0 125.0 73.0 74.0 72.0 74.0 14:28:16 INFO - 2015-11-13 14:28:16,690 DEBUG : BROWSER_OUTPUT: 14:28:16 INFO - 2015-11-13 14:28:16,690 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.80 Median:91.50 stddev:18.25 (19.9%) stddev-sans-first:18.85 14:28:16 INFO - 2015-11-13 14:28:16,690 DEBUG : BROWSER_OUTPUT: Values: 91.0 92.0 135.0 91.0 92.0 91.0 126.0 92.0 92.0 126.0 14:28:16 INFO - 2015-11-13 14:28:16,690 DEBUG : BROWSER_OUTPUT: 14:28:16 INFO - 2015-11-13 14:28:16,691 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 14:28:16 INFO - 2015-11-13 14:28:16,691 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 109.0 110.0 110.0 111.0 111.0 110.0 110.0 14:28:16 INFO - 2015-11-13 14:28:16,691 DEBUG : BROWSER_OUTPUT: 14:28:16 INFO - 2015-11-13 14:28:16,691 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:149.40 Median:149.50 stddev:1.07 (0.7%) stddev-sans-first:1.13 14:28:16 INFO - 2015-11-13 14:28:16,691 DEBUG : BROWSER_OUTPUT: Values: 149.0 150.0 151.0 149.0 149.0 148.0 151.0 149.0 150.0 148.0 14:28:16 INFO - 2015-11-13 14:28:16,691 DEBUG : BROWSER_OUTPUT: 14:28:16 INFO - 2015-11-13 14:28:16,691 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.80 Median:96.00 stddev:2.25 (2.3%) stddev-sans-first:2.37 14:28:16 INFO - 2015-11-13 14:28:16,691 DEBUG : BROWSER_OUTPUT: Values: 96.0 103.0 96.0 96.0 96.0 97.0 96.0 97.0 95.0 96.0 14:28:16 INFO - 2015-11-13 14:28:16,692 DEBUG : BROWSER_OUTPUT: 14:28:16 INFO - 2015-11-13 14:28:16,692 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.10 Median:71.00 stddev:0.99 (1.4%) stddev-sans-first:1.05 14:28:16 INFO - 2015-11-13 14:28:16,692 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 70.0 70.0 72.0 70.0 71.0 73.0 71.0 72.0 14:28:16 INFO - 2015-11-13 14:28:16,692 DEBUG : BROWSER_OUTPUT: 14:28:16 INFO - 2015-11-13 14:28:16,692 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.50 Median:69.50 stddev:0.71 (1.0%) stddev-sans-first:0.73 14:28:16 INFO - 2015-11-13 14:28:16,692 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 69.0 70.0 70.0 70.0 69.0 69.0 71.0 14:28:16 INFO - 2015-11-13 14:28:16,692 DEBUG : BROWSER_OUTPUT: 14:28:16 INFO - 2015-11-13 14:28:16,692 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:84.00 stddev:1.29 (1.5%) stddev-sans-first:1.36 14:28:16 INFO - 2015-11-13 14:28:16,693 DEBUG : BROWSER_OUTPUT: Values: 84.0 82.0 84.0 84.0 84.0 84.0 87.0 83.0 84.0 85.0 14:28:16 INFO - 2015-11-13 14:28:16,693 DEBUG : BROWSER_OUTPUT: 14:28:16 INFO - 2015-11-13 14:28:16,693 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.60 Median:124.50 stddev:3.60 (2.9%) stddev-sans-first:3.69 14:28:16 INFO - 2015-11-13 14:28:16,693 DEBUG : BROWSER_OUTPUT: Values: 122.0 124.0 120.0 128.0 124.0 127.0 123.0 121.0 125.0 132.0 14:28:16 INFO - 2015-11-13 14:28:16,693 DEBUG : BROWSER_OUTPUT: 14:28:16 INFO - 2015-11-13 14:28:16,693 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.10 Median:151.50 stddev:8.06 (5.3%) stddev-sans-first:7.48 14:28:16 INFO - 2015-11-13 14:28:16,693 DEBUG : BROWSER_OUTPUT: Values: 140.0 151.0 157.0 151.0 152.0 165.0 160.0 150.0 141.0 144.0 14:28:16 INFO - 2015-11-13 14:28:16,693 DEBUG : BROWSER_OUTPUT: 14:28:16 INFO - 2015-11-13 14:28:16,693 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:71.00 stddev:1.40 (2.0%) stddev-sans-first:1.48 14:28:16 INFO - 2015-11-13 14:28:16,693 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 70.0 71.0 74.0 70.0 69.0 71.0 70.0 70.0 14:28:16 INFO - 2015-11-13 14:28:16,694 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:28:16 INFO - 2015-11-13 14:28:16,694 DEBUG : BROWSER_OUTPUT: 14:28:17 INFO - 2015-11-13 14:28:17,629 INFO : Browser exited with error code: 0 14:28:17 INFO - 2015-11-13 14:28:17,676 INFO : Completed test kraken (00:01:02) 14:28:17 INFO - 2015-11-13 14:28:17,676 INFO : Starting test v8_7 14:28:17 INFO - 2015-11-13 14:28:17,676 DEBUG : operating with platform_type : linux_ 14:28:17 INFO - 2015-11-13 14:28:17,676 INFO : Initialising browser for v8_7 test... 14:28:17 INFO - 2015-11-13 14:28:17,682 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQrhlS2/profile http://localhost:35795/getInfo.html 14:28:23 INFO - 2015-11-13 14:28:23,317 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:28:23 INFO - 2015-11-13 14:28:23,317 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:28:23 INFO - 2015-11-13 14:28:23,317 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:28:23 INFO - 2015-11-13 14:28:23,317 DEBUG : BROWSER_OUTPUT: __metrics 14:28:24 INFO - 2015-11-13 14:28:24,577 INFO : Browser initialized. 14:28:24 INFO - 2015-11-13 14:28:24,578 INFO : Running cycle 1/1 for v8_7 test... 14:28:24 INFO - 2015-11-13 14:28:24,578 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQrhlS2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:28:36 INFO - 2015-11-13 14:28:36,504 DEBUG : BROWSER_OUTPUT: RSS: Main: 141025280 14:28:36 INFO - 2015-11-13 14:28:36,504 DEBUG : BROWSER_OUTPUT: 14:28:58 INFO - 2015-11-13 14:28:58,043 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35795/tests/v8_7/run.html (next: http://localhost:35795/tests/v8_7/run.html) 14:28:58 INFO - 2015-11-13 14:28:58,293 DEBUG : BROWSER_OUTPUT: RSS: Main: 138285056 14:28:58 INFO - 2015-11-13 14:28:58,293 DEBUG : BROWSER_OUTPUT: 14:28:58 INFO - 2015-11-13 14:28:58,293 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:28:58 INFO - 2015-11-13 14:28:58,294 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:28:58 INFO - 2015-11-13 14:28:58,294 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:28:58 INFO - 2015-11-13 14:28:58,294 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:28:58 INFO - 2015-11-13 14:28:58,294 DEBUG : BROWSER_OUTPUT: |0;Richards;163.77333770062233 14:28:58 INFO - 2015-11-13 14:28:58,294 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.27773527161438 14:28:58 INFO - 2015-11-13 14:28:58,294 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.50490883590464 14:28:58 INFO - 2015-11-13 14:28:58,294 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5050.50505050505 14:28:58 INFO - 2015-11-13 14:28:58,294 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1074.1138560687432 14:28:58 INFO - 2015-11-13 14:28:58,294 DEBUG : BROWSER_OUTPUT: |5;Earley;776.3975155279503 14:28:58 INFO - 2015-11-13 14:28:58,294 DEBUG : BROWSER_OUTPUT: |6;Boyer;12493.827160493827 14:28:58 INFO - 2015-11-13 14:28:58,294 DEBUG : BROWSER_OUTPUT: |7;RegExp;27162.162162162163 14:28:58 INFO - 2015-11-13 14:28:58,294 DEBUG : BROWSER_OUTPUT: |8;Splay;613.8735420503376 14:28:58 INFO - 2015-11-13 14:28:58,294 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 14:28:58 INFO - 2015-11-13 14:28:58,294 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:28:58 INFO - 2015-11-13 14:28:58,295 DEBUG : BROWSER_OUTPUT: __startTimestamp1447453738292__endTimestamp 14:28:58 INFO - 2015-11-13 14:28:58,295 DEBUG : BROWSER_OUTPUT: 14:28:58 INFO - 2015-11-13 14:28:58,295 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:28:58 INFO - 2015-11-13 14:28:58,295 DEBUG : BROWSER_OUTPUT: Number of tests: 10 14:28:58 INFO - 2015-11-13 14:28:58,295 DEBUG : BROWSER_OUTPUT: 14:28:58 INFO - 2015-11-13 14:28:58,295 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.77 Median:163.77 stddev:0.00 (0.0%) 14:28:58 INFO - 2015-11-13 14:28:58,295 DEBUG : BROWSER_OUTPUT: Values: 163.8 14:28:58 INFO - 2015-11-13 14:28:58,295 DEBUG : BROWSER_OUTPUT: 14:28:58 INFO - 2015-11-13 14:28:58,295 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.28 Median:191.28 stddev:0.00 (0.0%) 14:28:58 INFO - 2015-11-13 14:28:58,295 DEBUG : BROWSER_OUTPUT: Values: 191.3 14:28:58 INFO - 2015-11-13 14:28:58,295 DEBUG : BROWSER_OUTPUT: 14:28:58 INFO - 2015-11-13 14:28:58,296 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.50 Median:280.50 stddev:0.00 (0.0%) 14:28:58 INFO - 2015-11-13 14:28:58,296 DEBUG : BROWSER_OUTPUT: Values: 280.5 14:28:58 INFO - 2015-11-13 14:28:58,296 DEBUG : BROWSER_OUTPUT: 14:28:58 INFO - 2015-11-13 14:28:58,296 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5050.51 Median:5050.51 stddev:0.00 (0.0%) 14:28:58 INFO - 2015-11-13 14:28:58,296 DEBUG : BROWSER_OUTPUT: Values: 5050.5 14:28:58 INFO - 2015-11-13 14:28:58,296 DEBUG : BROWSER_OUTPUT: 14:28:58 INFO - 2015-11-13 14:28:58,296 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1074.11 Median:1074.11 stddev:0.00 (0.0%) 14:28:58 INFO - 2015-11-13 14:28:58,296 DEBUG : BROWSER_OUTPUT: Values: 1074.1 14:28:58 INFO - 2015-11-13 14:28:58,296 DEBUG : BROWSER_OUTPUT: 14:28:58 INFO - 2015-11-13 14:28:58,296 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:776.40 Median:776.40 stddev:0.00 (0.0%) 14:28:58 INFO - 2015-11-13 14:28:58,296 DEBUG : BROWSER_OUTPUT: Values: 776.4 14:28:58 INFO - 2015-11-13 14:28:58,298 DEBUG : BROWSER_OUTPUT: 14:28:58 INFO - 2015-11-13 14:28:58,298 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12493.83 Median:12493.83 stddev:0.00 (0.0%) 14:28:58 INFO - 2015-11-13 14:28:58,298 DEBUG : BROWSER_OUTPUT: Values: 12493.8 14:28:58 INFO - 2015-11-13 14:28:58,298 DEBUG : BROWSER_OUTPUT: 14:28:58 INFO - 2015-11-13 14:28:58,298 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27162.16 Median:27162.16 stddev:0.00 (0.0%) 14:28:58 INFO - 2015-11-13 14:28:58,298 DEBUG : BROWSER_OUTPUT: Values: 27162.2 14:28:58 INFO - 2015-11-13 14:28:58,299 DEBUG : BROWSER_OUTPUT: 14:28:58 INFO - 2015-11-13 14:28:58,299 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:613.87 Median:613.87 stddev:0.00 (0.0%) 14:28:58 INFO - 2015-11-13 14:28:58,299 DEBUG : BROWSER_OUTPUT: Values: 613.9 14:28:58 INFO - 2015-11-13 14:28:58,299 DEBUG : BROWSER_OUTPUT: 14:28:58 INFO - 2015-11-13 14:28:58,299 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 14:28:58 INFO - 2015-11-13 14:28:58,299 DEBUG : BROWSER_OUTPUT: Values: 4822.1 14:28:58 INFO - 2015-11-13 14:28:58,299 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:28:58 INFO - 2015-11-13 14:28:58,300 DEBUG : BROWSER_OUTPUT: 14:28:59 INFO - 2015-11-13 14:28:59,274 INFO : Browser exited with error code: 0 14:28:59 INFO - 2015-11-13 14:28:59,290 INFO : Completed test v8_7 (00:00:41) 14:28:59 INFO - 2015-11-13 14:28:59,293 INFO : Completed test suite (00:20:25) 14:28:59 INFO - 2015-11-13 14:28:59,293 DEBUG : Working with test: dromaeo_css 14:28:59 INFO - 2015-11-13 14:28:59,294 DEBUG : Generating results file: dromaeo_css 14:28:59 INFO - 2015-11-13 14:28:59,295 DEBUG : Working with test: kraken 14:28:59 INFO - 2015-11-13 14:28:59,295 DEBUG : Generating results file: kraken 14:28:59 INFO - 2015-11-13 14:28:59,295 INFO : javascript benchmark 14:28:59 INFO - 2015-11-13 14:28:59,295 DEBUG : Working with test: v8_7 14:28:59 INFO - 2015-11-13 14:28:59,295 DEBUG : Generating results file: v8_7 14:28:59 INFO - 2015-11-13 14:28:59,296 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:28:59 INFO - 2015-11-13 14:28:59,345 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,131,43]] 14:28:59 INFO - 2015-11-13 14:28:59,346 DEBUG : process_Request line: dromaeo_css 6007.01 graph.html#tests=[[72,131,43]] 14:28:59 INFO - 2015-11-13 14:28:59,346 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:28:59 INFO - 2015-11-13 14:28:59,370 DEBUG : process_Request line: kraken 1536.70 graph.html#tests=[[232,131,43]] 14:28:59 INFO - 2015-11-13 14:28:59,371 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:28:59 INFO - 2015-11-13 14:28:59,403 DEBUG : process_Request line: v8_7 21013.13 graph.html#tests=[[230,131,43]] 14:28:59 INFO - 2015-11-13 14:28:59,405 INFO : javascript benchmark 14:28:59 INFO - 2015-11-13 14:28:59,408 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [310.44275525431846, 312.5265223186871, 325.157980043056, 326.6325383943064, 332.2043705325745, 10922.235443518957, 11308.09535237181, 14783.186924719135, 15029.32368043438, 15210.619734506628, 10984.670459886196, 11069.78232394436, 11107.500162492686, 11128.666140015792, 11293.604723834667, 4065.796710164495, 4191.580841915815, 4212.55768144345, 4222.619964203221, 4235.449391579091, 4063.6952228582973, 4115.115250221202, 4151.750894946298, 4162.167566486714, 4183.393407955845, 4128.834846606147, 4137.834486620532, 4288.399624052635, 4436.201483732927, 4437.35658329542, 4322.092360604277, 4391.341298805189, 4391.912161756779, 4403.6256918162, 4406.713563618355, 3754.399296112636, 3990.221906728189, 3991.600839916014, 4008.8596899108684, 4019.0756126091164, 10809.513571889205, 10872.130229581693, 10974.835377469344, 11054.060404865597, 11088.279261848034, 1661.0, 1724.4136993422171, 1750.772399588058, 1760.0583687727133, 1771.7076682347397, 9056.637734490612, 9318.86021709675, 9461.24310055194, 9481.0, 9595.184409325217, 1586.6292599550488, 1610.9033457992557, 1649.4062137630444, 1650.909199994, 1692.323070771689, 52659.73670131625, 54746.726266368416, 54831.0, 55404.16893746638, 56066.71966640181, 6394.488440924715, 6463.7091330890225, 6491.610503369813, 6632.535722499379, 6657.53397262187, 7618.428617853683, 7653.0051093358625, 7763.068431788109, 7795.493292935941, 7803.804904877424, 5263.973680131575, 5340.25236466895, 5344.064788662046, 5376.569874410038, 5421.1055175895535, 5472.315960504937, 5536.2249285100115, 5536.640118392372, 5539.086050801653, 5544.944550554524, 2996.445657553316, 2996.625421822272, 3028.4700177468853, 3049.0, 3058.831764252943, 1050.1231471721046, 1055.9260851740457, 1059.5391004912888, 1065.5418170186895, 1117.234694234452, 371.6432225063969, 402.48883917424706, 454.5499955044482, 455.2306601842875, 471.0602348315133, 10557.9472102639, 11397.829032564518, 11401.315921044765, 11404.315741055398, 11516.1362897783, 427.8609451928074, 431.07749416249254, 434.281264507241, 443.16684632890605, 454.7453426081405, 5691.402402747734, 6160.414760597736, 6169.290531588835, 6191.81424557255, 6195.504359651217, 494558.0, 501862.0, 502132.0, 505321.0, 513486.0, 64897.351026490076, 65804.67097664576, 67042.66478667673, 67385.66307168432, 68300.6584967072, 487.6562023773302, 499.39323721678335, 502.30430853268484, 503.02915373329097, 503.5342308364748, 9622.951885240529, 10279.94860025695, 10418.322809017389, 10598.31110977784, 10660.786784264426, 28790.856045719636, 29197.0, 29360.265993349483, 30784.0, 30908.845455772578, 35993.64006359903, 37107.8144609286, 37135.25729485449, 42183.578164217965, 42753.0, 5745.885082298414, 5837.854053648693, 5852.648841069549, 5853.882922341444, 5859.531237501075, 10600.151987841109, 10623.309484883457, 10651.360918344924, 10718.839217411589, 11190.272632278877, 8075.83848323042, 8281.130481299377, 9272.814543709223, 9538.666146684833, 9582.712518624452, 9142.0, 9394.43633381972, 9414.011528789653, 9567.282453815853, 9641.0, 9921.603135874484, 10065.748356291151, 10118.747031324276, 10128.34165779222, 10222.13111885498, 5976.940230597812, 6227.377262273918, 6238.157848690369, 6245.906311405423, 6266.248050234001, 9448.196903263299, 9718.222542196467, 9939.65211217604, 9983.700488985342, 10009.499525023573], "dojo.html": [2677.250369896429, 2730.549459339209, 2755.0908200293916, 2755.7657599104077, 2770.376665250318, 4608.83869064582, 4734.550217729319, 4758.714477131374, 4764.618830493561, 4774.11678839415, 4722.0, 4734.053189362124, 4774.809007639699, 4822.300766388871, 4828.73441960692, 4382.145481631083, 4403.075354175611, 4462.955370446302, 4470.7094038887535, 4495.123450927071, 4418.624416924566, 4479.08178823342, 4520.434945631796, 4559.817607295704, 4586.793594288265, 4334.393184954109, 4352.869413917556, 4447.8443254486265, 4483.036147228361, 4495.235809912323, 4463.129689710508, 4467.441569803775, 4473.105378924196, 4485.50659427466, 4510.030343476168, 4454.799534020977, 4462.642988560908, 4467.352233926063, 4468.955310446919, 4485.3944717463055, 4582.541745825424, 4593.47175074864, 4691.0, 4699.506551812079, 4705.670603057787, 5043.722595257259, 5099.031184075051, 5099.515546023122, 5115.667481613683, 5157.819476318311, 4895.461499235082, 5112.463191364927, 5112.795488180505, 5113.207452844815, 5114.744262786846, 4695.178343789823, 4736.9526304736855, 4743.5967942724565, 4749.715017098916, 4799.0641824844515, 5213.530782229617, 5289.9471005290225, 5300.966311569284, 5320.201969704575, 5321.547668448148, 4858.125537403302, 4975.154223781966, 5079.212722028018, 5085.644004919694, 5100.69395836251, 5040.722760248222, 5123.590112790967, 5179.637425380262, 5197.636165468457, 5247.344081989751, 5022.547970682656, 5033.672811267256, 5087.567556757643, 5095.923561146586, 5135.537801597874, 4837.6613637045775, 4898.90202195954, 4907.754612269372, 5038.697678139323, 5067.062593420229, 4142.420061191436, 4197.601227883346, 4211.620954114144, 4237.385579091015, 4244.236037513278, 3762.1347090169415, 3765.849366025383, 3770.8680196193, 3799.9430008549894, 3820.522434695663, 4529.456465224128, 4532.818687252473, 4534.433195850519, 4541.091781643684, 4551.52209018055, 4991.625628077909, 5060.0, 5107.029664363759, 5110.28456016158, 5119.078565858107, 4462.821487140478, 4469.754163520973, 4470.597646211857, 4502.684812063189, 4508.526604706524, 4509.7970591323465, 4514.390557274792, 4529.297958816389, 4540.659450541157, 4560.087982403533, 4681.976590117096, 4754.762261886961, 4794.520547945178, 4842.4189097308545, 4873.074115918106, 4964.627652926118, 4969.503049695001, 4980.452150263541, 4988.376452943382, 5015.899682006412, 4768.070226305837, 4773.618110551078, 4792.0, 4799.208130658542, 4838.7822547986125, 4910.82812101589, 4975.278584605285, 5031.094403007493, 5054.887924656569, 5092.8472145835685, 5055.848324550269, 5117.692938423706, 5130.179171332569, 5135.255387968649, 5169.7673604687125, 4839.879003024953, 4946.1097002538445, 4962.3052772611145, 4963.801447942042, 4967.379077615298, 4875.658703890836, 4877.585405240594, 4918.532739389752, 4937.506249375034, 4966.18058020437, 4836.758162091811, 4868.61051115917, 4887.486813884491, 4900.901981960412, 4916.85249442503, 4806.807727690853, 4983.202687569971, 5000.524950129732, 5011.4487406386, 5053.646244762831, 4831.106245344622, 4836.153673107263, 4852.393450818648, 4870.439899411613, 4959.429665588504], "mootools.html": [1441.0849110814643, 1587.761835724641, 1632.8367163283674, 1657.4613250693528, 1659.9253033613486, 6260.968695156518, 6419.486441084714, 6446.742130314788, 6640.169978752656, 6695.598264104151, 6803.591784492934, 7034.2262351141335, 7042.295770422955, 7078.150621925363, 7147.106611673541, 2006.277740013594, 2041.0407108658906, 2044.631966246075, 2051.3128102085743, 2056.9201169386115, 1991.2234228650766, 2049.549099198174, 2066.8863212523306, 2079.854410191287, 2088.6553718636483, 2034.104993802722, 2064.2465500092508, 2070.492729281328, 2071.326818783901, 2071.9171233150655, 2079.1995081893506, 2104.5790841831617, 2104.968425473619, 2110.5778844231213, 2111.4193596761015, 2002.8497862660213, 2013.8590298679098, 2016.1935225909754, 2017.404865564662, 2031.5124370151204, 6986.056882320923, 7026.543274687129, 7051.717931282743, 7073.257307982639, 7082.00851880732, 4067.715259931806, 4177.498700156001, 4181.707280490367, 4186.413902053715, 4190.245755763961, 2674.4651069785928, 2815.81697189682, 2837.872295746696, 2846.245744877609, 2850.4156647887135, 1699.3967141664778, 1709.803372612153, 1713.3746182643245, 1773.4245646232816, 1783.2955982387014, 9573.952130239304, 9682.854757178648, 9733.17268032211, 9747.074027967403, 9762.072603102693, 3704.370257056307, 3836.827342769582, 3858.575556688762, 3892.3188442022533, 3894.240623078529, 7687.730929417444, 7770.922290777133, 7810.062792464941, 7868.527888326718, 7913.287804097658, 4254.659627229814, 4267.551907049778, 4274.358846173037, 4284.378765079108, 4291.506476755213, 3912.041549820255, 3921.137349783043, 3927.9410808837893, 3955.20895820837, 3968.027833180889, 3060.4185204811015, 3068.98465507671, 3110.502319628894, 3141.8429078545983, 3156.021633293686, 942.6747772018642, 955.5174636808367, 956.818204541135, 977.5014742481386, 980.2060331131806, 1136.72718547548, 1148.3683973814368, 1175.735459521601, 1191.0531127753457, 1191.8927296543352, 6502.707378167994, 6555.082288479617, 6574.276829548746, 6776.69504872282, 7081.964590177016, 934.065934065934, 941.5010044676195, 952.7046615549064, 964.7250533597891, 969.0842154164388, 5143.305653736773, 5256.474352564789, 5281.55106815925, 5346.572274218053, 5356.250124982505, 6752.5273230874345, 6776.2546119926765, 6854.6229957352825, 6883.070785444002, 6922.58464492132, 7920.128785833554, 8252.628631711588, 8300.501969881827, 8343.791405214919, 8356.206160414751, 6603.075569420285, 6657.167854018247, 6709.6980635871505, 6717.932820671828, 6741.797746067626, 6371.808845734636, 6439.291677915332, 6504.349565043458, 6540.084388185753, 6542.44389226902, 7322.0, 7516.173220945582, 7520.661570229244, 7530.623468826647, 7633.5419874807685, 7670.846583068196, 7726.18875018115, 7876.212378762078, 7958.641861116148, 7979.122296547491, 6109.083637454418, 6112.786052488142, 6167.074938759042, 6174.950258456163, 6182.474489668429, 6996.685149168198, 7027.648617568999, 7050.435965122881, 7053.576785392893, 7057.36483716468, 6356.173697419306, 6404.615723056631, 6411.743530258737, 6599.241087275025, 6689.632070236184, 6527.11883895687, 6616.4045235929, 6643.534952553468, 6648.401643852077, 6715.496337774589, 6440.710168042543, 6462.901306777953, 6509.641969691523, 6509.772157974448, 6529.9020514691365, 6015.6691381974415, 6066.696665166813, 6103.450689437795, 6103.908441373472, 6106.175666285172, 6122.265328160649, 6127.417895299939, 6179.474744646755, 6189.6286222826775, 6210.441060304413], "ext.html": [564.2270089976732, 572.3646752105162, 573.1517354315613, 580.6603137164758, 582.1122787748685, 36992.260154796924, 36997.630023699756, 37264.99999999996, 37423.438648420226, 37461.812690936575, 38887.611123888826, 39493.605063949355, 39637.0, 40079.198416031664, 40367.59632403675, 7926.8810967835525, 8044.356451483896, 8141.592920353988, 8147.0, 8157.143499932481, 7842.3726101912, 7985.920140798576, 7989.201079892023, 7998.480098793589, 8013.439059265825, 8017.238362355567, 8065.1934806519175, 8134.105248422668, 8135.471194372377, 8157.592120393986, 7917.683292668286, 8057.919420805805, 8095.878561821548, 8098.635561399751, 8108.75673729789, 7929.801754956115, 8068.273855352988, 8071.31393831525, 8073.233042860918, 8099.595020248964, 36615.0, 36863.262734745425, 36900.07749806249, 37265.81367093174, 37320.0, 2880.3807181456086, 2967.2581854536365, 3167.635721891989, 3274.705276525124, 3705.907352316187, 27890.442191156064, 28352.574711379344, 28796.71203287961, 28820.567691484644, 28925.276868078257, 2924.985375073132, 2925.283305590144, 2957.512010518262, 2972.9256768580744, 3006.699330066998, 215432.0, 215765.0, 215858.99999999843, 216112.0, 216119.91940040357, 49504.50495495071, 50619.24071138936, 52830.471695283326, 52923.47076529262, 52941.2058819118, 48291.0, 48368.0, 48430.0, 48786.5121348789, 48998.0, 14270.571882843531, 14380.209088500233, 14499.130052196902, 14525.346359413852, 14526.0, 10882.347059176474, 11063.612773552886, 11074.394212839254, 11106.333619982826, 11109.444527773741, 17780.91109544444, 18408.631827363646, 18524.351647692267, 18719.0, 18757.0, 7424.443166762514, 7588.241175882367, 7665.8850117248285, 7690.384769218449, 7712.7300544481795, 819.9754007379788, 828.1966492502263, 869.4174902815129, 930.3534043839602, 987.9209663226925, 25303.873480632847, 26079.087231946793, 26602.0, 26750.866245668647, 26893.596596051077, 916.1082364916559, 936.4100616611628, 938.5213541094091, 946.2902822882838, 1063.3194755356578, 13909.0, 14032.298385080909, 14044.087134336236, 14145.929270353583, 14370.497032604018, 265436.0, 268673.0, 270539.0, 270852.0, 271496.0, 46051.30923036157, 46326.0, 46356.3046554302, 46432.7678361606, 46480.0, 1187.0, 1188.3107797477442, 1189.9881001190051, 1199.2504684572143, 1202.326697049655, 25408.237752867444, 25436.49127017486, 25604.23187304384, 25642.871785640953, 25834.87082564575, 40551.59448405596, 41194.0, 41309.38035929403, 41311.173776524905, 41445.0, 254644.0, 256460.0, 257972.0, 260506.0, 260813.0, 29315.068493150513, 29360.0, 29831.850840745657, 29867.10398688043, 29884.551731723608, 35059.298814024085, 35795.463068053476, 35988.0, 36289.63710362863, 36726.63273367339, 30827.229319267197, 30886.0, 32680.67319326776, 34793.826030869684, 36277.0, 32614.0, 32963.67036329702, 33060.0, 33099.50350744693, 33541.83229083839, 33084.503732443554, 33097.83451082729, 33408.0, 33444.66555334415, 33502.329953401284, 28578.428431431672, 29611.0, 30133.849330753204, 30214.69785302119, 30286.091417257518, 23217.3034808956, 23841.403964901016, 23878.0, 24131.75868241295, 24185.51628967446], "prototype.html": [304.52798162847586, 307.37295916330686, 314.00773555564405, 314.8819192802699, 316.45727577205116, 5508.063629183039, 5638.548916086714, 5655.5475561955045, 5663.603547751654, 5674.773009079632, 5503.284573005513, 5540.141278101891, 5547.72261386931, 5567.220589117527, 5567.47109024642, 4113.547509773923, 4264.701470897038, 4306.18182545317, 4308.482982042159, 4315.568443155675, 4249.851255206068, 4254.127903779733, 4260.637845783112, 4265.104328091089, 4282.828686852522, 4222.324428091506, 4226.112516371566, 4230.069384735353, 4234.597713217239, 4235.258829704805, 4219.303814870558, 4221.577842215785, 4228.788560571975, 4231.1749208904275, 4240.960964563671, 3433.6051354094348, 3669.9633003669887, 3676.8713095041544, 3677.5403074615674, 3679.1537946272238, 5079.873003174913, 5203.713795741232, 5244.947550524484, 5260.2372655965055, 5263.473652634744, 4826.758662066883, 4847.272909063633, 4852.320675105488, 4852.514748525119, 4857.927131093036, 5761.798337058183, 5833.095870140135, 5859.7656093756195, 5860.120981852713, 5864.354920958691, 3865.265599536079, 3933.331333673282, 3958.6239307265764, 3962.286788378091, 3963.8414463421427, 6085.786997455112, 6165.506759459233, 6172.07418887166, 6173.722182501753, 6182.659953702545, 3990.3216453203027, 4046.575109613448, 4089.5092588889524, 4095.815688294034, 4100.5489396166395, 4110.876673699794, 4111.814968326433, 4113.300738874398, 4124.628783409447, 4153.792310384529, 4608.5621865922685, 4849.151398505318, 4850.223964165716, 4852.975735121302, 4859.3682821233015, 5761.711914404263, 5835.854103647443, 5863.501602363762, 5868.530517558585, 5873.060310350324, 1450.3111022264552, 1451.122071146962, 1451.8330392004843, 1474.1523623916078, 1474.7492926202572, 964.4068897627908, 981.8969008254173, 990.019880318494, 992.0674565908023, 1006.2603986070233, 5144.176931690911, 5151.4333423323405, 5154.7938082476285, 5159.948400516022, 5165.251038599382, 5934.228550288435, 5985.281766187998, 5987.042073268256, 6040.0, 6047.78832740852, 5118.155504341817, 5124.333836601292, 5127.359080114986, 5140.3831540215415, 5141.897162056738, 3175.9836852207072, 3239.7570182236427, 3261.119497735598, 3269.395161895057, 3271.836408179629, 5612.663240205601, 5630.155476678449, 5671.829845104653, 5687.9431205687415, 5688.601797874109, 6191.690415479208, 6264.123022776815, 6269.968650156811, 6276.748930042839, 6293.339199383999, 5659.603827732101, 5660.603757737002, 5689.9146512802345, 5751.798687045934, 5758.337791154071, 6026.126211699367, 6055.333913269625, 6070.0591408331775, 6077.4834139098675, 6094.360092190256, 5819.476247137778, 5964.373740757158, 5971.820845374646, 5987.730552125077, 6021.849453763691, 5762.740676669644, 5765.1928729977, 5766.711664416846, 5772.509336706427, 5785.0, 4034.2133284009337, 4035.435039094588, 4041.0503531669447, 4058.1477889643506, 4066.0851308456545, 5827.825165245049, 5993.31076926159, 6000.69996500182, 6002.549808764273, 6031.939680603138, 5733.569982251264, 5739.971300143473, 5742.540596752333, 5750.741216645345, 5751.424857514216, 5815.098659707752, 5829.125631155191, 5861.912071319019, 5864.354920958605, 5867.970660146672, 5513.283273174462, 5723.399043100415, 5731.8567035824435, 5750.367459579526, 5760.942390576208, 5774.0761478163295, 5776.537876969748, 5843.065109582616, 5875.882482350415, 5891.705414729161, 5581.023320918905, 5687.630304030225, 5691.231683722644, 5723.284589426322, 5741.425857414225], "yui.html": [628.6416742456798, 755.792157156782, 771.4252881603206, 776.3944123583607, 780.3679019993809, 11504.827427588583, 11732.120090993178, 11752.471138798743, 13377.59867203983, 13389.263590502544, 12492.312922789266, 12759.617211483646, 12809.551665691703, 12824.166429182096, 12868.09923305369, 732.7179036071097, 743.5724458436393, 752.4807882561015, 755.6788364944904, 757.2162811490109, 741.6180666956494, 746.7274444827653, 748.4162353364358, 749.3892477630714, 750.6922161913617, 774.6785084190054, 780.0327593783724, 783.4046124945025, 784.3215618489994, 787.94484386093, 758.2379708393084, 770.8920751094852, 771.1478815908397, 771.7221800151941, 778.828657695309, 563.276190095725, 563.613924461745, 564.5540023381565, 570.6918264137361, 572.6077636818792, 11845.822312665317, 11930.701732456671, 12125.333106679129, 12151.878481215163, 12163.939180304042, 8771.12288771124, 8871.866921996176, 9007.68876588623, 9147.725568232963, 9593.280503962162, 8396.874046889301, 8568.485890846569, 8572.785680357978, 8717.389782715212, 9241.537923103886, 2734.6991830898587, 2769.4599553087155, 2824.1668707731064, 2829.39168078862, 2848.700886406918, 37136.62863371359, 37672.99999999972, 37968.810155949046, 38145.42781858274, 38275.808620956996, 6238.0, 6302.306746257908, 6351.96824015877, 6360.936390636127, 6384.106225128486, 9981.750456238507, 9983.35108217978, 9984.750381240381, 10014.599416023277, 10034.949825250827, 5574.442555744474, 5583.804566840141, 5591.7483713233005, 5715.685637289906, 5864.237649105674, 3553.307105114478, 3650.7261955353456, 3671.0638787109115, 3674.52231209941, 3674.779513229215, 2317.3627252505694, 2318.2002209237785, 2319.373769082372, 2323.93028209154, 2328.2898715891815, 392.95481019683103, 395.7744085871083, 395.91289916218386, 396.3044856277273, 396.3974758367266, 465.6158669098008, 487.5270987142466, 489.559396543114, 493.5705935835846, 556.8635684257301, 7791.376689864911, 7943.682252709942, 8077.959610201911, 8084.272415482635, 8369.455985360932, 474.27199249152386, 522.0837430309782, 533.773146412773, 550.2736387967844, 554.9805756798493, 3514.578250609943, 3603.3153700796765, 3605.4772058051435, 3704.5739739929713, 3744.1575645479547, 54627.453725463034, 54797.90404191973, 54883.45116548784, 55017.1747423789, 55143.448565514635, 46827.531724683, 47035.76482117636, 47178.29232561514, 47339.5266047342, 48143.0, 40591.0, 41494.79252603718, 42166.789166053975, 42952.140957181306, 43254.351184732885, 7712.537247765152, 7746.65140068687, 7862.842743145219, 7994.600269986361, 8426.0, 30900.0, 30978.69021309758, 31559.368812624078, 31606.841965790023, 31860.522092168172, 40221.1955760889, 40990.385144222266, 41655.7917210412, 41907.161856763305, 41916.58083419127, 6790.151231096113, 7092.929070709227, 7218.169910460364, 7226.313500217471, 7264.309890560388, 10711.571537138427, 10767.6231331903, 10778.353298802096, 10963.616273430393, 11079.0, 10212.285140040423, 10499.632512862014, 10648.680539583826, 10673.092787113183, 10692.251542391958, 10416.270861039655, 10590.576376944837, 10647.467626618793, 10653.094486968694, 10657.25399222047, 10113.089821916063, 10192.0, 10216.438095904796, 10217.438040907822, 10222.284440089123, 8613.397062205586, 8867.73396798097, 8972.641094356153, 9018.143276388733, 9053.456792592202, 8858.867116993122, 8865.734027979172, 8938.553072346487, 9122.224610908148, 9213.493257870881]}, "summary": {"lowerIsBetter": false, "suite": 6007.0079733033, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6232.968128284043, "unit": "ms", "value": 6232.968128284043}, "dojo.html": {"lowerIsBetter": false, "filtered": 4684.394153428154, "unit": "ms", "value": 4684.394153428154}, "mootools.html": {"lowerIsBetter": false, "filtered": 4124.904049682649, "unit": "ms", "value": 4124.904049682649}, "ext.html": {"lowerIsBetter": false, "filtered": 16780.360588612544, "unit": "ms", "value": 16780.360588612544}, "prototype.html": {"lowerIsBetter": false, "filtered": 4344.396756386317, "unit": "ms", "value": 4344.396756386317}, "yui.html": {"lowerIsBetter": false, "filtered": 5350.759196826008, "unit": "ms", "value": 5350.759196826008}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-020.e"}, "testrun": {"date": 1447452513, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151113134833", "branch": "Mozilla-Inbound-Non-PGO", "revision": "94e2a6d21337f9b45593027b0a8e98a2157c53ad"}}, {"talos_counters": {}, "results": {"audio-dft": [164.0, 164.0, 162.0, 163.0, 164.0, 173.0, 164.0, 162.0, 167.0, 163.0], "ai-astar": [113.0, 108.0, 113.0, 112.0, 115.0, 125.0, 113.0, 111.0, 111.0, 112.0], "imaging-gaussian-blur": [110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 111.0, 111.0, 110.0, 110.0], "audio-beat-detection": [155.0, 132.0, 157.0, 169.0, 141.0, 157.0, 159.0, 131.0, 169.0, 130.0], "json-stringify-tinderbox": [69.0, 69.0, 69.0, 69.0, 70.0, 70.0, 70.0, 69.0, 69.0, 71.0], "stanford-crypto-pbkdf2": [140.0, 151.0, 157.0, 151.0, 152.0, 165.0, 160.0, 150.0, 141.0, 144.0], "json-parse-financial": [71.0, 71.0, 70.0, 70.0, 72.0, 70.0, 71.0, 73.0, 71.0, 72.0], "stanford-crypto-sha256-iterative": [71.0, 72.0, 70.0, 71.0, 74.0, 70.0, 69.0, 71.0, 70.0, 70.0], "audio-fft": [73.0, 73.0, 74.0, 73.0, 74.0, 125.0, 73.0, 74.0, 72.0, 74.0], "imaging-darkroom": [149.0, 150.0, 151.0, 149.0, 149.0, 148.0, 151.0, 149.0, 150.0, 148.0], "stanford-crypto-ccm": [122.0, 124.0, 120.0, 128.0, 124.0, 127.0, 123.0, 121.0, 125.0, 132.0], "audio-oscillator": [91.0, 92.0, 135.0, 91.0, 92.0, 91.0, 126.0, 92.0, 92.0, 126.0], "stanford-crypto-aes": [84.0, 82.0, 84.0, 84.0, 84.0, 84.0, 87.0, 83.0, 84.0, 85.0], "imaging-desaturate": [96.0, 103.0, 96.0, 96.0, 96.0, 97.0, 96.0, 97.0, 95.0, 96.0]}, "summary": {"lowerIsBetter": true, "suite": 1536.6999999999996, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 78.5, "unit": "ms", "value": 78.5}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 151.1, "unit": "ms", "value": 151.1}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 150.0, "unit": "ms", "value": 150.0}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 124.6, "unit": "ms", "value": 124.6}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 149.4, "unit": "ms", "value": 149.4}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 71.1, "unit": "ms", "value": 71.1}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 102.8, "unit": "ms", "value": 102.8}, "ai-astar": {"lowerIsBetter": true, "filtered": 113.3, "unit": "ms", "value": 113.3}, "audio-dft": {"lowerIsBetter": true, "filtered": 164.6, "unit": "ms", "value": 164.6}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 70.8, "unit": "ms", "value": 70.8}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 69.5, "unit": "ms", "value": 69.5}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 110.1, "unit": "ms", "value": 110.1}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 84.1, "unit": "ms", "value": 84.1}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 96.8, "unit": "ms", "value": 96.8}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-020.e"}, "testrun": {"date": 1447452513, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151113134833", "branch": "Mozilla-Inbound-Non-PGO", "revision": "94e2a6d21337f9b45593027b0a8e98a2157c53ad"}}, {"talos_counters": {}, "results": {"DeltaBlue": [191.27773527161438], "Encrypt": [280.50490883590464], "NavierStokes": [4822.115384615385], "Decrypt": [5050.50505050505], "Splay": [613.8735420503376], "Richards": [163.77333770062233], "RegExp": [27162.162162162163], "Earley": [776.3975155279503], "Boyer": [12493.827160493827], "RayTrace": [1074.1138560687432]}, "summary": {"lowerIsBetter": false, "suite": 21013.130881435918, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 345.66490400000004, "unit": "score", "value": 345.66490400000004}, "Encrypt": {"lowerIsBetter": false, "filtered": 948.9352650000003, "unit": "score", "value": 948.9352650000003}, "NavierStokes": {"lowerIsBetter": false, "filtered": 307.7487537387835, "unit": "score", "value": 307.7487537387835}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.70383799999996, "unit": "score", "value": 52.70383799999996}, "Splay": {"lowerIsBetter": false, "filtered": 132.748839, "unit": "score", "value": 132.748839}, "RegExp": {"lowerIsBetter": false, "filtered": 33.538751243781114, "unit": "score", "value": 33.538751243781114}, "Richards": {"lowerIsBetter": false, "filtered": 215.55401199999997, "unit": "score", "value": 215.55401199999997}, "Earley": {"lowerIsBetter": false, "filtered": 858.4043439999999, "unit": "score", "value": 858.4043439999999}, "Boyer": {"lowerIsBetter": false, "filtered": 53.34338241106715, "unit": "score", "value": 53.34338241106715}, "RayTrace": {"lowerIsBetter": false, "filtered": 688.9297590000002, "unit": "score", "value": 688.9297590000002}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-020.e"}, "testrun": {"date": 1447452513, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151113134833", "branch": "Mozilla-Inbound-Non-PGO", "revision": "94e2a6d21337f9b45593027b0a8e98a2157c53ad"}}] 14:28:59 INFO - RETURN: dromaeo_css: 6007.01 14:28:59 INFO - RETURN: kraken: 1536.70 14:28:59 INFO - RETURN: v8_7: 21013.13 14:28:59 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,131,43]]", "result": "21013.13"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,131,43]]", "result": "1536.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,131,43]]", "result": "6007.01"}}} 14:28:59 INFO - Return code: 0 14:28:59 INFO - # TBPL SUCCESS # 14:28:59 INFO - Running post-action listener: _resource_record_post_action 14:28:59 INFO - Running post-run listener: _resource_record_post_run 14:29:00 INFO - Total resource usage - Wall time: 1241s; CPU: 13.0%; Read bytes: 10338304; Write bytes: 407580672; Read time: 4148; Write time: 1065896 14:29:00 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 9416704; Read time: 0; Write time: 11048 14:29:00 INFO - run-tests - Wall time: 1227s; CPU: 13.0%; Read bytes: 8601600; Write bytes: 378470400; Read time: 4036; Write time: 1043424 14:29:00 INFO - Running post-run listener: _upload_blobber_files 14:29:00 INFO - Blob upload gear active. 14:29:00 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 14:29:00 INFO - Copying logs to upload dir... 14:29:00 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1292.495040 ========= master_lag: 0.14 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 32 secs) (at 2015-11-13 14:29:00.684263) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-13 14:29:00.687616) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1447452124.806030-2062463427 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/wmIpCheHQXi7OKVX1ruotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009848 build_url: 'https://queue.taskcluster.net/v1/task/wmIpCheHQXi7OKVX1ruotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-13 14:29:00.738093) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 14:29:00.738432) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1447452124.806030-2062463427 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004440 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 14:29:00.788120) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-13 14:29:00.788432) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-13 14:29:00.788723) ========= ========= Total master_lag: 0.36 =========