builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-047 starttime: 1448325753.45 results: success (0) buildid: 20151123161132 builduid: 44e585c9529d4f6aaa81d26a5d97eacf revision: 06223b0f30bb1e057b6d118ca2c03ff6f0176520 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 16:42:33.452596) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 16:42:33.453278) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 16:42:33.453748) ========= 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=f5f5a079460e1a9be8676904000001c1-1448324306.771813-789733296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.002950 basedir: '/builds/slave/test' ========= master_lag: 0.08 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 16:42:33.538869) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 16:42:33.539253) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 16:42:33.663441) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 16:42:33.663865) ========= 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=f5f5a079460e1a9be8676904000001c1-1448324306.771813-789733296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.027008 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 16:42:33.719806) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 16:42:33.720361) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 16:42:33.720982) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 16:42:33.721466) ========= 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=f5f5a079460e1a9be8676904000001c1-1448324306.771813-789733296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-23 16:42:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.4M=0s 2015-11-23 16:42:33 (47.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.280075 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 16:42:34.014581) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 16:42:34.014900) ========= 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=f5f5a079460e1a9be8676904000001c1-1448324306.771813-789733296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.182819 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 16:42:34.207512) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 16:42:34.207980) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 06223b0f30bb1e057b6d118ca2c03ff6f0176520 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 06223b0f30bb1e057b6d118ca2c03ff6f0176520 --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=f5f5a079460e1a9be8676904000001c1-1448324306.771813-789733296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-23 16:42:34,239 truncating revision to first 12 chars 2015-11-23 16:42:34,239 Setting DEBUG logging. 2015-11-23 16:42:34,239 attempt 1/10 2015-11-23 16:42:34,239 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/06223b0f30bb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 16:42:34,499 unpacking tar archive at: fx-team-06223b0f30bb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.526168 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 16:42:34.750772) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 16:42:34.751089) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 16:42:34.765406) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 16:42:34.765964) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 16:42:34.766754) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2015-11-23 16:42:34.767693) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=f5f5a079460e1a9be8676904000001c1-1448324306.771813-789733296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:42:35 INFO - MultiFileLogger online at 20151123 16:42:35 in /builds/slave/test 16:42:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 16:42:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:42:35 INFO - {'append_to_log': False, 16:42:35 INFO - 'base_work_dir': '/builds/slave/test', 16:42:35 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 16:42:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:42:35 INFO - 'branch': 'Fx-Team-Non-PGO', 16:42:35 INFO - 'buildbot_json_path': 'buildprops.json', 16:42:35 INFO - 'config_files': ('talos/linux_config.py',), 16:42:35 INFO - 'default_actions': ('clobber', 16:42:35 INFO - 'read-buildbot-config', 16:42:35 INFO - 'download-and-extract', 16:42:35 INFO - 'populate-webroot', 16:42:35 INFO - 'create-virtualenv', 16:42:35 INFO - 'install', 16:42:35 INFO - 'run-tests'), 16:42:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:42:35 INFO - 'download_minidump_stackwalk': True, 16:42:35 INFO - 'download_symbols': 'ondemand', 16:42:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:42:35 INFO - 'tooltool.py': '/tools/tooltool.py', 16:42:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:42:35 INFO - '/tools/misc-python/virtualenv.py')}, 16:42:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:42:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:42:35 INFO - 'installer_path': 'installer.exe', 16:42:35 INFO - 'log_level': 'info', 16:42:35 INFO - 'log_name': 'talos', 16:42:35 INFO - 'log_to_console': True, 16:42:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:42:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:42:35 INFO - 'opt_config_files': (), 16:42:35 INFO - 'pip_index': False, 16:42:35 INFO - 'sps_profile': False, 16:42:35 INFO - 'sps_profile_interval': 0, 16:42:35 INFO - 'suite': 'dromaeojs', 16:42:35 INFO - 'system_bits': '64', 16:42:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:42:35 INFO - 'title': 'talos-linux64-ix-047', 16:42:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:42:35 INFO - 'use_talos_json': True, 16:42:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:42:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:42:35 INFO - 'work_dir': 'build'} 16:42:35 INFO - ##### 16:42:35 INFO - ##### Running clobber step. 16:42:35 INFO - ##### 16:42:35 INFO - Running pre-action listener: _resource_record_pre_action 16:42:35 INFO - Running main action method: clobber 16:42:35 INFO - rmtree: /builds/slave/test/build 16:42:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:42:37 INFO - Running post-action listener: _resource_record_post_action 16:42:37 INFO - ##### 16:42:37 INFO - ##### Running read-buildbot-config step. 16:42:37 INFO - ##### 16:42:37 INFO - Running pre-action listener: _resource_record_pre_action 16:42:37 INFO - Running main action method: read_buildbot_config 16:42:37 INFO - Using buildbot properties: 16:42:37 INFO - { 16:42:37 INFO - "properties": { 16:42:37 INFO - "buildnumber": 909, 16:42:37 INFO - "product": "firefox", 16:42:37 INFO - "script_repo_revision": "production", 16:42:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:42:37 INFO - "repository": "", 16:42:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 16:42:37 INFO - "buildid": "20151123161132", 16:42:37 INFO - "slavename": "talos-linux64-ix-047", 16:42:37 INFO - "pgo_build": "False", 16:42:37 INFO - "basedir": "/builds/slave/test", 16:42:37 INFO - "project": "", 16:42:37 INFO - "platform": "ubuntu64_hw", 16:42:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:42:37 INFO - "slavebuilddir": "test", 16:42:37 INFO - "scheduler": "tests-fx-team-linux64-talos", 16:42:37 INFO - "branch": "fx-team", 16:42:37 INFO - "repo_path": "integration/fx-team", 16:42:37 INFO - "stage_platform": "linux64", 16:42:37 INFO - "builduid": "44e585c9529d4f6aaa81d26a5d97eacf", 16:42:37 INFO - "revision": "06223b0f30bb1e057b6d118ca2c03ff6f0176520" 16:42:37 INFO - }, 16:42:37 INFO - "sourcestamp": { 16:42:37 INFO - "repository": "", 16:42:37 INFO - "hasPatch": false, 16:42:37 INFO - "project": "", 16:42:37 INFO - "branch": "fx-team-linux64-talos", 16:42:37 INFO - "changes": [ 16:42:37 INFO - { 16:42:37 INFO - "category": null, 16:42:37 INFO - "files": [ 16:42:37 INFO - { 16:42:37 INFO - "url": null, 16:42:37 INFO - "name": "https://queue.taskcluster.net/v1/task/rrm0nzFbTwyeQM_oTUe4mg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 16:42:37 INFO - } 16:42:37 INFO - ], 16:42:37 INFO - "repository": "", 16:42:37 INFO - "rev": "06223b0f30bb1e057b6d118ca2c03ff6f0176520", 16:42:37 INFO - "who": "jryans@gmail.com", 16:42:37 INFO - "when": 1448325721, 16:42:37 INFO - "number": 6697960, 16:42:37 INFO - "comments": "Bug 1226699 - Add per-app DevTools prefs to Graphene. r=fabrice\n", 16:42:37 INFO - "project": "", 16:42:37 INFO - "at": "Mon 23 Nov 2015 16:42:01", 16:42:37 INFO - "branch": "fx-team-linux64-talos", 16:42:37 INFO - "revlink": "", 16:42:37 INFO - "properties": [ 16:42:37 INFO - [ 16:42:37 INFO - "buildid", 16:42:37 INFO - "20151123161132", 16:42:37 INFO - "Change" 16:42:37 INFO - ], 16:42:37 INFO - [ 16:42:37 INFO - "builduid", 16:42:37 INFO - "44e585c9529d4f6aaa81d26a5d97eacf", 16:42:37 INFO - "Change" 16:42:37 INFO - ], 16:42:37 INFO - [ 16:42:37 INFO - "pgo_build", 16:42:37 INFO - "False", 16:42:37 INFO - "Change" 16:42:37 INFO - ] 16:42:37 INFO - ], 16:42:37 INFO - "revision": "06223b0f30bb1e057b6d118ca2c03ff6f0176520" 16:42:37 INFO - } 16:42:37 INFO - ], 16:42:37 INFO - "revision": "06223b0f30bb1e057b6d118ca2c03ff6f0176520" 16:42:37 INFO - } 16:42:37 INFO - } 16:42:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/rrm0nzFbTwyeQM_oTUe4mg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 16:42:37 INFO - Running post-action listener: _resource_record_post_action 16:42:37 INFO - ##### 16:42:37 INFO - ##### Running download-and-extract step. 16:42:37 INFO - ##### 16:42:37 INFO - Running pre-action listener: _resource_record_pre_action 16:42:37 INFO - Running main action method: download_and_extract 16:42:37 INFO - mkdir: /builds/slave/test/build/tests 16:42:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:37 INFO - https://queue.taskcluster.net/v1/task/rrm0nzFbTwyeQM_oTUe4mg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:42:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rrm0nzFbTwyeQM_oTUe4mg/artifacts/public/build/test_packages.json 16:42:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rrm0nzFbTwyeQM_oTUe4mg/artifacts/public/build/test_packages.json 16:42:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rrm0nzFbTwyeQM_oTUe4mg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 16:42:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rrm0nzFbTwyeQM_oTUe4mg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 16:42:45 INFO - Downloaded 1302 bytes. 16:42:45 INFO - Reading from file /builds/slave/test/build/test_packages.json 16:42:45 INFO - Using the following test package requirements: 16:42:45 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 16:42:45 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:42:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:42:45 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:42:45 INFO - u'jsshell-linux-x86_64.zip'], 16:42:45 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:42:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:42:45 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 16:42:45 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:42:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:42:45 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:42:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:42:45 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:42:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:42:45 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 16:42:45 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:42:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:42:45 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:42:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:45 INFO - https://queue.taskcluster.net/v1/task/rrm0nzFbTwyeQM_oTUe4mg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:42:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rrm0nzFbTwyeQM_oTUe4mg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:42:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rrm0nzFbTwyeQM_oTUe4mg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:42:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rrm0nzFbTwyeQM_oTUe4mg/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 16:42:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rrm0nzFbTwyeQM_oTUe4mg/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 16:42:52 INFO - Downloaded 21341300 bytes. 16:42:52 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 16:42:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:42:52 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 16:42:54 INFO - Return code: 0 16:42:54 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 16:42: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')]} 16:42:54 INFO - https://queue.taskcluster.net/v1/task/rrm0nzFbTwyeQM_oTUe4mg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:42:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rrm0nzFbTwyeQM_oTUe4mg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:42:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rrm0nzFbTwyeQM_oTUe4mg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:42:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rrm0nzFbTwyeQM_oTUe4mg/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 16:42:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rrm0nzFbTwyeQM_oTUe4mg/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 16:42:55 INFO - Downloaded 21341300 bytes. 16:42:55 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 16:42:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:42:55 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 16:42:56 INFO - Return code: 0 16:42:56 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')]} 16:42:56 INFO - https://queue.taskcluster.net/v1/task/rrm0nzFbTwyeQM_oTUe4mg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:42:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rrm0nzFbTwyeQM_oTUe4mg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 16:42:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rrm0nzFbTwyeQM_oTUe4mg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 16:42:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rrm0nzFbTwyeQM_oTUe4mg/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 16:42:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rrm0nzFbTwyeQM_oTUe4mg/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 16:42:57 INFO - Downloaded 11130997 bytes. 16:42:57 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 16:42:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 16:42:57 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 16:42:58 INFO - Return code: 0 16:42: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')]} 16:42:58 INFO - https://queue.taskcluster.net/v1/task/rrm0nzFbTwyeQM_oTUe4mg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:42:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rrm0nzFbTwyeQM_oTUe4mg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:42:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rrm0nzFbTwyeQM_oTUe4mg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:42:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rrm0nzFbTwyeQM_oTUe4mg/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 16:42:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rrm0nzFbTwyeQM_oTUe4mg/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 16:43:01 INFO - Downloaded 56064664 bytes. 16:43:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/rrm0nzFbTwyeQM_oTUe4mg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:43:01 INFO - mkdir: /builds/slave/test/properties 16:43:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:43:01 INFO - Writing to file /builds/slave/test/properties/build_url 16:43:01 INFO - Contents: 16:43:01 INFO - build_url:https://queue.taskcluster.net/v1/task/rrm0nzFbTwyeQM_oTUe4mg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:43:01 INFO - Running post-action listener: _resource_record_post_action 16:43:01 INFO - Running post-action listener: set_extra_try_arguments 16:43:01 INFO - ##### 16:43:01 INFO - ##### Running populate-webroot step. 16:43:01 INFO - ##### 16:43:01 INFO - Running pre-action listener: _resource_record_pre_action 16:43:01 INFO - Running main action method: populate_webroot 16:43:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:43:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:43:01 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 16:43:01 INFO - '../fennec_ids.txt'], 16:43:01 INFO - 'tests': ['tcheck2']}, 16:43:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:43:01 INFO - '--tppagecycles', 16:43:01 INFO - '7'], 16:43:01 INFO - 'tests': ['tsvgm']}}, 16:43:01 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:43:01 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:43:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:43:01 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:43:01 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:43:01 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:43:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:43:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:43:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:43:01 INFO - 'talos_options': ['--e10s'], 16:43:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:43:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:43:01 INFO - 'tests': ['damp', 'tps']}, 16:43:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:43:01 INFO - 'talos_options': ['--e10s'], 16:43:01 INFO - 'tests': ['damp', 'tps']}, 16:43:01 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:43:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:43:01 INFO - 'other': {'tests': ['a11yr', 16:43:01 INFO - 'ts_paint', 16:43:01 INFO - 'tpaint', 16:43:01 INFO - 'sessionrestore', 16:43:01 INFO - 'sessionrestore_no_auto_restore']}, 16:43:01 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:43:01 INFO - 'tests': ['a11yr', 16:43:01 INFO - 'ts_paint', 16:43:01 INFO - 'tpaint', 16:43:01 INFO - 'sessionrestore', 16:43:01 INFO - 'sessionrestore_no_auto_restore']}, 16:43:01 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:43:01 INFO - 'tests': ['a11yr', 16:43:01 INFO - 'ts_paint', 16:43:01 INFO - 'tpaint', 16:43:01 INFO - 'sessionrestore', 16:43:01 INFO - 'sessionrestore_no_auto_restore']}, 16:43:01 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:43:01 INFO - 'tests': ['a11yr', 16:43:01 INFO - 'ts_paint', 16:43:01 INFO - 'tpaint', 16:43:01 INFO - 'sessionrestore', 16:43:01 INFO - 'sessionrestore_no_auto_restore']}, 16:43:01 INFO - 'other_l64': {'tests': ['a11yr', 16:43:01 INFO - 'ts_paint', 16:43:01 INFO - 'tpaint', 16:43:01 INFO - 'sessionrestore', 16:43:01 INFO - 'sessionrestore_no_auto_restore']}, 16:43:01 INFO - 'other_nol64': {'tests': ['a11yr', 16:43:01 INFO - 'ts_paint', 16:43:01 INFO - 'tpaint', 16:43:01 INFO - 'sessionrestore', 16:43:01 INFO - 'sessionrestore_no_auto_restore']}, 16:43:01 INFO - 'svgr': {'tests': ['tsvgx', 16:43:01 INFO - 'tsvgr_opacity', 16:43:01 INFO - 'tart', 16:43:01 INFO - 'tscrollx', 16:43:01 INFO - 'cart']}, 16:43:01 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:43:01 INFO - 'tests': ['tsvgx', 16:43:01 INFO - 'tsvgr_opacity', 16:43:01 INFO - 'tart', 16:43:01 INFO - 'tscrollx', 16:43:01 INFO - 'cart']}, 16:43:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:43:01 INFO - 'tests': ['tp5o']}, 16:43:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:43:01 INFO - 'talos_options': ['--e10s'], 16:43:01 INFO - 'tests': ['tp5o']}, 16:43:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:43:01 INFO - 'talos_options': ['--xperf_path', 16:43:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:43:01 INFO - 'tests': ['tp5n']}, 16:43:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:43:01 INFO - 'talos_options': ['--e10s', 16:43:01 INFO - '--xperf_path', 16:43:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:43:01 INFO - 'tests': ['tp5n']}}, 16:43:01 INFO - 'talos.zip': {'path': '', 16:43:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:43:01 INFO - Running post-action listener: _resource_record_post_action 16:43:01 INFO - ##### 16:43:01 INFO - ##### Running create-virtualenv step. 16:43:01 INFO - ##### 16:43:01 INFO - Running pre-action listener: _resource_record_pre_action 16:43:01 INFO - Running main action method: create_virtualenv 16:43:01 INFO - Creating virtualenv /builds/slave/test/build/venv 16:43:01 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 16:43:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:43:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:43:01 INFO - Using real prefix '/usr' 16:43:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:43:01 INFO - Installing distribute.............................................................................................................................................................................................done. 16:43:03 INFO - Installing pip.................done. 16:43:03 INFO - Return code: 0 16:43:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:43:03 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')]} 16:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:03 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')]} 16:43:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:03 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 0x7f6331739c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ff900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2845b70>, '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 0x2896dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2897250>, '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': 'f5f5a079460e1a9be8676904000001c1-1448324306.771813-789733296', '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 16:43:03 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 16:43:03 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 16:43:03 INFO - Using env: {'DISPLAY': ':0', 16:43:03 INFO - 'HOME': '/home/cltbld', 16:43:03 INFO - 'LANG': 'en_US.UTF-8', 16:43:03 INFO - 'LANGUAGE': 'en_US:en', 16:43:03 INFO - 'LOGNAME': 'cltbld', 16:43:03 INFO - 'MAIL': '/var/mail/cltbld', 16:43:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:03 INFO - 'MOZ_NO_REMOTE': '1', 16:43:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:43:03 INFO - 'NO_EM_RESTART': '1', 16:43:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:43:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:03 INFO - 'PWD': '/builds/slave/test', 16:43:03 INFO - 'SHELL': '/bin/bash', 16:43:03 INFO - 'SHLVL': '1', 16:43:03 INFO - 'TERM': 'linux', 16:43:03 INFO - 'TMOUT': '86400', 16:43:03 INFO - 'USER': 'cltbld', 16:43:03 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1448324306.771813-789733296', 16:43:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:03 INFO - '_': '/tools/buildbot/bin/python'} 16:43:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:04 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 16:43:04 INFO - Cleaning up... 16:43:04 INFO - Return code: 0 16:43:04 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:43: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')]} 16:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43: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')]} 16:43:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6331739c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ff900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2845b70>, '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 0x2896dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2897250>, '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': 'f5f5a079460e1a9be8676904000001c1-1448324306.771813-789733296', '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 16:43:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 16:43:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:43:04 INFO - Using env: {'DISPLAY': ':0', 16:43:04 INFO - 'HOME': '/home/cltbld', 16:43:04 INFO - 'LANG': 'en_US.UTF-8', 16:43:04 INFO - 'LANGUAGE': 'en_US:en', 16:43:04 INFO - 'LOGNAME': 'cltbld', 16:43:04 INFO - 'MAIL': '/var/mail/cltbld', 16:43:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:04 INFO - 'MOZ_NO_REMOTE': '1', 16:43:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:43:04 INFO - 'NO_EM_RESTART': '1', 16:43:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:43:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:04 INFO - 'PWD': '/builds/slave/test', 16:43:04 INFO - 'SHELL': '/bin/bash', 16:43:04 INFO - 'SHLVL': '1', 16:43:04 INFO - 'TERM': 'linux', 16:43:04 INFO - 'TMOUT': '86400', 16:43:04 INFO - 'USER': 'cltbld', 16:43:04 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1448324306.771813-789733296', 16:43:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:04 INFO - '_': '/tools/buildbot/bin/python'} 16:43:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:04 INFO - Downloading/unpacking psutil>=0.7.1 16:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:06 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 16:43:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:43:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:43:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:43:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:43:06 INFO - Installing collected packages: psutil 16:43:06 INFO - Running setup.py install for psutil 16:43:06 INFO - building 'psutil._psutil_linux' extension 16:43:06 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 16:43:07 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 16:43:07 INFO - building 'psutil._psutil_posix' extension 16:43:07 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 16:43:07 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 16:43:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:43:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:43:07 INFO - Successfully installed psutil 16:43:07 INFO - Cleaning up... 16:43:07 INFO - Return code: 0 16:43:07 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:43:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:43:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:43:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f6331739c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ff900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2845b70>, '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 0x2896dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2897250>, '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': 'f5f5a079460e1a9be8676904000001c1-1448324306.771813-789733296', '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 16:43:07 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 16:43:07 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 16:43:07 INFO - Using env: {'DISPLAY': ':0', 16:43:07 INFO - 'HOME': '/home/cltbld', 16:43:07 INFO - 'LANG': 'en_US.UTF-8', 16:43:07 INFO - 'LANGUAGE': 'en_US:en', 16:43:07 INFO - 'LOGNAME': 'cltbld', 16:43:07 INFO - 'MAIL': '/var/mail/cltbld', 16:43:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:07 INFO - 'MOZ_NO_REMOTE': '1', 16:43:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:43:07 INFO - 'NO_EM_RESTART': '1', 16:43:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:43:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:07 INFO - 'PWD': '/builds/slave/test', 16:43:07 INFO - 'SHELL': '/bin/bash', 16:43:07 INFO - 'SHLVL': '1', 16:43:07 INFO - 'TERM': 'linux', 16:43:07 INFO - 'TMOUT': '86400', 16:43:07 INFO - 'USER': 'cltbld', 16:43:07 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1448324306.771813-789733296', 16:43:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:07 INFO - '_': '/tools/buildbot/bin/python'} 16:43:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:43:07 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 16:43:07 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 16:43:07 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 16:43:07 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 16:43:07 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 16:43:07 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 16:43:09 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:43:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:43:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:43:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:43:09 INFO - Installing collected packages: mozsystemmonitor 16:43:09 INFO - Running setup.py install for mozsystemmonitor 16:43:09 INFO - Successfully installed mozsystemmonitor 16:43:09 INFO - Cleaning up... 16:43:09 INFO - Return code: 0 16:43:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:43:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:43:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:09 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 0x7f6331739c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ff900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2845b70>, '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 0x2896dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2897250>, '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': 'f5f5a079460e1a9be8676904000001c1-1448324306.771813-789733296', '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 16:43:09 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 16:43:09 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 16:43:09 INFO - Using env: {'DISPLAY': ':0', 16:43:09 INFO - 'HOME': '/home/cltbld', 16:43:09 INFO - 'LANG': 'en_US.UTF-8', 16:43:09 INFO - 'LANGUAGE': 'en_US:en', 16:43:09 INFO - 'LOGNAME': 'cltbld', 16:43:09 INFO - 'MAIL': '/var/mail/cltbld', 16:43:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:09 INFO - 'MOZ_NO_REMOTE': '1', 16:43:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:43:09 INFO - 'NO_EM_RESTART': '1', 16:43:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:43:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:09 INFO - 'PWD': '/builds/slave/test', 16:43:09 INFO - 'SHELL': '/bin/bash', 16:43:09 INFO - 'SHLVL': '1', 16:43:09 INFO - 'TERM': 'linux', 16:43:09 INFO - 'TMOUT': '86400', 16:43:09 INFO - 'USER': 'cltbld', 16:43:09 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1448324306.771813-789733296', 16:43:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:09 INFO - '_': '/tools/buildbot/bin/python'} 16:43:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:09 INFO - Downloading/unpacking blobuploader==1.2.4 16:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:11 INFO - Downloading blobuploader-1.2.4.tar.gz 16:43:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:43:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:43:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:43:11 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 16:43:11 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 16:43:11 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 16:43:11 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 16:43:11 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 16:43:11 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 16:43:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:43:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:43:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:43:12 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 16:43:12 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 16:43:12 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 16:43:12 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 16:43:12 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 16:43:12 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 16:43:12 INFO - Downloading docopt-0.6.1.tar.gz 16:43:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:43:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:43:12 INFO - Installing collected packages: blobuploader, requests, docopt 16:43:12 INFO - Running setup.py install for blobuploader 16:43:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:43:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:43:12 INFO - Running setup.py install for requests 16:43:12 INFO - Running setup.py install for docopt 16:43:12 INFO - Successfully installed blobuploader requests docopt 16:43:12 INFO - Cleaning up... 16:43:12 INFO - Return code: 0 16:43:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:43:12 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')]} 16:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:12 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')]} 16:43:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:12 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 0x7f6331739c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ff900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2845b70>, '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 0x2896dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2897250>, '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': 'f5f5a079460e1a9be8676904000001c1-1448324306.771813-789733296', '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 16:43:12 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 16:43:12 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 16:43:12 INFO - Using env: {'DISPLAY': ':0', 16:43:12 INFO - 'HOME': '/home/cltbld', 16:43:12 INFO - 'LANG': 'en_US.UTF-8', 16:43:12 INFO - 'LANGUAGE': 'en_US:en', 16:43:12 INFO - 'LOGNAME': 'cltbld', 16:43:12 INFO - 'MAIL': '/var/mail/cltbld', 16:43:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:12 INFO - 'MOZ_NO_REMOTE': '1', 16:43:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:43:12 INFO - 'NO_EM_RESTART': '1', 16:43:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:43:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:12 INFO - 'PWD': '/builds/slave/test', 16:43:12 INFO - 'SHELL': '/bin/bash', 16:43:12 INFO - 'SHLVL': '1', 16:43:12 INFO - 'TERM': 'linux', 16:43:12 INFO - 'TMOUT': '86400', 16:43:12 INFO - 'USER': 'cltbld', 16:43:12 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1448324306.771813-789733296', 16:43:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:12 INFO - '_': '/tools/buildbot/bin/python'} 16:43:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:43:13 INFO - Running setup.py (path:/tmp/pip-QcdueS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:43:13 INFO - Running setup.py (path:/tmp/pip-MWSZQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:43:13 INFO - Running setup.py (path:/tmp/pip-_7wSqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:43:13 INFO - Running setup.py (path:/tmp/pip-6vDhRK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:43:13 INFO - Running setup.py (path:/tmp/pip-WgIyV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:43:13 INFO - Running setup.py (path:/tmp/pip-EbJNgp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:43:13 INFO - Running setup.py (path:/tmp/pip-821a7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:43:13 INFO - Running setup.py (path:/tmp/pip-TlwrR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:43:13 INFO - Running setup.py (path:/tmp/pip-aO5jOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:43:13 INFO - Running setup.py (path:/tmp/pip-iXaLb5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:43:13 INFO - Running setup.py (path:/tmp/pip-uo1zjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:43:13 INFO - Running setup.py (path:/tmp/pip-sg2M8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:43:14 INFO - Running setup.py (path:/tmp/pip-wKcttg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:43:14 INFO - Running setup.py (path:/tmp/pip-XXFiJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:43:14 INFO - Running setup.py (path:/tmp/pip-YhCyvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:43:14 INFO - Running setup.py (path:/tmp/pip-mtdqje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:43:14 INFO - Running setup.py (path:/tmp/pip-GEBmni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:43:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:43:14 INFO - Running setup.py install for manifestparser 16:43:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:43:14 INFO - Running setup.py install for mozcrash 16:43:14 INFO - Running setup.py install for mozdebug 16:43:14 INFO - Running setup.py install for mozdevice 16:43:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:43:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:43:14 INFO - Running setup.py install for mozfile 16:43:14 INFO - Running setup.py install for mozhttpd 16:43:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:43:15 INFO - Running setup.py install for mozinfo 16:43:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:43:15 INFO - Running setup.py install for mozInstall 16:43:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:43:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:43:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:43:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:43:15 INFO - Running setup.py install for mozleak 16:43:15 INFO - Running setup.py install for mozlog 16:43:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:43:15 INFO - Running setup.py install for moznetwork 16:43:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:43:15 INFO - Running setup.py install for mozprocess 16:43:15 INFO - Running setup.py install for mozprofile 16:43:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:43:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:43:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:43:15 INFO - Running setup.py install for mozrunner 16:43:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:43:15 INFO - Running setup.py install for mozscreenshot 16:43:15 INFO - Running setup.py install for moztest 16:43:16 INFO - Running setup.py install for mozversion 16:43:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:43:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:43:16 INFO - Cleaning up... 16:43:16 INFO - Return code: 0 16:43:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:43: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')]} 16:43:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43: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')]} 16:43:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43: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', '-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 0x7f6331739c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ff900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2845b70>, '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 0x2896dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2897250>, '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': 'f5f5a079460e1a9be8676904000001c1-1448324306.771813-789733296', '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 16:43:16 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 16:43:16 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 16:43:16 INFO - Using env: {'DISPLAY': ':0', 16:43:16 INFO - 'HOME': '/home/cltbld', 16:43:16 INFO - 'LANG': 'en_US.UTF-8', 16:43:16 INFO - 'LANGUAGE': 'en_US:en', 16:43:16 INFO - 'LOGNAME': 'cltbld', 16:43:16 INFO - 'MAIL': '/var/mail/cltbld', 16:43:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:16 INFO - 'MOZ_NO_REMOTE': '1', 16:43:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:43:16 INFO - 'NO_EM_RESTART': '1', 16:43:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:43:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:16 INFO - 'PWD': '/builds/slave/test', 16:43:16 INFO - 'SHELL': '/bin/bash', 16:43:16 INFO - 'SHLVL': '1', 16:43:16 INFO - 'TERM': 'linux', 16:43:16 INFO - 'TMOUT': '86400', 16:43:16 INFO - 'USER': 'cltbld', 16:43:16 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1448324306.771813-789733296', 16:43:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:16 INFO - '_': '/tools/buildbot/bin/python'} 16:43:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:43:16 INFO - Running setup.py (path:/tmp/pip-2LWODr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:43:16 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)) 16:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:43:16 INFO - Running setup.py (path:/tmp/pip-DlBGqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:43:16 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)) 16:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:43:16 INFO - Running setup.py (path:/tmp/pip-CSVJ_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:43:16 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)) 16:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:43:16 INFO - Running setup.py (path:/tmp/pip-IxGvLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:43:16 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)) 16:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:43:16 INFO - Running setup.py (path:/tmp/pip-xyo9xY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:43:16 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)) 16:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:43:16 INFO - Running setup.py (path:/tmp/pip-v27Lr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:43:16 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)) 16:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:43:16 INFO - Running setup.py (path:/tmp/pip-yJYvhR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:43:16 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)) 16:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:43:16 INFO - Running setup.py (path:/tmp/pip-PJgcr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:43:16 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)) 16:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:43:16 INFO - Running setup.py (path:/tmp/pip-pveYdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:43:17 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)) 16:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:43:17 INFO - Running setup.py (path:/tmp/pip-sVQfjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:43:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:43:17 INFO - Running setup.py (path:/tmp/pip-NuoiqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:43:17 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)) 16:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:43:17 INFO - Running setup.py (path:/tmp/pip-4hpLYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:43:17 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)) 16:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:43:17 INFO - Running setup.py (path:/tmp/pip-2v484a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:43:17 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)) 16:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:43:17 INFO - Running setup.py (path:/tmp/pip-Nh_cfw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:43:17 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)) 16:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:43:17 INFO - Running setup.py (path:/tmp/pip-Z3KbHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:43:17 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)) 16:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:43:17 INFO - Running setup.py (path:/tmp/pip-zdVzNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:43:17 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)) 16:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:43:17 INFO - Running setup.py (path:/tmp/pip-VrNUEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:43:17 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)) 16:43:17 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)) 16:43:17 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)) 16:43:17 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)) 16:43:17 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)) 16:43:17 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)) 16:43:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:43: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 16:43: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 16:43: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 16:43: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 16:43: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 16:43: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 16:43:20 INFO - Downloading blessings-1.5.1.tar.gz 16:43:20 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 16:43:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:43:20 INFO - Installing collected packages: blessings 16:43:20 INFO - Running setup.py install for blessings 16:43:20 INFO - Successfully installed blessings 16:43:20 INFO - Cleaning up... 16:43:20 INFO - Return code: 0 16:43:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:43:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:43:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:43:20 INFO - Reading from file tmpfile_stdout 16:43:20 INFO - Current package versions: 16:43:20 INFO - argparse == 1.2.1 16:43:20 INFO - blessings == 1.5.1 16:43:20 INFO - blobuploader == 1.2.4 16:43:20 INFO - docopt == 0.6.1 16:43:20 INFO - manifestparser == 1.1 16:43:20 INFO - mozInstall == 1.12 16:43:20 INFO - mozcrash == 0.16 16:43:20 INFO - mozdebug == 0.1 16:43:20 INFO - mozdevice == 0.47 16:43:20 INFO - mozfile == 1.2 16:43:20 INFO - mozhttpd == 0.7 16:43:20 INFO - mozinfo == 0.9 16:43:20 INFO - mozleak == 0.1 16:43:20 INFO - mozlog == 3.1 16:43:20 INFO - moznetwork == 0.27 16:43:20 INFO - mozprocess == 0.22 16:43:20 INFO - mozprofile == 0.27 16:43:20 INFO - mozrunner == 6.11 16:43:20 INFO - mozscreenshot == 0.1 16:43:20 INFO - mozsystemmonitor == 0.0 16:43:20 INFO - moztest == 0.7 16:43:20 INFO - mozversion == 1.4 16:43:20 INFO - psutil == 3.1.1 16:43:20 INFO - requests == 1.2.3 16:43:20 INFO - wsgiref == 0.1.2 16:43:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:43:20 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')]} 16:43:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:20 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')]} 16:43:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:20 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 0x7f6331739c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ff900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2845b70>, '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 0x2896dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2897250>, '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': 'f5f5a079460e1a9be8676904000001c1-1448324306.771813-789733296', '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 16:43:20 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 16:43:20 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 16:43:20 INFO - Using env: {'DISPLAY': ':0', 16:43:20 INFO - 'HOME': '/home/cltbld', 16:43:20 INFO - 'LANG': 'en_US.UTF-8', 16:43:20 INFO - 'LANGUAGE': 'en_US:en', 16:43:20 INFO - 'LOGNAME': 'cltbld', 16:43:20 INFO - 'MAIL': '/var/mail/cltbld', 16:43:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:20 INFO - 'MOZ_NO_REMOTE': '1', 16:43:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:43:20 INFO - 'NO_EM_RESTART': '1', 16:43:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:43:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:20 INFO - 'PWD': '/builds/slave/test', 16:43:20 INFO - 'SHELL': '/bin/bash', 16:43:20 INFO - 'SHLVL': '1', 16:43:20 INFO - 'TERM': 'linux', 16:43:20 INFO - 'TMOUT': '86400', 16:43:20 INFO - 'USER': 'cltbld', 16:43:20 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1448324306.771813-789733296', 16:43:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:20 INFO - '_': '/tools/buildbot/bin/python'} 16:43:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:20 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)) 16:43:20 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)) 16:43:20 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)) 16:43:20 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)) 16:43:20 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)) 16:43:21 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)) 16:43:21 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)) 16:43:21 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)) 16:43:21 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)) 16:43:21 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)) 16:43:21 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)) 16:43:21 INFO - Cleaning up... 16:43:21 INFO - Return code: 0 16:43:21 INFO - Running post-action listener: _resource_record_post_action 16:43:21 INFO - Running post-action listener: _start_resource_monitoring 16:43:21 INFO - Starting resource monitoring. 16:43:21 INFO - ##### 16:43:21 INFO - ##### Running install step. 16:43:21 INFO - ##### 16:43:21 INFO - Running pre-action listener: _resource_record_pre_action 16:43:21 INFO - Running main action method: install 16:43:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:43:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:43:21 INFO - Reading from file tmpfile_stdout 16:43:21 INFO - Detecting whether we're running mozinstall >=1.0... 16:43:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:43:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:43:21 INFO - Reading from file tmpfile_stdout 16:43:21 INFO - Output received: 16:43:21 INFO - Usage: mozinstall [options] installer 16:43:21 INFO - Options: 16:43:21 INFO - -h, --help show this help message and exit 16:43:21 INFO - -d DEST, --destination=DEST 16:43:21 INFO - Directory to install application into. [default: 16:43:21 INFO - "/builds/slave/test"] 16:43:21 INFO - --app=APP Application being installed. [default: firefox] 16:43:21 INFO - mkdir: /builds/slave/test/build/application 16:43:21 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'] 16:43:21 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 16:43:35 INFO - Reading from file tmpfile_stdout 16:43:35 INFO - Output received: 16:43:35 INFO - /builds/slave/test/build/application/firefox/firefox 16:43:35 INFO - Running post-action listener: _resource_record_post_action 16:43:35 INFO - ##### 16:43:35 INFO - ##### Running run-tests step. 16:43:35 INFO - ##### 16:43:35 INFO - Running pre-action listener: _resource_record_pre_action 16:43:35 INFO - Running main action method: run_tests 16:43:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:43:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:43:35 INFO - Python 2.7.3 16:43:35 INFO - Return code: 0 16:43:35 INFO - grabbing minidump binary from tooltool 16:43:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:43:35 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 0x2845b70>, '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 0x2896dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2897250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:43:35 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 16:43:35 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 16:43:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:43:35 INFO - Return code: 0 16:43:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:43:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:43:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:43:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:43:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:43:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/rrm0nzFbTwyeQM_oTUe4mg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost'] in /builds/slave/test/build 16:43:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/rrm0nzFbTwyeQM_oTUe4mg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost 16:43:35 INFO - Using env: {'DISPLAY': ':0', 16:43:35 INFO - 'HOME': '/home/cltbld', 16:43:35 INFO - 'LANG': 'en_US.UTF-8', 16:43:35 INFO - 'LANGUAGE': 'en_US:en', 16:43:35 INFO - 'LOGNAME': 'cltbld', 16:43:35 INFO - 'MAIL': '/var/mail/cltbld', 16:43:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:43:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:43:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:35 INFO - 'MOZ_NO_REMOTE': '1', 16:43:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:43:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:43:35 INFO - 'NO_EM_RESTART': '1', 16:43:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:43:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:35 INFO - 'PWD': '/builds/slave/test', 16:43:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:43:35 INFO - 'SHELL': '/bin/bash', 16:43:35 INFO - 'SHLVL': '1', 16:43:35 INFO - 'TERM': 'linux', 16:43:35 INFO - 'TMOUT': '86400', 16:43:35 INFO - 'USER': 'cltbld', 16:43:35 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1448324306.771813-789733296', 16:43:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:35 INFO - '_': '/tools/buildbot/bin/python'} 16:43:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/rrm0nzFbTwyeQM_oTUe4mg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost'] with output_timeout 3600 16:43:36 INFO - mozversion INFO | application_buildid: 20151123161132 16:43:36 INFO - mozversion INFO | application_changeset: 06223b0f30bb1e057b6d118ca2c03ff6f0176520 16:43:36 INFO - mozversion INFO | application_display_name: Nightly 16:43:36 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:43:36 INFO - mozversion INFO | application_name: Firefox 16:43:36 INFO - mozversion INFO | application_remotingname: firefox 16:43:36 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 16:43:36 INFO - mozversion INFO | application_vendor: Mozilla 16:43:36 INFO - mozversion INFO | application_version: 45.0a1 16:43:36 INFO - mozversion INFO | platform_buildid: 20151123161132 16:43:36 INFO - mozversion INFO | platform_changeset: 06223b0f30bb1e057b6d118ca2c03ff6f0176520 16:43:36 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 16:43:36 INFO - mozversion INFO | platform_version: 45.0a1 16:43:36 INFO - 2015-11-23 16:43:36,181 DEBUG : using testdate: 1448325816 16:43:36 INFO - 2015-11-23 16:43:36,181 DEBUG : actual date: 1448325816 16:43:36 INFO - 2015-11-23 16:43:36,189 INFO : starting webserver on 'localhost:52851' 16:43:36 INFO - 2015-11-23 16:43:36,190 INFO : Starting test suite talos-linux64-ix-047 16:43:36 INFO - 2015-11-23 16:43:36,190 INFO : Starting test dromaeo_css 16:43:36 INFO - 2015-11-23 16:43:36,190 DEBUG : operating with platform_type : linux_ 16:43:36 INFO - 2015-11-23 16:43:36,191 INFO : Initialising browser for dromaeo_css test... 16:43:36 INFO - 2015-11-23 16:43:36,209 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUbA7nS/profile http://localhost:52851/getInfo.html 16:43:42 INFO - 2015-11-23 16:43:42,589 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:43:42 INFO - 2015-11-23 16:43:42,589 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:43:42 INFO - 2015-11-23 16:43:42,589 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:43:42 INFO - 2015-11-23 16:43:42,589 DEBUG : BROWSER_OUTPUT: __metrics 16:43:42 INFO - 2015-11-23 16:43:42,786 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:43:44 INFO - 2015-11-23 16:43:44,365 INFO : Browser initialized. 16:43:44 INFO - 2015-11-23 16:43:44,365 INFO : Running cycle 1/1 for dromaeo_css test... 16:43:44 INFO - 2015-11-23 16:43:44,366 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUbA7nS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:43:56 INFO - 2015-11-23 16:43:56,255 DEBUG : BROWSER_OUTPUT: RSS: Main: 142118912 16:43:56 INFO - 2015-11-23 16:43:56,256 DEBUG : BROWSER_OUTPUT: 16:44:47 INFO - 2015-11-23 16:44:47,630 DEBUG : BROWSER_OUTPUT: 1448325887623 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] 16:46:59 INFO - 2015-11-23 16:46:59,789 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52851/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52851/tests/dromaeo/cssquery-ext.html) 16:47:00 INFO - 2015-11-23 16:47:00,874 DEBUG : BROWSER_OUTPUT: RSS: Main: 224624640 16:47:00 INFO - 2015-11-23 16:47:00,874 DEBUG : BROWSER_OUTPUT: 16:50:03 INFO - 2015-11-23 16:50:03,406 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52851/tests/dromaeo/cssquery-ext.html (next: http://localhost:52851/tests/dromaeo/cssquery-jquery.html) 16:50:03 INFO - 2015-11-23 16:50:03,979 DEBUG : BROWSER_OUTPUT: RSS: Main: 222011392 16:50:03 INFO - 2015-11-23 16:50:03,979 DEBUG : BROWSER_OUTPUT: 16:53:05 INFO - 2015-11-23 16:53:05,968 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52851/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52851/tests/dromaeo/cssquery-mootools.html) 16:53:06 INFO - 2015-11-23 16:53:06,534 DEBUG : BROWSER_OUTPUT: RSS: Main: 217051136 16:53:06 INFO - 2015-11-23 16:53:06,534 DEBUG : BROWSER_OUTPUT: 16:56:08 INFO - 2015-11-23 16:56:08,513 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52851/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52851/tests/dromaeo/cssquery-prototype.html) 16:56:09 INFO - 2015-11-23 16:56:09,081 DEBUG : BROWSER_OUTPUT: RSS: Main: 204390400 16:56:09 INFO - 2015-11-23 16:56:09,082 DEBUG : BROWSER_OUTPUT: 16:59:11 INFO - 2015-11-23 16:59:11,775 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52851/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52851/tests/dromaeo/cssquery-yui.html) 16:59:12 INFO - 2015-11-23 16:59:12,362 DEBUG : BROWSER_OUTPUT: RSS: Main: 206462976 16:59:12 INFO - 2015-11-23 16:59:12,362 DEBUG : BROWSER_OUTPUT: 17:02:14 INFO - 2015-11-23 17:02:14,989 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52851/tests/dromaeo/cssquery-yui.html (next: http://localhost:52851/tests/dromaeo/cssquery-dojo.html) 17:02:15 INFO - 2015-11-23 17:02:15,239 DEBUG : BROWSER_OUTPUT: RSS: Main: 251428864 17:02:15 INFO - 2015-11-23 17:02:15,239 DEBUG : BROWSER_OUTPUT: 17:02:15 INFO - 2015-11-23 17:02:15,239 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:02:15 INFO - 2015-11-23 17:02:15,239 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:02:15 INFO - 2015-11-23 17:02:15,240 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:02:15 INFO - 2015-11-23 17:02:15,240 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:02:15 INFO - 2015-11-23 17:02:15,240 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2597.6882774067108;2661.614065960435;2665.613486044525;2672.9465410691773;2691.4213444109514;4483;4610.70030448021;4612.7232366058015;4636.350910872472;4639.698419602723;4557.74932378719;4592.770361481929;4627.861164165072;4685.297205419189;4713.481517033124;4312;4320.438343015404;4340.696151269412;4403.6256918161835;4412.4925633552075;4397.890052748691;4422.11557688462;4430.623397011242;4444.33334999751;4444.666650001247;4159.792010399498;4273.337632666941;4278.336857787048;4363.454568178978;4414.337849322627;4196.559361267054;4281.993731473101;4294.355846623001;4318.028443600165;4322.178786030644;4276.700630955835;4316.136772645484;4334.913301733979;4335.111302183045;4372.0162963333;4382.758948257844;4486.327050942352;4598.149342371672;4617.746023968681;4638.814447422099;4879.341288925985;4937.604991600663;5070.771815268322;5077.898442031139;5081.339425874649;5025.824096156617;5027.622928280393;5030.320906677588;5034.4713805050305;5043.873903152414;4643.8374656886845;4647.837325693585;4649.721016739007;4669.066186762661;4704.64715146362;5014.674046186986;5022.547970682583;5156.871078222999;5159.974200128975;5177.870553236124;4951.950480495149;4954.331165292711;4956.8760780980765;4958.504149585013;5003.624728145403;5019.0965626187635;5035.521625445577;5041.168207245763;5049.772760225798;5049.8737531562;4797.280407938837;4858.58702010333;4906.116898958222;4907.116718990616;4907.60739140875;4901.632377571696;4911.533404326655;4940.456549779521;4955.157623204064;4962.255661650709;4169.708120431541;4170.249355116108;4181.937270940877;4202.453681021509;4202.810873510699;3548.982255088708;3580.7493475456467;3660.816959152032;3665.651763082503;3672.59601443841;4245.660347172219;4303.591158839905;4310.870673879788;4337.284348082531;4343.782810859444;4977.601791856643;4983.053219888209;5026.79892804291;5028.5977121830165;5049.5707864831165;4126.7523948563185;4222.936655950163;4224.936625950613;4273.145370925828;4291.206126866539;4322.243607368698;4430.712003719748;4445.555444455593;4460.687751857339;4496.595306422438;4783.808647654055;4783.856484305476;4784.665073444826;4787.4494433139935;4801.087793319258;4794.304825800309;4928.359313289249;5044.722540260174;5048.570871475966;5084.567811735896;4588.334691469651;4640.953590464187;4655.4413470382415;4684.812607495662;4741.810327586858;4880.731559764247;4886.633502487257;4892.290617860462;4899.069176856386;4948.975255123702;4661.766911654471;4768.737719425465;4930.359053323045;4953.72754498506;4991.07665081961;4635.513271106485;4672.883177920579;4707.905841883212;4743.0988112258565;4762.14281429346;4736;4812.1578723722505;4813.9037219254715;4828.227483602606;4866.562009419169;4579.771011449481;4714.5992590630185;4721.173794586002;4772.976135119302;4779.617630589614;4707.340972263954;4745.572898439157;4776.641751868554;4810.374651295309;4812.735299558558;4744.905101898012;4787.688800227974;4793.760311984317;4795.616350692006;4843.346148269939 17:02:15 INFO - 2015-11-23 17:02:15,240 DEBUG : BROWSER_OUTPUT: |1;ext.html;556.568659289051;557.1141884403797;569.6553585081026;578.1905332534449;583.9386864379237;24725.876370618145;36530.26939461209;36946.26107477856;36971.4454283186;37038.4444233336;39455.21089578207;39728.40407393892;39778.20443591126;40051;40053.19893602126;6910.654467276616;6965.0248965144665;7803.1026431960345;7958.721444749435;7981.640826162808;9888.752781180456;10172.796544069115;10270.53782579782;10282.331648442865;10286.485675716185;9661.275404344668;9669.516524173798;9731.464769437678;9781.657641982532;9872.703818885446;7189.604571748552;7300.56196628204;9558.522073896278;9697.951510242474;9986.500674966295;9649.276304277137;9762.560684769202;9801.90198098017;9812.803743925153;9817;36438;36824.26351472982;36829.63170368289;36952;36972;2242.338510139513;2380.7262164850918;2449.155041510676;2489.788367988723;2919.022127587261;27034.188974330802;27293.454130917467;27387.86306068457;27871.86064069667;27910.02314918968;3149.685031496855;3236;3248.13924310058;3283.015095471373;3327.068420842168;214312;215797;216820;218655;220234.89882550645;49437.50562494401;50734.238986415236;54233.457665422844;54502.454975449735;54562.727186363816;63299.36700632935;64107.67946160239;64171.679141604924;64212;64242.67878660577;13377.665558360924;13638.113522620997;13747.725045499034;13776.793348099787;13791.448342066205;9220.723378298662;9222.262219022463;9226.938902026219;9228.307876909259;9278.489683067495;19010.42968710941;19222.519437013907;19230.519237019187;19233.230670773293;19290;7542.698292068256;7669;7739.922600774033;7758.379329653614;7826.882596761053;796.8167321515967;841.9115992820788;939.9436033837992;1036.0002597493456;1038.444432228754;26124.477510449684;26547.33631659224;26634.334141646228;26702.19893403201;26849;921.9216366608779;937.6015193542717;954.2270760683869;958.520739630185;1015.1320620869051;13512.59462216135;13628.266477717796;13819.239941803096;13832.377543010589;13872.306384680725;254431;258339;258344.70827645742;258430;258470;44239;44797.328040079425;44884.55115448869;44888.77555612201;44967.999999999345;1171.4494187731752;1189.8869607387285;1192.898603618702;1207.3057991654657;1212.8120141378101;24925.626115608644;25655.486890262462;25941.6108758365;26269.868650656623;26273.60589591196;35737;36573.817130914176;41442.1711565773;42589.787051064544;42622;181407;182157;182242;182969;184077;21939.890300548395;21961.67057494171;29178.270543236587;29647.851760741058;29648.555271671372;29470.410591788474;29921.850390747906;36361.818190908874;37288.627113728515;37877.43183852299;28724.856375717987;30207.244818879703;32949.17627059342;32995.505067423524;33035.504467432525;32355.51466728048;32616.836915815267;37496;39000.41499377568;39487.60512394954;33970.490442642884;34458.65541344655;34740.47889281713;34761.304773904885;34783.82608086943;30713.232169195948;30771.38457230798;31035.22411939629;31051.53422698616;31154;24192.87903560471;24581.76510868879;24618.753812462364;24704.50590988206;24851.627225591994 17:02:15 INFO - 2015-11-23 17:02:15,241 DEBUG : BROWSER_OUTPUT: |2;jquery.html;323.3823397311136;323.45820750243354;329.2181069958848;331.06492551039184;334.68873947229065;12404.13171078025;12477.31374774387;14679.486217982372;15129.319180636883;16048.277827497775;11254.155938304619;11781.352025638587;15030.323635436403;15035.09789412636;15040;4768.64235182361;5003.874903127415;5004.974975125119;5007.298978143063;5007.824726134568;3463.9134021649534;3524.3303772283184;4946.2580612908;4990.426100998396;4993.051320249141;5420.457954204588;5590.105583106703;5624.831255062355;5626.915596266059;5628.774849006035;5431.538319242849;5584.6090773645865;5584.804531841386;5586.748596313176;5587.38538760736;4916.360873086512;4924.113659541281;4926.359573255454;4927.137750893579;4928.359313289249;17795;18058.548536286566;18199.181036853373;18786.060696965098;18921;1628.5521481592539;1640.3602594987965;1646.6871294454136;1668.0158706363184;1733.6619359224956;8774.561271936378;8878.911210887873;11472.827907581393;12161.817572736416;12510.687232819162;1640.6718656268795;1675.8826882118256;1708.5216139480965;1718.3985605038263;1726.9568260793455;52378;54792.45207547913;54870.176947345426;55169.724151378985;55259.44740552583;9613.855792163124;9625.737951581374;9693.41839489633;9751.31740778153;9760.072793084646;11974.760504789856;12224.633261002184;12290.508379664892;12304.569340073054;12311.19977201479;6776.69504872282;6780.864382712318;6795.422389096982;6819.693113809891;6821.897671534931;6256.124142620037;6263.342349053375;6266.342034086447;6375.553711240262;6391.328910464427;4000.5599384067727;4010.2380547695843;4070.9185816283507;4090.447789548373;4123.587641235912;1553.269963117333;1569;1592.8805339599576;1615.8464945830128;1628.9022658640283;712.1454254894147;784.2157842157842;885.3138817416553;915.5010519267015;959.1176117971482;15402.383904643913;15906.204689765465;15920.601984950237;16427.178641067898;16985.575360615836;724.4457989637931;812.4394168024045;865.7272959017889;866.151171851589;889.7019498468086;8254.752357429286;8506.957465212634;8564.785880352916;8702.216800487986;8877.023527411979;459985;464148;468288;476077;476629;67452.662736686;70256.29743702497;70774.64612676903;71056.28943710496;71239.28760712431;966.1160038564775;981.5657170217758;990.1039559198792;990.4404011733347;992.6476100984191;14052.156870587798;14161.36273867699;14275.857241427868;14291;14348.856511434751;31748.36503269968;31939.201519961258;32480.35039299248;32607.836960815042;32911;41166.79416602898;42218;43351.78324108359;43531.78234108809;46269;8008.799780005314;8467.11095334981;8481.660733570588;8490.57547122629;8778.736637900873;9834.11492965608;9982.151517121127;10174.643887463903;15797.921010395334;16073.276702548646;12856.164349317265;13091.952643788665;13317.467301307839;13490.63913815098;13855.37650805696;12282.38588070575;12803;13020.674483137997;13033.892119169977;13329.933350333185;13733;13933.790993135313;14065.437382504995;14273.072250303698;14495.855041449451;7320.743773967885;7610.277023682741;8703.608337624695;8766.517841518778;8830.955845220733;12328.32194229326;12391.62825115248;12461;13055.34723263852;13092.607221783363 17:02:15 INFO - 2015-11-23 17:02:15,242 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1421.7369786589488;1572.551822730522;1615.9676806463872;1624.8131464881535;1650.7523871419285;5891.970540147304;6080.300765411979;6564.803055908318;6925.826854328638;6940.410065144462;6464.515161362893;6547.083408322838;6607.603543787376;6616.569922955005;6624.602523848561;1930.2857942561272;1933.6809426444654;1944.445832937613;1967.0263219706264;1971.1129991503808;1714.3999600139975;1744.0494930262973;1744.5987422892742;1870.9158087886078;1994.2720906869033;1934.8935808530525;1949.873258238217;1952.5801952580193;1952.9902350488228;1953.1601411393094;1866.56135808085;1885.4437940807495;1945.6984167454068;1952.7363805886166;1955.8533110016806;1946.0658883735887;1965.4005528313858;1976.0514952822725;1980.7028945658124;1981.9306324278725;6697.832554186136;6719.462443004548;6756.358145976174;6770.661466926634;6776.932230677679;3897.7466464679705;3962.207558488285;3963.7225394222414;3977.8607748728946;3979.522457305142;2599.2202339298133;2650.2314328844614;2675;2684.7315268473;2686.892524299026;745.904009732653;857.3055824781947;887.5207388010466;888.3470649072926;892.5983307511646;8767.78080547985;8871.290296776242;8896.0659130791;8916.866247006301;8917.331200160013;3720.572134204547;3772.038130276762;3805.353089974711;3819.789911554891;3821.044738815296;7875.330596899214;7875.960620196863;7890.447668663139;7891.684332626631;7896.960515197387;3921.6274453927404;3922.0391004204153;3959.8416063357145;3962.821673024721;3969.801509924492;3596.2627661329366;3630.419132938717;3633.091727068233;3638.1632224588493;3639.9636003640153;3202.6316973547873;3209.261869769966;3223.129754966146;3243.6107667079627;3247.6427592964756;1006.3207335048813;1021.1728499914944;1027.1833892055683;1027.3168343051937;1035.8342665173536;1004.2919741582313;1006.6174853555602;1016.6086056868011;1021.6168936648756;1027.3168343051937;6112.572119951649;6145.877082458326;6239.220097487814;6254.343293954069;6280.371962803683;407.9816408261635;417.50317122623983;1048.4548035021746;1088.1403691083956;1102.8456016157745;4841.95158048415;4931.87670308238;4937.604991600663;4941.03649788295;4953.2570114483115;7723.382129429632;7947.5231486111015;8071.313938315309;8083.544961906796;8092.150324215872;8045.477043992122;8100.675972961133;8153.95923020393;8171.387145964077;8174.550399727953;5206.609504287269;5258.684478931276;6234.937650623527;6287.402696743802;6341.587796793194;6068.939310607014;6162.630242185304;6183.103449999815;6263.279722831932;6309.936900630935;7073.575585464889;7092;7224.422046236184;7225.530340527849;7251.093613298127;7273.818154546178;7378.557286562824;7396.038514993016;7516.173220945582;7526.946227528041;5765.077587585966;5827.504662103599;5831.4168583141345;5841.50347220491;5846.1815345852465;5998.670073145844;6027.57806953509;6053.334133245427;6232.18981532416;6286.874262514632;5740.454656807597;5772.855678608068;5812.593118481665;5869.266341707286;5938.673372964528;5585.553155747449;5791;5807.883842323045;5810.709464526842;5867.149263356875;5598.3282006159525;5619.072852979212;5634.802781902614;5692.829215123553;5739.71301434935;5457.263269458573;5557.249771280987;5596.888062238651;5606.887862242651;5752.539796816161;5747.4252574742195;5777.3933736957015;5780.450857168562;5784.21913041734;5785.132230165509 17:02:15 INFO - 2015-11-23 17:02:15,246 DEBUG : BROWSER_OUTPUT: |4;prototype.html;282.62975502092246;296.47671859168565;296.63513877930137;301.8249415339102;306.6228538897155;5240.895182096356;5305.495977882105;5323.866903327414;5386.757595908184;5445.156000819869;5114.974425127878;5146.202338637517;5242.161254199329;5313.256144139824;5323.387810401805;4163.125743593849;4167.208230436223;4174.373843923406;4174.833006679729;4181.560936101711;3950.42718805773;4170.35359519275;4173.24881521326;4174.332106862903;4177.039280965365;3986.2625414298304;4042.2117687051036;4122.093139509303;4132.132252227021;4135.60711732385;4123.340265557526;4127.938080928789;4136.751794892286;4137.627613514768;4137.855175068873;3612.4581312803025;3621.818909054563;3624.963750362489;3627.818609069536;3631.9273614527824;5141.074606570815;5142.125838607446;5146.639735218536;5147.202183661539;5149.30484384607;4566.680332376735;4695.859124226245;4703.341532185496;4717.764111794397;4723.07899959508;5583.637063590894;5586.078297080977;5601.103823388238;5604.691741954191;5610.046292130348;3870.3420418528917;3873.9806300968316;3880.5149356330458;3882.825272862728;3884.5726970033274;5830.883382332372;5906.616069955482;5908.940910590882;5914.852128696817;5918.141869428909;3886.9028274292805;3990.7206495545033;3992.2414741199077;4000.439938408625;4017.1563971565715;4049.311617025113;4050.0684842485803;4055.270051390719;4059.6346328829954;4061.6953728470485;4653.046125544255;4660.324252983299;4672.6962747421985;4674.158651442705;4684.81260749573;5602.915956260659;5615.438456154352;5616.101423772258;5621.100623900156;5626.381098079208;1375.2023826180791;1402.2988505747126;1431.8568143185598;1437.23826372023;1439.8776104031065;939.7697564096703;948.8434408322549;953.9475328856979;958.3674774648698;965.3869792681697;4957.628177886673;4963.230699241623;4965.602751779849;4967.677100988496;4973.303737476756;5827.59206855516;5831.825045248649;5834.212381328552;5836.562257830679;5838.4453476919625;4779.091972525209;4845.830395936126;4919.65562410635;4934.777934992934;5042.294078828967;3158.0367987763952;3163.8576264068174;3178.4596618574897;3180.8568614412407;3184.251700850298;5589.524890384363;5597.832065038056;5598;5600.963821693;5601.971990140105;5886.646801191942;6058.394160583906;6067.939320606737;6073.5748497604745;6076.5442591805795;5618.85952851182;5630.71846407678;5636.549076073904;5638.15427685834;5638.182463542763;5926.051831706906;5930.140129681085;5932.0508718604815;5932.080527518242;5936.525077993837;5782.5373970081455;5785.27684039495;5790.855228619318;5795.884082318245;5801.3038435388025;5429.6199266051;5560.360558535658;5561.749721262472;5610.811783404394;5628.971855140698;4076.307027805221;4119.134981653767;4120.526139493996;4121.876343709693;4122.113745544722;5920.407959204045;5932.644041357532;5933.584649074696;5935.139404786196;5935.169076329231;5584.553235741212;5705.7147142643535;5711.657300561979;5714.514266287412;5722.656640601577;5668.064769313017;5696.715164241854;5709.371969083314;5713.742881570256;5715.914261286167;5585.162225666182;5591.356993945586;5594.4125866785025;5595.748191331481;5599.188117722989;5730.914036289542;5749.281339832521;5750.884982300414;5753.798617048551;5758.193852860687;5449.700266485382;5594.720263986703;5595.216669666169;5596.86007849807;5604.187392828098 17:02:15 INFO - 2015-11-23 17:02:15,246 DEBUG : BROWSER_OUTPUT: |5;yui.html;645.7191121861994;663.4161937495004;715.5241764226789;724.5688815154981;730.9305615966483;10633.840492392621;10772.461376931142;10794.298370605924;10795.892041079587;10803.081738052266;11446.027087697536;11478.827817582744;11512.942435287832;11734.41327933602;11802.173847830656;574.9022666146744;580.0834681203688;721.0878239027621;732.9560226386408;740.1044735869577;728.10806761717;730.6565914020401;735.3675838778673;735.4667865797308;735.6174789109659;771.4561234329784;779.5166996462201;779.8128449172186;780.1418439716323;785.862474067036;617.9536534759889;626.1421852062681;774.7365895595468;790.2926880441972;792.053496072194;577.8064348443277;578.1270281874358;587.3539106982328;588.2411688921286;589.416477687091;11032.28290161137;11136.443177841076;11258.493367798386;11314.886851131549;11354.318740875575;9797.363171393836;10559.41923194224;10864.185186110994;11069.944650276777;11625.418729063513;8751.34364922627;8883.333749968779;9060.184583387461;9071.501067441288;9084.545772711337;2770.8753106110275;2818.957715634267;2866.3550701092295;2903.462859371023;2945.7054294570585;39192.216155677015;39313.21373572513;39405.60594394048;40234.79882600597;40303.59696403057;8439;8553.871691924625;8591.140885911358;8713.128687131237;8735.082816304324;14974.326155323037;14977.326020329112;14982.325795339237;15029.173395463355;15029.398824047134;5946.940530594638;5960.821175364746;6040.879182416327;6047.03247480401;6104.145419641254;3251.6260630027377;3314.8839790607212;3333.333333333343;3339.5491608632524;3377.3751855906244;2389.605715056996;2461.864597447122;2462.0274991378305;2465.9136930207715;2739.876705548255;492.6477568538512;495.27442297035014;501.34574380433156;504.8788290810179;505.48945564979635;413.59054536009137;432.3946474935116;436.05158779654124;484.30260424987904;508.9491050894881;6086.610253857641;6169.198004259418;6210.658413787285;6233.283172435137;6269.435750782452;405.8721502726632;503.8916632923939;537.6048604275854;538.4050624060357;547.6905548365161;3108.129723677374;3140.780145389801;3208.117767613925;3231.6768323167494;3239.919002024921;45370.77314613472;45455.54544454513;53987.460125399026;54271.72864135733;54374.728126359114;42961;43534.34698479525;43945.560544394786;44229.77885110618;44529.33206001913;39401;39925.60074399277;41067;42912.35631465593;43598;6649.301823308677;6736.6968486417245;6838.04267402574;6873.140857392826;6882.483813713891;29738.55392169076;29784.55323170111;30199.245018874703;30575.776968920993;31409.8429507851;36619.52149480489;39827.203455931296;39838.80080599579;40293.59706403016;40357.798211008754;8823.779405514657;8826.24976876947;8959;9070.229030532215;9203.309751768511;9498.762530936781;9703.369280996712;9750.853737193806;9925.751856203653;10376.844347334645;9311.72064838056;9358.298127640319;9510.09654082861;9548.665796697082;9645.9035409645;8375.16248375182;8906.86639700392;9182.125250595613;9304.191889669502;9415.576299066695;9373.906260937303;9466.574004169966;9573;9745.074217949283;9810.068043535854;8030.357571394391;8060.11338752725;8253.876191857247;8294.502329860228;8309.709160179365;7531.774046778605;7648.464607477423;7837.529748215125;8026.95986520087;8105.189481051848 17:02:15 INFO - 2015-11-23 17:02:15,246 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:02:15 INFO - 2015-11-23 17:02:15,246 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:02:15 INFO - 2015-11-23 17:02:15,247 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,883 17:02:15 INFO - 2015-11-23 17:02:15,247 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:02:15 INFO - 2015-11-23 17:02:15,248 DEBUG : BROWSER_OUTPUT: __startTimestamp1448326935237__endTimestamp 17:02:15 INFO - 2015-11-23 17:02:15,248 DEBUG : BROWSER_OUTPUT: 17:02:15 INFO - 2015-11-23 17:02:15,248 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:02:15 INFO - 2015-11-23 17:02:15,249 DEBUG : BROWSER_OUTPUT: Number of tests: 6 17:02:15 INFO - 2015-11-23 17:02:15,249 DEBUG : BROWSER_OUTPUT: 17:02:15 INFO - 2015-11-23 17:02:15,249 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4591.83 Median:4707.34 stddev:474.28 (10.1%) stddev-sans-first:449.19 17:02:15 INFO - 2015-11-23 17:02:15,250 DEBUG : BROWSER_OUTPUT: Values: 2597.7 2661.6 2665.6 2672.9 2691.4 4483.0 4610.7 4612.7 4636.4 4639.7 4557.7 4592.8 4627.9 4685.3 4713.5 4312.0 4320.4 4340.7 4403.6 4412.5 4397.9 4422.1 4430.6 4444.3 4444.7 4159.8 4273.3 4278.3 4363.5 4414.3 4196.6 4282.0 4294.4 4318.0 4322.2 4276.7 4316.1 4334.9 4335.1 4372.0 4382.8 4486.3 4598.1 4617.7 4638.8 4879.3 4937.6 5070.8 5077.9 5081.3 5025.8 5027.6 5030.3 5034.5 5043.9 4643.8 4647.8 4649.7 4669.1 4704.6 5014.7 5022.5 5156.9 5160.0 5177.9 4952.0 4954.3 4956.9 4958.5 5003.6 5019.1 5035.5 5041.2 5049.8 5049.9 4797.3 4858.6 4906.1 4907.1 4907.6 4901.6 4911.5 4940.5 4955.2 4962.3 4169.7 4170.2 4181.9 4202.5 4202.8 3549.0 3580.7 3660.8 3665.7 3672.6 4245.7 4303.6 4310.9 4337.3 4343.8 4977.6 4983.1 5026.8 5028.6 5049.6 4126.8 4222.9 4224.9 4273.1 4291.2 4322.2 4430.7 4445.6 4460.7 4496.6 4783.8 4783.9 4784.7 4787.4 4801.1 4794.3 4928.4 5044.7 5048.6 5084.6 4588.3 4641.0 4655.4 4684.8 4741.8 4880.7 4886.6 4892.3 4899.1 4949.0 4661.8 4768.7 4930.4 4953.7 4991.1 4635.5 4672.9 4707.9 4743.1 4762.1 4736.0 4812.2 4813.9 4828.2 4866.6 4579.8 4714.6 4721.2 4773.0 4779.6 4707.3 4745.6 4776.6 4810.4 4812.7 4744.9 4787.7 4793.8 4795.6 4843.3 17:02:15 INFO - 2015-11-23 17:02:15,251 DEBUG : BROWSER_OUTPUT: 17:02:15 INFO - 2015-11-23 17:02:15,251 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38526.10 Median:18181.29 stddev:57530.36 (316.4%) stddev-sans-first:57621.11 17:02:15 INFO - 2015-11-23 17:02:15,252 DEBUG : BROWSER_OUTPUT: Values: 556.6 557.1 569.7 578.2 583.9 24725.9 36530.3 36946.3 36971.4 37038.4 39455.2 39728.4 39778.2 40051.0 40053.2 6910.7 6965.0 7803.1 7958.7 7981.6 9888.8 10172.8 10270.5 10282.3 10286.5 9661.3 9669.5 9731.5 9781.7 9872.7 7189.6 7300.6 9558.5 9698.0 9986.5 9649.3 9762.6 9801.9 9812.8 9817.0 36438.0 36824.3 36829.6 36952.0 36972.0 2242.3 2380.7 2449.2 2489.8 2919.0 27034.2 27293.5 27387.9 27871.9 27910.0 3149.7 3236.0 3248.1 3283.0 3327.1 214312.0 215797.0 216820.0 218655.0 220234.9 49437.5 50734.2 54233.5 54502.5 54562.7 63299.4 64107.7 64171.7 64212.0 64242.7 13377.7 13638.1 13747.7 13776.8 13791.4 9220.7 9222.3 9226.9 9228.3 9278.5 19010.4 19222.5 19230.5 19233.2 19290.0 7542.7 7669.0 7739.9 7758.4 7826.9 796.8 841.9 939.9 1036.0 1038.4 26124.5 26547.3 26634.3 26702.2 26849.0 921.9 937.6 954.2 958.5 1015.1 13512.6 13628.3 13819.2 13832.4 13872.3 254431.0 258339.0 258344.7 258430.0 258470.0 44239.0 44797.3 44884.6 44888.8 44968.0 1171.4 1189.9 1192.9 1207.3 1212.8 24925.6 25655.5 25941.6 26269.9 26273.6 35737.0 36573.8 41442.2 42589.8 42622.0 181407.0 182157.0 182242.0 182969.0 184077.0 21939.9 21961.7 29178.3 29647.9 29648.6 29470.4 29921.9 36361.8 37288.6 37877.4 28724.9 30207.2 32949.2 32995.5 33035.5 32355.5 32616.8 37496.0 39000.4 39487.6 33970.5 34458.7 34740.5 34761.3 34783.8 30713.2 30771.4 31035.2 31051.5 31154.0 24192.9 24581.8 24618.8 24704.5 24851.6 17:02:15 INFO - 2015-11-23 17:02:15,252 DEBUG : BROWSER_OUTPUT: 17:02:15 INFO - 2015-11-23 17:02:15,252 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25544.81 Median:43441.78 stddev:76631.19 (176.4%) stddev-sans-first:76822.76 17:02:15 INFO - 2015-11-23 17:02:15,254 DEBUG : BROWSER_OUTPUT: Values: 323.4 323.5 329.2 331.1 334.7 12404.1 12477.3 14679.5 15129.3 16048.3 11254.2 11781.4 15030.3 15035.1 15040.0 4768.6 5003.9 5005.0 5007.3 5007.8 3463.9 3524.3 4946.3 4990.4 4993.1 5420.5 5590.1 5624.8 5626.9 5628.8 5431.5 5584.6 5584.8 5586.7 5587.4 4916.4 4924.1 4926.4 4927.1 4928.4 17795.0 18058.5 18199.2 18786.1 18921.0 1628.6 1640.4 1646.7 1668.0 1733.7 8774.6 8878.9 11472.8 12161.8 12510.7 1640.7 1675.9 1708.5 1718.4 1727.0 52378.0 54792.5 54870.2 55169.7 55259.4 9613.9 9625.7 9693.4 9751.3 9760.1 11974.8 12224.6 12290.5 12304.6 12311.2 6776.7 6780.9 6795.4 6819.7 6821.9 6256.1 6263.3 6266.3 6375.6 6391.3 4000.6 4010.2 4070.9 4090.4 4123.6 1553.3 1569.0 1592.9 1615.8 1628.9 712.1 784.2 885.3 915.5 959.1 15402.4 15906.2 15920.6 16427.2 16985.6 724.4 812.4 865.7 866.2 889.7 8254.8 8507.0 8564.8 8702.2 8877.0 459985.0 464148.0 468288.0 476077.0 476629.0 67452.7 70256.3 70774.6 71056.3 71239.3 966.1 981.6 990.1 990.4 992.6 14052.2 14161.4 14275.9 14291.0 14348.9 31748.4 31939.2 32480.4 32607.8 32911.0 41166.8 42218.0 43351.8 43531.8 46269.0 8008.8 8467.1 8481.7 8490.6 8778.7 9834.1 9982.2 10174.6 15797.9 16073.3 12856.2 13092.0 13317.5 13490.6 13855.4 12282.4 12803.0 13020.7 13033.9 13329.9 13733.0 13933.8 14065.4 14273.1 14495.9 7320.7 7610.3 8703.6 8766.5 8831.0 12328.3 12391.6 12461.0 13055.3 13092.6 17:02:15 INFO - 2015-11-23 17:02:15,254 DEBUG : BROWSER_OUTPUT: 17:02:15 INFO - 2015-11-23 17:02:15,254 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4641.92 Median:5716.27 stddev:2389.17 (41.8%) stddev-sans-first:2383.62 17:02:15 INFO - 2015-11-23 17:02:15,255 DEBUG : BROWSER_OUTPUT: Values: 1421.7 1572.6 1616.0 1624.8 1650.8 5892.0 6080.3 6564.8 6925.8 6940.4 6464.5 6547.1 6607.6 6616.6 6624.6 1930.3 1933.7 1944.4 1967.0 1971.1 1714.4 1744.0 1744.6 1870.9 1994.3 1934.9 1949.9 1952.6 1953.0 1953.2 1866.6 1885.4 1945.7 1952.7 1955.9 1946.1 1965.4 1976.1 1980.7 1981.9 6697.8 6719.5 6756.4 6770.7 6776.9 3897.7 3962.2 3963.7 3977.9 3979.5 2599.2 2650.2 2675.0 2684.7 2686.9 745.9 857.3 887.5 888.3 892.6 8767.8 8871.3 8896.1 8916.9 8917.3 3720.6 3772.0 3805.4 3819.8 3821.0 7875.3 7876.0 7890.4 7891.7 7897.0 3921.6 3922.0 3959.8 3962.8 3969.8 3596.3 3630.4 3633.1 3638.2 3640.0 3202.6 3209.3 3223.1 3243.6 3247.6 1006.3 1021.2 1027.2 1027.3 1035.8 1004.3 1006.6 1016.6 1021.6 1027.3 6112.6 6145.9 6239.2 6254.3 6280.4 408.0 417.5 1048.5 1088.1 1102.8 4842.0 4931.9 4937.6 4941.0 4953.3 7723.4 7947.5 8071.3 8083.5 8092.2 8045.5 8100.7 8154.0 8171.4 8174.6 5206.6 5258.7 6234.9 6287.4 6341.6 6068.9 6162.6 6183.1 6263.3 6309.9 7073.6 7092.0 7224.4 7225.5 7251.1 7273.8 7378.6 7396.0 7516.2 7526.9 5765.1 5827.5 5831.4 5841.5 5846.2 5998.7 6027.6 6053.3 6232.2 6286.9 5740.5 5772.9 5812.6 5869.3 5938.7 5585.6 5791.0 5807.9 5810.7 5867.1 5598.3 5619.1 5634.8 5692.8 5739.7 5457.3 5557.2 5596.9 5606.9 5752.5 5747.4 5777.4 5780.5 5784.2 5785.1 17:02:15 INFO - 2015-11-23 17:02:15,255 DEBUG : BROWSER_OUTPUT: 17:02:15 INFO - 2015-11-23 17:02:15,255 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4684.88 Median:5318.32 stddev:1392.37 (26.2%) stddev-sans-first:1356.50 17:02:15 INFO - 2015-11-23 17:02:15,255 DEBUG : BROWSER_OUTPUT: Values: 282.6 296.5 296.6 301.8 306.6 5240.9 5305.5 5323.9 5386.8 5445.2 5115.0 5146.2 5242.2 5313.3 5323.4 4163.1 4167.2 4174.4 4174.8 4181.6 3950.4 4170.4 4173.2 4174.3 4177.0 3986.3 4042.2 4122.1 4132.1 4135.6 4123.3 4127.9 4136.8 4137.6 4137.9 3612.5 3621.8 3625.0 3627.8 3631.9 5141.1 5142.1 5146.6 5147.2 5149.3 4566.7 4695.9 4703.3 4717.8 4723.1 5583.6 5586.1 5601.1 5604.7 5610.0 3870.3 3874.0 3880.5 3882.8 3884.6 5830.9 5906.6 5908.9 5914.9 5918.1 3886.9 3990.7 3992.2 4000.4 4017.2 4049.3 4050.1 4055.3 4059.6 4061.7 4653.0 4660.3 4672.7 4674.2 4684.8 5602.9 5615.4 5616.1 5621.1 5626.4 1375.2 1402.3 1431.9 1437.2 1439.9 939.8 948.8 953.9 958.4 965.4 4957.6 4963.2 4965.6 4967.7 4973.3 5827.6 5831.8 5834.2 5836.6 5838.4 4779.1 4845.8 4919.7 4934.8 5042.3 3158.0 3163.9 3178.5 3180.9 3184.3 5589.5 5597.8 5598.0 5601.0 5602.0 5886.6 6058.4 6067.9 6073.6 6076.5 5618.9 5630.7 5636.5 5638.2 5638.2 5926.1 5930.1 5932.1 5932.1 5936.5 5782.5 5785.3 5790.9 5795.9 5801.3 5429.6 5560.4 5561.7 5610.8 5629.0 4076.3 4119.1 4120.5 4121.9 4122.1 5920.4 5932.6 5933.6 5935.1 5935.2 5584.6 5705.7 5711.7 5714.5 5722.7 5668.1 5696.7 5709.4 5713.7 5715.9 5585.2 5591.4 5594.4 5595.7 5599.2 5730.9 5749.3 5750.9 5753.8 5758.2 5449.7 5594.7 5595.2 5596.9 5604.2 17:02:15 INFO - 2015-11-23 17:02:15,255 DEBUG : BROWSER_OUTPUT: 17:02:15 INFO - 2015-11-23 17:02:15,255 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11715.14 Median:576.35 stddev:13920.04 (2415.2%) stddev-sans-first:13934.27 17:02:15 INFO - 2015-11-23 17:02:15,257 DEBUG : BROWSER_OUTPUT: Values: 645.7 663.4 715.5 724.6 730.9 10633.8 10772.5 10794.3 10795.9 10803.1 11446.0 11478.8 11512.9 11734.4 11802.2 574.9 580.1 721.1 733.0 740.1 728.1 730.7 735.4 735.5 735.6 771.5 779.5 779.8 780.1 785.9 618.0 626.1 774.7 790.3 792.1 577.8 578.1 587.4 588.2 589.4 11032.3 11136.4 11258.5 11314.9 11354.3 9797.4 10559.4 10864.2 11069.9 11625.4 8751.3 8883.3 9060.2 9071.5 9084.5 2770.9 2819.0 2866.4 2903.5 2945.7 39192.2 39313.2 39405.6 40234.8 40303.6 8439.0 8553.9 8591.1 8713.1 8735.1 14974.3 14977.3 14982.3 15029.2 15029.4 5946.9 5960.8 6040.9 6047.0 6104.1 3251.6 3314.9 3333.3 3339.5 3377.4 2389.6 2461.9 2462.0 2465.9 2739.9 492.6 495.3 501.3 504.9 505.5 413.6 432.4 436.1 484.3 508.9 6086.6 6169.2 6210.7 6233.3 6269.4 405.9 503.9 537.6 538.4 547.7 3108.1 3140.8 3208.1 3231.7 3239.9 45370.8 45455.5 53987.5 54271.7 54374.7 42961.0 43534.3 43945.6 44229.8 44529.3 39401.0 39925.6 41067.0 42912.4 43598.0 6649.3 6736.7 6838.0 6873.1 6882.5 29738.6 29784.6 30199.2 30575.8 31409.8 36619.5 39827.2 39838.8 40293.6 40357.8 8823.8 8826.2 8959.0 9070.2 9203.3 9498.8 9703.4 9750.9 9925.8 10376.8 9311.7 9358.3 9510.1 9548.7 9645.9 8375.2 8906.9 9182.1 9304.2 9415.6 9373.9 9466.6 9573.0 9745.1 9810.1 8030.4 8060.1 8253.9 8294.5 8309.7 7531.8 7648.5 7837.5 8027.0 8105.2 17:02:15 INFO - 2015-11-23 17:02:15,257 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:02:15 INFO - 2015-11-23 17:02:15,257 DEBUG : BROWSER_OUTPUT: 17:02:16 INFO - 2015-11-23 17:02:16,053 INFO : Browser exited with error code: 0 17:02:16 INFO - 2015-11-23 17:02:16,074 INFO : Completed test dromaeo_css (00:18:39) 17:02:16 INFO - 2015-11-23 17:02:16,074 INFO : Starting test kraken 17:02:16 INFO - 2015-11-23 17:02:16,074 DEBUG : operating with platform_type : linux_ 17:02:16 INFO - 2015-11-23 17:02:16,075 INFO : Initialising browser for kraken test... 17:02:16 INFO - 2015-11-23 17:02:16,081 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx9wp_j/profile http://localhost:52851/getInfo.html 17:02:20 INFO - 2015-11-23 17:02:20,135 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:02:20 INFO - 2015-11-23 17:02:20,135 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:02:20 INFO - 2015-11-23 17:02:20,135 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:02:20 INFO - 2015-11-23 17:02:20,135 DEBUG : BROWSER_OUTPUT: __metrics 17:02:20 INFO - 2015-11-23 17:02:20,296 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:02:21 INFO - 2015-11-23 17:02:21,651 INFO : Browser initialized. 17:02:21 INFO - 2015-11-23 17:02:21,651 INFO : Running cycle 1/1 for kraken test... 17:02:21 INFO - 2015-11-23 17:02:21,651 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx9wp_j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:02:33 INFO - 2015-11-23 17:02:33,594 DEBUG : BROWSER_OUTPUT: RSS: Main: 141156352 17:02:33 INFO - 2015-11-23 17:02:33,594 DEBUG : BROWSER_OUTPUT: 17:02:36 INFO - 2015-11-23 17:02:36,218 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52851/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52851/tests/kraken/driver.html?testName=audio-beat-detection) 17:02:36 INFO - 2015-11-23 17:02:36,806 DEBUG : BROWSER_OUTPUT: RSS: Main: 179576832 17:02:36 INFO - 2015-11-23 17:02:36,806 DEBUG : BROWSER_OUTPUT: 17:02:39 INFO - 2015-11-23 17:02:39,491 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52851/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52851/tests/kraken/driver.html?testName=audio-dft) 17:02:40 INFO - 2015-11-23 17:02:40,064 DEBUG : BROWSER_OUTPUT: RSS: Main: 168452096 17:02:40 INFO - 2015-11-23 17:02:40,064 DEBUG : BROWSER_OUTPUT: 17:02:43 INFO - 2015-11-23 17:02:43,055 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52851/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52851/tests/kraken/driver.html?testName=audio-fft) 17:02:43 INFO - 2015-11-23 17:02:43,628 DEBUG : BROWSER_OUTPUT: RSS: Main: 151404544 17:02:43 INFO - 2015-11-23 17:02:43,629 DEBUG : BROWSER_OUTPUT: 17:02:45 INFO - 2015-11-23 17:02:45,670 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52851/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52851/tests/kraken/driver.html?testName=audio-oscillator) 17:02:46 INFO - 2015-11-23 17:02:46,237 DEBUG : BROWSER_OUTPUT: RSS: Main: 155414528 17:02:46 INFO - 2015-11-23 17:02:46,237 DEBUG : BROWSER_OUTPUT: 17:02:48 INFO - 2015-11-23 17:02:48,491 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52851/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52851/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:02:49 INFO - 2015-11-23 17:02:49,052 DEBUG : BROWSER_OUTPUT: RSS: Main: 157351936 17:02:49 INFO - 2015-11-23 17:02:49,052 DEBUG : BROWSER_OUTPUT: 17:02:52 INFO - 2015-11-23 17:02:52,018 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52851/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52851/tests/kraken/driver.html?testName=imaging-darkroom) 17:02:52 INFO - 2015-11-23 17:02:52,599 DEBUG : BROWSER_OUTPUT: RSS: Main: 157761536 17:02:52 INFO - 2015-11-23 17:02:52,599 DEBUG : BROWSER_OUTPUT: 17:02:56 INFO - 2015-11-23 17:02:56,082 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52851/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52851/tests/kraken/driver.html?testName=imaging-desaturate) 17:02:56 INFO - 2015-11-23 17:02:56,663 DEBUG : BROWSER_OUTPUT: RSS: Main: 153812992 17:02:56 INFO - 2015-11-23 17:02:56,663 DEBUG : BROWSER_OUTPUT: 17:02:59 INFO - 2015-11-23 17:02:59,486 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52851/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52851/tests/kraken/driver.html?testName=json-parse-financial) 17:03:00 INFO - 2015-11-23 17:03:00,067 DEBUG : BROWSER_OUTPUT: RSS: Main: 156336128 17:03:00 INFO - 2015-11-23 17:03:00,067 DEBUG : BROWSER_OUTPUT: 17:03:01 INFO - 2015-11-23 17:03:01,810 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52851/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52851/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:03:02 INFO - 2015-11-23 17:03:02,379 DEBUG : BROWSER_OUTPUT: RSS: Main: 168685568 17:03:02 INFO - 2015-11-23 17:03:02,379 DEBUG : BROWSER_OUTPUT: 17:03:04 INFO - 2015-11-23 17:03:04,261 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52851/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52851/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:03:04 INFO - 2015-11-23 17:03:04,869 DEBUG : BROWSER_OUTPUT: RSS: Main: 166141952 17:03:04 INFO - 2015-11-23 17:03:04,869 DEBUG : BROWSER_OUTPUT: 17:03:07 INFO - 2015-11-23 17:03:07,271 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52851/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52851/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:03:07 INFO - 2015-11-23 17:03:07,857 DEBUG : BROWSER_OUTPUT: RSS: Main: 171012096 17:03:07 INFO - 2015-11-23 17:03:07,857 DEBUG : BROWSER_OUTPUT: 17:03:10 INFO - 2015-11-23 17:03:10,365 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52851/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52851/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:03:10 INFO - 2015-11-23 17:03:10,945 DEBUG : BROWSER_OUTPUT: RSS: Main: 180764672 17:03:10 INFO - 2015-11-23 17:03:10,945 DEBUG : BROWSER_OUTPUT: 17:03:13 INFO - 2015-11-23 17:03:13,532 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52851/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52851/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:03:14 INFO - 2015-11-23 17:03:14,114 DEBUG : BROWSER_OUTPUT: RSS: Main: 180781056 17:03:14 INFO - 2015-11-23 17:03:14,115 DEBUG : BROWSER_OUTPUT: 17:03:15 INFO - 2015-11-23 17:03:15,865 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52851/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52851/tests/kraken/driver.html?testName=ai-astar) 17:03:16 INFO - 2015-11-23 17:03:16,114 DEBUG : BROWSER_OUTPUT: RSS: Main: 238354432 17:03:16 INFO - 2015-11-23 17:03:16,114 DEBUG : BROWSER_OUTPUT: 17:03:16 INFO - 2015-11-23 17:03:16,116 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:03:16 INFO - 2015-11-23 17:03:16,116 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:03:16 INFO - 2015-11-23 17:03:16,116 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:03:16 INFO - 2015-11-23 17:03:16,117 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:03:16 INFO - 2015-11-23 17:03:16,117 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;113;107;112;113;114;103;113;113;106 17:03:16 INFO - 2015-11-23 17:03:16,117 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;131;157;163;131;151;152;131;170;134 17:03:16 INFO - 2015-11-23 17:03:16,117 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;159;161;161;160;162;163;161;164;163 17:03:16 INFO - 2015-11-23 17:03:16,117 DEBUG : BROWSER_OUTPUT: |3;audio-fft;75;73;81;92;71;73;76;103;91;71 17:03:16 INFO - 2015-11-23 17:03:16,117 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;93;132;94;94;94;128;94;94;132 17:03:16 INFO - 2015-11-23 17:03:16,117 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;109;110;109;109;110;109;109 17:03:16 INFO - 2015-11-23 17:03:16,117 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;147;146;147;146;146;147;146;148 17:03:16 INFO - 2015-11-23 17:03:16,117 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;96;95;95;95;96;95;96;95 17:03:16 INFO - 2015-11-23 17:03:16,117 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;70;70;71;75;70;71;78;69;68 17:03:16 INFO - 2015-11-23 17:03:16,117 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;69;68;69;68;69;68;68;69;69 17:03:16 INFO - 2015-11-23 17:03:16,117 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;80;81;83;82;83;83;83;85;83;83 17:03:16 INFO - 2015-11-23 17:03:16,118 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;118;120;128;120;129;123;129;121;128;120 17:03:16 INFO - 2015-11-23 17:03:16,118 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;142;148;153;148;149;137;148;148;149;134 17:03:16 INFO - 2015-11-23 17:03:16,118 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;70;70;68;68;69;70;70;67;68 17:03:16 INFO - 2015-11-23 17:03:16,118 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:03:16 INFO - 2015-11-23 17:03:16,118 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:03:16 INFO - 2015-11-23 17:03:16,118 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,988 17:03:16 INFO - 2015-11-23 17:03:16,118 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:03:16 INFO - 2015-11-23 17:03:16,118 DEBUG : BROWSER_OUTPUT: __startTimestamp1448326996115__endTimestamp 17:03:16 INFO - 2015-11-23 17:03:16,118 DEBUG : BROWSER_OUTPUT: 17:03:16 INFO - 2015-11-23 17:03:16,121 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:03:16 INFO - 2015-11-23 17:03:16,121 DEBUG : BROWSER_OUTPUT: Number of tests: 14 17:03:16 INFO - 2015-11-23 17:03:16,122 DEBUG : BROWSER_OUTPUT: 17:03:16 INFO - 2015-11-23 17:03:16,122 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.40 Median:113.00 stddev:3.78 (3.3%) stddev-sans-first:4.00 17:03:16 INFO - 2015-11-23 17:03:16,122 DEBUG : BROWSER_OUTPUT: Values: 110.0 113.0 107.0 112.0 113.0 114.0 103.0 113.0 113.0 106.0 17:03:16 INFO - 2015-11-23 17:03:16,122 DEBUG : BROWSER_OUTPUT: 17:03:16 INFO - 2015-11-23 17:03:16,122 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.30 Median:152.50 stddev:14.52 (9.5%) stddev-sans-first:15.26 17:03:16 INFO - 2015-11-23 17:03:16,122 DEBUG : BROWSER_OUTPUT: Values: 153.0 131.0 157.0 163.0 131.0 151.0 152.0 131.0 170.0 134.0 17:03:16 INFO - 2015-11-23 17:03:16,122 DEBUG : BROWSER_OUTPUT: 17:03:16 INFO - 2015-11-23 17:03:16,122 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.51 (0.9%) stddev-sans-first:1.59 17:03:16 INFO - 2015-11-23 17:03:16,122 DEBUG : BROWSER_OUTPUT: Values: 162.0 159.0 161.0 161.0 160.0 162.0 163.0 161.0 164.0 163.0 17:03:16 INFO - 2015-11-23 17:03:16,122 DEBUG : BROWSER_OUTPUT: 17:03:16 INFO - 2015-11-23 17:03:16,122 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.60 Median:75.50 stddev:11.02 (14.6%) stddev-sans-first:11.50 17:03:16 INFO - 2015-11-23 17:03:16,122 DEBUG : BROWSER_OUTPUT: Values: 75.0 73.0 81.0 92.0 71.0 73.0 76.0 103.0 91.0 71.0 17:03:16 INFO - 2015-11-23 17:03:16,122 DEBUG : BROWSER_OUTPUT: 17:03:16 INFO - 2015-11-23 17:03:16,122 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.90 Median:94.00 stddev:17.82 (19.0%) stddev-sans-first:18.46 17:03:16 INFO - 2015-11-23 17:03:16,122 DEBUG : BROWSER_OUTPUT: Values: 94.0 93.0 132.0 94.0 94.0 94.0 128.0 94.0 94.0 132.0 17:03:16 INFO - 2015-11-23 17:03:16,123 DEBUG : BROWSER_OUTPUT: 17:03:16 INFO - 2015-11-23 17:03:16,123 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 17:03:16 INFO - 2015-11-23 17:03:16,123 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 109.0 110.0 109.0 109.0 110.0 109.0 109.0 17:03:16 INFO - 2015-11-23 17:03:16,123 DEBUG : BROWSER_OUTPUT: 17:03:16 INFO - 2015-11-23 17:03:16,124 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 17:03:16 INFO - 2015-11-23 17:03:16,124 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 147.0 146.0 147.0 146.0 146.0 147.0 146.0 148.0 17:03:16 INFO - 2015-11-23 17:03:16,124 DEBUG : BROWSER_OUTPUT: 17:03:16 INFO - 2015-11-23 17:03:16,124 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 17:03:16 INFO - 2015-11-23 17:03:16,124 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 96.0 95.0 95.0 95.0 96.0 95.0 96.0 95.0 17:03:16 INFO - 2015-11-23 17:03:16,124 DEBUG : BROWSER_OUTPUT: 17:03:16 INFO - 2015-11-23 17:03:16,124 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.30 Median:71.00 stddev:2.98 (4.2%) stddev-sans-first:3.16 17:03:16 INFO - 2015-11-23 17:03:16,124 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 70.0 71.0 75.0 70.0 71.0 78.0 69.0 68.0 17:03:16 INFO - 2015-11-23 17:03:16,124 DEBUG : BROWSER_OUTPUT: 17:03:16 INFO - 2015-11-23 17:03:16,124 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:69.00 stddev:0.70 (1.0%) stddev-sans-first:0.53 17:03:16 INFO - 2015-11-23 17:03:16,124 DEBUG : BROWSER_OUTPUT: Values: 67.0 69.0 68.0 69.0 68.0 69.0 68.0 68.0 69.0 69.0 17:03:16 INFO - 2015-11-23 17:03:16,124 DEBUG : BROWSER_OUTPUT: 17:03:16 INFO - 2015-11-23 17:03:16,124 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:83.00 stddev:1.35 (1.6%) stddev-sans-first:1.05 17:03:16 INFO - 2015-11-23 17:03:16,124 DEBUG : BROWSER_OUTPUT: Values: 80.0 81.0 83.0 82.0 83.0 83.0 83.0 85.0 83.0 83.0 17:03:16 INFO - 2015-11-23 17:03:16,125 DEBUG : BROWSER_OUTPUT: 17:03:16 INFO - 2015-11-23 17:03:16,125 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.60 Median:125.50 stddev:4.40 (3.5%) stddev-sans-first:4.18 17:03:16 INFO - 2015-11-23 17:03:16,125 DEBUG : BROWSER_OUTPUT: Values: 118.0 120.0 128.0 120.0 129.0 123.0 129.0 121.0 128.0 120.0 17:03:16 INFO - 2015-11-23 17:03:16,125 DEBUG : BROWSER_OUTPUT: 17:03:16 INFO - 2015-11-23 17:03:16,125 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.60 Median:148.00 stddev:5.99 (4.0%) stddev-sans-first:6.20 17:03:16 INFO - 2015-11-23 17:03:16,125 DEBUG : BROWSER_OUTPUT: Values: 142.0 148.0 153.0 148.0 149.0 137.0 148.0 148.0 149.0 134.0 17:03:16 INFO - 2015-11-23 17:03:16,125 DEBUG : BROWSER_OUTPUT: 17:03:16 INFO - 2015-11-23 17:03:16,125 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.50 stddev:1.14 (1.6%) stddev-sans-first:1.17 17:03:16 INFO - 2015-11-23 17:03:16,125 DEBUG : BROWSER_OUTPUT: Values: 68.0 70.0 70.0 68.0 68.0 69.0 70.0 70.0 67.0 68.0 17:03:16 INFO - 2015-11-23 17:03:16,125 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:03:16 INFO - 2015-11-23 17:03:16,125 DEBUG : BROWSER_OUTPUT: 17:03:17 INFO - 2015-11-23 17:03:17,065 INFO : Browser exited with error code: 0 17:03:17 INFO - 2015-11-23 17:03:17,113 INFO : Completed test kraken (00:01:01) 17:03:17 INFO - 2015-11-23 17:03:17,114 INFO : Starting test v8_7 17:03:17 INFO - 2015-11-23 17:03:17,114 DEBUG : operating with platform_type : linux_ 17:03:17 INFO - 2015-11-23 17:03:17,114 INFO : Initialising browser for v8_7 test... 17:03:17 INFO - 2015-11-23 17:03:17,120 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQpG45b/profile http://localhost:52851/getInfo.html 17:03:21 INFO - 2015-11-23 17:03:21,095 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:03:21 INFO - 2015-11-23 17:03:21,095 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:03:21 INFO - 2015-11-23 17:03:21,095 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:03:21 INFO - 2015-11-23 17:03:21,095 DEBUG : BROWSER_OUTPUT: __metrics 17:03:21 INFO - 2015-11-23 17:03:21,273 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:03:21 INFO - 2015-11-23 17:03:21,914 DEBUG : BROWSER_OUTPUT: console.error: 17:03:21 INFO - 2015-11-23 17:03:21,916 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 17:03:21 INFO - 2015-11-23 17:03:21,916 DEBUG : BROWSER_OUTPUT: Stack: 17:03:21 INFO - 2015-11-23 17:03:21,916 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 17:03:21 INFO - 2015-11-23 17:03:21,916 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 17:03:21 INFO - 2015-11-23 17:03:21,916 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 17:03:21 INFO - 2015-11-23 17:03:21,916 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 17:03:21 INFO - 2015-11-23 17:03:21,916 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 17:03:21 INFO - 2015-11-23 17:03:21,916 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 17:03:21 INFO - 2015-11-23 17:03:21,916 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 17:03:21 INFO - 2015-11-23 17:03:21,917 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 17:03:21 INFO - 2015-11-23 17:03:21,917 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 17:03:21 INFO - 2015-11-23 17:03:21,917 DEBUG : BROWSER_OUTPUT: 17:03:22 INFO - 2015-11-23 17:03:22,540 INFO : Browser initialized. 17:03:22 INFO - 2015-11-23 17:03:22,540 INFO : Running cycle 1/1 for v8_7 test... 17:03:22 INFO - 2015-11-23 17:03:22,541 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQpG45b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:03:34 INFO - 2015-11-23 17:03:34,567 DEBUG : BROWSER_OUTPUT: RSS: Main: 140062720 17:03:34 INFO - 2015-11-23 17:03:34,568 DEBUG : BROWSER_OUTPUT: 17:03:55 INFO - 2015-11-23 17:03:55,985 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52851/tests/v8_7/run.html (next: http://localhost:52851/tests/v8_7/run.html) 17:03:56 INFO - 2015-11-23 17:03:56,235 DEBUG : BROWSER_OUTPUT: RSS: Main: 442892288 17:03:56 INFO - 2015-11-23 17:03:56,235 DEBUG : BROWSER_OUTPUT: 17:03:56 INFO - 2015-11-23 17:03:56,236 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:03:56 INFO - 2015-11-23 17:03:56,237 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:03:56 INFO - 2015-11-23 17:03:56,237 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:03:56 INFO - 2015-11-23 17:03:56,237 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:03:56 INFO - 2015-11-23 17:03:56,237 DEBUG : BROWSER_OUTPUT: |0;Richards;189.64536317087047 17:03:56 INFO - 2015-11-23 17:03:56,237 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.93857965451056 17:03:56 INFO - 2015-11-23 17:03:56,237 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.78449958182324 17:03:56 INFO - 2015-11-23 17:03:56,237 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5005 17:03:56 INFO - 2015-11-23 17:03:56,237 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2044.9897750511248 17:03:56 INFO - 2015-11-23 17:03:56,237 DEBUG : BROWSER_OUTPUT: |5;Earley;796.8127490039841 17:03:56 INFO - 2015-11-23 17:03:56,237 DEBUG : BROWSER_OUTPUT: |6;Boyer;12060.240963855422 17:03:56 INFO - 2015-11-23 17:03:56,237 DEBUG : BROWSER_OUTPUT: |7;RegExp;25692.30769230769 17:03:56 INFO - 2015-11-23 17:03:56,237 DEBUG : BROWSER_OUTPUT: |8;Splay;621.8905472636816 17:03:56 INFO - 2015-11-23 17:03:56,238 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 17:03:56 INFO - 2015-11-23 17:03:56,238 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:03:56 INFO - 2015-11-23 17:03:56,238 DEBUG : BROWSER_OUTPUT: __startTimestamp1448327036235__endTimestamp 17:03:56 INFO - 2015-11-23 17:03:56,238 DEBUG : BROWSER_OUTPUT: 17:03:56 INFO - 2015-11-23 17:03:56,238 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:03:56 INFO - 2015-11-23 17:03:56,239 DEBUG : BROWSER_OUTPUT: Number of tests: 10 17:03:56 INFO - 2015-11-23 17:03:56,239 DEBUG : BROWSER_OUTPUT: 17:03:56 INFO - 2015-11-23 17:03:56,239 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:189.65 Median:189.65 stddev:0.00 (0.0%) 17:03:56 INFO - 2015-11-23 17:03:56,239 DEBUG : BROWSER_OUTPUT: Values: 189.6 17:03:56 INFO - 2015-11-23 17:03:56,239 DEBUG : BROWSER_OUTPUT: 17:03:56 INFO - 2015-11-23 17:03:56,239 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.94 Median:191.94 stddev:0.00 (0.0%) 17:03:56 INFO - 2015-11-23 17:03:56,239 DEBUG : BROWSER_OUTPUT: Values: 191.9 17:03:56 INFO - 2015-11-23 17:03:56,239 DEBUG : BROWSER_OUTPUT: 17:03:56 INFO - 2015-11-23 17:03:56,240 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.78 Median:278.78 stddev:0.00 (0.0%) 17:03:56 INFO - 2015-11-23 17:03:56,240 DEBUG : BROWSER_OUTPUT: Values: 278.8 17:03:56 INFO - 2015-11-23 17:03:56,240 DEBUG : BROWSER_OUTPUT: 17:03:56 INFO - 2015-11-23 17:03:56,240 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5005.00 Median:5005.00 stddev:0.00 (0.0%) 17:03:56 INFO - 2015-11-23 17:03:56,240 DEBUG : BROWSER_OUTPUT: Values: 5005.0 17:03:56 INFO - 2015-11-23 17:03:56,240 DEBUG : BROWSER_OUTPUT: 17:03:56 INFO - 2015-11-23 17:03:56,240 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2044.99 Median:2044.99 stddev:0.00 (0.0%) 17:03:56 INFO - 2015-11-23 17:03:56,240 DEBUG : BROWSER_OUTPUT: Values: 2045.0 17:03:56 INFO - 2015-11-23 17:03:56,240 DEBUG : BROWSER_OUTPUT: 17:03:56 INFO - 2015-11-23 17:03:56,240 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:796.81 Median:796.81 stddev:0.00 (0.0%) 17:03:56 INFO - 2015-11-23 17:03:56,240 DEBUG : BROWSER_OUTPUT: Values: 796.8 17:03:56 INFO - 2015-11-23 17:03:56,240 DEBUG : BROWSER_OUTPUT: 17:03:56 INFO - 2015-11-23 17:03:56,240 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12060.24 Median:12060.24 stddev:0.00 (0.0%) 17:03:56 INFO - 2015-11-23 17:03:56,240 DEBUG : BROWSER_OUTPUT: Values: 12060.2 17:03:56 INFO - 2015-11-23 17:03:56,240 DEBUG : BROWSER_OUTPUT: 17:03:56 INFO - 2015-11-23 17:03:56,240 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25692.31 Median:25692.31 stddev:0.00 (0.0%) 17:03:56 INFO - 2015-11-23 17:03:56,241 DEBUG : BROWSER_OUTPUT: Values: 25692.3 17:03:56 INFO - 2015-11-23 17:03:56,241 DEBUG : BROWSER_OUTPUT: 17:03:56 INFO - 2015-11-23 17:03:56,241 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:621.89 Median:621.89 stddev:0.00 (0.0%) 17:03:56 INFO - 2015-11-23 17:03:56,241 DEBUG : BROWSER_OUTPUT: Values: 621.9 17:03:56 INFO - 2015-11-23 17:03:56,241 DEBUG : BROWSER_OUTPUT: 17:03:56 INFO - 2015-11-23 17:03:56,241 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 17:03:56 INFO - 2015-11-23 17:03:56,241 DEBUG : BROWSER_OUTPUT: Values: 4840.6 17:03:56 INFO - 2015-11-23 17:03:56,241 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:03:56 INFO - 2015-11-23 17:03:56,241 DEBUG : BROWSER_OUTPUT: 17:03:57 INFO - 2015-11-23 17:03:57,149 INFO : Browser exited with error code: 0 17:03:57 INFO - 2015-11-23 17:03:57,168 INFO : Completed test v8_7 (00:00:40) 17:03:57 INFO - 2015-11-23 17:03:57,284 INFO : Completed test suite (00:20:21) 17:03:57 INFO - 2015-11-23 17:03:57,284 DEBUG : Working with test: dromaeo_css 17:03:57 INFO - 2015-11-23 17:03:57,284 DEBUG : Generating results file: dromaeo_css 17:03:57 INFO - 2015-11-23 17:03:57,285 DEBUG : Working with test: kraken 17:03:57 INFO - 2015-11-23 17:03:57,286 DEBUG : Generating results file: kraken 17:03:57 INFO - 2015-11-23 17:03:57,286 INFO : javascript benchmark 17:03:57 INFO - 2015-11-23 17:03:57,286 DEBUG : Working with test: v8_7 17:03:57 INFO - 2015-11-23 17:03:57,286 DEBUG : Generating results file: v8_7 17:03:57 INFO - 2015-11-23 17:03:57,286 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:03:57 INFO - 2015-11-23 17:03:57,335 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 17:03:57 INFO - 2015-11-23 17:03:57,335 DEBUG : process_Request line: dromaeo_css 6114.70 graph.html#tests=[[72,132,35]] 17:03:57 INFO - 2015-11-23 17:03:57,336 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:03:57 INFO - 2015-11-23 17:03:57,372 DEBUG : process_Request line: kraken 1516.40 graph.html#tests=[[232,132,35]] 17:03:57 INFO - 2015-11-23 17:03:57,372 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:03:57 INFO - 2015-11-23 17:03:57,404 DEBUG : process_Request line: v8_7 19525.20 graph.html#tests=[[230,132,35]] 17:03:57 INFO - 2015-11-23 17:03:57,405 INFO : javascript benchmark 17:03:57 INFO - 2015-11-23 17:03:57,409 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2597.6882774067108, 2661.614065960435, 2665.613486044525, 2672.9465410691773, 2691.4213444109514, 4483.0, 4610.70030448021, 4612.7232366058015, 4636.350910872472, 4639.698419602723, 4557.74932378719, 4592.770361481929, 4627.861164165072, 4685.297205419189, 4713.481517033124, 4312.0, 4320.438343015404, 4340.696151269412, 4403.6256918161835, 4412.4925633552075, 4397.890052748691, 4422.11557688462, 4430.623397011242, 4444.33334999751, 4444.666650001247, 4159.792010399498, 4273.337632666941, 4278.336857787048, 4363.454568178978, 4414.337849322627, 4196.559361267054, 4281.993731473101, 4294.355846623001, 4318.028443600165, 4322.178786030644, 4276.700630955835, 4316.136772645484, 4334.913301733979, 4335.111302183045, 4372.0162963333, 4382.758948257844, 4486.327050942352, 4598.149342371672, 4617.746023968681, 4638.814447422099, 4879.341288925985, 4937.604991600663, 5070.771815268322, 5077.898442031139, 5081.339425874649, 5025.824096156617, 5027.622928280393, 5030.320906677588, 5034.4713805050305, 5043.873903152414, 4643.8374656886845, 4647.837325693585, 4649.721016739007, 4669.066186762661, 4704.64715146362, 5014.674046186986, 5022.547970682583, 5156.871078222999, 5159.974200128975, 5177.870553236124, 4951.950480495149, 4954.331165292711, 4956.8760780980765, 4958.504149585013, 5003.624728145403, 5019.0965626187635, 5035.521625445577, 5041.168207245763, 5049.772760225798, 5049.8737531562, 4797.280407938837, 4858.58702010333, 4906.116898958222, 4907.116718990616, 4907.60739140875, 4901.632377571696, 4911.533404326655, 4940.456549779521, 4955.157623204064, 4962.255661650709, 4169.708120431541, 4170.249355116108, 4181.937270940877, 4202.453681021509, 4202.810873510699, 3548.982255088708, 3580.7493475456467, 3660.816959152032, 3665.651763082503, 3672.59601443841, 4245.660347172219, 4303.591158839905, 4310.870673879788, 4337.284348082531, 4343.782810859444, 4977.601791856643, 4983.053219888209, 5026.79892804291, 5028.5977121830165, 5049.5707864831165, 4126.7523948563185, 4222.936655950163, 4224.936625950613, 4273.145370925828, 4291.206126866539, 4322.243607368698, 4430.712003719748, 4445.555444455593, 4460.687751857339, 4496.595306422438, 4783.808647654055, 4783.856484305476, 4784.665073444826, 4787.4494433139935, 4801.087793319258, 4794.304825800309, 4928.359313289249, 5044.722540260174, 5048.570871475966, 5084.567811735896, 4588.334691469651, 4640.953590464187, 4655.4413470382415, 4684.812607495662, 4741.810327586858, 4880.731559764247, 4886.633502487257, 4892.290617860462, 4899.069176856386, 4948.975255123702, 4661.766911654471, 4768.737719425465, 4930.359053323045, 4953.72754498506, 4991.07665081961, 4635.513271106485, 4672.883177920579, 4707.905841883212, 4743.0988112258565, 4762.14281429346, 4736.0, 4812.1578723722505, 4813.9037219254715, 4828.227483602606, 4866.562009419169, 4579.771011449481, 4714.5992590630185, 4721.173794586002, 4772.976135119302, 4779.617630589614, 4707.340972263954, 4745.572898439157, 4776.641751868554, 4810.374651295309, 4812.735299558558, 4744.905101898012, 4787.688800227974, 4793.760311984317, 4795.616350692006, 4843.346148269939], "unit": "ms", "name": "dojo.html", "value": 4562.4696735509315}, {"lowerIsBetter": false, "replicates": [556.568659289051, 557.1141884403797, 569.6553585081026, 578.1905332534449, 583.9386864379237, 24725.876370618145, 36530.26939461209, 36946.26107477856, 36971.4454283186, 37038.4444233336, 39455.21089578207, 39728.40407393892, 39778.20443591126, 40051.0, 40053.19893602126, 6910.654467276616, 6965.0248965144665, 7803.1026431960345, 7958.721444749435, 7981.640826162808, 9888.752781180456, 10172.796544069115, 10270.53782579782, 10282.331648442865, 10286.485675716185, 9661.275404344668, 9669.516524173798, 9731.464769437678, 9781.657641982532, 9872.703818885446, 7189.604571748552, 7300.56196628204, 9558.522073896278, 9697.951510242474, 9986.500674966295, 9649.276304277137, 9762.560684769202, 9801.90198098017, 9812.803743925153, 9817.0, 36438.0, 36824.26351472982, 36829.63170368289, 36952.0, 36972.0, 2242.338510139513, 2380.7262164850918, 2449.155041510676, 2489.788367988723, 2919.022127587261, 27034.188974330802, 27293.454130917467, 27387.86306068457, 27871.86064069667, 27910.02314918968, 3149.685031496855, 3236.0, 3248.13924310058, 3283.015095471373, 3327.068420842168, 214312.0, 215797.0, 216820.0, 218655.0, 220234.89882550645, 49437.50562494401, 50734.238986415236, 54233.457665422844, 54502.454975449735, 54562.727186363816, 63299.36700632935, 64107.67946160239, 64171.679141604924, 64212.0, 64242.67878660577, 13377.665558360924, 13638.113522620997, 13747.725045499034, 13776.793348099787, 13791.448342066205, 9220.723378298662, 9222.262219022463, 9226.938902026219, 9228.307876909259, 9278.489683067495, 19010.42968710941, 19222.519437013907, 19230.519237019187, 19233.230670773293, 19290.0, 7542.698292068256, 7669.0, 7739.922600774033, 7758.379329653614, 7826.882596761053, 796.8167321515967, 841.9115992820788, 939.9436033837992, 1036.0002597493456, 1038.444432228754, 26124.477510449684, 26547.33631659224, 26634.334141646228, 26702.19893403201, 26849.0, 921.9216366608779, 937.6015193542717, 954.2270760683869, 958.520739630185, 1015.1320620869051, 13512.59462216135, 13628.266477717796, 13819.239941803096, 13832.377543010589, 13872.306384680725, 254431.0, 258339.0, 258344.70827645742, 258430.0, 258470.0, 44239.0, 44797.328040079425, 44884.55115448869, 44888.77555612201, 44967.999999999345, 1171.4494187731752, 1189.8869607387285, 1192.898603618702, 1207.3057991654657, 1212.8120141378101, 24925.626115608644, 25655.486890262462, 25941.6108758365, 26269.868650656623, 26273.60589591196, 35737.0, 36573.817130914176, 41442.1711565773, 42589.787051064544, 42622.0, 181407.0, 182157.0, 182242.0, 182969.0, 184077.0, 21939.890300548395, 21961.67057494171, 29178.270543236587, 29647.851760741058, 29648.555271671372, 29470.410591788474, 29921.850390747906, 36361.818190908874, 37288.627113728515, 37877.43183852299, 28724.856375717987, 30207.244818879703, 32949.17627059342, 32995.505067423524, 33035.504467432525, 32355.51466728048, 32616.836915815267, 37496.0, 39000.41499377568, 39487.60512394954, 33970.490442642884, 34458.65541344655, 34740.47889281713, 34761.304773904885, 34783.82608086943, 30713.232169195948, 30771.38457230798, 31035.22411939629, 31051.53422698616, 31154.0, 24192.87903560471, 24581.76510868879, 24618.753812462364, 24704.50590988206, 24851.627225591994], "unit": "ms", "name": "ext.html", "value": 16796.525724775332}, {"lowerIsBetter": false, "replicates": [323.3823397311136, 323.45820750243354, 329.2181069958848, 331.06492551039184, 334.68873947229065, 12404.13171078025, 12477.31374774387, 14679.486217982372, 15129.319180636883, 16048.277827497775, 11254.155938304619, 11781.352025638587, 15030.323635436403, 15035.09789412636, 15040.0, 4768.64235182361, 5003.874903127415, 5004.974975125119, 5007.298978143063, 5007.824726134568, 3463.9134021649534, 3524.3303772283184, 4946.2580612908, 4990.426100998396, 4993.051320249141, 5420.457954204588, 5590.105583106703, 5624.831255062355, 5626.915596266059, 5628.774849006035, 5431.538319242849, 5584.6090773645865, 5584.804531841386, 5586.748596313176, 5587.38538760736, 4916.360873086512, 4924.113659541281, 4926.359573255454, 4927.137750893579, 4928.359313289249, 17795.0, 18058.548536286566, 18199.181036853373, 18786.060696965098, 18921.0, 1628.5521481592539, 1640.3602594987965, 1646.6871294454136, 1668.0158706363184, 1733.6619359224956, 8774.561271936378, 8878.911210887873, 11472.827907581393, 12161.817572736416, 12510.687232819162, 1640.6718656268795, 1675.8826882118256, 1708.5216139480965, 1718.3985605038263, 1726.9568260793455, 52378.0, 54792.45207547913, 54870.176947345426, 55169.724151378985, 55259.44740552583, 9613.855792163124, 9625.737951581374, 9693.41839489633, 9751.31740778153, 9760.072793084646, 11974.760504789856, 12224.633261002184, 12290.508379664892, 12304.569340073054, 12311.19977201479, 6776.69504872282, 6780.864382712318, 6795.422389096982, 6819.693113809891, 6821.897671534931, 6256.124142620037, 6263.342349053375, 6266.342034086447, 6375.553711240262, 6391.328910464427, 4000.5599384067727, 4010.2380547695843, 4070.9185816283507, 4090.447789548373, 4123.587641235912, 1553.269963117333, 1569.0, 1592.8805339599576, 1615.8464945830128, 1628.9022658640283, 712.1454254894147, 784.2157842157842, 885.3138817416553, 915.5010519267015, 959.1176117971482, 15402.383904643913, 15906.204689765465, 15920.601984950237, 16427.178641067898, 16985.575360615836, 724.4457989637931, 812.4394168024045, 865.7272959017889, 866.151171851589, 889.7019498468086, 8254.752357429286, 8506.957465212634, 8564.785880352916, 8702.216800487986, 8877.023527411979, 459985.0, 464148.0, 468288.0, 476077.0, 476629.0, 67452.662736686, 70256.29743702497, 70774.64612676903, 71056.28943710496, 71239.28760712431, 966.1160038564775, 981.5657170217758, 990.1039559198792, 990.4404011733347, 992.6476100984191, 14052.156870587798, 14161.36273867699, 14275.857241427868, 14291.0, 14348.856511434751, 31748.36503269968, 31939.201519961258, 32480.35039299248, 32607.836960815042, 32911.0, 41166.79416602898, 42218.0, 43351.78324108359, 43531.78234108809, 46269.0, 8008.799780005314, 8467.11095334981, 8481.660733570588, 8490.57547122629, 8778.736637900873, 9834.11492965608, 9982.151517121127, 10174.643887463903, 15797.921010395334, 16073.276702548646, 12856.164349317265, 13091.952643788665, 13317.467301307839, 13490.63913815098, 13855.37650805696, 12282.38588070575, 12803.0, 13020.674483137997, 13033.892119169977, 13329.933350333185, 13733.0, 13933.790993135313, 14065.437382504995, 14273.072250303698, 14495.855041449451, 7320.743773967885, 7610.277023682741, 8703.608337624695, 8766.517841518778, 8830.955845220733, 12328.32194229326, 12391.62825115248, 12461.0, 13055.34723263852, 13092.607221783363], "unit": "ms", "name": "jquery.html", "value": 8017.896213516129}, {"lowerIsBetter": false, "replicates": [1421.7369786589488, 1572.551822730522, 1615.9676806463872, 1624.8131464881535, 1650.7523871419285, 5891.970540147304, 6080.300765411979, 6564.803055908318, 6925.826854328638, 6940.410065144462, 6464.515161362893, 6547.083408322838, 6607.603543787376, 6616.569922955005, 6624.602523848561, 1930.2857942561272, 1933.6809426444654, 1944.445832937613, 1967.0263219706264, 1971.1129991503808, 1714.3999600139975, 1744.0494930262973, 1744.5987422892742, 1870.9158087886078, 1994.2720906869033, 1934.8935808530525, 1949.873258238217, 1952.5801952580193, 1952.9902350488228, 1953.1601411393094, 1866.56135808085, 1885.4437940807495, 1945.6984167454068, 1952.7363805886166, 1955.8533110016806, 1946.0658883735887, 1965.4005528313858, 1976.0514952822725, 1980.7028945658124, 1981.9306324278725, 6697.832554186136, 6719.462443004548, 6756.358145976174, 6770.661466926634, 6776.932230677679, 3897.7466464679705, 3962.207558488285, 3963.7225394222414, 3977.8607748728946, 3979.522457305142, 2599.2202339298133, 2650.2314328844614, 2675.0, 2684.7315268473, 2686.892524299026, 745.904009732653, 857.3055824781947, 887.5207388010466, 888.3470649072926, 892.5983307511646, 8767.78080547985, 8871.290296776242, 8896.0659130791, 8916.866247006301, 8917.331200160013, 3720.572134204547, 3772.038130276762, 3805.353089974711, 3819.789911554891, 3821.044738815296, 7875.330596899214, 7875.960620196863, 7890.447668663139, 7891.684332626631, 7896.960515197387, 3921.6274453927404, 3922.0391004204153, 3959.8416063357145, 3962.821673024721, 3969.801509924492, 3596.2627661329366, 3630.419132938717, 3633.091727068233, 3638.1632224588493, 3639.9636003640153, 3202.6316973547873, 3209.261869769966, 3223.129754966146, 3243.6107667079627, 3247.6427592964756, 1006.3207335048813, 1021.1728499914944, 1027.1833892055683, 1027.3168343051937, 1035.8342665173536, 1004.2919741582313, 1006.6174853555602, 1016.6086056868011, 1021.6168936648756, 1027.3168343051937, 6112.572119951649, 6145.877082458326, 6239.220097487814, 6254.343293954069, 6280.371962803683, 407.9816408261635, 417.50317122623983, 1048.4548035021746, 1088.1403691083956, 1102.8456016157745, 4841.95158048415, 4931.87670308238, 4937.604991600663, 4941.03649788295, 4953.2570114483115, 7723.382129429632, 7947.5231486111015, 8071.313938315309, 8083.544961906796, 8092.150324215872, 8045.477043992122, 8100.675972961133, 8153.95923020393, 8171.387145964077, 8174.550399727953, 5206.609504287269, 5258.684478931276, 6234.937650623527, 6287.402696743802, 6341.587796793194, 6068.939310607014, 6162.630242185304, 6183.103449999815, 6263.279722831932, 6309.936900630935, 7073.575585464889, 7092.0, 7224.422046236184, 7225.530340527849, 7251.093613298127, 7273.818154546178, 7378.557286562824, 7396.038514993016, 7516.173220945582, 7526.946227528041, 5765.077587585966, 5827.504662103599, 5831.4168583141345, 5841.50347220491, 5846.1815345852465, 5998.670073145844, 6027.57806953509, 6053.334133245427, 6232.18981532416, 6286.874262514632, 5740.454656807597, 5772.855678608068, 5812.593118481665, 5869.266341707286, 5938.673372964528, 5585.553155747449, 5791.0, 5807.883842323045, 5810.709464526842, 5867.149263356875, 5598.3282006159525, 5619.072852979212, 5634.802781902614, 5692.829215123553, 5739.71301434935, 5457.263269458573, 5557.249771280987, 5596.888062238651, 5606.887862242651, 5752.539796816161, 5747.4252574742195, 5777.3933736957015, 5780.450857168562, 5784.21913041734, 5785.132230165509], "unit": "ms", "name": "mootools.html", "value": 3822.909633561857}, {"lowerIsBetter": false, "replicates": [282.62975502092246, 296.47671859168565, 296.63513877930137, 301.8249415339102, 306.6228538897155, 5240.895182096356, 5305.495977882105, 5323.866903327414, 5386.757595908184, 5445.156000819869, 5114.974425127878, 5146.202338637517, 5242.161254199329, 5313.256144139824, 5323.387810401805, 4163.125743593849, 4167.208230436223, 4174.373843923406, 4174.833006679729, 4181.560936101711, 3950.42718805773, 4170.35359519275, 4173.24881521326, 4174.332106862903, 4177.039280965365, 3986.2625414298304, 4042.2117687051036, 4122.093139509303, 4132.132252227021, 4135.60711732385, 4123.340265557526, 4127.938080928789, 4136.751794892286, 4137.627613514768, 4137.855175068873, 3612.4581312803025, 3621.818909054563, 3624.963750362489, 3627.818609069536, 3631.9273614527824, 5141.074606570815, 5142.125838607446, 5146.639735218536, 5147.202183661539, 5149.30484384607, 4566.680332376735, 4695.859124226245, 4703.341532185496, 4717.764111794397, 4723.07899959508, 5583.637063590894, 5586.078297080977, 5601.103823388238, 5604.691741954191, 5610.046292130348, 3870.3420418528917, 3873.9806300968316, 3880.5149356330458, 3882.825272862728, 3884.5726970033274, 5830.883382332372, 5906.616069955482, 5908.940910590882, 5914.852128696817, 5918.141869428909, 3886.9028274292805, 3990.7206495545033, 3992.2414741199077, 4000.439938408625, 4017.1563971565715, 4049.311617025113, 4050.0684842485803, 4055.270051390719, 4059.6346328829954, 4061.6953728470485, 4653.046125544255, 4660.324252983299, 4672.6962747421985, 4674.158651442705, 4684.81260749573, 5602.915956260659, 5615.438456154352, 5616.101423772258, 5621.100623900156, 5626.381098079208, 1375.2023826180791, 1402.2988505747126, 1431.8568143185598, 1437.23826372023, 1439.8776104031065, 939.7697564096703, 948.8434408322549, 953.9475328856979, 958.3674774648698, 965.3869792681697, 4957.628177886673, 4963.230699241623, 4965.602751779849, 4967.677100988496, 4973.303737476756, 5827.59206855516, 5831.825045248649, 5834.212381328552, 5836.562257830679, 5838.4453476919625, 4779.091972525209, 4845.830395936126, 4919.65562410635, 4934.777934992934, 5042.294078828967, 3158.0367987763952, 3163.8576264068174, 3178.4596618574897, 3180.8568614412407, 3184.251700850298, 5589.524890384363, 5597.832065038056, 5598.0, 5600.963821693, 5601.971990140105, 5886.646801191942, 6058.394160583906, 6067.939320606737, 6073.5748497604745, 6076.5442591805795, 5618.85952851182, 5630.71846407678, 5636.549076073904, 5638.15427685834, 5638.182463542763, 5926.051831706906, 5930.140129681085, 5932.0508718604815, 5932.080527518242, 5936.525077993837, 5782.5373970081455, 5785.27684039495, 5790.855228619318, 5795.884082318245, 5801.3038435388025, 5429.6199266051, 5560.360558535658, 5561.749721262472, 5610.811783404394, 5628.971855140698, 4076.307027805221, 4119.134981653767, 4120.526139493996, 4121.876343709693, 4122.113745544722, 5920.407959204045, 5932.644041357532, 5933.584649074696, 5935.139404786196, 5935.169076329231, 5584.553235741212, 5705.7147142643535, 5711.657300561979, 5714.514266287412, 5722.656640601577, 5668.064769313017, 5696.715164241854, 5709.371969083314, 5713.742881570256, 5715.914261286167, 5585.162225666182, 5591.356993945586, 5594.4125866785025, 5595.748191331481, 5599.188117722989, 5730.914036289542, 5749.281339832521, 5750.884982300414, 5753.798617048551, 5758.193852860687, 5449.700266485382, 5594.720263986703, 5595.216669666169, 5596.86007849807, 5604.187392828098], "unit": "ms", "name": "prototype.html", "value": 4231.434205313533}, {"lowerIsBetter": false, "replicates": [645.7191121861994, 663.4161937495004, 715.5241764226789, 724.5688815154981, 730.9305615966483, 10633.840492392621, 10772.461376931142, 10794.298370605924, 10795.892041079587, 10803.081738052266, 11446.027087697536, 11478.827817582744, 11512.942435287832, 11734.41327933602, 11802.173847830656, 574.9022666146744, 580.0834681203688, 721.0878239027621, 732.9560226386408, 740.1044735869577, 728.10806761717, 730.6565914020401, 735.3675838778673, 735.4667865797308, 735.6174789109659, 771.4561234329784, 779.5166996462201, 779.8128449172186, 780.1418439716323, 785.862474067036, 617.9536534759889, 626.1421852062681, 774.7365895595468, 790.2926880441972, 792.053496072194, 577.8064348443277, 578.1270281874358, 587.3539106982328, 588.2411688921286, 589.416477687091, 11032.28290161137, 11136.443177841076, 11258.493367798386, 11314.886851131549, 11354.318740875575, 9797.363171393836, 10559.41923194224, 10864.185186110994, 11069.944650276777, 11625.418729063513, 8751.34364922627, 8883.333749968779, 9060.184583387461, 9071.501067441288, 9084.545772711337, 2770.8753106110275, 2818.957715634267, 2866.3550701092295, 2903.462859371023, 2945.7054294570585, 39192.216155677015, 39313.21373572513, 39405.60594394048, 40234.79882600597, 40303.59696403057, 8439.0, 8553.871691924625, 8591.140885911358, 8713.128687131237, 8735.082816304324, 14974.326155323037, 14977.326020329112, 14982.325795339237, 15029.173395463355, 15029.398824047134, 5946.940530594638, 5960.821175364746, 6040.879182416327, 6047.03247480401, 6104.145419641254, 3251.6260630027377, 3314.8839790607212, 3333.333333333343, 3339.5491608632524, 3377.3751855906244, 2389.605715056996, 2461.864597447122, 2462.0274991378305, 2465.9136930207715, 2739.876705548255, 492.6477568538512, 495.27442297035014, 501.34574380433156, 504.8788290810179, 505.48945564979635, 413.59054536009137, 432.3946474935116, 436.05158779654124, 484.30260424987904, 508.9491050894881, 6086.610253857641, 6169.198004259418, 6210.658413787285, 6233.283172435137, 6269.435750782452, 405.8721502726632, 503.8916632923939, 537.6048604275854, 538.4050624060357, 547.6905548365161, 3108.129723677374, 3140.780145389801, 3208.117767613925, 3231.6768323167494, 3239.919002024921, 45370.77314613472, 45455.54544454513, 53987.460125399026, 54271.72864135733, 54374.728126359114, 42961.0, 43534.34698479525, 43945.560544394786, 44229.77885110618, 44529.33206001913, 39401.0, 39925.60074399277, 41067.0, 42912.35631465593, 43598.0, 6649.301823308677, 6736.6968486417245, 6838.04267402574, 6873.140857392826, 6882.483813713891, 29738.55392169076, 29784.55323170111, 30199.245018874703, 30575.776968920993, 31409.8429507851, 36619.52149480489, 39827.203455931296, 39838.80080599579, 40293.59706403016, 40357.798211008754, 8823.779405514657, 8826.24976876947, 8959.0, 9070.229030532215, 9203.309751768511, 9498.762530936781, 9703.369280996712, 9750.853737193806, 9925.751856203653, 10376.844347334645, 9311.72064838056, 9358.298127640319, 9510.09654082861, 9548.665796697082, 9645.9035409645, 8375.16248375182, 8906.86639700392, 9182.125250595613, 9304.191889669502, 9415.576299066695, 9373.906260937303, 9466.574004169966, 9573.0, 9745.074217949283, 9810.068043535854, 8030.357571394391, 8060.11338752725, 8253.876191857247, 8294.502329860228, 8309.709160179365, 7531.774046778605, 7648.464607477423, 7837.529748215125, 8026.95986520087, 8105.189481051848], "unit": "ms", "name": "yui.html", "value": 5258.234034200468}], "name": "dromaeo_css", "value": 6114.696172967526}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 113.0, 107.0, 112.0, 113.0, 114.0, 103.0, 113.0, 113.0, 106.0], "unit": "ms", "name": "ai-astar", "value": 110.4}, {"lowerIsBetter": true, "replicates": [153.0, 131.0, 157.0, 163.0, 131.0, 151.0, 152.0, 131.0, 170.0, 134.0], "unit": "ms", "name": "audio-beat-detection", "value": 147.3}, {"lowerIsBetter": true, "replicates": [162.0, 159.0, 161.0, 161.0, 160.0, 162.0, 163.0, 161.0, 164.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 81.0, 92.0, 71.0, 73.0, 76.0, 103.0, 91.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 80.6}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 132.0, 94.0, 94.0, 94.0, 128.0, 94.0, 94.0, 132.0], "unit": "ms", "name": "audio-oscillator", "value": 104.9}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 110.0, 109.0, 109.0, 110.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 70.0, 71.0, 75.0, 70.0, 71.0, 78.0, 69.0, 68.0], "unit": "ms", "name": "json-parse-financial", "value": 71.3}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 68.0, 69.0, 68.0, 69.0, 68.0, 68.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.4}, {"lowerIsBetter": true, "replicates": [80.0, 81.0, 83.0, 82.0, 83.0, 83.0, 83.0, 85.0, 83.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.6}, {"lowerIsBetter": true, "replicates": [118.0, 120.0, 128.0, 120.0, 129.0, 123.0, 129.0, 121.0, 128.0, 120.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 123.6}, {"lowerIsBetter": true, "replicates": [142.0, 148.0, 153.0, 148.0, 149.0, 137.0, 148.0, 148.0, 149.0, 134.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.6}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 70.0, 68.0, 68.0, 69.0, 70.0, 70.0, 67.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.8}], "name": "kraken", "value": 1516.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [189.64536317087047], "unit": "score", "name": "Richards", "value": 186.14744600000003}, {"lowerIsBetter": false, "replicates": [191.93857965451056], "unit": "score", "name": "DeltaBlue", "value": 344.4747799999999}, {"lowerIsBetter": false, "replicates": [278.78449958182324], "unit": "score", "name": "Encrypt", "value": 954.7912470000005}, {"lowerIsBetter": false, "replicates": [5005.0], "unit": "score", "name": "Decrypt", "value": 53.18301698301701}, {"lowerIsBetter": false, "replicates": [2044.9897750511248], "unit": "score", "name": "RayTrace", "value": 361.85462099999995}, {"lowerIsBetter": false, "replicates": [796.8127490039841], "unit": "score", "name": "Earley", "value": 836.4110649999999}, {"lowerIsBetter": false, "replicates": [12060.240963855422], "unit": "score", "name": "Boyer", "value": 55.2611678321678}, {"lowerIsBetter": false, "replicates": [25692.30769230769], "unit": "score", "name": "RegExp", "value": 35.4575}, {"lowerIsBetter": false, "replicates": [621.8905472636816], "unit": "score", "name": "Splay", "value": 131.03752799999995}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19525.20343223637}]} 17:03:57 INFO - RETURN: dromaeo_css: 6114.70 17:03:57 INFO - RETURN: kraken: 1516.40 17:03:57 INFO - RETURN: v8_7: 19525.20 17:03:57 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19525.20"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1516.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6114.70"}}} 17:03:57 INFO - Return code: 0 17:03:57 INFO - # TBPL SUCCESS # 17:03:57 INFO - Running post-action listener: _resource_record_post_action 17:03:57 INFO - Running post-run listener: _resource_record_post_run 17:03:58 INFO - Total resource usage - Wall time: 1236s; CPU: 13.0%; Read bytes: 10534912; Write bytes: 408342528; Read time: 3432; Write time: 366180 17:03:58 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 475136; Read time: 0; Write time: 44 17:03:58 INFO - run-tests - Wall time: 1222s; CPU: 13.0%; Read bytes: 8343552; Write bytes: 360210432; Read time: 2708; Write time: 331264 17:03:58 INFO - Running post-run listener: _upload_blobber_files 17:03:58 INFO - Blob upload gear active. 17:03:58 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 17:03:58 INFO - Copying logs to upload dir... 17:03:58 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1283.861930 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2015-11-23 17:03:58.654966) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 17:03:58.658761) ========= 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=f5f5a079460e1a9be8676904000001c1-1448324306.771813-789733296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/rrm0nzFbTwyeQM_oTUe4mg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.008939 build_url: 'https://queue.taskcluster.net/v1/task/rrm0nzFbTwyeQM_oTUe4mg/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-23 17:03:58.709433) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 17:03:58.709746) ========= 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=f5f5a079460e1a9be8676904000001c1-1448324306.771813-789733296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 17:03:58.759346) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 17:03:58.759660) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 17:03:58.759952) ========= ========= Total master_lag: 0.26 =========