builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-026 starttime: 1447445748.89 results: success (0) buildid: 20151113071449 builduid: 711e742845b04de995278c4edd3802dd revision: d1029ba11d5c64c455412a58a2a77d14511286d6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-13 12:15:48.894373) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-13 12:15:48.894775) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-13 12:15:48.895076) ========= 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=a65b340e283ce644d68cb24e000001c9-1447445383.947546-1644588785 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006546 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-13 12:15:48.944493) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-13 12:15:48.944786) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-13 12:15:48.960856) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 12:15:48.961220) ========= 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=a65b340e283ce644d68cb24e000001c9-1447445383.947546-1644588785 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004664 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 12:15:49.010565) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-13 12:15:49.010866) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-13 12:15:49.011203) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 12:15:49.011499) ========= 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=a65b340e283ce644d68cb24e000001c9-1447445383.947546-1644588785 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-13 12:15:49-- 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% 211M=0s 2015-11-13 12:15:49 (211 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121847 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 12:15:49.147690) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 12:15:49.147994) ========= 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=a65b340e283ce644d68cb24e000001c9-1447445383.947546-1644588785 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022237 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 12:15:49.199753) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 12:15:49.200323) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d1029ba11d5c64c455412a58a2a77d14511286d6 --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 d1029ba11d5c64c455412a58a2a77d14511286d6 --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=a65b340e283ce644d68cb24e000001c9-1447445383.947546-1644588785 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-13 12:15:49,328 truncating revision to first 12 chars 2015-11-13 12:15:49,328 Setting DEBUG logging. 2015-11-13 12:15:49,328 attempt 1/10 2015-11-13 12:15:49,328 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/d1029ba11d5c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-13 12:15:49,594 unpacking tar archive at: mozilla-inbound-d1029ba11d5c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.586421 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 12:15:49.805023) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-13 12:15:49.805339) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-13 12:15:49.816891) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-13 12:15:49.817206) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-13 12:15:49.817588) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-11-13 12:15:49.817885) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=a65b340e283ce644d68cb24e000001c9-1447445383.947546-1644588785 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:15:50 INFO - MultiFileLogger online at 20151113 12:15:50 in /builds/slave/test 12:15:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 12:15:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:15:50 INFO - {'append_to_log': False, 12:15:50 INFO - 'base_work_dir': '/builds/slave/test', 12:15:50 INFO - 'blob_upload_branch': 'Mozilla-Inbound-Non-PGO', 12:15:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:15:50 INFO - 'branch': 'Mozilla-Inbound-Non-PGO', 12:15:50 INFO - 'buildbot_json_path': 'buildprops.json', 12:15:50 INFO - 'config_files': ('talos/linux_config.py',), 12:15:50 INFO - 'default_actions': ('clobber', 12:15:50 INFO - 'read-buildbot-config', 12:15:50 INFO - 'download-and-extract', 12:15:50 INFO - 'populate-webroot', 12:15:50 INFO - 'create-virtualenv', 12:15:50 INFO - 'install', 12:15:50 INFO - 'run-tests'), 12:15:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:15:50 INFO - 'download_minidump_stackwalk': True, 12:15:50 INFO - 'download_symbols': 'ondemand', 12:15:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:15:50 INFO - 'tooltool.py': '/tools/tooltool.py', 12:15:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:15:50 INFO - '/tools/misc-python/virtualenv.py')}, 12:15:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:15:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:15:50 INFO - 'installer_path': 'installer.exe', 12:15:50 INFO - 'log_level': 'info', 12:15:50 INFO - 'log_name': 'talos', 12:15:50 INFO - 'log_to_console': True, 12:15:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:15:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:15:50 INFO - 'opt_config_files': (), 12:15:50 INFO - 'pip_index': False, 12:15:50 INFO - 'sps_profile': False, 12:15:50 INFO - 'sps_profile_interval': 0, 12:15:50 INFO - 'suite': 'dromaeojs', 12:15:50 INFO - 'system_bits': '64', 12:15:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:15:50 INFO - 'title': 'talos-linux64-ix-026', 12:15:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:15:50 INFO - 'use_talos_json': True, 12:15:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:15:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:15:50 INFO - 'work_dir': 'build'} 12:15:50 INFO - ##### 12:15:50 INFO - ##### Running clobber step. 12:15:50 INFO - ##### 12:15:50 INFO - Running pre-action listener: _resource_record_pre_action 12:15:50 INFO - Running main action method: clobber 12:15:50 INFO - rmtree: /builds/slave/test/build 12:15:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:15:50 INFO - Running post-action listener: _resource_record_post_action 12:15:50 INFO - ##### 12:15:50 INFO - ##### Running read-buildbot-config step. 12:15:50 INFO - ##### 12:15:50 INFO - Running pre-action listener: _resource_record_pre_action 12:15:50 INFO - Running main action method: read_buildbot_config 12:15:50 INFO - Using buildbot properties: 12:15:50 INFO - { 12:15:50 INFO - "properties": { 12:15:50 INFO - "buildnumber": 2839, 12:15:50 INFO - "product": "firefox", 12:15:50 INFO - "script_repo_revision": "production", 12:15:50 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 12:15:50 INFO - "repository": "", 12:15:50 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound talos dromaeojs", 12:15:50 INFO - "buildid": "20151113071449", 12:15:50 INFO - "slavename": "talos-linux64-ix-026", 12:15:50 INFO - "pgo_build": "False", 12:15:50 INFO - "basedir": "/builds/slave/test", 12:15:50 INFO - "project": "", 12:15:50 INFO - "platform": "ubuntu64_hw", 12:15:50 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:15:50 INFO - "slavebuilddir": "test", 12:15:50 INFO - "scheduler": "tests-mozilla-inbound-linux64-talos", 12:15:50 INFO - "branch": "mozilla-inbound", 12:15:50 INFO - "repo_path": "integration/mozilla-inbound", 12:15:50 INFO - "stage_platform": "linux64", 12:15:50 INFO - "builduid": "711e742845b04de995278c4edd3802dd", 12:15:50 INFO - "revision": "d1029ba11d5c64c455412a58a2a77d14511286d6" 12:15:50 INFO - }, 12:15:50 INFO - "sourcestamp": { 12:15:50 INFO - "repository": "", 12:15:50 INFO - "hasPatch": false, 12:15:50 INFO - "project": "", 12:15:50 INFO - "branch": "mozilla-inbound-linux64-talos", 12:15:50 INFO - "changes": [ 12:15:50 INFO - { 12:15:50 INFO - "category": null, 12:15:50 INFO - "files": [ 12:15:50 INFO - { 12:15:50 INFO - "url": null, 12:15:50 INFO - "name": "https://queue.taskcluster.net/v1/task/OOG17jUCTP6c4jwOJuo1-g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 12:15:50 INFO - } 12:15:50 INFO - ], 12:15:50 INFO - "repository": "", 12:15:50 INFO - "rev": "d1029ba11d5c64c455412a58a2a77d14511286d6", 12:15:50 INFO - "who": "mchang@mozilla.com", 12:15:50 INFO - "when": 1447430133, 12:15:50 INFO - "number": 6658796, 12:15:50 INFO - "comments": "Bug 1210261. Tick root refresh driver last. r=mattwoodrow", 12:15:50 INFO - "project": "", 12:15:50 INFO - "at": "Fri 13 Nov 2015 07:55:33", 12:15:50 INFO - "branch": "mozilla-inbound-linux64-talos", 12:15:50 INFO - "revlink": "", 12:15:50 INFO - "properties": [ 12:15:50 INFO - [ 12:15:50 INFO - "buildid", 12:15:50 INFO - "20151113071449", 12:15:50 INFO - "Change" 12:15:50 INFO - ], 12:15:50 INFO - [ 12:15:50 INFO - "builduid", 12:15:50 INFO - "711e742845b04de995278c4edd3802dd", 12:15:50 INFO - "Change" 12:15:50 INFO - ], 12:15:50 INFO - [ 12:15:50 INFO - "pgo_build", 12:15:50 INFO - "False", 12:15:50 INFO - "Change" 12:15:50 INFO - ] 12:15:50 INFO - ], 12:15:50 INFO - "revision": "d1029ba11d5c64c455412a58a2a77d14511286d6" 12:15:50 INFO - } 12:15:50 INFO - ], 12:15:50 INFO - "revision": "d1029ba11d5c64c455412a58a2a77d14511286d6" 12:15:50 INFO - } 12:15:50 INFO - } 12:15:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/OOG17jUCTP6c4jwOJuo1-g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 12:15:50 INFO - Running post-action listener: _resource_record_post_action 12:15:50 INFO - ##### 12:15:50 INFO - ##### Running download-and-extract step. 12:15:50 INFO - ##### 12:15:50 INFO - Running pre-action listener: _resource_record_pre_action 12:15:50 INFO - Running main action method: download_and_extract 12:15:50 INFO - mkdir: /builds/slave/test/build/tests 12:15:50 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')]} 12:15:50 INFO - https://queue.taskcluster.net/v1/task/OOG17jUCTP6c4jwOJuo1-g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:15:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOG17jUCTP6c4jwOJuo1-g/artifacts/public/build/test_packages.json 12:15:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOG17jUCTP6c4jwOJuo1-g/artifacts/public/build/test_packages.json 12:15:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOG17jUCTP6c4jwOJuo1-g/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 12:15:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOG17jUCTP6c4jwOJuo1-g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 12:15:54 INFO - Downloaded 1302 bytes. 12:15:54 INFO - Reading from file /builds/slave/test/build/test_packages.json 12:15:54 INFO - Using the following test package requirements: 12:15:54 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:15:54 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:15:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:15:54 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:15:54 INFO - u'jsshell-linux-x86_64.zip'], 12:15:54 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:15:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:15:54 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:15:54 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:15:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:15:54 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:15:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:15:54 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:15:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:15:54 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:15:54 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:15:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:15:54 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:15:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:15:54 INFO - https://queue.taskcluster.net/v1/task/OOG17jUCTP6c4jwOJuo1-g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:15:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOG17jUCTP6c4jwOJuo1-g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:15:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOG17jUCTP6c4jwOJuo1-g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:15:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOG17jUCTP6c4jwOJuo1-g/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 12:15:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOG17jUCTP6c4jwOJuo1-g/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 12:15:57 INFO - Downloaded 21256903 bytes. 12:15:57 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 12:15:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:15:57 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 12:15:58 INFO - Return code: 0 12:15:58 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 12:15:58 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')]} 12:15:58 INFO - https://queue.taskcluster.net/v1/task/OOG17jUCTP6c4jwOJuo1-g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:15:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOG17jUCTP6c4jwOJuo1-g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:15:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOG17jUCTP6c4jwOJuo1-g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:15:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOG17jUCTP6c4jwOJuo1-g/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 12:15:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOG17jUCTP6c4jwOJuo1-g/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 12:16:03 INFO - Downloaded 21256903 bytes. 12:16:03 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 12:16:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:16:03 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 12:16:04 INFO - Return code: 0 12:16:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:04 INFO - https://queue.taskcluster.net/v1/task/OOG17jUCTP6c4jwOJuo1-g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:16:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOG17jUCTP6c4jwOJuo1-g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:16:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOG17jUCTP6c4jwOJuo1-g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:16:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOG17jUCTP6c4jwOJuo1-g/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 12:16:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOG17jUCTP6c4jwOJuo1-g/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 12:16:05 INFO - Downloaded 11131693 bytes. 12:16:05 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 12:16:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:16:05 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 12:16:05 INFO - Return code: 0 12:16: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')]} 12:16:05 INFO - https://queue.taskcluster.net/v1/task/OOG17jUCTP6c4jwOJuo1-g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:16:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOG17jUCTP6c4jwOJuo1-g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:16:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOG17jUCTP6c4jwOJuo1-g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:16:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOG17jUCTP6c4jwOJuo1-g/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 12:16:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOG17jUCTP6c4jwOJuo1-g/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 12:16:11 INFO - Downloaded 55622333 bytes. 12:16:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OOG17jUCTP6c4jwOJuo1-g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:16:11 INFO - mkdir: /builds/slave/test/properties 12:16:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:16:11 INFO - Writing to file /builds/slave/test/properties/build_url 12:16:11 INFO - Contents: 12:16:11 INFO - build_url:https://queue.taskcluster.net/v1/task/OOG17jUCTP6c4jwOJuo1-g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:16:11 INFO - Running post-action listener: _resource_record_post_action 12:16:11 INFO - Running post-action listener: set_extra_try_arguments 12:16:11 INFO - ##### 12:16:11 INFO - ##### Running populate-webroot step. 12:16:11 INFO - ##### 12:16:11 INFO - Running pre-action listener: _resource_record_pre_action 12:16:11 INFO - Running main action method: populate_webroot 12:16:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:16:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:16:11 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 12:16:11 INFO - '../fennec_ids.txt'], 12:16:11 INFO - 'tests': ['tcheck2']}, 12:16:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:16:11 INFO - '--tppagecycles', 12:16:11 INFO - '7'], 12:16:11 INFO - 'tests': ['tsvgm']}}, 12:16:11 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:16:11 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:16:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:16:11 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:16:11 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:16:11 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:16:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:16:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:11 INFO - 'talos_options': ['--e10s'], 12:16:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:16:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:11 INFO - 'tests': ['damp', 'tps']}, 12:16:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:11 INFO - 'talos_options': ['--e10s'], 12:16:11 INFO - 'tests': ['damp', 'tps']}, 12:16:11 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:16:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:16:11 INFO - 'other': {'tests': ['a11yr', 12:16:11 INFO - 'ts_paint', 12:16:11 INFO - 'tpaint', 12:16:11 INFO - 'sessionrestore', 12:16:11 INFO - 'sessionrestore_no_auto_restore']}, 12:16:11 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:16:11 INFO - 'tests': ['a11yr', 12:16:11 INFO - 'ts_paint', 12:16:11 INFO - 'tpaint', 12:16:11 INFO - 'sessionrestore', 12:16:11 INFO - 'sessionrestore_no_auto_restore']}, 12:16:11 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:16:11 INFO - 'tests': ['a11yr', 12:16:11 INFO - 'ts_paint', 12:16:11 INFO - 'tpaint', 12:16:11 INFO - 'sessionrestore', 12:16:11 INFO - 'sessionrestore_no_auto_restore']}, 12:16:11 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:16:11 INFO - 'tests': ['a11yr', 12:16:11 INFO - 'ts_paint', 12:16:11 INFO - 'tpaint', 12:16:11 INFO - 'sessionrestore', 12:16:11 INFO - 'sessionrestore_no_auto_restore']}, 12:16:11 INFO - 'other_l64': {'tests': ['a11yr', 12:16:11 INFO - 'ts_paint', 12:16:11 INFO - 'tpaint', 12:16:11 INFO - 'sessionrestore', 12:16:11 INFO - 'sessionrestore_no_auto_restore']}, 12:16:11 INFO - 'other_nol64': {'tests': ['a11yr', 12:16:11 INFO - 'ts_paint', 12:16:11 INFO - 'tpaint', 12:16:11 INFO - 'sessionrestore', 12:16:11 INFO - 'sessionrestore_no_auto_restore']}, 12:16:11 INFO - 'svgr': {'tests': ['tsvgx', 12:16:11 INFO - 'tsvgr_opacity', 12:16:11 INFO - 'tart', 12:16:11 INFO - 'tscrollx', 12:16:11 INFO - 'cart']}, 12:16:11 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:16:11 INFO - 'tests': ['tsvgx', 12:16:11 INFO - 'tsvgr_opacity', 12:16:11 INFO - 'tart', 12:16:11 INFO - 'tscrollx', 12:16:11 INFO - 'cart']}, 12:16:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:11 INFO - 'tests': ['tp5o']}, 12:16:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:11 INFO - 'talos_options': ['--e10s'], 12:16:11 INFO - 'tests': ['tp5o']}, 12:16:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:11 INFO - 'talos_options': ['--xperf_path', 12:16:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:16:11 INFO - 'tests': ['tp5n']}, 12:16:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:11 INFO - 'talos_options': ['--e10s', 12:16:11 INFO - '--xperf_path', 12:16:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:16:11 INFO - 'tests': ['tp5n']}}, 12:16:11 INFO - 'talos.zip': {'path': '', 12:16:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:16:11 INFO - Running post-action listener: _resource_record_post_action 12:16:11 INFO - ##### 12:16:11 INFO - ##### Running create-virtualenv step. 12:16:11 INFO - ##### 12:16:11 INFO - Running pre-action listener: _resource_record_pre_action 12:16:11 INFO - Running main action method: create_virtualenv 12:16:11 INFO - Creating virtualenv /builds/slave/test/build/venv 12:16:11 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 12:16:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:16:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:16:11 INFO - Using real prefix '/usr' 12:16:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:16:12 INFO - Installing distribute.............................................................................................................................................................................................done. 12:16:14 INFO - Installing pip.................done. 12:16:14 INFO - Return code: 0 12:16:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:16: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')]} 12:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16: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')]} 12:16:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f724c51dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25086c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b99a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2648ac0>, '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 0x26499a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2649e50>, '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': 'a65b340e283ce644d68cb24e000001c9-1447445383.947546-1644588785', '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 12:16:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:16:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:16:14 INFO - Using env: {'DISPLAY': ':0', 12:16:14 INFO - 'HOME': '/home/cltbld', 12:16:14 INFO - 'LANG': 'en_US.UTF-8', 12:16:14 INFO - 'LANGUAGE': 'en_US:en', 12:16:14 INFO - 'LOGNAME': 'cltbld', 12:16:14 INFO - 'MAIL': '/var/mail/cltbld', 12:16:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:14 INFO - 'MOZ_NO_REMOTE': '1', 12:16:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:14 INFO - 'NO_EM_RESTART': '1', 12:16:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:14 INFO - 'PWD': '/builds/slave/test', 12:16:14 INFO - 'SHELL': '/bin/bash', 12:16:14 INFO - 'SHLVL': '1', 12:16:14 INFO - 'TERM': 'linux', 12:16:14 INFO - 'TMOUT': '86400', 12:16:14 INFO - 'USER': 'cltbld', 12:16:14 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1447445383.947546-1644588785', 12:16:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:14 INFO - '_': '/tools/buildbot/bin/python'} 12:16:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:14 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 12:16:14 INFO - Cleaning up... 12:16:14 INFO - Return code: 0 12:16:14 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:16: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')]} 12:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16: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')]} 12:16:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f724c51dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25086c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b99a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2648ac0>, '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 0x26499a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2649e50>, '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': 'a65b340e283ce644d68cb24e000001c9-1447445383.947546-1644588785', '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 12:16:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 12:16:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 12:16:14 INFO - Using env: {'DISPLAY': ':0', 12:16:14 INFO - 'HOME': '/home/cltbld', 12:16:14 INFO - 'LANG': 'en_US.UTF-8', 12:16:14 INFO - 'LANGUAGE': 'en_US:en', 12:16:14 INFO - 'LOGNAME': 'cltbld', 12:16:14 INFO - 'MAIL': '/var/mail/cltbld', 12:16:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:14 INFO - 'MOZ_NO_REMOTE': '1', 12:16:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:14 INFO - 'NO_EM_RESTART': '1', 12:16:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:14 INFO - 'PWD': '/builds/slave/test', 12:16:14 INFO - 'SHELL': '/bin/bash', 12:16:14 INFO - 'SHLVL': '1', 12:16:14 INFO - 'TERM': 'linux', 12:16:14 INFO - 'TMOUT': '86400', 12:16:14 INFO - 'USER': 'cltbld', 12:16:14 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1447445383.947546-1644588785', 12:16:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:14 INFO - '_': '/tools/buildbot/bin/python'} 12:16:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:14 INFO - Downloading/unpacking psutil>=0.7.1 12:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:16 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 12:16:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 12:16:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:16:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:16:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:16:16 INFO - Installing collected packages: psutil 12:16:16 INFO - Running setup.py install for psutil 12:16:16 INFO - building 'psutil._psutil_linux' extension 12:16:16 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 12:16:16 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 12:16:16 INFO - building 'psutil._psutil_posix' extension 12:16:16 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 12:16:16 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 12:16:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:16:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:16:16 INFO - Successfully installed psutil 12:16:16 INFO - Cleaning up... 12:16:16 INFO - Return code: 0 12:16:16 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:16:16 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')]} 12:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:16 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')]} 12:16:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:16 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 0x7f724c51dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25086c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b99a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2648ac0>, '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 0x26499a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2649e50>, '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': 'a65b340e283ce644d68cb24e000001c9-1447445383.947546-1644588785', '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 12:16:16 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 12:16:16 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 12:16:16 INFO - Using env: {'DISPLAY': ':0', 12:16:16 INFO - 'HOME': '/home/cltbld', 12:16:16 INFO - 'LANG': 'en_US.UTF-8', 12:16:16 INFO - 'LANGUAGE': 'en_US:en', 12:16:16 INFO - 'LOGNAME': 'cltbld', 12:16:16 INFO - 'MAIL': '/var/mail/cltbld', 12:16:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:16 INFO - 'MOZ_NO_REMOTE': '1', 12:16:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:16 INFO - 'NO_EM_RESTART': '1', 12:16:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:16 INFO - 'PWD': '/builds/slave/test', 12:16:16 INFO - 'SHELL': '/bin/bash', 12:16:16 INFO - 'SHLVL': '1', 12:16:16 INFO - 'TERM': 'linux', 12:16:16 INFO - 'TMOUT': '86400', 12:16:16 INFO - 'USER': 'cltbld', 12:16:16 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1447445383.947546-1644588785', 12:16:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:16 INFO - '_': '/tools/buildbot/bin/python'} 12:16:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:17 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:18 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:16:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 12:16:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:16:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:16:18 INFO - Installing collected packages: mozsystemmonitor 12:16:18 INFO - Running setup.py install for mozsystemmonitor 12:16:18 INFO - Successfully installed mozsystemmonitor 12:16:18 INFO - Cleaning up... 12:16:18 INFO - Return code: 0 12:16:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:16:18 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')]} 12:16:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:18 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')]} 12:16:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:18 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 0x7f724c51dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25086c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b99a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2648ac0>, '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 0x26499a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2649e50>, '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': 'a65b340e283ce644d68cb24e000001c9-1447445383.947546-1644588785', '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 12:16:18 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 12:16:18 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 12:16:18 INFO - Using env: {'DISPLAY': ':0', 12:16:18 INFO - 'HOME': '/home/cltbld', 12:16:18 INFO - 'LANG': 'en_US.UTF-8', 12:16:18 INFO - 'LANGUAGE': 'en_US:en', 12:16:18 INFO - 'LOGNAME': 'cltbld', 12:16:18 INFO - 'MAIL': '/var/mail/cltbld', 12:16:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:18 INFO - 'MOZ_NO_REMOTE': '1', 12:16:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:18 INFO - 'NO_EM_RESTART': '1', 12:16:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:18 INFO - 'PWD': '/builds/slave/test', 12:16:18 INFO - 'SHELL': '/bin/bash', 12:16:18 INFO - 'SHLVL': '1', 12:16:18 INFO - 'TERM': 'linux', 12:16:18 INFO - 'TMOUT': '86400', 12:16:18 INFO - 'USER': 'cltbld', 12:16:18 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1447445383.947546-1644588785', 12:16:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:18 INFO - '_': '/tools/buildbot/bin/python'} 12:16:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:19 INFO - Downloading/unpacking blobuploader==1.2.4 12:16:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:20 INFO - Downloading blobuploader-1.2.4.tar.gz 12:16:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 12:16:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:16:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:16:20 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 12:16:20 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 12:16:20 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 12:16:20 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 12:16:20 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 12:16:20 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 12:16:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 12:16:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:16:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:16:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:21 INFO - Downloading docopt-0.6.1.tar.gz 12:16:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 12:16:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:16:21 INFO - Installing collected packages: blobuploader, requests, docopt 12:16:21 INFO - Running setup.py install for blobuploader 12:16:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:16:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:16:21 INFO - Running setup.py install for requests 12:16:21 INFO - Running setup.py install for docopt 12:16:22 INFO - Successfully installed blobuploader requests docopt 12:16:22 INFO - Cleaning up... 12:16:22 INFO - Return code: 0 12:16:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:16:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f724c51dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25086c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b99a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2648ac0>, '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 0x26499a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2649e50>, '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': 'a65b340e283ce644d68cb24e000001c9-1447445383.947546-1644588785', '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 12:16:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:16:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:16:22 INFO - Using env: {'DISPLAY': ':0', 12:16:22 INFO - 'HOME': '/home/cltbld', 12:16:22 INFO - 'LANG': 'en_US.UTF-8', 12:16:22 INFO - 'LANGUAGE': 'en_US:en', 12:16:22 INFO - 'LOGNAME': 'cltbld', 12:16:22 INFO - 'MAIL': '/var/mail/cltbld', 12:16:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:22 INFO - 'MOZ_NO_REMOTE': '1', 12:16:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:22 INFO - 'NO_EM_RESTART': '1', 12:16:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:22 INFO - 'PWD': '/builds/slave/test', 12:16:22 INFO - 'SHELL': '/bin/bash', 12:16:22 INFO - 'SHLVL': '1', 12:16:22 INFO - 'TERM': 'linux', 12:16:22 INFO - 'TMOUT': '86400', 12:16:22 INFO - 'USER': 'cltbld', 12:16:22 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1447445383.947546-1644588785', 12:16:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:22 INFO - '_': '/tools/buildbot/bin/python'} 12:16:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:16:22 INFO - Running setup.py (path:/tmp/pip-PIoA2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:16:22 INFO - Running setup.py (path:/tmp/pip-PR3iA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:16:22 INFO - Running setup.py (path:/tmp/pip-Y5cC4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:16:22 INFO - Running setup.py (path:/tmp/pip-A2hJfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:16:22 INFO - Running setup.py (path:/tmp/pip-2VTfte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:16:22 INFO - Running setup.py (path:/tmp/pip-iLMvD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:16:22 INFO - Running setup.py (path:/tmp/pip-gocOn8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:16:22 INFO - Running setup.py (path:/tmp/pip-EExRQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:16:22 INFO - Running setup.py (path:/tmp/pip-lqCQlR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:16:22 INFO - Running setup.py (path:/tmp/pip-hz8rSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:16:22 INFO - Running setup.py (path:/tmp/pip-8amWRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:16:23 INFO - Running setup.py (path:/tmp/pip-ePMLzn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:16:23 INFO - Running setup.py (path:/tmp/pip-RDWr_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:16:23 INFO - Running setup.py (path:/tmp/pip-GaiCgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:16:23 INFO - Running setup.py (path:/tmp/pip-PrvYL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:16:23 INFO - Running setup.py (path:/tmp/pip-UC9unn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:16:23 INFO - Running setup.py (path:/tmp/pip-3nbLIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:16:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:16:23 INFO - Running setup.py install for manifestparser 12:16:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:16:23 INFO - Running setup.py install for mozcrash 12:16:23 INFO - Running setup.py install for mozdebug 12:16:23 INFO - Running setup.py install for mozdevice 12:16:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:16:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:16:23 INFO - Running setup.py install for mozfile 12:16:24 INFO - Running setup.py install for mozhttpd 12:16:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:16:24 INFO - Running setup.py install for mozinfo 12:16:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:16:24 INFO - Running setup.py install for mozInstall 12:16:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:16:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:16:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:16:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:16:24 INFO - Running setup.py install for mozleak 12:16:24 INFO - Running setup.py install for mozlog 12:16:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:16:24 INFO - Running setup.py install for moznetwork 12:16:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:16:24 INFO - Running setup.py install for mozprocess 12:16:24 INFO - Running setup.py install for mozprofile 12:16:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:16:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:16:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:16:24 INFO - Running setup.py install for mozrunner 12:16:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:16:24 INFO - Running setup.py install for mozscreenshot 12:16:25 INFO - Running setup.py install for moztest 12:16:25 INFO - Running setup.py install for mozversion 12:16:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:16:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:16:25 INFO - Cleaning up... 12:16:25 INFO - Return code: 0 12:16:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:25 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 0x7f724c51dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25086c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b99a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2648ac0>, '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 0x26499a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2649e50>, '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': 'a65b340e283ce644d68cb24e000001c9-1447445383.947546-1644588785', '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 12:16:25 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 12:16:25 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 12:16:25 INFO - Using env: {'DISPLAY': ':0', 12:16:25 INFO - 'HOME': '/home/cltbld', 12:16:25 INFO - 'LANG': 'en_US.UTF-8', 12:16:25 INFO - 'LANGUAGE': 'en_US:en', 12:16:25 INFO - 'LOGNAME': 'cltbld', 12:16:25 INFO - 'MAIL': '/var/mail/cltbld', 12:16:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:25 INFO - 'MOZ_NO_REMOTE': '1', 12:16:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:25 INFO - 'NO_EM_RESTART': '1', 12:16:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:25 INFO - 'PWD': '/builds/slave/test', 12:16:25 INFO - 'SHELL': '/bin/bash', 12:16:25 INFO - 'SHLVL': '1', 12:16:25 INFO - 'TERM': 'linux', 12:16:25 INFO - 'TMOUT': '86400', 12:16:25 INFO - 'USER': 'cltbld', 12:16:25 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1447445383.947546-1644588785', 12:16:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:25 INFO - '_': '/tools/buildbot/bin/python'} 12:16:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:16:25 INFO - Running setup.py (path:/tmp/pip-O2c7QP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:16:25 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)) 12:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:16:25 INFO - Running setup.py (path:/tmp/pip-z1Tuhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:16:25 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)) 12:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:16:25 INFO - Running setup.py (path:/tmp/pip-sB8oTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:16:25 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)) 12:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:16:25 INFO - Running setup.py (path:/tmp/pip-yrfRkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:16:25 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)) 12:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:16:25 INFO - Running setup.py (path:/tmp/pip-vaH3NZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:16:25 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)) 12:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:16:25 INFO - Running setup.py (path:/tmp/pip-mIWPq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:16:25 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)) 12:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:16:25 INFO - Running setup.py (path:/tmp/pip-TaCs6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:16:25 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)) 12:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:16:25 INFO - Running setup.py (path:/tmp/pip-3TMgdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:16:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:16:26 INFO - Running setup.py (path:/tmp/pip-hcXV7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:16:26 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)) 12:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:16:26 INFO - Running setup.py (path:/tmp/pip-dtRfeW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:16:26 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)) 12:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:16:26 INFO - Running setup.py (path:/tmp/pip-kmfrDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:16:26 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)) 12:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:16:26 INFO - Running setup.py (path:/tmp/pip-kUzE3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:16:26 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)) 12:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:16:26 INFO - Running setup.py (path:/tmp/pip-N8eny0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:16:26 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)) 12:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:16:26 INFO - Running setup.py (path:/tmp/pip-mSdLsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:16:26 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)) 12:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:16:26 INFO - Running setup.py (path:/tmp/pip-Gufw0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:16:26 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)) 12:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:16:26 INFO - Running setup.py (path:/tmp/pip-niaK6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:16:26 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)) 12:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:16:26 INFO - Running setup.py (path:/tmp/pip-0hNlTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:16:26 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)) 12:16:26 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)) 12:16:26 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)) 12:16:26 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)) 12:16:26 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)) 12:16:26 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)) 12:16:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:16:26 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 12:16:26 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 12:16:26 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 12:16:26 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 12:16:26 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 12:16:26 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 12:16:28 INFO - Downloading blessings-1.5.1.tar.gz 12:16:28 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 12:16:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:16:28 INFO - Installing collected packages: blessings 12:16:28 INFO - Running setup.py install for blessings 12:16:28 INFO - Successfully installed blessings 12:16:28 INFO - Cleaning up... 12:16:28 INFO - Return code: 0 12:16:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:16:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:16:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:16:28 INFO - Reading from file tmpfile_stdout 12:16:28 INFO - Current package versions: 12:16:28 INFO - argparse == 1.2.1 12:16:28 INFO - blessings == 1.5.1 12:16:28 INFO - blobuploader == 1.2.4 12:16:28 INFO - docopt == 0.6.1 12:16:28 INFO - manifestparser == 1.1 12:16:28 INFO - mozInstall == 1.12 12:16:28 INFO - mozcrash == 0.16 12:16:28 INFO - mozdebug == 0.1 12:16:28 INFO - mozdevice == 0.47 12:16:28 INFO - mozfile == 1.2 12:16:28 INFO - mozhttpd == 0.7 12:16:28 INFO - mozinfo == 0.9 12:16:28 INFO - mozleak == 0.1 12:16:28 INFO - mozlog == 3.0 12:16:28 INFO - moznetwork == 0.27 12:16:28 INFO - mozprocess == 0.22 12:16:28 INFO - mozprofile == 0.27 12:16:28 INFO - mozrunner == 6.11 12:16:28 INFO - mozscreenshot == 0.1 12:16:28 INFO - mozsystemmonitor == 0.0 12:16:28 INFO - moztest == 0.7 12:16:28 INFO - mozversion == 1.4 12:16:28 INFO - psutil == 3.1.1 12:16:28 INFO - requests == 1.2.3 12:16:28 INFO - wsgiref == 0.1.2 12:16:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:16:28 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')]} 12:16:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:28 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')]} 12:16:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:28 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 0x7f724c51dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25086c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b99a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2648ac0>, '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 0x26499a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2649e50>, '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': 'a65b340e283ce644d68cb24e000001c9-1447445383.947546-1644588785', '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 12:16:28 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 12:16:28 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 12:16:28 INFO - Using env: {'DISPLAY': ':0', 12:16:28 INFO - 'HOME': '/home/cltbld', 12:16:28 INFO - 'LANG': 'en_US.UTF-8', 12:16:28 INFO - 'LANGUAGE': 'en_US:en', 12:16:28 INFO - 'LOGNAME': 'cltbld', 12:16:28 INFO - 'MAIL': '/var/mail/cltbld', 12:16:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:28 INFO - 'MOZ_NO_REMOTE': '1', 12:16:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:28 INFO - 'NO_EM_RESTART': '1', 12:16:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:28 INFO - 'PWD': '/builds/slave/test', 12:16:28 INFO - 'SHELL': '/bin/bash', 12:16:28 INFO - 'SHLVL': '1', 12:16:28 INFO - 'TERM': 'linux', 12:16:28 INFO - 'TMOUT': '86400', 12:16:28 INFO - 'USER': 'cltbld', 12:16:28 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1447445383.947546-1644588785', 12:16:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:28 INFO - '_': '/tools/buildbot/bin/python'} 12:16:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:16:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:16:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:16:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:16:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:16:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:16:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:16:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:16:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:16:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:16:29 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:16:29 INFO - Cleaning up... 12:16:29 INFO - Return code: 0 12:16:29 INFO - Running post-action listener: _resource_record_post_action 12:16:29 INFO - Running post-action listener: _start_resource_monitoring 12:16:29 INFO - Starting resource monitoring. 12:16:29 INFO - ##### 12:16:29 INFO - ##### Running install step. 12:16:29 INFO - ##### 12:16:29 INFO - Running pre-action listener: _resource_record_pre_action 12:16:29 INFO - Running main action method: install 12:16:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:16:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:16:29 INFO - Reading from file tmpfile_stdout 12:16:29 INFO - Detecting whether we're running mozinstall >=1.0... 12:16:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:16:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:16:29 INFO - Reading from file tmpfile_stdout 12:16:29 INFO - Output received: 12:16:29 INFO - Usage: mozinstall [options] installer 12:16:29 INFO - Options: 12:16:29 INFO - -h, --help show this help message and exit 12:16:29 INFO - -d DEST, --destination=DEST 12:16:29 INFO - Directory to install application into. [default: 12:16:29 INFO - "/builds/slave/test"] 12:16:29 INFO - --app=APP Application being installed. [default: firefox] 12:16:29 INFO - mkdir: /builds/slave/test/build/application 12:16:29 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'] 12:16:29 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 12:16:43 INFO - Reading from file tmpfile_stdout 12:16:43 INFO - Output received: 12:16:43 INFO - /builds/slave/test/build/application/firefox/firefox 12:16:43 INFO - Running post-action listener: _resource_record_post_action 12:16:43 INFO - ##### 12:16:43 INFO - ##### Running run-tests step. 12:16:43 INFO - ##### 12:16:43 INFO - Running pre-action listener: _resource_record_pre_action 12:16:43 INFO - Running main action method: run_tests 12:16:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:16:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:16:43 INFO - Python 2.7.3 12:16:43 INFO - Return code: 0 12:16:43 INFO - grabbing minidump binary from tooltool 12:16:43 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')]} 12:16:43 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 0x2648ac0>, '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 0x26499a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2649e50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:16:43 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 12:16:43 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 12:16:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:16:43 INFO - Return code: 0 12:16:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:16:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:16:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:16:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:16:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:16:43 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OOG17jUCTP6c4jwOJuo1-g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost'] in /builds/slave/test/build 12:16:43 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OOG17jUCTP6c4jwOJuo1-g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --webServer localhost 12:16:43 INFO - Using env: {'DISPLAY': ':0', 12:16:43 INFO - 'HOME': '/home/cltbld', 12:16:43 INFO - 'LANG': 'en_US.UTF-8', 12:16:43 INFO - 'LANGUAGE': 'en_US:en', 12:16:43 INFO - 'LOGNAME': 'cltbld', 12:16:43 INFO - 'MAIL': '/var/mail/cltbld', 12:16:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:16:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:16:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:43 INFO - 'MOZ_NO_REMOTE': '1', 12:16:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:16:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:43 INFO - 'NO_EM_RESTART': '1', 12:16:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:43 INFO - 'PWD': '/builds/slave/test', 12:16:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:16:43 INFO - 'SHELL': '/bin/bash', 12:16:43 INFO - 'SHLVL': '1', 12:16:43 INFO - 'TERM': 'linux', 12:16:43 INFO - 'TMOUT': '86400', 12:16:43 INFO - 'USER': 'cltbld', 12:16:43 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1447445383.947546-1644588785', 12:16:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:43 INFO - '_': '/tools/buildbot/bin/python'} 12:16:43 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OOG17jUCTP6c4jwOJuo1-g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost'] with output_timeout 3600 12:16:43 INFO - mozversion INFO | application_buildid: 20151113071449 12:16:43 INFO - mozversion INFO | application_changeset: d1029ba11d5c64c455412a58a2a77d14511286d6 12:16:43 INFO - mozversion INFO | application_display_name: Nightly 12:16:43 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:16:43 INFO - mozversion INFO | application_name: Firefox 12:16:43 INFO - mozversion INFO | application_remotingname: firefox 12:16:43 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 12:16:43 INFO - mozversion INFO | application_vendor: Mozilla 12:16:43 INFO - mozversion INFO | application_version: 45.0a1 12:16:43 INFO - mozversion INFO | platform_buildid: 20151113071449 12:16:43 INFO - mozversion INFO | platform_changeset: d1029ba11d5c64c455412a58a2a77d14511286d6 12:16:43 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 12:16:43 INFO - mozversion INFO | platform_version: 45.0a1 12:16:43 INFO - 2015-11-13 12:16:43,665 DEBUG : using testdate: 1447445803 12:16:43 INFO - 2015-11-13 12:16:43,665 DEBUG : actual date: 1447445803 12:16:43 INFO - 2015-11-13 12:16:43,679 INFO : starting webserver on 'localhost:51493' 12:16:43 INFO - 2015-11-13 12:16:43,680 INFO : Starting test suite talos-linux64-ix-026 12:16:43 INFO - 2015-11-13 12:16:43,680 INFO : Starting test dromaeo_css 12:16:43 INFO - 2015-11-13 12:16:43,680 DEBUG : operating with platform_type : linux_ 12:16:43 INFO - 2015-11-13 12:16:43,681 INFO : Initialising browser for dromaeo_css test... 12:16:43 INFO - 2015-11-13 12:16:43,693 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEvY2G9/profile http://localhost:51493/getInfo.html 12:16:48 INFO - 2015-11-13 12:16:48,102 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:16:48 INFO - 2015-11-13 12:16:48,102 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:16:48 INFO - 2015-11-13 12:16:48,102 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:16:48 INFO - 2015-11-13 12:16:48,103 DEBUG : BROWSER_OUTPUT: __metrics 12:16:48 INFO - 2015-11-13 12:16:48,260 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:16:49 INFO - 2015-11-13 12:16:49,363 INFO : Browser initialized. 12:16:49 INFO - 2015-11-13 12:16:49,364 INFO : Running cycle 1/1 for dromaeo_css test... 12:16:49 INFO - 2015-11-13 12:16:49,364 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEvY2G9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:17:01 INFO - 2015-11-13 12:17:01,261 DEBUG : BROWSER_OUTPUT: RSS: Main: 141185024 12:17:01 INFO - 2015-11-13 12:17:01,261 DEBUG : BROWSER_OUTPUT: 12:17:52 INFO - 2015-11-13 12:17:52,574 DEBUG : BROWSER_OUTPUT: 1447445872566 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] 12:20:04 INFO - 2015-11-13 12:20:04,372 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51493/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51493/tests/dromaeo/cssquery-ext.html) 12:20:05 INFO - 2015-11-13 12:20:05,456 DEBUG : BROWSER_OUTPUT: RSS: Main: 244850688 12:20:05 INFO - 2015-11-13 12:20:05,457 DEBUG : BROWSER_OUTPUT: 12:23:08 INFO - 2015-11-13 12:23:08,012 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51493/tests/dromaeo/cssquery-ext.html (next: http://localhost:51493/tests/dromaeo/cssquery-jquery.html) 12:23:08 INFO - 2015-11-13 12:23:08,577 DEBUG : BROWSER_OUTPUT: RSS: Main: 210210816 12:23:08 INFO - 2015-11-13 12:23:08,577 DEBUG : BROWSER_OUTPUT: 12:26:10 INFO - 2015-11-13 12:26:10,526 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51493/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51493/tests/dromaeo/cssquery-mootools.html) 12:26:11 INFO - 2015-11-13 12:26:11,108 DEBUG : BROWSER_OUTPUT: RSS: Main: 203784192 12:26:11 INFO - 2015-11-13 12:26:11,108 DEBUG : BROWSER_OUTPUT: 12:29:13 INFO - 2015-11-13 12:29:13,029 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51493/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51493/tests/dromaeo/cssquery-prototype.html) 12:29:13 INFO - 2015-11-13 12:29:13,610 DEBUG : BROWSER_OUTPUT: RSS: Main: 199462912 12:29:13 INFO - 2015-11-13 12:29:13,610 DEBUG : BROWSER_OUTPUT: 12:32:16 INFO - 2015-11-13 12:32:16,297 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51493/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51493/tests/dromaeo/cssquery-yui.html) 12:32:16 INFO - 2015-11-13 12:32:16,865 DEBUG : BROWSER_OUTPUT: RSS: Main: 204423168 12:32:16 INFO - 2015-11-13 12:32:16,865 DEBUG : BROWSER_OUTPUT: 12:35:19 INFO - 2015-11-13 12:35:19,349 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51493/tests/dromaeo/cssquery-yui.html (next: http://localhost:51493/tests/dromaeo/cssquery-dojo.html) 12:35:19 INFO - 2015-11-13 12:35:19,607 DEBUG : BROWSER_OUTPUT: RSS: Main: 246063104 12:35:19 INFO - 2015-11-13 12:35:19,607 DEBUG : BROWSER_OUTPUT: 12:35:19 INFO - 2015-11-13 12:35:19,607 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:35:19 INFO - 2015-11-13 12:35:19,607 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:35:19 INFO - 2015-11-13 12:35:19,607 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:35:19 INFO - 2015-11-13 12:35:19,608 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:35:19 INFO - 2015-11-13 12:35:19,608 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2624.33079564711;2703.0809524761576;2708.580170073638;2711.9457610847794;2724.7275272472757;4592.035672508777;4680.461746899112;4700.482946875841;4712.128256272592;4715.669903106779;4666.160091183586;4669.556392142741;4727;4727.22000869856;4737.7631118444115;4324.07032488015;4374.387585737999;4406.71356361837;4442.3336499525;4478.305862591287;4208.410822484854;4401.163778882018;4407.779611019452;4453.53237910018;4479.328100784892;4214.093969796509;4292.50636176839;4300.311950087971;4302.354646802974;4316.870493885189;4395.626371758404;4396.626286765629;4402.889927751799;4413.227685155117;4436.401085853433;4140.60664236897;4245.830166793356;4361.781910904442;4387.451568553931;4426.867193984185;4615.215413379734;4680.765961701902;4704.647151463654;4732.124556956974;4733.077049975256;4983.526564976358;4988.775505102279;4991.126552853236;5022.673526220784;5113.488651134894;4832.395950506187;4946.802127914879;5002;5004.324416203803;5044.924326135111;4558.8632341029825;4604.769761511911;4607.378003969421;4655.4878963314;4672.182368085605;5224.242484839677;5225.085610018307;5231.032259032091;5233.267342572043;5277.630565860353;4769.761511924459;4876.975615121902;5021.648484606116;5030.0694371541385;5036.874078148076;5026.170681837456;5030.773615187325;5108.233764935289;5108.744562771846;5131.102057139986;5046.697198168122;5054.949450505448;5062.670926389773;5064.949350506521;5102.081625307406;4799.472058073609;4918.213085906309;5015.548600625962;5022.748862556858;5025.422076461181;4144.689148313828;4185.707000509996;4208.074223670787;4219.9789001055415;4221.598948099926;3748.868789592406;3753.418220175877;3757.04195430169;3769.095417099931;3785.242951409729;4178.477690288714;4440.267355886307;4440.489343725449;4451.643868490513;4489.910201795946;4905.779239934212;4977.1538838397555;4991;5067.695938243717;5118.283440318359;4344.956550434518;4358.8038538265855;4364.148990946798;4366.279563871989;4403.295472724349;4260.488741351058;4506.81972721094;4508.391367165391;4514.819407223675;4545.954540454619;4666.533346665306;4669.836555720602;4690.273007683746;4767.046590681947;4804.42346918372;5094.7707353169935;5099.133147365031;5099.413567439792;5117.053345131014;5132.820351287687;4532.32015197723;4833.250846118857;4834.081524510332;4838.322634831196;4884.7069175849565;4874.293227482066;4892.68197567157;4945.777440015136;5009.7996080157845;5036.496350364934;5132.461091585479;5134.743262836769;5135.332406787244;5136.922946155736;5154.304168937296;4971.2046072629655;4982.252662100569;4982.277569752293;4983.626228032985;5003.0744312300885;4722.960948591304;4859.611231101433;4861.854144375674;4887.022595480989;4958.057968985881;4837.612990960644;4840.177169881058;4851.102546028996;4860.562549370432;4875.731834749123;4944.233643785075;4945.727984960861;4956.281339205723;4989.72556509381;4993.300937868774;4641.327007583814;4740.905181896412;4744.762761861962;4758.76206189696;4853.369062022056 12:35:19 INFO - 2015-11-13 12:35:19,608 DEBUG : BROWSER_OUTPUT: |1;ext.html;548.4570275427327;555.5194756535595;556.0769123255396;572.133218174466;582.798934367643;27762.722372776265;36064.81967590165;36386.8180659097;36387.63612363879;36487.27025459496;40063.19873602533;40471.190576188455;40547.39178912318;40561.18877622446;40688;7006.369426751591;7121.181064177608;7982.92017079829;8161.714339998101;8167.918320816775;10246.692599221999;10515.263931524796;10531.473426328692;10541.683749487527;10542.47287635619;10222;10335.069843714064;10341.844872326921;10346.224033197503;10349.948250258738;7151.427885769126;7328.890066649004;7338.889916651255;7345.3021962913435;9886.060824221688;7036;10279.434631095286;10544;10560.577576896914;10567.78864422715;36567.26865462703;37092.629073709184;37117.44323835144;37158;37220.813895930616;2965.4662160811044;3015.306479509703;3039.8784048638026;3043.786934914535;3489.7731647442833;27524.862375687993;27740.861295693594;28439.431211375657;28746.856265718747;29846.70153298461;3140.3876244132402;3177.777555571111;3233.175540237248;3233.5958005249345;3279.1474216703828;229364;229728;230137;230279;231051;46935.765321173174;47832.282515762294;55620;55918.440815592134;56027.43972560222;59974.40025599775;60917.39082609117;61002.69498652567;61045;61058.38941610527;13716.794248086288;13905.513307034205;13960.022798404014;13978.650533736534;13992.790108148385;9315.627374905063;9582.472963987047;10410.167186625053;10484.63303784379;10493.685189444328;19221.90389048046;19438.4168474946;19550.5112372189;19605.8039419604;19686.90156549208;7557.5465472071855;7866.881996769938;7869.370450363957;7965.8805117923275;8040.638171282189;789.0334340433038;833.4790755777639;836.7908022994252;912.1106920752346;961.2694352292308;24070.51858962811;26067.73932260691;26124.73875261261;26148.73851261463;26150.73849261521;932.165711688049;938.3712912348743;939.5818860607101;976.3995142987012;1117.100733909211;13350.46598136083;13527.526536571173;13663.795043074362;13681.31593420325;13738.86261137376;531031;543248;544712;549120;553637;48626;49319.260211096145;49351;49456.50543494519;49459;1200.1778781534676;1218.3908045977012;1219.183147291317;1228.0175859312515;1229.428315833124;26744;27784.86107569449;27789.722102778713;28073.157805265873;28311.2922176939;39581.604183958945;40073.79963100166;40087;40093.59906400899;40094.39858402068;248170;248227;249958;250036;251332;23505.764942350357;28217.858910705316;28218.2945426366;28293.71706282911;28640.283992900346;33731.83134084314;45070.549294506636;46258.074838503715;46592.53407465882;47198;33857.66142338644;34448.13879652928;35003.47494787529;35143.648563514034;35310.646893530735;32908.50637240396;33904.3219135611;34456;34624.653753462146;37013.81493092625;34363;34625.307493849476;34883.30233395369;34940.47589286112;35124.297514050086;28393.43213135767;31389.52915706312;31582.684173157973;31645.683543164272;31709.5243571342;24142;24402.633960490963;24597.754022459547;24869.25392238236;24886.37784055413 12:35:19 INFO - 2015-11-13 12:35:19,608 DEBUG : BROWSER_OUTPUT: |2;jquery.html;324.1846755410143;325.35904268590883;330.84615653721016;333.5796895911152;339.4822895084995;14777;15157.621059473506;15232.847671523281;15488.922555387235;15539.456119035836;12171.33057681827;12211.328376939266;12225.205361651486;12228.44971976261;13650.522231721892;4796.4244290685165;5077.720725360104;5091.643584949055;5092.949070509303;5095.3376061112185;5033.949660503385;5056.494350564933;5067.923981140286;5070.580237533478;5074.822381216658;3552.342816578941;3646.3254297954963;4896.975515122419;5026.346574945252;5700.572457065716;5717.999350113713;5718.714064296769;5731.627444216134;5738.340090889559;5762;3930.233604447134;4015.9397609035886;4020.296448121567;5021.322121513585;5026.045051440251;10355.94822025885;10851.728706782314;11677.41612919359;11782.082204043118;11982.64052078439;1673.3306677329044;1681.6468541606278;1739.5998920248414;1773.645270945816;1781.8841775284695;9116.954415227881;9282.489463079528;9331.175035022843;9442.339036267464;9442.858357124649;1529.6099494628797;1616.1353675783516;1617.4096454794033;1620.473346162502;1647.604574902015;52481.21278180869;53888.46111538874;54393;54892.72553637206;55025.44974550283;6488.740450381932;6496.382843629847;6514.478841692653;6558;6581.86836263272;7459.664315105833;7552.320291173711;7556.395488360918;7574.128975167816;7579.393648508106;4925.630577706686;4941.65408421407;4954.975225123923;4965.851024469272;4986.254810816185;4882.316475693406;4906.313116163668;4975.676581022294;5025.824096156617;5039.84880453587;2962.6153293126295;2998.610180676498;3027.742641875421;3031.7271445570004;3031.969680303213;1050.9737256568646;1054.9525271362807;1066.8719753629614;1089.411717672448;1113.3041848844473;351.4552443712287;376.5481422293259;424.3253227368499;424.60299619855533;445.4698908299114;10201.234907381977;10480.947595261974;10525.84211236832;10538.420386878795;10578.788424231472;353.39216547538194;419.5846112348814;425.7977460706202;432.3342053238041;435.9084592235666;5521.337439507285;5595.580331475156;5731.426857314319;5740.885182296331;5822.126680997884;459940;466720;474110;477795;482615;62375;63907;65310.34689653137;65504.672476637315;66827.33172668211;464.1482878917157;466.48453458928077;474.46148621314364;480.61310644931166;481.1675800864524;9321;9346.579403926975;9488.95255523718;9596.9040309596;10155.593776249163;29607;30787.38425231438;31011.224719382197;33008.33983320272;33582.49626255657;42403.363949541395;42629.786851065546;43011.3548296782;43258;43837;14116.435342586181;14288.928555357157;14356.210408427636;14387.784183237469;14664.12015279044;17617.64764704673;17660.470185894443;18015.369462068764;18077.005764682544;18139.546511336794;14001.789973150208;15021.699566008838;15162.848371516586;15277.694446111238;15330.386784528493;8630.654773809229;8797.516136612549;14331.570052898429;14821.703565928836;14981;8601.35489838252;8774.122587741174;9026.413283136575;9068.503696889939;9075.863862041942;9560.713178604654;13325.866741332851;13426.731465370833;13550.322483875963;13577.932110339385;13138.474461021453;13257.80113298282;13264.80102798478;13297.80053299182;13562.864371356554 12:35:19 INFO - 2015-11-13 12:35:19,608 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1367.1660287224793;1425.593705793849;1528.6636939873224;1600.3758534171668;1701.506563096702;6582.4075833175;6688.765893193739;6690.531662783601;6740.22487413947;6746.6626668666495;6830.624315662637;6875.346842049998;6878.552894061882;6888.965555172217;6897.068895699079;1954.3062212914388;1975.5752513209657;1975.940721778349;1975.9802401976012;1977.772556156039;2005.1077270614583;2015.083137172583;2016.5865997470557;2020.0909590684178;2047.2015913793632;1661.9002859828388;1692.0270844264535;1936.9225230990744;1978.9808248751904;1996.950076248091;1921.0682818832854;1934.139308007937;1941.2914286285545;1942.9611407771836;1944.8930308833008;1936.0513348459153;1959.226105688245;2026.0882602828785;2028.4320390290743;2031.3702752146735;5914.674692891889;5999.220101386835;6604.405603495708;6785.219699734495;6793.252742198354;4036.414719865603;4091.3453847384276;4103.2409004334295;4103.5691252418665;4104.835806567734;2662.5739881618847;2671.6259723638705;2707.472042951625;2716.4838680650614;2740.10946442407;863.5164307987548;908.7092130518237;910.026271889079;918.9448633082036;925.3383830561181;9293.953530232373;9341.859872101855;9361.672341468084;9370.765730856714;9370.95314523423;3848.9615103849164;3901.668358189529;3904.668103211202;3936.9212615748097;3953.6046395360236;8124.390670699721;8139.43023988327;8144.14486478923;8144.185581441927;8153.510789352657;4179.477565304337;4203.558626344251;4204.705670603028;4206.074663574009;4208.200441916026;3784.6404591563755;3792.412176112707;3805.505284313077;3808.200277941608;3815.4276858471453;3087.0397297716113;3101.8138911665374;3103.239706271933;3112.9221769455944;3113.9377212455624;1006.9295149339476;1009.0414106598761;1012.9848052279222;1036.8548403223556;1038.8389799581078;911.544227886057;978.2223132609593;1157.4155051698838;1187.4478367559127;1196.294186429993;6632.2372927114;6654.367835055662;6671.1994560652065;6681.76613818514;6696.296888826603;1034.75165960169;1047.5181416548473;1058.6400623787795;1062.8033813744482;1086.5002099034532;4889.413270407574;5336.839894803162;5364.839054828361;5370.543503802142;5380;7446.515976461513;8119.594020298961;8239.670413183405;8313.12712165226;8352.081271060179;8105.837883242302;8146.75559733209;8177.79555511117;8185.386096042821;8218.096009438957;6197.349278325801;6317.1156038154695;6332.366763323723;6341.048842673636;6371.585846919936;6417.647029413427;6472.579282346821;6477.77327793525;6494.350564943468;6505.316941721051;7192.856142877218;7474.289942455458;7532.661030253761;7533.510321829063;7550.848983020419;7520.699172033276;7665.731699390494;7711.190325016017;7796.10344810354;7823.061232652118;6273.498120150468;6303.9684801575695;6327.430531252209;6357.618542887441;6383.712732926937;6831.11195544576;6868.553544019623;6869.862602748017;6871.896921546081;6898.896516552356;6472.385123413268;6536.084948107364;6543.857290125977;6580.5722628029025;6638.701258443285;6334.873302534015;6367.968160159169;6446;6499.122618446449;6558.704858281293;6175.84560385994;6219.875602488016;6232.626042437469;6234.438900498977;6239.688015599293;5973.611715238496;6002.969985150046;6047.123167140828;6052.0316749321655;6096.268447786117;6089.208402907594;6128.846778830565;6133.877322453437;6134.693265336805;6135.447809697149 12:35:19 INFO - 2015-11-13 12:35:19,608 DEBUG : BROWSER_OUTPUT: |4;prototype.html;282.50984541819946;287.079908892001;290.6860590562192;291.11646153922834;292.3874482958202;5124.692518448886;5379.488948549886;5419.864503387417;5450.56395488361;5451.928267258441;5402.189671549269;5417.079096553585;5417.106177480711;5428.321459817523;5428.782848686048;4130.607592278744;4134.297169481188;4134.875953721393;4148.917021659565;4149.522804877448;4135.958640413587;4136.482939632546;4149;4149.502059752819;4154.169166166764;4014.2573623879675;4099.8770036898795;4101.815418306169;4102.610252026067;4107.260693075245;4085.7957102144774;4100.056986893016;4100.507939047304;4100.917981640366;4114.280000999843;3563.803990780506;3569.5002699622073;3574.0350105471375;3578.624244454347;3580.44503102017;5247.422783493813;5249.291345668324;5279.208118782213;5284.101702710548;5290.497402746733;4461.821527138911;4724.858254252378;4729.0541891621815;4733.621310295168;4736.550027747358;4643.721376717374;5266.92099618506;5447.155690867922;5589.496945274904;5675.971620141914;3873.5932727063814;3903.746256493319;3914.7846868422225;3918.725689201757;3923.058465968176;5622.381538030813;5790.913136303001;5930.673812940287;5932.584719069667;5939.613925094898;3934.429507721364;3955;3963.147923196527;4022.074922767721;4042.312806822847;4081.428599996003;4103.4870641169855;4109.116539943867;4109.239790638741;4110.095778928631;4675.345451636774;4689;4705.223638099744;4707.81168753246;4715.174844402216;5456.536194423518;5638.887222255532;5655.886882262332;5657.915131273035;5660.547156227574;1374.4639590559689;1374.5051781358702;1376.6076668149528;1376.8347798264272;1377.1461693749939;893.718478679214;903.2728653433917;915.2906497464385;915.7619019054961;921.1847514949318;4972.701637901738;4973.477784832613;4982.003599280086;4982.153033984231;4986.900261994812;5852.619579727304;5864.882702346014;5873.148393483007;5874.089516125007;5874.882502349929;4964.677295975822;4976.800927962913;4982.750862456863;4984.2025275955675;4984.825531106467;3088.5984821972997;3139.8744050237733;3173.9365212695616;3175.4601717708047;3178.682131786849;5617.157426385993;5627.8593035174445;5631.324241091095;5637.774489020393;5640.153976903497;6095.420935011167;6096.390360963868;6103.816885493442;6111.297200821962;6111.602745821508;5594.664320140723;5600.299962504687;5600.747966341524;5604.41153678866;5605.747741351567;5705.942940570541;5859.326177489473;5914.319853216935;5934.881302374015;5937.703114844154;5774.249347584787;5777.335606405317;5782.826515204551;5786.30564332266;5789.710514474344;5364.114921037985;5606.775728970795;5615.382307946041;5619.494245517923;5630.23991761107;3718.0704823794053;3861.67175790061;3953.802309884437;3957.6635985941516;3958.8218530165636;5829.0090684584575;5858;5860.560457965755;5867.325257595431;5871.089981052944;5648.915266270927;5652.180433836988;5656.915146272891;5657.066584013592;5659.688717120598;5538.113901775858;5620.960122377373;5637.548996080386;5654.604177707521;5661.66030038199;5526.198701188386;5531.9723401382735;5545.667259964415;5547.778088876561;5557.610967232255;5684.147377893349;5691.943080569141;5700.401457846866;5703.030484817674;5705;5410.648307859977;5547;5547.278853748987;5551.195076713934;5551.8889622208135 12:35:19 INFO - 2015-11-13 12:35:19,608 DEBUG : BROWSER_OUTPUT: |5;yui.html;647.213635432949;667.5327270910363;748.8801791713323;757.821911850715;774.3185996323239;11811.763764724701;11816.172867899251;12114.636560903165;12132.454039568218;12147.514099436023;11877.821832672516;11945.402729863494;11979.7604047919;11981.041516678666;12008.399580020985;604.8880957022943;611.544399422431;774.2567135549879;788.2196625340929;805.7582725182451;793.6825269892032;801.2028032108061;801.6793282686942;805.64551597297;808.9029316482001;824.884516167737;839.5927974932154;840.3781201910604;841.4110122913954;841.6423020216414;627.2754968011953;637.1207733328001;814.6252723747053;839.8152406470567;840.7771940435789;598.0132780911488;603.2369053147771;604.2959951656316;605.0863196573163;607.4472230270477;11579.015783658399;11849.69653338132;11862.644120676394;11865.466054027589;11946.283223006647;11145.777084458347;11330.886691133066;11631.30212187263;11940.522379104825;12590.118691691585;9517.286203534693;9539.47532885698;9625.326227164102;9677.854832177452;9772.51137443132;3282.720968717638;3333.866645334184;3357.9832100839585;3365.7475689323155;3365.848536815825;39839;41125.794371028256;41344;41651.58348416538;41701.79149104235;8592.183742544448;9476.526173691425;9484;9491.19324857381;9572.521373931415;16796.916015419843;16820.495385138467;16821.41125060617;16824.915875420545;16842;6722.798316050526;6839.658017099126;6854.074699915547;6890.621015844176;6958.512904096665;3772.245550889833;3826.559945606291;3934.272159650474;3936.0356712605594;4014.6788256939376;2768.9030883918967;2774.195483309858;2794.9720502795117;2796.384795345021;2801.2856721535877;411.78381349791;414.1654566049413;419.14494431360293;420.44711204765633;422.2336459326313;514.5471984653481;559.9552035837205;573.4237091722792;595.8033848829875;623.1805176193292;8057.919420805717;8078.838423231502;8180.427370084156;8705.260052895575;8706.869396959051;408.98159582818846;473.64713288599523;477.3246103825517;488.9926651100236;615.6613862375675;3492.371373152857;3613.674769270726;3746.4942232798767;3749.700023998128;3873.7288389812443;48389.758051209516;49424.25863612049;52488.47511524836;52884;53103;41599.04415791284;41709.37435938463;41852.790736046125;42055.57944420578;42380.338162802065;42342.36486452706;42982.35526467105;43053.354199687026;44679.55320446884;44738;7950.125486196398;8071.959640201761;8332.375071869512;8367.163283671583;8470.407071504935;31533.684663153992;31943;32239.35521289608;32249;32460;38976.80511597424;39350.80324598359;40777.38833917553;42889;43166.56833431751;6305.842353941005;6864.931350686429;6921.446284297345;6944.583325000516;7091.716331346895;11303.547858085585;11311.830322545004;11313.604023859454;11498.942505287754;11569.768604628029;10731.087857531886;10806;10937.45312734376;10963.50664220096;10973.945130274617;10833.620823271147;10888;10906.127509799355;11093.168012399265;11467.942660286979;10809.297395669257;10861.456927153453;11004.889951100708;11185.105191584491;11189.048930840645;9180.127887850644;9189.954050229973;9374.343795934219;9562.665306714232;9580.712578622653;9144.771380715269;9152.633894644407;9157.404768690014;9245.167934885892;9287.535623218677 12:35:19 INFO - 2015-11-13 12:35:19,608 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:35:19 INFO - 2015-11-13 12:35:19,609 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:35:19 INFO - 2015-11-13 12:35:19,609 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,869 12:35:19 INFO - 2015-11-13 12:35:19,609 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:35:19 INFO - 2015-11-13 12:35:19,609 DEBUG : BROWSER_OUTPUT: __startTimestamp1447446919600__endTimestamp 12:35:19 INFO - 2015-11-13 12:35:19,609 DEBUG : BROWSER_OUTPUT: 12:35:19 INFO - 2015-11-13 12:35:19,610 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:35:19 INFO - 2015-11-13 12:35:19,610 DEBUG : BROWSER_OUTPUT: Number of tests: 6 12:35:19 INFO - 2015-11-13 12:35:19,610 DEBUG : BROWSER_OUTPUT: 12:35:19 INFO - 2015-11-13 12:35:19,611 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4660.24 Median:4744.76 stddev:483.88 (10.2%) stddev-sans-first:458.25 12:35:19 INFO - 2015-11-13 12:35:19,611 DEBUG : BROWSER_OUTPUT: Values: 2624.3 2703.1 2708.6 2711.9 2724.7 4592.0 4680.5 4700.5 4712.1 4715.7 4666.2 4669.6 4727.0 4727.2 4737.8 4324.1 4374.4 4406.7 4442.3 4478.3 4208.4 4401.2 4407.8 4453.5 4479.3 4214.1 4292.5 4300.3 4302.4 4316.9 4395.6 4396.6 4402.9 4413.2 4436.4 4140.6 4245.8 4361.8 4387.5 4426.9 4615.2 4680.8 4704.6 4732.1 4733.1 4983.5 4988.8 4991.1 5022.7 5113.5 4832.4 4946.8 5002.0 5004.3 5044.9 4558.9 4604.8 4607.4 4655.5 4672.2 5224.2 5225.1 5231.0 5233.3 5277.6 4769.8 4877.0 5021.6 5030.1 5036.9 5026.2 5030.8 5108.2 5108.7 5131.1 5046.7 5054.9 5062.7 5064.9 5102.1 4799.5 4918.2 5015.5 5022.7 5025.4 4144.7 4185.7 4208.1 4220.0 4221.6 3748.9 3753.4 3757.0 3769.1 3785.2 4178.5 4440.3 4440.5 4451.6 4489.9 4905.8 4977.2 4991.0 5067.7 5118.3 4345.0 4358.8 4364.1 4366.3 4403.3 4260.5 4506.8 4508.4 4514.8 4546.0 4666.5 4669.8 4690.3 4767.0 4804.4 5094.8 5099.1 5099.4 5117.1 5132.8 4532.3 4833.3 4834.1 4838.3 4884.7 4874.3 4892.7 4945.8 5009.8 5036.5 5132.5 5134.7 5135.3 5136.9 5154.3 4971.2 4982.3 4982.3 4983.6 5003.1 4723.0 4859.6 4861.9 4887.0 4958.1 4837.6 4840.2 4851.1 4860.6 4875.7 4944.2 4945.7 4956.3 4989.7 4993.3 4641.3 4740.9 4744.8 4758.8 4853.4 12:35:19 INFO - 2015-11-13 12:35:19,611 DEBUG : BROWSER_OUTPUT: 12:35:19 INFO - 2015-11-13 12:35:19,611 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:49230.11 Median:33880.99 stddev:98955.03 (292.1%) stddev-sans-first:99165.12 12:35:19 INFO - 2015-11-13 12:35:19,611 DEBUG : BROWSER_OUTPUT: Values: 548.5 555.5 556.1 572.1 582.8 27762.7 36064.8 36386.8 36387.6 36487.3 40063.2 40471.2 40547.4 40561.2 40688.0 7006.4 7121.2 7982.9 8161.7 8167.9 10246.7 10515.3 10531.5 10541.7 10542.5 10222.0 10335.1 10341.8 10346.2 10349.9 7151.4 7328.9 7338.9 7345.3 9886.1 7036.0 10279.4 10544.0 10560.6 10567.8 36567.3 37092.6 37117.4 37158.0 37220.8 2965.5 3015.3 3039.9 3043.8 3489.8 27524.9 27740.9 28439.4 28746.9 29846.7 3140.4 3177.8 3233.2 3233.6 3279.1 229364.0 229728.0 230137.0 230279.0 231051.0 46935.8 47832.3 55620.0 55918.4 56027.4 59974.4 60917.4 61002.7 61045.0 61058.4 13716.8 13905.5 13960.0 13978.7 13992.8 9315.6 9582.5 10410.2 10484.6 10493.7 19221.9 19438.4 19550.5 19605.8 19686.9 7557.5 7866.9 7869.4 7965.9 8040.6 789.0 833.5 836.8 912.1 961.3 24070.5 26067.7 26124.7 26148.7 26150.7 932.2 938.4 939.6 976.4 1117.1 13350.5 13527.5 13663.8 13681.3 13738.9 531031.0 543248.0 544712.0 549120.0 553637.0 48626.0 49319.3 49351.0 49456.5 49459.0 1200.2 1218.4 1219.2 1228.0 1229.4 26744.0 27784.9 27789.7 28073.2 28311.3 39581.6 40073.8 40087.0 40093.6 40094.4 248170.0 248227.0 249958.0 250036.0 251332.0 23505.8 28217.9 28218.3 28293.7 28640.3 33731.8 45070.5 46258.1 46592.5 47198.0 33857.7 34448.1 35003.5 35143.6 35310.6 32908.5 33904.3 34456.0 34624.7 37013.8 34363.0 34625.3 34883.3 34940.5 35124.3 28393.4 31389.5 31582.7 31645.7 31709.5 24142.0 24402.6 24597.8 24869.3 24886.4 12:35:19 INFO - 2015-11-13 12:35:19,611 DEBUG : BROWSER_OUTPUT: 12:35:19 INFO - 2015-11-13 12:35:19,611 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24782.52 Median:21527.79 stddev:77207.57 (358.6%) stddev-sans-first:77402.32 12:35:19 INFO - 2015-11-13 12:35:19,612 DEBUG : BROWSER_OUTPUT: Values: 324.2 325.4 330.8 333.6 339.5 14777.0 15157.6 15232.8 15488.9 15539.5 12171.3 12211.3 12225.2 12228.4 13650.5 4796.4 5077.7 5091.6 5092.9 5095.3 5033.9 5056.5 5067.9 5070.6 5074.8 3552.3 3646.3 4897.0 5026.3 5700.6 5718.0 5718.7 5731.6 5738.3 5762.0 3930.2 4015.9 4020.3 5021.3 5026.0 10355.9 10851.7 11677.4 11782.1 11982.6 1673.3 1681.6 1739.6 1773.6 1781.9 9117.0 9282.5 9331.2 9442.3 9442.9 1529.6 1616.1 1617.4 1620.5 1647.6 52481.2 53888.5 54393.0 54892.7 55025.4 6488.7 6496.4 6514.5 6558.0 6581.9 7459.7 7552.3 7556.4 7574.1 7579.4 4925.6 4941.7 4955.0 4965.9 4986.3 4882.3 4906.3 4975.7 5025.8 5039.8 2962.6 2998.6 3027.7 3031.7 3032.0 1051.0 1055.0 1066.9 1089.4 1113.3 351.5 376.5 424.3 424.6 445.5 10201.2 10480.9 10525.8 10538.4 10578.8 353.4 419.6 425.8 432.3 435.9 5521.3 5595.6 5731.4 5740.9 5822.1 459940.0 466720.0 474110.0 477795.0 482615.0 62375.0 63907.0 65310.3 65504.7 66827.3 464.1 466.5 474.5 480.6 481.2 9321.0 9346.6 9489.0 9596.9 10155.6 29607.0 30787.4 31011.2 33008.3 33582.5 42403.4 42629.8 43011.4 43258.0 43837.0 14116.4 14288.9 14356.2 14387.8 14664.1 17617.6 17660.5 18015.4 18077.0 18139.5 14001.8 15021.7 15162.8 15277.7 15330.4 8630.7 8797.5 14331.6 14821.7 14981.0 8601.4 8774.1 9026.4 9068.5 9075.9 9560.7 13325.9 13426.7 13550.3 13577.9 13138.5 13257.8 13264.8 13297.8 13562.9 12:35:19 INFO - 2015-11-13 12:35:19,613 DEBUG : BROWSER_OUTPUT: 12:35:19 INFO - 2015-11-13 12:35:19,613 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4871.19 Median:6186.60 stddev:2507.51 (40.5%) stddev-sans-first:2500.72 12:35:19 INFO - 2015-11-13 12:35:19,613 DEBUG : BROWSER_OUTPUT: Values: 1367.2 1425.6 1528.7 1600.4 1701.5 6582.4 6688.8 6690.5 6740.2 6746.7 6830.6 6875.3 6878.6 6889.0 6897.1 1954.3 1975.6 1975.9 1976.0 1977.8 2005.1 2015.1 2016.6 2020.1 2047.2 1661.9 1692.0 1936.9 1979.0 1997.0 1921.1 1934.1 1941.3 1943.0 1944.9 1936.1 1959.2 2026.1 2028.4 2031.4 5914.7 5999.2 6604.4 6785.2 6793.3 4036.4 4091.3 4103.2 4103.6 4104.8 2662.6 2671.6 2707.5 2716.5 2740.1 863.5 908.7 910.0 918.9 925.3 9294.0 9341.9 9361.7 9370.8 9371.0 3849.0 3901.7 3904.7 3936.9 3953.6 8124.4 8139.4 8144.1 8144.2 8153.5 4179.5 4203.6 4204.7 4206.1 4208.2 3784.6 3792.4 3805.5 3808.2 3815.4 3087.0 3101.8 3103.2 3112.9 3113.9 1006.9 1009.0 1013.0 1036.9 1038.8 911.5 978.2 1157.4 1187.4 1196.3 6632.2 6654.4 6671.2 6681.8 6696.3 1034.8 1047.5 1058.6 1062.8 1086.5 4889.4 5336.8 5364.8 5370.5 5380.0 7446.5 8119.6 8239.7 8313.1 8352.1 8105.8 8146.8 8177.8 8185.4 8218.1 6197.3 6317.1 6332.4 6341.0 6371.6 6417.6 6472.6 6477.8 6494.4 6505.3 7192.9 7474.3 7532.7 7533.5 7550.8 7520.7 7665.7 7711.2 7796.1 7823.1 6273.5 6304.0 6327.4 6357.6 6383.7 6831.1 6868.6 6869.9 6871.9 6898.9 6472.4 6536.1 6543.9 6580.6 6638.7 6334.9 6368.0 6446.0 6499.1 6558.7 6175.8 6219.9 6232.6 6234.4 6239.7 5973.6 6003.0 6047.1 6052.0 6096.3 6089.2 6128.8 6133.9 6134.7 6135.4 12:35:19 INFO - 2015-11-13 12:35:19,613 DEBUG : BROWSER_OUTPUT: 12:35:19 INFO - 2015-11-13 12:35:19,613 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4670.56 Median:5406.42 stddev:1398.38 (25.9%) stddev-sans-first:1362.97 12:35:19 INFO - 2015-11-13 12:35:19,613 DEBUG : BROWSER_OUTPUT: Values: 282.5 287.1 290.7 291.1 292.4 5124.7 5379.5 5419.9 5450.6 5451.9 5402.2 5417.1 5417.1 5428.3 5428.8 4130.6 4134.3 4134.9 4148.9 4149.5 4136.0 4136.5 4149.0 4149.5 4154.2 4014.3 4099.9 4101.8 4102.6 4107.3 4085.8 4100.1 4100.5 4100.9 4114.3 3563.8 3569.5 3574.0 3578.6 3580.4 5247.4 5249.3 5279.2 5284.1 5290.5 4461.8 4724.9 4729.1 4733.6 4736.6 4643.7 5266.9 5447.2 5589.5 5676.0 3873.6 3903.7 3914.8 3918.7 3923.1 5622.4 5790.9 5930.7 5932.6 5939.6 3934.4 3955.0 3963.1 4022.1 4042.3 4081.4 4103.5 4109.1 4109.2 4110.1 4675.3 4689.0 4705.2 4707.8 4715.2 5456.5 5638.9 5655.9 5657.9 5660.5 1374.5 1374.5 1376.6 1376.8 1377.1 893.7 903.3 915.3 915.8 921.2 4972.7 4973.5 4982.0 4982.2 4986.9 5852.6 5864.9 5873.1 5874.1 5874.9 4964.7 4976.8 4982.8 4984.2 4984.8 3088.6 3139.9 3173.9 3175.5 3178.7 5617.2 5627.9 5631.3 5637.8 5640.2 6095.4 6096.4 6103.8 6111.3 6111.6 5594.7 5600.3 5600.7 5604.4 5605.7 5705.9 5859.3 5914.3 5934.9 5937.7 5774.2 5777.3 5782.8 5786.3 5789.7 5364.1 5606.8 5615.4 5619.5 5630.2 3718.1 3861.7 3953.8 3957.7 3958.8 5829.0 5858.0 5860.6 5867.3 5871.1 5648.9 5652.2 5656.9 5657.1 5659.7 5538.1 5621.0 5637.5 5654.6 5661.7 5526.2 5532.0 5545.7 5547.8 5557.6 5684.1 5691.9 5700.4 5703.0 5705.0 5410.6 5547.0 5547.3 5551.2 5551.9 12:35:19 INFO - 2015-11-13 12:35:19,613 DEBUG : BROWSER_OUTPUT: 12:35:19 INFO - 2015-11-13 12:35:19,614 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12418.66 Median:42935.68 stddev:14100.60 (32.8%) stddev-sans-first:14112.44 12:35:19 INFO - 2015-11-13 12:35:19,614 DEBUG : BROWSER_OUTPUT: Values: 647.2 667.5 748.9 757.8 774.3 11811.8 11816.2 12114.6 12132.5 12147.5 11877.8 11945.4 11979.8 11981.0 12008.4 604.9 611.5 774.3 788.2 805.8 793.7 801.2 801.7 805.6 808.9 824.9 839.6 840.4 841.4 841.6 627.3 637.1 814.6 839.8 840.8 598.0 603.2 604.3 605.1 607.4 11579.0 11849.7 11862.6 11865.5 11946.3 11145.8 11330.9 11631.3 11940.5 12590.1 9517.3 9539.5 9625.3 9677.9 9772.5 3282.7 3333.9 3358.0 3365.7 3365.8 39839.0 41125.8 41344.0 41651.6 41701.8 8592.2 9476.5 9484.0 9491.2 9572.5 16796.9 16820.5 16821.4 16824.9 16842.0 6722.8 6839.7 6854.1 6890.6 6958.5 3772.2 3826.6 3934.3 3936.0 4014.7 2768.9 2774.2 2795.0 2796.4 2801.3 411.8 414.2 419.1 420.4 422.2 514.5 560.0 573.4 595.8 623.2 8057.9 8078.8 8180.4 8705.3 8706.9 409.0 473.6 477.3 489.0 615.7 3492.4 3613.7 3746.5 3749.7 3873.7 48389.8 49424.3 52488.5 52884.0 53103.0 41599.0 41709.4 41852.8 42055.6 42380.3 42342.4 42982.4 43053.4 44679.6 44738.0 7950.1 8072.0 8332.4 8367.2 8470.4 31533.7 31943.0 32239.4 32249.0 32460.0 38976.8 39350.8 40777.4 42889.0 43166.6 6305.8 6864.9 6921.4 6944.6 7091.7 11303.5 11311.8 11313.6 11498.9 11569.8 10731.1 10806.0 10937.5 10963.5 10973.9 10833.6 10888.0 10906.1 11093.2 11467.9 10809.3 10861.5 11004.9 11185.1 11189.0 9180.1 9190.0 9374.3 9562.7 9580.7 9144.8 9152.6 9157.4 9245.2 9287.5 12:35:19 INFO - 2015-11-13 12:35:19,614 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:35:19 INFO - 2015-11-13 12:35:19,614 DEBUG : BROWSER_OUTPUT: 12:35:20 INFO - 2015-11-13 12:35:20,384 INFO : Browser exited with error code: 0 12:35:20 INFO - 2015-11-13 12:35:20,402 INFO : Completed test dromaeo_css (00:18:36) 12:35:20 INFO - 2015-11-13 12:35:20,402 INFO : Starting test kraken 12:35:20 INFO - 2015-11-13 12:35:20,402 DEBUG : operating with platform_type : linux_ 12:35:20 INFO - 2015-11-13 12:35:20,402 INFO : Initialising browser for kraken test... 12:35:20 INFO - 2015-11-13 12:35:20,408 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdVPWqV/profile http://localhost:51493/getInfo.html 12:35:24 INFO - 2015-11-13 12:35:24,430 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:35:24 INFO - 2015-11-13 12:35:24,430 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:35:24 INFO - 2015-11-13 12:35:24,430 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:35:24 INFO - 2015-11-13 12:35:24,430 DEBUG : BROWSER_OUTPUT: __metrics 12:35:24 INFO - 2015-11-13 12:35:24,579 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:35:25 INFO - 2015-11-13 12:35:25,828 INFO : Browser initialized. 12:35:25 INFO - 2015-11-13 12:35:25,828 INFO : Running cycle 1/1 for kraken test... 12:35:25 INFO - 2015-11-13 12:35:25,828 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdVPWqV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:35:37 INFO - 2015-11-13 12:35:37,691 DEBUG : BROWSER_OUTPUT: RSS: Main: 141176832 12:35:37 INFO - 2015-11-13 12:35:37,691 DEBUG : BROWSER_OUTPUT: 12:35:40 INFO - 2015-11-13 12:35:40,307 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51493/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51493/tests/kraken/driver.html?testName=audio-beat-detection) 12:35:40 INFO - 2015-11-13 12:35:40,890 DEBUG : BROWSER_OUTPUT: RSS: Main: 178552832 12:35:40 INFO - 2015-11-13 12:35:40,890 DEBUG : BROWSER_OUTPUT: 12:35:43 INFO - 2015-11-13 12:35:43,629 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51493/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51493/tests/kraken/driver.html?testName=audio-dft) 12:35:44 INFO - 2015-11-13 12:35:44,194 DEBUG : BROWSER_OUTPUT: RSS: Main: 168759296 12:35:44 INFO - 2015-11-13 12:35:44,195 DEBUG : BROWSER_OUTPUT: 12:35:47 INFO - 2015-11-13 12:35:47,235 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51493/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51493/tests/kraken/driver.html?testName=audio-fft) 12:35:47 INFO - 2015-11-13 12:35:47,796 DEBUG : BROWSER_OUTPUT: RSS: Main: 154181632 12:35:47 INFO - 2015-11-13 12:35:47,796 DEBUG : BROWSER_OUTPUT: 12:35:49 INFO - 2015-11-13 12:35:49,841 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51493/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51493/tests/kraken/driver.html?testName=audio-oscillator) 12:35:50 INFO - 2015-11-13 12:35:50,406 DEBUG : BROWSER_OUTPUT: RSS: Main: 153944064 12:35:50 INFO - 2015-11-13 12:35:50,406 DEBUG : BROWSER_OUTPUT: 12:35:52 INFO - 2015-11-13 12:35:52,643 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51493/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51493/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:35:53 INFO - 2015-11-13 12:35:53,208 DEBUG : BROWSER_OUTPUT: RSS: Main: 156397568 12:35:53 INFO - 2015-11-13 12:35:53,208 DEBUG : BROWSER_OUTPUT: 12:35:56 INFO - 2015-11-13 12:35:56,171 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51493/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51493/tests/kraken/driver.html?testName=imaging-darkroom) 12:35:56 INFO - 2015-11-13 12:35:56,744 DEBUG : BROWSER_OUTPUT: RSS: Main: 155090944 12:35:56 INFO - 2015-11-13 12:35:56,744 DEBUG : BROWSER_OUTPUT: 12:36:00 INFO - 2015-11-13 12:36:00,146 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51493/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51493/tests/kraken/driver.html?testName=imaging-desaturate) 12:36:00 INFO - 2015-11-13 12:36:00,719 DEBUG : BROWSER_OUTPUT: RSS: Main: 158498816 12:36:00 INFO - 2015-11-13 12:36:00,719 DEBUG : BROWSER_OUTPUT: 12:36:03 INFO - 2015-11-13 12:36:03,538 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51493/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51493/tests/kraken/driver.html?testName=json-parse-financial) 12:36:04 INFO - 2015-11-13 12:36:04,118 DEBUG : BROWSER_OUTPUT: RSS: Main: 156282880 12:36:04 INFO - 2015-11-13 12:36:04,119 DEBUG : BROWSER_OUTPUT: 12:36:05 INFO - 2015-11-13 12:36:05,868 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51493/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51493/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:36:06 INFO - 2015-11-13 12:36:06,434 DEBUG : BROWSER_OUTPUT: RSS: Main: 164900864 12:36:06 INFO - 2015-11-13 12:36:06,434 DEBUG : BROWSER_OUTPUT: 12:36:08 INFO - 2015-11-13 12:36:08,305 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51493/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51493/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:36:08 INFO - 2015-11-13 12:36:08,898 DEBUG : BROWSER_OUTPUT: RSS: Main: 164802560 12:36:08 INFO - 2015-11-13 12:36:08,898 DEBUG : BROWSER_OUTPUT: 12:36:11 INFO - 2015-11-13 12:36:11,015 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51493/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51493/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:36:11 INFO - 2015-11-13 12:36:11,596 DEBUG : BROWSER_OUTPUT: RSS: Main: 179732480 12:36:11 INFO - 2015-11-13 12:36:11,596 DEBUG : BROWSER_OUTPUT: 12:36:14 INFO - 2015-11-13 12:36:14,138 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51493/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51493/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:36:14 INFO - 2015-11-13 12:36:14,724 DEBUG : BROWSER_OUTPUT: RSS: Main: 181215232 12:36:14 INFO - 2015-11-13 12:36:14,724 DEBUG : BROWSER_OUTPUT: 12:36:17 INFO - 2015-11-13 12:36:17,300 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51493/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51493/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:36:17 INFO - 2015-11-13 12:36:17,867 DEBUG : BROWSER_OUTPUT: RSS: Main: 182616064 12:36:17 INFO - 2015-11-13 12:36:17,867 DEBUG : BROWSER_OUTPUT: 12:36:19 INFO - 2015-11-13 12:36:19,623 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51493/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51493/tests/kraken/driver.html?testName=ai-astar) 12:36:19 INFO - 2015-11-13 12:36:19,881 DEBUG : BROWSER_OUTPUT: RSS: Main: 240115712 12:36:19 INFO - 2015-11-13 12:36:19,881 DEBUG : BROWSER_OUTPUT: 12:36:19 INFO - 2015-11-13 12:36:19,881 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:36:19 INFO - 2015-11-13 12:36:19,881 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:36:19 INFO - 2015-11-13 12:36:19,881 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:36:19 INFO - 2015-11-13 12:36:19,881 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:36:19 INFO - 2015-11-13 12:36:19,881 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;112;108;112;112;112;103;111;105;112 12:36:19 INFO - 2015-11-13 12:36:19,881 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;131;154;179;132;160;152;133;167;130 12:36:19 INFO - 2015-11-13 12:36:19,881 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;164;160;163;161;160;161;160;162;163 12:36:19 INFO - 2015-11-13 12:36:19,881 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;80;89;73;72;73;97;93;73 12:36:19 INFO - 2015-11-13 12:36:19,882 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;92;126;93;91;92;134;93;92;129 12:36:19 INFO - 2015-11-13 12:36:19,882 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;109;110;110;110;110;110;110 12:36:19 INFO - 2015-11-13 12:36:19,882 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;147;146;147;146;146;148;147;147;147 12:36:19 INFO - 2015-11-13 12:36:19,882 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;96;96;96;96;96;95;95 12:36:19 INFO - 2015-11-13 12:36:19,882 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;77;69;70;70;70;70;71;78;69;67 12:36:19 INFO - 2015-11-13 12:36:19,882 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;67;66;68;67;66;67;67;67;67 12:36:19 INFO - 2015-11-13 12:36:19,882 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;83;84;85;82;83;82;84;85;83 12:36:19 INFO - 2015-11-13 12:36:19,882 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;127;133;127;126;127;121;126;126;118 12:36:19 INFO - 2015-11-13 12:36:19,882 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;150;133;143;145;145;132;144;156;133;132 12:36:19 INFO - 2015-11-13 12:36:19,882 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;71;68;71;70;69;68;69;69;69 12:36:19 INFO - 2015-11-13 12:36:19,882 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:36:19 INFO - 2015-11-13 12:36:19,882 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:36:19 INFO - 2015-11-13 12:36:19,883 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,959 12:36:19 INFO - 2015-11-13 12:36:19,883 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:36:19 INFO - 2015-11-13 12:36:19,883 DEBUG : BROWSER_OUTPUT: __startTimestamp1447446979875__endTimestamp 12:36:19 INFO - 2015-11-13 12:36:19,883 DEBUG : BROWSER_OUTPUT: 12:36:19 INFO - 2015-11-13 12:36:19,883 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:36:19 INFO - 2015-11-13 12:36:19,883 DEBUG : BROWSER_OUTPUT: Number of tests: 14 12:36:19 INFO - 2015-11-13 12:36:19,883 DEBUG : BROWSER_OUTPUT: 12:36:19 INFO - 2015-11-13 12:36:19,883 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.70 Median:112.00 stddev:3.30 (2.9%) stddev-sans-first:3.50 12:36:19 INFO - 2015-11-13 12:36:19,883 DEBUG : BROWSER_OUTPUT: Values: 110.0 112.0 108.0 112.0 112.0 112.0 103.0 111.0 105.0 112.0 12:36:19 INFO - 2015-11-13 12:36:19,883 DEBUG : BROWSER_OUTPUT: 12:36:19 INFO - 2015-11-13 12:36:19,883 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.30 Median:154.50 stddev:17.14 (11.1%) stddev-sans-first:18.06 12:36:19 INFO - 2015-11-13 12:36:19,884 DEBUG : BROWSER_OUTPUT: Values: 155.0 131.0 154.0 179.0 132.0 160.0 152.0 133.0 167.0 130.0 12:36:19 INFO - 2015-11-13 12:36:19,884 DEBUG : BROWSER_OUTPUT: 12:36:19 INFO - 2015-11-13 12:36:19,884 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.70 Median:162.50 stddev:1.49 (0.9%) stddev-sans-first:1.51 12:36:19 INFO - 2015-11-13 12:36:19,884 DEBUG : BROWSER_OUTPUT: Values: 163.0 164.0 160.0 163.0 161.0 160.0 161.0 160.0 162.0 163.0 12:36:19 INFO - 2015-11-13 12:36:19,884 DEBUG : BROWSER_OUTPUT: 12:36:19 INFO - 2015-11-13 12:36:19,884 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.60 Median:76.50 stddev:9.70 (12.7%) stddev-sans-first:9.99 12:36:19 INFO - 2015-11-13 12:36:19,884 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 80.0 89.0 73.0 72.0 73.0 97.0 93.0 73.0 12:36:19 INFO - 2015-11-13 12:36:19,884 DEBUG : BROWSER_OUTPUT: 12:36:19 INFO - 2015-11-13 12:36:19,884 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.30 Median:92.00 stddev:18.31 (19.9%) stddev-sans-first:18.87 12:36:19 INFO - 2015-11-13 12:36:19,884 DEBUG : BROWSER_OUTPUT: Values: 91.0 92.0 126.0 93.0 91.0 92.0 134.0 93.0 92.0 129.0 12:36:19 INFO - 2015-11-13 12:36:19,884 DEBUG : BROWSER_OUTPUT: 12:36:19 INFO - 2015-11-13 12:36:19,884 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 12:36:19 INFO - 2015-11-13 12:36:19,884 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 109.0 110.0 110.0 110.0 110.0 110.0 110.0 12:36:19 INFO - 2015-11-13 12:36:19,885 DEBUG : BROWSER_OUTPUT: 12:36:19 INFO - 2015-11-13 12:36:19,885 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 12:36:19 INFO - 2015-11-13 12:36:19,885 DEBUG : BROWSER_OUTPUT: Values: 146.0 147.0 146.0 147.0 146.0 146.0 148.0 147.0 147.0 147.0 12:36:19 INFO - 2015-11-13 12:36:19,885 DEBUG : BROWSER_OUTPUT: 12:36:19 INFO - 2015-11-13 12:36:19,885 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 12:36:19 INFO - 2015-11-13 12:36:19,885 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 96.0 96.0 96.0 96.0 96.0 95.0 95.0 12:36:19 INFO - 2015-11-13 12:36:19,885 DEBUG : BROWSER_OUTPUT: 12:36:19 INFO - 2015-11-13 12:36:19,885 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.10 Median:70.00 stddev:3.54 (5.1%) stddev-sans-first:3.05 12:36:19 INFO - 2015-11-13 12:36:19,885 DEBUG : BROWSER_OUTPUT: Values: 77.0 69.0 70.0 70.0 70.0 70.0 71.0 78.0 69.0 67.0 12:36:19 INFO - 2015-11-13 12:36:19,885 DEBUG : BROWSER_OUTPUT: 12:36:19 INFO - 2015-11-13 12:36:19,885 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:67.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 12:36:19 INFO - 2015-11-13 12:36:19,885 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 66.0 68.0 67.0 66.0 67.0 67.0 67.0 67.0 12:36:19 INFO - 2015-11-13 12:36:19,885 DEBUG : BROWSER_OUTPUT: 12:36:19 INFO - 2015-11-13 12:36:19,885 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:83.50 stddev:1.32 (1.6%) stddev-sans-first:1.13 12:36:19 INFO - 2015-11-13 12:36:19,885 DEBUG : BROWSER_OUTPUT: Values: 81.0 83.0 84.0 85.0 82.0 83.0 82.0 84.0 85.0 83.0 12:36:19 INFO - 2015-11-13 12:36:19,885 DEBUG : BROWSER_OUTPUT: 12:36:19 INFO - 2015-11-13 12:36:19,886 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.10 Median:126.50 stddev:4.33 (3.4%) stddev-sans-first:4.18 12:36:19 INFO - 2015-11-13 12:36:19,886 DEBUG : BROWSER_OUTPUT: Values: 120.0 127.0 133.0 127.0 126.0 127.0 121.0 126.0 126.0 118.0 12:36:19 INFO - 2015-11-13 12:36:19,886 DEBUG : BROWSER_OUTPUT: 12:36:19 INFO - 2015-11-13 12:36:19,886 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.30 Median:144.50 stddev:8.43 (5.8%) stddev-sans-first:8.34 12:36:19 INFO - 2015-11-13 12:36:19,886 DEBUG : BROWSER_OUTPUT: Values: 150.0 133.0 143.0 145.0 145.0 132.0 144.0 156.0 133.0 132.0 12:36:19 INFO - 2015-11-13 12:36:19,886 DEBUG : BROWSER_OUTPUT: 12:36:19 INFO - 2015-11-13 12:36:19,886 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.00 stddev:1.06 (1.5%) stddev-sans-first:1.12 12:36:19 INFO - 2015-11-13 12:36:19,886 DEBUG : BROWSER_OUTPUT: Values: 69.0 71.0 68.0 71.0 70.0 69.0 68.0 69.0 69.0 69.0 12:36:19 INFO - 2015-11-13 12:36:19,886 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:36:19 INFO - 2015-11-13 12:36:19,886 DEBUG : BROWSER_OUTPUT: 12:36:20 INFO - 2015-11-13 12:36:20,820 INFO : Browser exited with error code: 0 12:36:20 INFO - 2015-11-13 12:36:20,868 INFO : Completed test kraken (00:01:00) 12:36:20 INFO - 2015-11-13 12:36:20,868 INFO : Starting test v8_7 12:36:20 INFO - 2015-11-13 12:36:20,868 DEBUG : operating with platform_type : linux_ 12:36:20 INFO - 2015-11-13 12:36:20,868 INFO : Initialising browser for v8_7 test... 12:36:20 INFO - 2015-11-13 12:36:20,874 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWfkCWK/profile http://localhost:51493/getInfo.html 12:36:24 INFO - 2015-11-13 12:36:24,875 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:36:24 INFO - 2015-11-13 12:36:24,875 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:36:24 INFO - 2015-11-13 12:36:24,876 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:36:24 INFO - 2015-11-13 12:36:24,876 DEBUG : BROWSER_OUTPUT: __metrics 12:36:24 INFO - 2015-11-13 12:36:24,972 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:36:26 INFO - 2015-11-13 12:36:26,445 INFO : Browser initialized. 12:36:26 INFO - 2015-11-13 12:36:26,445 INFO : Running cycle 1/1 for v8_7 test... 12:36:26 INFO - 2015-11-13 12:36:26,446 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWfkCWK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:36:38 INFO - 2015-11-13 12:36:38,287 DEBUG : BROWSER_OUTPUT: RSS: Main: 141373440 12:36:38 INFO - 2015-11-13 12:36:38,287 DEBUG : BROWSER_OUTPUT: 12:36:59 INFO - 2015-11-13 12:36:59,840 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51493/tests/v8_7/run.html (next: http://localhost:51493/tests/v8_7/run.html) 12:37:00 INFO - 2015-11-13 12:37:00,085 DEBUG : BROWSER_OUTPUT: RSS: Main: 436080640 12:37:00 INFO - 2015-11-13 12:37:00,085 DEBUG : BROWSER_OUTPUT: 12:37:00 INFO - 2015-11-13 12:37:00,086 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:37:00 INFO - 2015-11-13 12:37:00,086 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:37:00 INFO - 2015-11-13 12:37:00,086 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:37:00 INFO - 2015-11-13 12:37:00,086 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:37:00 INFO - 2015-11-13 12:37:00,086 DEBUG : BROWSER_OUTPUT: |0;Richards;171.67381974248926 12:37:00 INFO - 2015-11-13 12:37:00,086 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.15089798185522 12:37:00 INFO - 2015-11-13 12:37:00,086 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.79854504756577 12:37:00 INFO - 2015-11-13 12:37:00,087 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5035.175879396985 12:37:00 INFO - 2015-11-13 12:37:00,087 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1990.0596421471173 12:37:00 INFO - 2015-11-13 12:37:00,087 DEBUG : BROWSER_OUTPUT: |5;Earley;821.6926869350863 12:37:00 INFO - 2015-11-13 12:37:00,087 DEBUG : BROWSER_OUTPUT: |6;Boyer;11858.823529411764 12:37:00 INFO - 2015-11-13 12:37:00,088 DEBUG : BROWSER_OUTPUT: |7;RegExp;26315.78947368421 12:37:00 INFO - 2015-11-13 12:37:00,088 DEBUG : BROWSER_OUTPUT: |8;Splay;600.3573555687909 12:37:00 INFO - 2015-11-13 12:37:00,088 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4850.241545893719 12:37:00 INFO - 2015-11-13 12:37:00,088 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:37:00 INFO - 2015-11-13 12:37:00,089 DEBUG : BROWSER_OUTPUT: __startTimestamp1447447020084__endTimestamp 12:37:00 INFO - 2015-11-13 12:37:00,089 DEBUG : BROWSER_OUTPUT: 12:37:00 INFO - 2015-11-13 12:37:00,089 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:37:00 INFO - 2015-11-13 12:37:00,089 DEBUG : BROWSER_OUTPUT: Number of tests: 10 12:37:00 INFO - 2015-11-13 12:37:00,089 DEBUG : BROWSER_OUTPUT: 12:37:00 INFO - 2015-11-13 12:37:00,090 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:171.67 Median:171.67 stddev:0.00 (0.0%) 12:37:00 INFO - 2015-11-13 12:37:00,090 DEBUG : BROWSER_OUTPUT: Values: 171.7 12:37:00 INFO - 2015-11-13 12:37:00,090 DEBUG : BROWSER_OUTPUT: 12:37:00 INFO - 2015-11-13 12:37:00,090 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.15 Median:185.15 stddev:0.00 (0.0%) 12:37:00 INFO - 2015-11-13 12:37:00,091 DEBUG : BROWSER_OUTPUT: Values: 185.2 12:37:00 INFO - 2015-11-13 12:37:00,091 DEBUG : BROWSER_OUTPUT: 12:37:00 INFO - 2015-11-13 12:37:00,091 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.80 Median:279.80 stddev:0.00 (0.0%) 12:37:00 INFO - 2015-11-13 12:37:00,091 DEBUG : BROWSER_OUTPUT: Values: 279.8 12:37:00 INFO - 2015-11-13 12:37:00,091 DEBUG : BROWSER_OUTPUT: 12:37:00 INFO - 2015-11-13 12:37:00,091 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5035.18 Median:5035.18 stddev:0.00 (0.0%) 12:37:00 INFO - 2015-11-13 12:37:00,092 DEBUG : BROWSER_OUTPUT: Values: 5035.2 12:37:00 INFO - 2015-11-13 12:37:00,092 DEBUG : BROWSER_OUTPUT: 12:37:00 INFO - 2015-11-13 12:37:00,092 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1990.06 Median:1990.06 stddev:0.00 (0.0%) 12:37:00 INFO - 2015-11-13 12:37:00,092 DEBUG : BROWSER_OUTPUT: Values: 1990.1 12:37:00 INFO - 2015-11-13 12:37:00,092 DEBUG : BROWSER_OUTPUT: 12:37:00 INFO - 2015-11-13 12:37:00,092 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:821.69 Median:821.69 stddev:0.00 (0.0%) 12:37:00 INFO - 2015-11-13 12:37:00,092 DEBUG : BROWSER_OUTPUT: Values: 821.7 12:37:00 INFO - 2015-11-13 12:37:00,092 DEBUG : BROWSER_OUTPUT: 12:37:00 INFO - 2015-11-13 12:37:00,092 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11858.82 Median:11858.82 stddev:0.00 (0.0%) 12:37:00 INFO - 2015-11-13 12:37:00,094 DEBUG : BROWSER_OUTPUT: Values: 11858.8 12:37:00 INFO - 2015-11-13 12:37:00,094 DEBUG : BROWSER_OUTPUT: 12:37:00 INFO - 2015-11-13 12:37:00,094 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26315.79 Median:26315.79 stddev:0.00 (0.0%) 12:37:00 INFO - 2015-11-13 12:37:00,094 DEBUG : BROWSER_OUTPUT: Values: 26315.8 12:37:00 INFO - 2015-11-13 12:37:00,094 DEBUG : BROWSER_OUTPUT: 12:37:00 INFO - 2015-11-13 12:37:00,094 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:600.36 Median:600.36 stddev:0.00 (0.0%) 12:37:00 INFO - 2015-11-13 12:37:00,094 DEBUG : BROWSER_OUTPUT: Values: 600.4 12:37:00 INFO - 2015-11-13 12:37:00,094 DEBUG : BROWSER_OUTPUT: 12:37:00 INFO - 2015-11-13 12:37:00,094 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 12:37:00 INFO - 2015-11-13 12:37:00,094 DEBUG : BROWSER_OUTPUT: Values: 4850.2 12:37:00 INFO - 2015-11-13 12:37:00,094 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:37:00 INFO - 2015-11-13 12:37:00,094 DEBUG : BROWSER_OUTPUT: 12:37:01 INFO - 2015-11-13 12:37:01,032 INFO : Browser exited with error code: 0 12:37:01 INFO - 2015-11-13 12:37:01,050 INFO : Completed test v8_7 (00:00:40) 12:37:01 INFO - 2015-11-13 12:37:01,457 INFO : Completed test suite (00:20:17) 12:37:01 INFO - 2015-11-13 12:37:01,457 DEBUG : Working with test: dromaeo_css 12:37:01 INFO - 2015-11-13 12:37:01,457 DEBUG : Generating results file: dromaeo_css 12:37:01 INFO - 2015-11-13 12:37:01,458 DEBUG : Working with test: kraken 12:37:01 INFO - 2015-11-13 12:37:01,458 DEBUG : Generating results file: kraken 12:37:01 INFO - 2015-11-13 12:37:01,458 INFO : javascript benchmark 12:37:01 INFO - 2015-11-13 12:37:01,458 DEBUG : Working with test: v8_7 12:37:01 INFO - 2015-11-13 12:37:01,459 DEBUG : Generating results file: v8_7 12:37:01 INFO - 2015-11-13 12:37:01,459 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:37:01 INFO - 2015-11-13 12:37:01,512 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,131,35]] 12:37:01 INFO - 2015-11-13 12:37:01,512 DEBUG : process_Request line: dromaeo_css 6154.85 graph.html#tests=[[72,131,35]] 12:37:01 INFO - 2015-11-13 12:37:01,512 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:37:01 INFO - 2015-11-13 12:37:01,544 DEBUG : process_Request line: kraken 1512.40 graph.html#tests=[[232,131,35]] 12:37:01 INFO - 2015-11-13 12:37:01,545 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:37:01 INFO - 2015-11-13 12:37:01,575 DEBUG : process_Request line: v8_7 19818.01 graph.html#tests=[[230,131,35]] 12:37:01 INFO - 2015-11-13 12:37:01,576 INFO : javascript benchmark 12:37:01 INFO - 2015-11-13 12:37:01,580 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [324.1846755410143, 325.35904268590883, 330.84615653721016, 333.5796895911152, 339.4822895084995, 14777.0, 15157.621059473506, 15232.847671523281, 15488.922555387235, 15539.456119035836, 12171.33057681827, 12211.328376939266, 12225.205361651486, 12228.44971976261, 13650.522231721892, 4796.4244290685165, 5077.720725360104, 5091.643584949055, 5092.949070509303, 5095.3376061112185, 5033.949660503385, 5056.494350564933, 5067.923981140286, 5070.580237533478, 5074.822381216658, 3552.342816578941, 3646.3254297954963, 4896.975515122419, 5026.346574945252, 5700.572457065716, 5717.999350113713, 5718.714064296769, 5731.627444216134, 5738.340090889559, 5762.0, 3930.233604447134, 4015.9397609035886, 4020.296448121567, 5021.322121513585, 5026.045051440251, 10355.94822025885, 10851.728706782314, 11677.41612919359, 11782.082204043118, 11982.64052078439, 1673.3306677329044, 1681.6468541606278, 1739.5998920248414, 1773.645270945816, 1781.8841775284695, 9116.954415227881, 9282.489463079528, 9331.175035022843, 9442.339036267464, 9442.858357124649, 1529.6099494628797, 1616.1353675783516, 1617.4096454794033, 1620.473346162502, 1647.604574902015, 52481.21278180869, 53888.46111538874, 54393.0, 54892.72553637206, 55025.44974550283, 6488.740450381932, 6496.382843629847, 6514.478841692653, 6558.0, 6581.86836263272, 7459.664315105833, 7552.320291173711, 7556.395488360918, 7574.128975167816, 7579.393648508106, 4925.630577706686, 4941.65408421407, 4954.975225123923, 4965.851024469272, 4986.254810816185, 4882.316475693406, 4906.313116163668, 4975.676581022294, 5025.824096156617, 5039.84880453587, 2962.6153293126295, 2998.610180676498, 3027.742641875421, 3031.7271445570004, 3031.969680303213, 1050.9737256568646, 1054.9525271362807, 1066.8719753629614, 1089.411717672448, 1113.3041848844473, 351.4552443712287, 376.5481422293259, 424.3253227368499, 424.60299619855533, 445.4698908299114, 10201.234907381977, 10480.947595261974, 10525.84211236832, 10538.420386878795, 10578.788424231472, 353.39216547538194, 419.5846112348814, 425.7977460706202, 432.3342053238041, 435.9084592235666, 5521.337439507285, 5595.580331475156, 5731.426857314319, 5740.885182296331, 5822.126680997884, 459940.0, 466720.0, 474110.0, 477795.0, 482615.0, 62375.0, 63907.0, 65310.34689653137, 65504.672476637315, 66827.33172668211, 464.1482878917157, 466.48453458928077, 474.46148621314364, 480.61310644931166, 481.1675800864524, 9321.0, 9346.579403926975, 9488.95255523718, 9596.9040309596, 10155.593776249163, 29607.0, 30787.38425231438, 31011.224719382197, 33008.33983320272, 33582.49626255657, 42403.363949541395, 42629.786851065546, 43011.3548296782, 43258.0, 43837.0, 14116.435342586181, 14288.928555357157, 14356.210408427636, 14387.784183237469, 14664.12015279044, 17617.64764704673, 17660.470185894443, 18015.369462068764, 18077.005764682544, 18139.546511336794, 14001.789973150208, 15021.699566008838, 15162.848371516586, 15277.694446111238, 15330.386784528493, 8630.654773809229, 8797.516136612549, 14331.570052898429, 14821.703565928836, 14981.0, 8601.35489838252, 8774.122587741174, 9026.413283136575, 9068.503696889939, 9075.863862041942, 9560.713178604654, 13325.866741332851, 13426.731465370833, 13550.322483875963, 13577.932110339385, 13138.474461021453, 13257.80113298282, 13264.80102798478, 13297.80053299182, 13562.864371356554], "dojo.html": [2624.33079564711, 2703.0809524761576, 2708.580170073638, 2711.9457610847794, 2724.7275272472757, 4592.035672508777, 4680.461746899112, 4700.482946875841, 4712.128256272592, 4715.669903106779, 4666.160091183586, 4669.556392142741, 4727.0, 4727.22000869856, 4737.7631118444115, 4324.07032488015, 4374.387585737999, 4406.71356361837, 4442.3336499525, 4478.305862591287, 4208.410822484854, 4401.163778882018, 4407.779611019452, 4453.53237910018, 4479.328100784892, 4214.093969796509, 4292.50636176839, 4300.311950087971, 4302.354646802974, 4316.870493885189, 4395.626371758404, 4396.626286765629, 4402.889927751799, 4413.227685155117, 4436.401085853433, 4140.60664236897, 4245.830166793356, 4361.781910904442, 4387.451568553931, 4426.867193984185, 4615.215413379734, 4680.765961701902, 4704.647151463654, 4732.124556956974, 4733.077049975256, 4983.526564976358, 4988.775505102279, 4991.126552853236, 5022.673526220784, 5113.488651134894, 4832.395950506187, 4946.802127914879, 5002.0, 5004.324416203803, 5044.924326135111, 4558.8632341029825, 4604.769761511911, 4607.378003969421, 4655.4878963314, 4672.182368085605, 5224.242484839677, 5225.085610018307, 5231.032259032091, 5233.267342572043, 5277.630565860353, 4769.761511924459, 4876.975615121902, 5021.648484606116, 5030.0694371541385, 5036.874078148076, 5026.170681837456, 5030.773615187325, 5108.233764935289, 5108.744562771846, 5131.102057139986, 5046.697198168122, 5054.949450505448, 5062.670926389773, 5064.949350506521, 5102.081625307406, 4799.472058073609, 4918.213085906309, 5015.548600625962, 5022.748862556858, 5025.422076461181, 4144.689148313828, 4185.707000509996, 4208.074223670787, 4219.9789001055415, 4221.598948099926, 3748.868789592406, 3753.418220175877, 3757.04195430169, 3769.095417099931, 3785.242951409729, 4178.477690288714, 4440.267355886307, 4440.489343725449, 4451.643868490513, 4489.910201795946, 4905.779239934212, 4977.1538838397555, 4991.0, 5067.695938243717, 5118.283440318359, 4344.956550434518, 4358.8038538265855, 4364.148990946798, 4366.279563871989, 4403.295472724349, 4260.488741351058, 4506.81972721094, 4508.391367165391, 4514.819407223675, 4545.954540454619, 4666.533346665306, 4669.836555720602, 4690.273007683746, 4767.046590681947, 4804.42346918372, 5094.7707353169935, 5099.133147365031, 5099.413567439792, 5117.053345131014, 5132.820351287687, 4532.32015197723, 4833.250846118857, 4834.081524510332, 4838.322634831196, 4884.7069175849565, 4874.293227482066, 4892.68197567157, 4945.777440015136, 5009.7996080157845, 5036.496350364934, 5132.461091585479, 5134.743262836769, 5135.332406787244, 5136.922946155736, 5154.304168937296, 4971.2046072629655, 4982.252662100569, 4982.277569752293, 4983.626228032985, 5003.0744312300885, 4722.960948591304, 4859.611231101433, 4861.854144375674, 4887.022595480989, 4958.057968985881, 4837.612990960644, 4840.177169881058, 4851.102546028996, 4860.562549370432, 4875.731834749123, 4944.233643785075, 4945.727984960861, 4956.281339205723, 4989.72556509381, 4993.300937868774, 4641.327007583814, 4740.905181896412, 4744.762761861962, 4758.76206189696, 4853.369062022056], "mootools.html": [1367.1660287224793, 1425.593705793849, 1528.6636939873224, 1600.3758534171668, 1701.506563096702, 6582.4075833175, 6688.765893193739, 6690.531662783601, 6740.22487413947, 6746.6626668666495, 6830.624315662637, 6875.346842049998, 6878.552894061882, 6888.965555172217, 6897.068895699079, 1954.3062212914388, 1975.5752513209657, 1975.940721778349, 1975.9802401976012, 1977.772556156039, 2005.1077270614583, 2015.083137172583, 2016.5865997470557, 2020.0909590684178, 2047.2015913793632, 1661.9002859828388, 1692.0270844264535, 1936.9225230990744, 1978.9808248751904, 1996.950076248091, 1921.0682818832854, 1934.139308007937, 1941.2914286285545, 1942.9611407771836, 1944.8930308833008, 1936.0513348459153, 1959.226105688245, 2026.0882602828785, 2028.4320390290743, 2031.3702752146735, 5914.674692891889, 5999.220101386835, 6604.405603495708, 6785.219699734495, 6793.252742198354, 4036.414719865603, 4091.3453847384276, 4103.2409004334295, 4103.5691252418665, 4104.835806567734, 2662.5739881618847, 2671.6259723638705, 2707.472042951625, 2716.4838680650614, 2740.10946442407, 863.5164307987548, 908.7092130518237, 910.026271889079, 918.9448633082036, 925.3383830561181, 9293.953530232373, 9341.859872101855, 9361.672341468084, 9370.765730856714, 9370.95314523423, 3848.9615103849164, 3901.668358189529, 3904.668103211202, 3936.9212615748097, 3953.6046395360236, 8124.390670699721, 8139.43023988327, 8144.14486478923, 8144.185581441927, 8153.510789352657, 4179.477565304337, 4203.558626344251, 4204.705670603028, 4206.074663574009, 4208.200441916026, 3784.6404591563755, 3792.412176112707, 3805.505284313077, 3808.200277941608, 3815.4276858471453, 3087.0397297716113, 3101.8138911665374, 3103.239706271933, 3112.9221769455944, 3113.9377212455624, 1006.9295149339476, 1009.0414106598761, 1012.9848052279222, 1036.8548403223556, 1038.8389799581078, 911.544227886057, 978.2223132609593, 1157.4155051698838, 1187.4478367559127, 1196.294186429993, 6632.2372927114, 6654.367835055662, 6671.1994560652065, 6681.76613818514, 6696.296888826603, 1034.75165960169, 1047.5181416548473, 1058.6400623787795, 1062.8033813744482, 1086.5002099034532, 4889.413270407574, 5336.839894803162, 5364.839054828361, 5370.543503802142, 5380.0, 7446.515976461513, 8119.594020298961, 8239.670413183405, 8313.12712165226, 8352.081271060179, 8105.837883242302, 8146.75559733209, 8177.79555511117, 8185.386096042821, 8218.096009438957, 6197.349278325801, 6317.1156038154695, 6332.366763323723, 6341.048842673636, 6371.585846919936, 6417.647029413427, 6472.579282346821, 6477.77327793525, 6494.350564943468, 6505.316941721051, 7192.856142877218, 7474.289942455458, 7532.661030253761, 7533.510321829063, 7550.848983020419, 7520.699172033276, 7665.731699390494, 7711.190325016017, 7796.10344810354, 7823.061232652118, 6273.498120150468, 6303.9684801575695, 6327.430531252209, 6357.618542887441, 6383.712732926937, 6831.11195544576, 6868.553544019623, 6869.862602748017, 6871.896921546081, 6898.896516552356, 6472.385123413268, 6536.084948107364, 6543.857290125977, 6580.5722628029025, 6638.701258443285, 6334.873302534015, 6367.968160159169, 6446.0, 6499.122618446449, 6558.704858281293, 6175.84560385994, 6219.875602488016, 6232.626042437469, 6234.438900498977, 6239.688015599293, 5973.611715238496, 6002.969985150046, 6047.123167140828, 6052.0316749321655, 6096.268447786117, 6089.208402907594, 6128.846778830565, 6133.877322453437, 6134.693265336805, 6135.447809697149], "ext.html": [548.4570275427327, 555.5194756535595, 556.0769123255396, 572.133218174466, 582.798934367643, 27762.722372776265, 36064.81967590165, 36386.8180659097, 36387.63612363879, 36487.27025459496, 40063.19873602533, 40471.190576188455, 40547.39178912318, 40561.18877622446, 40688.0, 7006.369426751591, 7121.181064177608, 7982.92017079829, 8161.714339998101, 8167.918320816775, 10246.692599221999, 10515.263931524796, 10531.473426328692, 10541.683749487527, 10542.47287635619, 10222.0, 10335.069843714064, 10341.844872326921, 10346.224033197503, 10349.948250258738, 7151.427885769126, 7328.890066649004, 7338.889916651255, 7345.3021962913435, 9886.060824221688, 7036.0, 10279.434631095286, 10544.0, 10560.577576896914, 10567.78864422715, 36567.26865462703, 37092.629073709184, 37117.44323835144, 37158.0, 37220.813895930616, 2965.4662160811044, 3015.306479509703, 3039.8784048638026, 3043.786934914535, 3489.7731647442833, 27524.862375687993, 27740.861295693594, 28439.431211375657, 28746.856265718747, 29846.70153298461, 3140.3876244132402, 3177.777555571111, 3233.175540237248, 3233.5958005249345, 3279.1474216703828, 229364.0, 229728.0, 230137.0, 230279.0, 231051.0, 46935.765321173174, 47832.282515762294, 55620.0, 55918.440815592134, 56027.43972560222, 59974.40025599775, 60917.39082609117, 61002.69498652567, 61045.0, 61058.38941610527, 13716.794248086288, 13905.513307034205, 13960.022798404014, 13978.650533736534, 13992.790108148385, 9315.627374905063, 9582.472963987047, 10410.167186625053, 10484.63303784379, 10493.685189444328, 19221.90389048046, 19438.4168474946, 19550.5112372189, 19605.8039419604, 19686.90156549208, 7557.5465472071855, 7866.881996769938, 7869.370450363957, 7965.8805117923275, 8040.638171282189, 789.0334340433038, 833.4790755777639, 836.7908022994252, 912.1106920752346, 961.2694352292308, 24070.51858962811, 26067.73932260691, 26124.73875261261, 26148.73851261463, 26150.73849261521, 932.165711688049, 938.3712912348743, 939.5818860607101, 976.3995142987012, 1117.100733909211, 13350.46598136083, 13527.526536571173, 13663.795043074362, 13681.31593420325, 13738.86261137376, 531031.0, 543248.0, 544712.0, 549120.0, 553637.0, 48626.0, 49319.260211096145, 49351.0, 49456.50543494519, 49459.0, 1200.1778781534676, 1218.3908045977012, 1219.183147291317, 1228.0175859312515, 1229.428315833124, 26744.0, 27784.86107569449, 27789.722102778713, 28073.157805265873, 28311.2922176939, 39581.604183958945, 40073.79963100166, 40087.0, 40093.59906400899, 40094.39858402068, 248170.0, 248227.0, 249958.0, 250036.0, 251332.0, 23505.764942350357, 28217.858910705316, 28218.2945426366, 28293.71706282911, 28640.283992900346, 33731.83134084314, 45070.549294506636, 46258.074838503715, 46592.53407465882, 47198.0, 33857.66142338644, 34448.13879652928, 35003.47494787529, 35143.648563514034, 35310.646893530735, 32908.50637240396, 33904.3219135611, 34456.0, 34624.653753462146, 37013.81493092625, 34363.0, 34625.307493849476, 34883.30233395369, 34940.47589286112, 35124.297514050086, 28393.43213135767, 31389.52915706312, 31582.684173157973, 31645.683543164272, 31709.5243571342, 24142.0, 24402.633960490963, 24597.754022459547, 24869.25392238236, 24886.37784055413], "prototype.html": [282.50984541819946, 287.079908892001, 290.6860590562192, 291.11646153922834, 292.3874482958202, 5124.692518448886, 5379.488948549886, 5419.864503387417, 5450.56395488361, 5451.928267258441, 5402.189671549269, 5417.079096553585, 5417.106177480711, 5428.321459817523, 5428.782848686048, 4130.607592278744, 4134.297169481188, 4134.875953721393, 4148.917021659565, 4149.522804877448, 4135.958640413587, 4136.482939632546, 4149.0, 4149.502059752819, 4154.169166166764, 4014.2573623879675, 4099.8770036898795, 4101.815418306169, 4102.610252026067, 4107.260693075245, 4085.7957102144774, 4100.056986893016, 4100.507939047304, 4100.917981640366, 4114.280000999843, 3563.803990780506, 3569.5002699622073, 3574.0350105471375, 3578.624244454347, 3580.44503102017, 5247.422783493813, 5249.291345668324, 5279.208118782213, 5284.101702710548, 5290.497402746733, 4461.821527138911, 4724.858254252378, 4729.0541891621815, 4733.621310295168, 4736.550027747358, 4643.721376717374, 5266.92099618506, 5447.155690867922, 5589.496945274904, 5675.971620141914, 3873.5932727063814, 3903.746256493319, 3914.7846868422225, 3918.725689201757, 3923.058465968176, 5622.381538030813, 5790.913136303001, 5930.673812940287, 5932.584719069667, 5939.613925094898, 3934.429507721364, 3955.0, 3963.147923196527, 4022.074922767721, 4042.312806822847, 4081.428599996003, 4103.4870641169855, 4109.116539943867, 4109.239790638741, 4110.095778928631, 4675.345451636774, 4689.0, 4705.223638099744, 4707.81168753246, 4715.174844402216, 5456.536194423518, 5638.887222255532, 5655.886882262332, 5657.915131273035, 5660.547156227574, 1374.4639590559689, 1374.5051781358702, 1376.6076668149528, 1376.8347798264272, 1377.1461693749939, 893.718478679214, 903.2728653433917, 915.2906497464385, 915.7619019054961, 921.1847514949318, 4972.701637901738, 4973.477784832613, 4982.003599280086, 4982.153033984231, 4986.900261994812, 5852.619579727304, 5864.882702346014, 5873.148393483007, 5874.089516125007, 5874.882502349929, 4964.677295975822, 4976.800927962913, 4982.750862456863, 4984.2025275955675, 4984.825531106467, 3088.5984821972997, 3139.8744050237733, 3173.9365212695616, 3175.4601717708047, 3178.682131786849, 5617.157426385993, 5627.8593035174445, 5631.324241091095, 5637.774489020393, 5640.153976903497, 6095.420935011167, 6096.390360963868, 6103.816885493442, 6111.297200821962, 6111.602745821508, 5594.664320140723, 5600.299962504687, 5600.747966341524, 5604.41153678866, 5605.747741351567, 5705.942940570541, 5859.326177489473, 5914.319853216935, 5934.881302374015, 5937.703114844154, 5774.249347584787, 5777.335606405317, 5782.826515204551, 5786.30564332266, 5789.710514474344, 5364.114921037985, 5606.775728970795, 5615.382307946041, 5619.494245517923, 5630.23991761107, 3718.0704823794053, 3861.67175790061, 3953.802309884437, 3957.6635985941516, 3958.8218530165636, 5829.0090684584575, 5858.0, 5860.560457965755, 5867.325257595431, 5871.089981052944, 5648.915266270927, 5652.180433836988, 5656.915146272891, 5657.066584013592, 5659.688717120598, 5538.113901775858, 5620.960122377373, 5637.548996080386, 5654.604177707521, 5661.66030038199, 5526.198701188386, 5531.9723401382735, 5545.667259964415, 5547.778088876561, 5557.610967232255, 5684.147377893349, 5691.943080569141, 5700.401457846866, 5703.030484817674, 5705.0, 5410.648307859977, 5547.0, 5547.278853748987, 5551.195076713934, 5551.8889622208135], "yui.html": [647.213635432949, 667.5327270910363, 748.8801791713323, 757.821911850715, 774.3185996323239, 11811.763764724701, 11816.172867899251, 12114.636560903165, 12132.454039568218, 12147.514099436023, 11877.821832672516, 11945.402729863494, 11979.7604047919, 11981.041516678666, 12008.399580020985, 604.8880957022943, 611.544399422431, 774.2567135549879, 788.2196625340929, 805.7582725182451, 793.6825269892032, 801.2028032108061, 801.6793282686942, 805.64551597297, 808.9029316482001, 824.884516167737, 839.5927974932154, 840.3781201910604, 841.4110122913954, 841.6423020216414, 627.2754968011953, 637.1207733328001, 814.6252723747053, 839.8152406470567, 840.7771940435789, 598.0132780911488, 603.2369053147771, 604.2959951656316, 605.0863196573163, 607.4472230270477, 11579.015783658399, 11849.69653338132, 11862.644120676394, 11865.466054027589, 11946.283223006647, 11145.777084458347, 11330.886691133066, 11631.30212187263, 11940.522379104825, 12590.118691691585, 9517.286203534693, 9539.47532885698, 9625.326227164102, 9677.854832177452, 9772.51137443132, 3282.720968717638, 3333.866645334184, 3357.9832100839585, 3365.7475689323155, 3365.848536815825, 39839.0, 41125.794371028256, 41344.0, 41651.58348416538, 41701.79149104235, 8592.183742544448, 9476.526173691425, 9484.0, 9491.19324857381, 9572.521373931415, 16796.916015419843, 16820.495385138467, 16821.41125060617, 16824.915875420545, 16842.0, 6722.798316050526, 6839.658017099126, 6854.074699915547, 6890.621015844176, 6958.512904096665, 3772.245550889833, 3826.559945606291, 3934.272159650474, 3936.0356712605594, 4014.6788256939376, 2768.9030883918967, 2774.195483309858, 2794.9720502795117, 2796.384795345021, 2801.2856721535877, 411.78381349791, 414.1654566049413, 419.14494431360293, 420.44711204765633, 422.2336459326313, 514.5471984653481, 559.9552035837205, 573.4237091722792, 595.8033848829875, 623.1805176193292, 8057.919420805717, 8078.838423231502, 8180.427370084156, 8705.260052895575, 8706.869396959051, 408.98159582818846, 473.64713288599523, 477.3246103825517, 488.9926651100236, 615.6613862375675, 3492.371373152857, 3613.674769270726, 3746.4942232798767, 3749.700023998128, 3873.7288389812443, 48389.758051209516, 49424.25863612049, 52488.47511524836, 52884.0, 53103.0, 41599.04415791284, 41709.37435938463, 41852.790736046125, 42055.57944420578, 42380.338162802065, 42342.36486452706, 42982.35526467105, 43053.354199687026, 44679.55320446884, 44738.0, 7950.125486196398, 8071.959640201761, 8332.375071869512, 8367.163283671583, 8470.407071504935, 31533.684663153992, 31943.0, 32239.35521289608, 32249.0, 32460.0, 38976.80511597424, 39350.80324598359, 40777.38833917553, 42889.0, 43166.56833431751, 6305.842353941005, 6864.931350686429, 6921.446284297345, 6944.583325000516, 7091.716331346895, 11303.547858085585, 11311.830322545004, 11313.604023859454, 11498.942505287754, 11569.768604628029, 10731.087857531886, 10806.0, 10937.45312734376, 10963.50664220096, 10973.945130274617, 10833.620823271147, 10888.0, 10906.127509799355, 11093.168012399265, 11467.942660286979, 10809.297395669257, 10861.456927153453, 11004.889951100708, 11185.105191584491, 11189.048930840645, 9180.127887850644, 9189.954050229973, 9374.343795934219, 9562.665306714232, 9580.712578622653, 9144.771380715269, 9152.633894644407, 9157.404768690014, 9245.167934885892, 9287.535623218677]}, "summary": {"lowerIsBetter": false, "suite": 6154.848583920715, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6896.939853716639, "unit": "ms", "value": 6896.939853716639}, "dojo.html": {"lowerIsBetter": false, "filtered": 4630.367717306706, "unit": "ms", "value": 4630.367717306706}, "mootools.html": {"lowerIsBetter": false, "filtered": 4009.021280615947, "unit": "ms", "value": 4009.021280615947}, "ext.html": {"lowerIsBetter": false, "filtered": 17705.76025814193, "unit": "ms", "value": 17705.76025814193}, "prototype.html": {"lowerIsBetter": false, "filtered": 4208.685180262576, "unit": "ms", "value": 4208.685180262576}, "yui.html": {"lowerIsBetter": false, "filtered": 5697.53871360442, "unit": "ms", "value": 5697.53871360442}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-026"}, "testrun": {"date": 1447445803, "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": "20151113071449", "branch": "Mozilla-Inbound-Non-PGO", "revision": "d1029ba11d5c64c455412a58a2a77d14511286d6"}}, {"talos_counters": {}, "results": {"audio-dft": [163.0, 164.0, 160.0, 163.0, 161.0, 160.0, 161.0, 160.0, 162.0, 163.0], "ai-astar": [110.0, 112.0, 108.0, 112.0, 112.0, 112.0, 103.0, 111.0, 105.0, 112.0], "imaging-gaussian-blur": [109.0, 110.0, 109.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0], "audio-beat-detection": [155.0, 131.0, 154.0, 179.0, 132.0, 160.0, 152.0, 133.0, 167.0, 130.0], "json-stringify-tinderbox": [67.0, 67.0, 66.0, 68.0, 67.0, 66.0, 67.0, 67.0, 67.0, 67.0], "stanford-crypto-pbkdf2": [150.0, 133.0, 143.0, 145.0, 145.0, 132.0, 144.0, 156.0, 133.0, 132.0], "json-parse-financial": [77.0, 69.0, 70.0, 70.0, 70.0, 70.0, 71.0, 78.0, 69.0, 67.0], "stanford-crypto-sha256-iterative": [69.0, 71.0, 68.0, 71.0, 70.0, 69.0, 68.0, 69.0, 69.0, 69.0], "audio-fft": [73.0, 73.0, 80.0, 89.0, 73.0, 72.0, 73.0, 97.0, 93.0, 73.0], "imaging-darkroom": [146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 148.0, 147.0, 147.0, 147.0], "stanford-crypto-ccm": [120.0, 127.0, 133.0, 127.0, 126.0, 127.0, 121.0, 126.0, 126.0, 118.0], "audio-oscillator": [91.0, 92.0, 126.0, 93.0, 91.0, 92.0, 134.0, 93.0, 92.0, 129.0], "stanford-crypto-aes": [81.0, 83.0, 84.0, 85.0, 82.0, 83.0, 82.0, 84.0, 85.0, 83.0], "imaging-desaturate": [95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0]}, "summary": {"lowerIsBetter": true, "suite": 1512.3999999999999, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 79.6, "unit": "ms", "value": 79.6}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 141.3, "unit": "ms", "value": 141.3}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 149.3, "unit": "ms", "value": 149.3}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 125.1, "unit": "ms", "value": 125.1}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 146.7, "unit": "ms", "value": 146.7}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 71.1, "unit": "ms", "value": 71.1}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 103.3, "unit": "ms", "value": 103.3}, "ai-astar": {"lowerIsBetter": true, "filtered": 109.7, "unit": "ms", "value": 109.7}, "audio-dft": {"lowerIsBetter": true, "filtered": 161.7, "unit": "ms", "value": 161.7}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 69.3, "unit": "ms", "value": 69.3}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 66.9, "unit": "ms", "value": 66.9}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.7, "unit": "ms", "value": 109.7}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 83.2, "unit": "ms", "value": 83.2}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.5, "unit": "ms", "value": 95.5}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-026"}, "testrun": {"date": 1447445803, "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": "20151113071449", "branch": "Mozilla-Inbound-Non-PGO", "revision": "d1029ba11d5c64c455412a58a2a77d14511286d6"}}, {"talos_counters": {}, "results": {"DeltaBlue": [185.15089798185522], "Encrypt": [279.79854504756577], "NavierStokes": [4850.241545893719], "Decrypt": [5035.175879396985], "Splay": [600.3573555687909], "Richards": [171.67381974248926], "RegExp": [26315.78947368421], "Earley": [821.6926869350863], "Boyer": [11858.823529411764], "RayTrace": [1990.0596421471173]}, "summary": {"lowerIsBetter": false, "suite": 19818.00590579225, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 357.10331800000006, "unit": "score", "value": 357.10331800000006}, "Encrypt": {"lowerIsBetter": false, "filtered": 951.330894, "unit": "score", "value": 951.330894}, "NavierStokes": {"lowerIsBetter": false, "filtered": 305.9641434262948, "unit": "score", "value": 305.9641434262948}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.864290419161705, "unit": "score", "value": 52.864290419161705}, "Splay": {"lowerIsBetter": false, "filtered": 135.73748908730155, "unit": "score", "value": 135.73748908730155}, "RegExp": {"lowerIsBetter": false, "filtered": 34.61742999999998, "unit": "score", "value": 34.61742999999998}, "Richards": {"lowerIsBetter": false, "filtered": 205.63415000000006, "unit": "score", "value": 205.63415000000006}, "Earley": {"lowerIsBetter": false, "filtered": 811.0854709999999, "unit": "score", "value": 811.0854709999999}, "Boyer": {"lowerIsBetter": false, "filtered": 56.19975694444442, "unit": "score", "value": 56.19975694444442}, "RayTrace": {"lowerIsBetter": false, "filtered": 371.84262437562455, "unit": "score", "value": 371.84262437562455}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-026"}, "testrun": {"date": 1447445803, "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": "20151113071449", "branch": "Mozilla-Inbound-Non-PGO", "revision": "d1029ba11d5c64c455412a58a2a77d14511286d6"}}] 12:37:01 INFO - RETURN: dromaeo_css: 6154.85 12:37:01 INFO - RETURN: kraken: 1512.40 12:37:01 INFO - RETURN: v8_7: 19818.01 12:37:01 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,131,35]]", "result": "19818.01"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,131,35]]", "result": "1512.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,131,35]]", "result": "6154.85"}}} 12:37:01 INFO - Return code: 0 12:37:01 INFO - # TBPL SUCCESS # 12:37:01 INFO - Running post-action listener: _resource_record_post_action 12:37:01 INFO - Running post-run listener: _resource_record_post_run 12:37:02 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 8192; Write bytes: 497733632; Read time: 256; Write time: 416652 12:37:02 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 4096; Write bytes: 214368256; Read time: 112; Write time: 235680 12:37:02 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 4096; Write bytes: 282882048; Read time: 144; Write time: 180456 12:37:02 INFO - Running post-run listener: _upload_blobber_files 12:37:02 INFO - Blob upload gear active. 12:37:02 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 12:37:02 INFO - Copying logs to upload dir... 12:37:02 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1272.865168 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-11-13 12:37:02.699016) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-13 12:37:02.702603) ========= 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=a65b340e283ce644d68cb24e000001c9-1447445383.947546-1644588785 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/OOG17jUCTP6c4jwOJuo1-g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009888 build_url: 'https://queue.taskcluster.net/v1/task/OOG17jUCTP6c4jwOJuo1-g/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 12:37:02.753401) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 12:37:02.753741) ========= 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=a65b340e283ce644d68cb24e000001c9-1447445383.947546-1644588785 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004650 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 12:37:02.803035) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-13 12:37:02.803351) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-13 12:37:02.803654) ========= ========= Total master_lag: 0.25 =========