builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-017 starttime: 1447755875.25 results: success (0) buildid: 20151117013304 builduid: 52511697da2748108ccd7cfdea092d45 revision: ab82ff5156bc1bd4281936310439f69e07073622 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 02:24:35.245473) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 02:24:35.246170) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 02:24:35.246475) ========= 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=6587686cb2da90a5f91b3170000001be-1447755266.291346-1169291835 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006449 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 02:24:35.270789) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 02:24:35.271315) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 02:24:35.305856) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 02:24:35.306144) ========= 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=6587686cb2da90a5f91b3170000001be-1447755266.291346-1169291835 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004668 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 02:24:35.368437) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 02:24:35.368698) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 02:24:35.369037) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 02:24:35.369301) ========= 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=6587686cb2da90a5f91b3170000001be-1447755266.291346-1169291835 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-17 02:24:35-- 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% 223M=0s 2015-11-17 02:24:36 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.127301 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 02:24:35.515648) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 02:24:35.515977) ========= 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=6587686cb2da90a5f91b3170000001be-1447755266.291346-1169291835 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020818 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 02:24:35.565603) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 02:24:35.565966) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ab82ff5156bc1bd4281936310439f69e07073622 --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 ab82ff5156bc1bd4281936310439f69e07073622 --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=6587686cb2da90a5f91b3170000001be-1447755266.291346-1169291835 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-17 02:24:36,192 truncating revision to first 12 chars 2015-11-17 02:24:36,192 Setting DEBUG logging. 2015-11-17 02:24:36,192 attempt 1/10 2015-11-17 02:24:36,192 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ab82ff5156bc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-17 02:24:36,441 unpacking tar archive at: fx-team-ab82ff5156bc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.547675 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 02:24:36.126711) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 02:24:36.127046) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 02:24:36.144722) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 02:24:36.145162) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 02:24:36.145663) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2015-11-17 02:24:36.145964) ========= /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=6587686cb2da90a5f91b3170000001be-1447755266.291346-1169291835 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:24:36 INFO - MultiFileLogger online at 20151117 02:24:36 in /builds/slave/test 02:24:36 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 02:24:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:24:36 INFO - {'append_to_log': False, 02:24:36 INFO - 'base_work_dir': '/builds/slave/test', 02:24:36 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:24:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:24:36 INFO - 'branch': 'Fx-Team-Non-PGO', 02:24:36 INFO - 'buildbot_json_path': 'buildprops.json', 02:24:36 INFO - 'config_files': ('talos/linux_config.py',), 02:24:36 INFO - 'default_actions': ('clobber', 02:24:36 INFO - 'read-buildbot-config', 02:24:36 INFO - 'download-and-extract', 02:24:36 INFO - 'populate-webroot', 02:24:36 INFO - 'create-virtualenv', 02:24:36 INFO - 'install', 02:24:36 INFO - 'run-tests'), 02:24:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:24:36 INFO - 'download_minidump_stackwalk': True, 02:24:36 INFO - 'download_symbols': 'ondemand', 02:24:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:24:36 INFO - 'tooltool.py': '/tools/tooltool.py', 02:24:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:24:36 INFO - '/tools/misc-python/virtualenv.py')}, 02:24:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:24:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:24:36 INFO - 'installer_path': 'installer.exe', 02:24:36 INFO - 'log_level': 'info', 02:24:36 INFO - 'log_name': 'talos', 02:24:36 INFO - 'log_to_console': True, 02:24:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:24:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:24:36 INFO - 'opt_config_files': (), 02:24:36 INFO - 'pip_index': False, 02:24:36 INFO - 'sps_profile': False, 02:24:36 INFO - 'sps_profile_interval': 0, 02:24:36 INFO - 'suite': 'dromaeojs', 02:24:36 INFO - 'system_bits': '64', 02:24:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:24:36 INFO - 'title': 'talos-linux64-ix-017', 02:24:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:24:36 INFO - 'use_talos_json': True, 02:24:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:24:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:24:36 INFO - 'work_dir': 'build'} 02:24:36 INFO - ##### 02:24:36 INFO - ##### Running clobber step. 02:24:36 INFO - ##### 02:24:36 INFO - Running pre-action listener: _resource_record_pre_action 02:24:36 INFO - Running main action method: clobber 02:24:36 INFO - rmtree: /builds/slave/test/build 02:24:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:24:37 INFO - Running post-action listener: _resource_record_post_action 02:24:37 INFO - ##### 02:24:37 INFO - ##### Running read-buildbot-config step. 02:24:37 INFO - ##### 02:24:37 INFO - Running pre-action listener: _resource_record_pre_action 02:24:37 INFO - Running main action method: read_buildbot_config 02:24:37 INFO - Using buildbot properties: 02:24:37 INFO - { 02:24:37 INFO - "properties": { 02:24:37 INFO - "buildnumber": 2072, 02:24:37 INFO - "product": "firefox", 02:24:37 INFO - "script_repo_revision": "production", 02:24:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:24:37 INFO - "repository": "", 02:24:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 02:24:37 INFO - "buildid": "20151117013304", 02:24:37 INFO - "slavename": "talos-linux64-ix-017", 02:24:37 INFO - "pgo_build": "False", 02:24:37 INFO - "basedir": "/builds/slave/test", 02:24:37 INFO - "project": "", 02:24:37 INFO - "platform": "ubuntu64_hw", 02:24:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:24:37 INFO - "slavebuilddir": "test", 02:24:37 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:24:37 INFO - "branch": "fx-team", 02:24:37 INFO - "repo_path": "integration/fx-team", 02:24:37 INFO - "stage_platform": "linux64", 02:24:37 INFO - "builduid": "52511697da2748108ccd7cfdea092d45", 02:24:37 INFO - "revision": "ab82ff5156bc1bd4281936310439f69e07073622" 02:24:37 INFO - }, 02:24:37 INFO - "sourcestamp": { 02:24:37 INFO - "repository": "", 02:24:37 INFO - "hasPatch": false, 02:24:37 INFO - "project": "", 02:24:37 INFO - "branch": "fx-team-linux64-talos", 02:24:37 INFO - "changes": [ 02:24:37 INFO - { 02:24:37 INFO - "category": null, 02:24:37 INFO - "files": [ 02:24:37 INFO - { 02:24:37 INFO - "url": null, 02:24:37 INFO - "name": "https://queue.taskcluster.net/v1/task/WPQbHwwLQ2GFvdSuUDLyXA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 02:24:37 INFO - } 02:24:37 INFO - ], 02:24:37 INFO - "repository": "", 02:24:37 INFO - "rev": "ab82ff5156bc1bd4281936310439f69e07073622", 02:24:37 INFO - "who": "cbook@mozilla.com", 02:24:37 INFO - "when": 1447755828, 02:24:37 INFO - "number": 6670968, 02:24:37 INFO - "comments": "Bug 1224958 - Update animation-fast-track.svg to be thinner. r=pbro", 02:24:37 INFO - "project": "", 02:24:37 INFO - "at": "Tue 17 Nov 2015 02:23:48", 02:24:37 INFO - "branch": "fx-team-linux64-talos", 02:24:37 INFO - "revlink": "", 02:24:37 INFO - "properties": [ 02:24:37 INFO - [ 02:24:37 INFO - "buildid", 02:24:37 INFO - "20151117013304", 02:24:37 INFO - "Change" 02:24:37 INFO - ], 02:24:37 INFO - [ 02:24:37 INFO - "builduid", 02:24:37 INFO - "52511697da2748108ccd7cfdea092d45", 02:24:37 INFO - "Change" 02:24:37 INFO - ], 02:24:37 INFO - [ 02:24:37 INFO - "pgo_build", 02:24:37 INFO - "False", 02:24:37 INFO - "Change" 02:24:37 INFO - ] 02:24:37 INFO - ], 02:24:37 INFO - "revision": "ab82ff5156bc1bd4281936310439f69e07073622" 02:24:37 INFO - } 02:24:37 INFO - ], 02:24:37 INFO - "revision": "ab82ff5156bc1bd4281936310439f69e07073622" 02:24:37 INFO - } 02:24:37 INFO - } 02:24:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/WPQbHwwLQ2GFvdSuUDLyXA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 02:24:37 INFO - Running post-action listener: _resource_record_post_action 02:24:37 INFO - ##### 02:24:37 INFO - ##### Running download-and-extract step. 02:24:37 INFO - ##### 02:24:37 INFO - Running pre-action listener: _resource_record_pre_action 02:24:37 INFO - Running main action method: download_and_extract 02:24:37 INFO - mkdir: /builds/slave/test/build/tests 02:24:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:37 INFO - https://queue.taskcluster.net/v1/task/WPQbHwwLQ2GFvdSuUDLyXA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:24:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPQbHwwLQ2GFvdSuUDLyXA/artifacts/public/build/test_packages.json 02:24:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPQbHwwLQ2GFvdSuUDLyXA/artifacts/public/build/test_packages.json 02:24:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPQbHwwLQ2GFvdSuUDLyXA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 02:24:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPQbHwwLQ2GFvdSuUDLyXA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 02:24:38 INFO - Downloaded 1302 bytes. 02:24:38 INFO - Reading from file /builds/slave/test/build/test_packages.json 02:24:38 INFO - Using the following test package requirements: 02:24:38 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 02:24:38 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:24:38 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:38 INFO - u'jsshell-linux-x86_64.zip'], 02:24:38 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:24:38 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 02:24:38 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:24:38 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:24:38 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:24:38 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 02:24:38 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:24:38 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:24:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:38 INFO - https://queue.taskcluster.net/v1/task/WPQbHwwLQ2GFvdSuUDLyXA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:24:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPQbHwwLQ2GFvdSuUDLyXA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:24:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPQbHwwLQ2GFvdSuUDLyXA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:24:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPQbHwwLQ2GFvdSuUDLyXA/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 02:24:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPQbHwwLQ2GFvdSuUDLyXA/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 02:24:39 INFO - Downloaded 21274852 bytes. 02:24:39 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 02:24:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:24:39 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 02:24:41 INFO - Return code: 0 02:24:41 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 02:24:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:41 INFO - https://queue.taskcluster.net/v1/task/WPQbHwwLQ2GFvdSuUDLyXA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:24:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPQbHwwLQ2GFvdSuUDLyXA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:24:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPQbHwwLQ2GFvdSuUDLyXA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:24:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPQbHwwLQ2GFvdSuUDLyXA/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 02:24:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPQbHwwLQ2GFvdSuUDLyXA/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 02:24:42 INFO - Downloaded 21274852 bytes. 02:24:42 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 02:24:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:24:42 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 02:24:43 INFO - Return code: 0 02:24:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:43 INFO - https://queue.taskcluster.net/v1/task/WPQbHwwLQ2GFvdSuUDLyXA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:24:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPQbHwwLQ2GFvdSuUDLyXA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 02:24:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPQbHwwLQ2GFvdSuUDLyXA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 02:24:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPQbHwwLQ2GFvdSuUDLyXA/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 02:24:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPQbHwwLQ2GFvdSuUDLyXA/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 02:24:44 INFO - Downloaded 11131693 bytes. 02:24:44 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 02:24:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 02:24:44 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 02:24:45 INFO - Return code: 0 02:24:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:45 INFO - https://queue.taskcluster.net/v1/task/WPQbHwwLQ2GFvdSuUDLyXA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:24:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPQbHwwLQ2GFvdSuUDLyXA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 02:24:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPQbHwwLQ2GFvdSuUDLyXA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 02:24:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPQbHwwLQ2GFvdSuUDLyXA/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 02:24:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPQbHwwLQ2GFvdSuUDLyXA/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 02:24:47 INFO - Downloaded 55618447 bytes. 02:24:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WPQbHwwLQ2GFvdSuUDLyXA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 02:24:47 INFO - mkdir: /builds/slave/test/properties 02:24:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:24:47 INFO - Writing to file /builds/slave/test/properties/build_url 02:24:47 INFO - Contents: 02:24:47 INFO - build_url:https://queue.taskcluster.net/v1/task/WPQbHwwLQ2GFvdSuUDLyXA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 02:24:47 INFO - Running post-action listener: _resource_record_post_action 02:24:47 INFO - Running post-action listener: set_extra_try_arguments 02:24:47 INFO - ##### 02:24:47 INFO - ##### Running populate-webroot step. 02:24:47 INFO - ##### 02:24:47 INFO - Running pre-action listener: _resource_record_pre_action 02:24:47 INFO - Running main action method: populate_webroot 02:24:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:24:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:24:47 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 02:24:47 INFO - '../fennec_ids.txt'], 02:24:47 INFO - 'tests': ['tcheck2']}, 02:24:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:24:47 INFO - '--tppagecycles', 02:24:47 INFO - '7'], 02:24:47 INFO - 'tests': ['tsvgm']}}, 02:24:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:24:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:24:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:24:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:24:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:24:47 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:24:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:24:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:47 INFO - 'talos_options': ['--e10s'], 02:24:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:24:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:47 INFO - 'tests': ['damp', 'tps']}, 02:24:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:47 INFO - 'talos_options': ['--e10s'], 02:24:47 INFO - 'tests': ['damp', 'tps']}, 02:24:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:24:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:24:47 INFO - 'other': {'tests': ['a11yr', 02:24:47 INFO - 'ts_paint', 02:24:47 INFO - 'tpaint', 02:24:47 INFO - 'sessionrestore', 02:24:47 INFO - 'sessionrestore_no_auto_restore']}, 02:24:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:24:47 INFO - 'tests': ['a11yr', 02:24:47 INFO - 'ts_paint', 02:24:47 INFO - 'tpaint', 02:24:47 INFO - 'sessionrestore', 02:24:47 INFO - 'sessionrestore_no_auto_restore']}, 02:24:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:24:47 INFO - 'tests': ['a11yr', 02:24:47 INFO - 'ts_paint', 02:24:47 INFO - 'tpaint', 02:24:47 INFO - 'sessionrestore', 02:24:47 INFO - 'sessionrestore_no_auto_restore']}, 02:24:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:24:47 INFO - 'tests': ['a11yr', 02:24:47 INFO - 'ts_paint', 02:24:47 INFO - 'tpaint', 02:24:47 INFO - 'sessionrestore', 02:24:47 INFO - 'sessionrestore_no_auto_restore']}, 02:24:47 INFO - 'other_l64': {'tests': ['a11yr', 02:24:47 INFO - 'ts_paint', 02:24:47 INFO - 'tpaint', 02:24:47 INFO - 'sessionrestore', 02:24:47 INFO - 'sessionrestore_no_auto_restore']}, 02:24:47 INFO - 'other_nol64': {'tests': ['a11yr', 02:24:47 INFO - 'ts_paint', 02:24:47 INFO - 'tpaint', 02:24:47 INFO - 'sessionrestore', 02:24:47 INFO - 'sessionrestore_no_auto_restore']}, 02:24:47 INFO - 'svgr': {'tests': ['tsvgx', 02:24:47 INFO - 'tsvgr_opacity', 02:24:47 INFO - 'tart', 02:24:47 INFO - 'tscrollx', 02:24:47 INFO - 'cart']}, 02:24:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:24:47 INFO - 'tests': ['tsvgx', 02:24:47 INFO - 'tsvgr_opacity', 02:24:47 INFO - 'tart', 02:24:47 INFO - 'tscrollx', 02:24:47 INFO - 'cart']}, 02:24:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:47 INFO - 'tests': ['tp5o']}, 02:24:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:47 INFO - 'talos_options': ['--e10s'], 02:24:47 INFO - 'tests': ['tp5o']}, 02:24:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:47 INFO - 'talos_options': ['--xperf_path', 02:24:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:24:47 INFO - 'tests': ['tp5n']}, 02:24:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:47 INFO - 'talos_options': ['--e10s', 02:24:47 INFO - '--xperf_path', 02:24:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:24:47 INFO - 'tests': ['tp5n']}}, 02:24:47 INFO - 'talos.zip': {'path': '', 02:24:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:24:47 INFO - Running post-action listener: _resource_record_post_action 02:24:47 INFO - ##### 02:24:47 INFO - ##### Running create-virtualenv step. 02:24:47 INFO - ##### 02:24:47 INFO - Running pre-action listener: _resource_record_pre_action 02:24:47 INFO - Running main action method: create_virtualenv 02:24:47 INFO - Creating virtualenv /builds/slave/test/build/venv 02:24:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:24:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:24:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:24:47 INFO - Using real prefix '/usr' 02:24:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:24:48 INFO - Installing distribute.............................................................................................................................................................................................done. 02:24:49 INFO - Installing pip.................done. 02:24:49 INFO - Return code: 0 02:24:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:24:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3ca77e3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cc6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0cac0>, '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 0x1b0d9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0de50>, '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': '6587686cb2da90a5f91b3170000001be-1447755266.291346-1169291835', '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 02:24:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:24:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:24:49 INFO - Using env: {'DISPLAY': ':0', 02:24:49 INFO - 'HOME': '/home/cltbld', 02:24:49 INFO - 'LANG': 'en_US.UTF-8', 02:24:49 INFO - 'LANGUAGE': 'en_US:en', 02:24:49 INFO - 'LOGNAME': 'cltbld', 02:24:49 INFO - 'MAIL': '/var/mail/cltbld', 02:24:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:49 INFO - 'MOZ_NO_REMOTE': '1', 02:24:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:49 INFO - 'NO_EM_RESTART': '1', 02:24:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:49 INFO - 'PWD': '/builds/slave/test', 02:24:49 INFO - 'SHELL': '/bin/bash', 02:24:49 INFO - 'SHLVL': '1', 02:24:49 INFO - 'TERM': 'linux', 02:24:49 INFO - 'TMOUT': '86400', 02:24:49 INFO - 'USER': 'cltbld', 02:24:49 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447755266.291346-1169291835', 02:24:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:49 INFO - '_': '/tools/buildbot/bin/python'} 02:24:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:50 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 02:24:50 INFO - Cleaning up... 02:24:50 INFO - Return code: 0 02:24:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:24:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:50 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 0x7f3ca77e3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cc6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0cac0>, '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 0x1b0d9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0de50>, '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': '6587686cb2da90a5f91b3170000001be-1447755266.291346-1169291835', '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 02:24:50 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 02:24:50 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 02:24:50 INFO - Using env: {'DISPLAY': ':0', 02:24:50 INFO - 'HOME': '/home/cltbld', 02:24:50 INFO - 'LANG': 'en_US.UTF-8', 02:24:50 INFO - 'LANGUAGE': 'en_US:en', 02:24:50 INFO - 'LOGNAME': 'cltbld', 02:24:50 INFO - 'MAIL': '/var/mail/cltbld', 02:24:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:50 INFO - 'MOZ_NO_REMOTE': '1', 02:24:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:50 INFO - 'NO_EM_RESTART': '1', 02:24:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:50 INFO - 'PWD': '/builds/slave/test', 02:24:50 INFO - 'SHELL': '/bin/bash', 02:24:50 INFO - 'SHLVL': '1', 02:24:50 INFO - 'TERM': 'linux', 02:24:50 INFO - 'TMOUT': '86400', 02:24:50 INFO - 'USER': 'cltbld', 02:24:50 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447755266.291346-1169291835', 02:24:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:50 INFO - '_': '/tools/buildbot/bin/python'} 02:24:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:50 INFO - Downloading/unpacking psutil>=0.7.1 02:24:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:52 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 02:24:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 02:24:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:24:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:24:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:24:52 INFO - Installing collected packages: psutil 02:24:52 INFO - Running setup.py install for psutil 02:24:52 INFO - building 'psutil._psutil_linux' extension 02:24:52 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 02:24:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:24:52 INFO - building 'psutil._psutil_posix' extension 02:24:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:24:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:24:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:24:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:24:52 INFO - Successfully installed psutil 02:24:52 INFO - Cleaning up... 02:24:52 INFO - Return code: 0 02:24:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3ca77e3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cc6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0cac0>, '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 0x1b0d9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0de50>, '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': '6587686cb2da90a5f91b3170000001be-1447755266.291346-1169291835', '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 02:24:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:24:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 02:24:52 INFO - Using env: {'DISPLAY': ':0', 02:24:52 INFO - 'HOME': '/home/cltbld', 02:24:52 INFO - 'LANG': 'en_US.UTF-8', 02:24:52 INFO - 'LANGUAGE': 'en_US:en', 02:24:52 INFO - 'LOGNAME': 'cltbld', 02:24:52 INFO - 'MAIL': '/var/mail/cltbld', 02:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:52 INFO - 'MOZ_NO_REMOTE': '1', 02:24:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:52 INFO - 'NO_EM_RESTART': '1', 02:24:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:52 INFO - 'PWD': '/builds/slave/test', 02:24:52 INFO - 'SHELL': '/bin/bash', 02:24:52 INFO - 'SHLVL': '1', 02:24:52 INFO - 'TERM': 'linux', 02:24:52 INFO - 'TMOUT': '86400', 02:24:52 INFO - 'USER': 'cltbld', 02:24:52 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447755266.291346-1169291835', 02:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:52 INFO - '_': '/tools/buildbot/bin/python'} 02:24:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:24:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 02:24:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:24:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:24:54 INFO - Installing collected packages: mozsystemmonitor 02:24:54 INFO - Running setup.py install for mozsystemmonitor 02:24:54 INFO - Successfully installed mozsystemmonitor 02:24:54 INFO - Cleaning up... 02:24:54 INFO - Return code: 0 02:24:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3ca77e3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cc6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0cac0>, '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 0x1b0d9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0de50>, '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': '6587686cb2da90a5f91b3170000001be-1447755266.291346-1169291835', '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 02:24:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:24:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:24:54 INFO - Using env: {'DISPLAY': ':0', 02:24:54 INFO - 'HOME': '/home/cltbld', 02:24:54 INFO - 'LANG': 'en_US.UTF-8', 02:24:54 INFO - 'LANGUAGE': 'en_US:en', 02:24:54 INFO - 'LOGNAME': 'cltbld', 02:24:54 INFO - 'MAIL': '/var/mail/cltbld', 02:24:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:54 INFO - 'MOZ_NO_REMOTE': '1', 02:24:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:54 INFO - 'NO_EM_RESTART': '1', 02:24:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:54 INFO - 'PWD': '/builds/slave/test', 02:24:54 INFO - 'SHELL': '/bin/bash', 02:24:54 INFO - 'SHLVL': '1', 02:24:54 INFO - 'TERM': 'linux', 02:24:54 INFO - 'TMOUT': '86400', 02:24:54 INFO - 'USER': 'cltbld', 02:24:54 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447755266.291346-1169291835', 02:24:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:54 INFO - '_': '/tools/buildbot/bin/python'} 02:24:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:54 INFO - Downloading/unpacking blobuploader==1.2.4 02:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:56 INFO - Downloading blobuploader-1.2.4.tar.gz 02:24:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 02:24:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:24:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 02:24:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:24:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:24:57 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 02:24:57 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 02:24:57 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 02:24:57 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 02:24:57 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 02:24:57 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 02:24:57 INFO - Downloading docopt-0.6.1.tar.gz 02:24:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 02:24:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:24:57 INFO - Installing collected packages: blobuploader, requests, docopt 02:24:57 INFO - Running setup.py install for blobuploader 02:24:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:24:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:24:57 INFO - Running setup.py install for requests 02:24:57 INFO - Running setup.py install for docopt 02:24:57 INFO - Successfully installed blobuploader requests docopt 02:24:57 INFO - Cleaning up... 02:24:57 INFO - Return code: 0 02:24:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:24:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3ca77e3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cc6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0cac0>, '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 0x1b0d9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0de50>, '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': '6587686cb2da90a5f91b3170000001be-1447755266.291346-1169291835', '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 02:24:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:24:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:24:57 INFO - Using env: {'DISPLAY': ':0', 02:24:57 INFO - 'HOME': '/home/cltbld', 02:24:57 INFO - 'LANG': 'en_US.UTF-8', 02:24:57 INFO - 'LANGUAGE': 'en_US:en', 02:24:57 INFO - 'LOGNAME': 'cltbld', 02:24:57 INFO - 'MAIL': '/var/mail/cltbld', 02:24:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:57 INFO - 'MOZ_NO_REMOTE': '1', 02:24:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:57 INFO - 'NO_EM_RESTART': '1', 02:24:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:57 INFO - 'PWD': '/builds/slave/test', 02:24:57 INFO - 'SHELL': '/bin/bash', 02:24:57 INFO - 'SHLVL': '1', 02:24:57 INFO - 'TERM': 'linux', 02:24:57 INFO - 'TMOUT': '86400', 02:24:57 INFO - 'USER': 'cltbld', 02:24:57 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447755266.291346-1169291835', 02:24:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:57 INFO - '_': '/tools/buildbot/bin/python'} 02:24:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:24:58 INFO - Running setup.py (path:/tmp/pip-dUZ6qo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:24:58 INFO - Running setup.py (path:/tmp/pip-sXo119-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:24:58 INFO - Running setup.py (path:/tmp/pip-FBJDTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:24:58 INFO - Running setup.py (path:/tmp/pip-BF0vbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:24:58 INFO - Running setup.py (path:/tmp/pip-FNdqrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:24:58 INFO - Running setup.py (path:/tmp/pip-JtDnzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:24:58 INFO - Running setup.py (path:/tmp/pip-6ZRr1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:24:58 INFO - Running setup.py (path:/tmp/pip-rYayiE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:24:58 INFO - Running setup.py (path:/tmp/pip-BaLXTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:24:58 INFO - Running setup.py (path:/tmp/pip-9HbEGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:24:58 INFO - Running setup.py (path:/tmp/pip-Q1_rgV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:24:58 INFO - Running setup.py (path:/tmp/pip-g5ms0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:24:59 INFO - Running setup.py (path:/tmp/pip-GCY28k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:24:59 INFO - Running setup.py (path:/tmp/pip-6JX0td-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:24:59 INFO - Running setup.py (path:/tmp/pip-FrstK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:24:59 INFO - Running setup.py (path:/tmp/pip-t6dpvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:24:59 INFO - Running setup.py (path:/tmp/pip-bB9_TF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:24:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:24:59 INFO - Running setup.py install for manifestparser 02:24:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:24:59 INFO - Running setup.py install for mozcrash 02:24:59 INFO - Running setup.py install for mozdebug 02:24:59 INFO - Running setup.py install for mozdevice 02:24:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:24:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:24:59 INFO - Running setup.py install for mozfile 02:24:59 INFO - Running setup.py install for mozhttpd 02:24:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:24:59 INFO - Running setup.py install for mozinfo 02:25:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:25:00 INFO - Running setup.py install for mozInstall 02:25:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:25:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:25:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:25:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:25:00 INFO - Running setup.py install for mozleak 02:25:00 INFO - Running setup.py install for mozlog 02:25:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:25:00 INFO - Running setup.py install for moznetwork 02:25:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:25:00 INFO - Running setup.py install for mozprocess 02:25:00 INFO - Running setup.py install for mozprofile 02:25:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:25:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:25:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:25:00 INFO - Running setup.py install for mozrunner 02:25:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:25:00 INFO - Running setup.py install for mozscreenshot 02:25:00 INFO - Running setup.py install for moztest 02:25:01 INFO - Running setup.py install for mozversion 02:25:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:25:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:25:01 INFO - Cleaning up... 02:25:01 INFO - Return code: 0 02:25:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:25:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:25:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:25:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:25:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:01 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 0x7f3ca77e3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cc6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0cac0>, '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 0x1b0d9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0de50>, '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': '6587686cb2da90a5f91b3170000001be-1447755266.291346-1169291835', '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 02:25:01 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 02:25:01 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 02:25:01 INFO - Using env: {'DISPLAY': ':0', 02:25:01 INFO - 'HOME': '/home/cltbld', 02:25:01 INFO - 'LANG': 'en_US.UTF-8', 02:25:01 INFO - 'LANGUAGE': 'en_US:en', 02:25:01 INFO - 'LOGNAME': 'cltbld', 02:25:01 INFO - 'MAIL': '/var/mail/cltbld', 02:25:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:25:01 INFO - 'MOZ_NO_REMOTE': '1', 02:25:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:25:01 INFO - 'NO_EM_RESTART': '1', 02:25:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:25:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:25:01 INFO - 'PWD': '/builds/slave/test', 02:25:01 INFO - 'SHELL': '/bin/bash', 02:25:01 INFO - 'SHLVL': '1', 02:25:01 INFO - 'TERM': 'linux', 02:25:01 INFO - 'TMOUT': '86400', 02:25:01 INFO - 'USER': 'cltbld', 02:25:01 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447755266.291346-1169291835', 02:25:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:25:01 INFO - '_': '/tools/buildbot/bin/python'} 02:25:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:25:01 INFO - Running setup.py (path:/tmp/pip-YELjAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:25:01 INFO - Running setup.py (path:/tmp/pip-yj7mdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:25:01 INFO - Running setup.py (path:/tmp/pip-mDpvle-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:25:01 INFO - Running setup.py (path:/tmp/pip-BON8xu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:25:01 INFO - Running setup.py (path:/tmp/pip-v8hsrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:25:01 INFO - Running setup.py (path:/tmp/pip-2Y7LXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:25:01 INFO - Running setup.py (path:/tmp/pip-GUBgYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:25:01 INFO - Running setup.py (path:/tmp/pip-lN8qcg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:25:01 INFO - Running setup.py (path:/tmp/pip-7EjfXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:25:02 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)) 02:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:25:02 INFO - Running setup.py (path:/tmp/pip-UVrNvF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:25:02 INFO - Running setup.py (path:/tmp/pip-x_n8di-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:25:02 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)) 02:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:25:02 INFO - Running setup.py (path:/tmp/pip-gRQRB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:25:02 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)) 02:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:25:02 INFO - Running setup.py (path:/tmp/pip-4DqIQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:25:02 INFO - Running setup.py (path:/tmp/pip-YSpxEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:25:02 INFO - Running setup.py (path:/tmp/pip-tqnJbN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:25:02 INFO - Running setup.py (path:/tmp/pip-xFvM9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:25:02 INFO - Running setup.py (path:/tmp/pip-9ebonj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:25:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:25:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:25:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:25:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:25:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:25:04 INFO - Downloading blessings-1.5.1.tar.gz 02:25:04 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 02:25:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:25:04 INFO - Installing collected packages: blessings 02:25:04 INFO - Running setup.py install for blessings 02:25:04 INFO - Successfully installed blessings 02:25:04 INFO - Cleaning up... 02:25:04 INFO - Return code: 0 02:25:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:25:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:25:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:25:04 INFO - Reading from file tmpfile_stdout 02:25:04 INFO - Current package versions: 02:25:04 INFO - argparse == 1.2.1 02:25:04 INFO - blessings == 1.5.1 02:25:04 INFO - blobuploader == 1.2.4 02:25:04 INFO - docopt == 0.6.1 02:25:04 INFO - manifestparser == 1.1 02:25:04 INFO - mozInstall == 1.12 02:25:04 INFO - mozcrash == 0.16 02:25:04 INFO - mozdebug == 0.1 02:25:04 INFO - mozdevice == 0.47 02:25:04 INFO - mozfile == 1.2 02:25:04 INFO - mozhttpd == 0.7 02:25:04 INFO - mozinfo == 0.9 02:25:04 INFO - mozleak == 0.1 02:25:04 INFO - mozlog == 3.0 02:25:04 INFO - moznetwork == 0.27 02:25:04 INFO - mozprocess == 0.22 02:25:04 INFO - mozprofile == 0.27 02:25:04 INFO - mozrunner == 6.11 02:25:04 INFO - mozscreenshot == 0.1 02:25:04 INFO - mozsystemmonitor == 0.0 02:25:04 INFO - moztest == 0.7 02:25:04 INFO - mozversion == 1.4 02:25:04 INFO - psutil == 3.1.1 02:25:04 INFO - requests == 1.2.3 02:25:04 INFO - wsgiref == 0.1.2 02:25:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:25:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:25:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:25:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:25:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3ca77e3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cc6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0cac0>, '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 0x1b0d9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0de50>, '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': '6587686cb2da90a5f91b3170000001be-1447755266.291346-1169291835', '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 02:25:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:25:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:25:04 INFO - Using env: {'DISPLAY': ':0', 02:25:04 INFO - 'HOME': '/home/cltbld', 02:25:04 INFO - 'LANG': 'en_US.UTF-8', 02:25:04 INFO - 'LANGUAGE': 'en_US:en', 02:25:04 INFO - 'LOGNAME': 'cltbld', 02:25:04 INFO - 'MAIL': '/var/mail/cltbld', 02:25:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:25:04 INFO - 'MOZ_NO_REMOTE': '1', 02:25:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:25:04 INFO - 'NO_EM_RESTART': '1', 02:25:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:25:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:25:04 INFO - 'PWD': '/builds/slave/test', 02:25:04 INFO - 'SHELL': '/bin/bash', 02:25:04 INFO - 'SHLVL': '1', 02:25:04 INFO - 'TERM': 'linux', 02:25:04 INFO - 'TMOUT': '86400', 02:25:04 INFO - 'USER': 'cltbld', 02:25:04 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447755266.291346-1169291835', 02:25:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:25:04 INFO - '_': '/tools/buildbot/bin/python'} 02:25:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:25:04 INFO - Cleaning up... 02:25:04 INFO - Return code: 0 02:25:04 INFO - Running post-action listener: _resource_record_post_action 02:25:04 INFO - Running post-action listener: _start_resource_monitoring 02:25:04 INFO - Starting resource monitoring. 02:25:04 INFO - ##### 02:25:04 INFO - ##### Running install step. 02:25:04 INFO - ##### 02:25:04 INFO - Running pre-action listener: _resource_record_pre_action 02:25:04 INFO - Running main action method: install 02:25:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:25:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:25:05 INFO - Reading from file tmpfile_stdout 02:25:05 INFO - Detecting whether we're running mozinstall >=1.0... 02:25:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:25:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:25:05 INFO - Reading from file tmpfile_stdout 02:25:05 INFO - Output received: 02:25:05 INFO - Usage: mozinstall [options] installer 02:25:05 INFO - Options: 02:25:05 INFO - -h, --help show this help message and exit 02:25:05 INFO - -d DEST, --destination=DEST 02:25:05 INFO - Directory to install application into. [default: 02:25:05 INFO - "/builds/slave/test"] 02:25:05 INFO - --app=APP Application being installed. [default: firefox] 02:25:05 INFO - mkdir: /builds/slave/test/build/application 02:25:05 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'] 02:25:05 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 02:25:19 INFO - Reading from file tmpfile_stdout 02:25:19 INFO - Output received: 02:25:19 INFO - /builds/slave/test/build/application/firefox/firefox 02:25:19 INFO - Running post-action listener: _resource_record_post_action 02:25:19 INFO - ##### 02:25:19 INFO - ##### Running run-tests step. 02:25:19 INFO - ##### 02:25:19 INFO - Running pre-action listener: _resource_record_pre_action 02:25:19 INFO - Running main action method: run_tests 02:25:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:25:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:25:19 INFO - Python 2.7.3 02:25:19 INFO - Return code: 0 02:25:19 INFO - grabbing minidump binary from tooltool 02:25:19 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')]} 02:25:19 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 0x1b0cac0>, '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 0x1b0d9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0de50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:25:19 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 02:25:19 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 02:25:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:25:19 INFO - Return code: 0 02:25:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:25:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:25:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:25:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:25:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:25:19 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/WPQbHwwLQ2GFvdSuUDLyXA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost'] in /builds/slave/test/build 02:25:19 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/WPQbHwwLQ2GFvdSuUDLyXA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost 02:25:19 INFO - Using env: {'DISPLAY': ':0', 02:25:19 INFO - 'HOME': '/home/cltbld', 02:25:19 INFO - 'LANG': 'en_US.UTF-8', 02:25:19 INFO - 'LANGUAGE': 'en_US:en', 02:25:19 INFO - 'LOGNAME': 'cltbld', 02:25:19 INFO - 'MAIL': '/var/mail/cltbld', 02:25:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:25:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:25:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:25:19 INFO - 'MOZ_NO_REMOTE': '1', 02:25:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:25:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:25:19 INFO - 'NO_EM_RESTART': '1', 02:25:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:25:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:25:19 INFO - 'PWD': '/builds/slave/test', 02:25:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:25:19 INFO - 'SHELL': '/bin/bash', 02:25:19 INFO - 'SHLVL': '1', 02:25:19 INFO - 'TERM': 'linux', 02:25:19 INFO - 'TMOUT': '86400', 02:25:19 INFO - 'USER': 'cltbld', 02:25:19 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447755266.291346-1169291835', 02:25:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:25:19 INFO - '_': '/tools/buildbot/bin/python'} 02:25:19 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/WPQbHwwLQ2GFvdSuUDLyXA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost'] with output_timeout 3600 02:25:19 INFO - mozversion INFO | application_buildid: 20151117013304 02:25:19 INFO - mozversion INFO | application_changeset: ab82ff5156bc1bd4281936310439f69e07073622 02:25:19 INFO - mozversion INFO | application_display_name: Nightly 02:25:19 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:25:19 INFO - mozversion INFO | application_name: Firefox 02:25:19 INFO - mozversion INFO | application_remotingname: firefox 02:25:19 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 02:25:19 INFO - mozversion INFO | application_vendor: Mozilla 02:25:19 INFO - mozversion INFO | application_version: 45.0a1 02:25:19 INFO - mozversion INFO | platform_buildid: 20151117013304 02:25:19 INFO - mozversion INFO | platform_changeset: ab82ff5156bc1bd4281936310439f69e07073622 02:25:19 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 02:25:19 INFO - mozversion INFO | platform_version: 45.0a1 02:25:19 INFO - 2015-11-17 02:25:19,611 DEBUG : using testdate: 1447755919 02:25:19 INFO - 2015-11-17 02:25:19,611 DEBUG : actual date: 1447755919 02:25:19 INFO - 2015-11-17 02:25:19,623 INFO : starting webserver on 'localhost:43355' 02:25:19 INFO - 2015-11-17 02:25:19,624 INFO : Starting test suite talos-linux64-ix-017 02:25:19 INFO - 2015-11-17 02:25:19,624 INFO : Starting test dromaeo_css 02:25:19 INFO - 2015-11-17 02:25:19,624 DEBUG : operating with platform_type : linux_ 02:25:19 INFO - 2015-11-17 02:25:19,625 INFO : Initialising browser for dromaeo_css test... 02:25:19 INFO - 2015-11-17 02:25:19,639 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDWeukR/profile http://localhost:43355/getInfo.html 02:25:23 INFO - 2015-11-17 02:25:23,554 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:25:23 INFO - 2015-11-17 02:25:23,554 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:25:23 INFO - 2015-11-17 02:25:23,554 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:25:23 INFO - 2015-11-17 02:25:23,554 DEBUG : BROWSER_OUTPUT: __metrics 02:25:23 INFO - 2015-11-17 02:25:23,703 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:25:25 INFO - 2015-11-17 02:25:25,008 INFO : Browser initialized. 02:25:25 INFO - 2015-11-17 02:25:25,008 INFO : Running cycle 1/1 for dromaeo_css test... 02:25:25 INFO - 2015-11-17 02:25:25,009 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDWeukR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:25:36 INFO - 2015-11-17 02:25:36,916 DEBUG : BROWSER_OUTPUT: RSS: Main: 141242368 02:25:36 INFO - 2015-11-17 02:25:36,916 DEBUG : BROWSER_OUTPUT: 02:26:28 INFO - 2015-11-17 02:26:28,187 DEBUG : BROWSER_OUTPUT: 1447755988185 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] 02:28:39 INFO - 2015-11-17 02:28:39,868 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43355/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43355/tests/dromaeo/cssquery-ext.html) 02:28:41 INFO - 2015-11-17 02:28:41,046 DEBUG : BROWSER_OUTPUT: RSS: Main: 252428288 02:28:41 INFO - 2015-11-17 02:28:41,046 DEBUG : BROWSER_OUTPUT: 02:31:43 INFO - 2015-11-17 02:31:43,639 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43355/tests/dromaeo/cssquery-ext.html (next: http://localhost:43355/tests/dromaeo/cssquery-jquery.html) 02:31:44 INFO - 2015-11-17 02:31:44,209 DEBUG : BROWSER_OUTPUT: RSS: Main: 226119680 02:31:44 INFO - 2015-11-17 02:31:44,209 DEBUG : BROWSER_OUTPUT: 02:34:46 INFO - 2015-11-17 02:34:46,307 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43355/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43355/tests/dromaeo/cssquery-mootools.html) 02:34:46 INFO - 2015-11-17 02:34:46,873 DEBUG : BROWSER_OUTPUT: RSS: Main: 212709376 02:34:46 INFO - 2015-11-17 02:34:46,873 DEBUG : BROWSER_OUTPUT: 02:37:48 INFO - 2015-11-17 02:37:48,872 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43355/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43355/tests/dromaeo/cssquery-prototype.html) 02:37:49 INFO - 2015-11-17 02:37:49,444 DEBUG : BROWSER_OUTPUT: RSS: Main: 204046336 02:37:49 INFO - 2015-11-17 02:37:49,444 DEBUG : BROWSER_OUTPUT: 02:40:52 INFO - 2015-11-17 02:40:52,121 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43355/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43355/tests/dromaeo/cssquery-yui.html) 02:40:52 INFO - 2015-11-17 02:40:52,706 DEBUG : BROWSER_OUTPUT: RSS: Main: 181288960 02:40:52 INFO - 2015-11-17 02:40:52,707 DEBUG : BROWSER_OUTPUT: 02:43:55 INFO - 2015-11-17 02:43:55,124 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43355/tests/dromaeo/cssquery-yui.html (next: http://localhost:43355/tests/dromaeo/cssquery-dojo.html) 02:43:55 INFO - 2015-11-17 02:43:55,374 DEBUG : BROWSER_OUTPUT: RSS: Main: 247934976 02:43:55 INFO - 2015-11-17 02:43:55,375 DEBUG : BROWSER_OUTPUT: 02:43:55 INFO - 2015-11-17 02:43:55,376 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:43:55 INFO - 2015-11-17 02:43:55,376 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:43:55 INFO - 2015-11-17 02:43:55,376 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:43:55 INFO - 2015-11-17 02:43:55,376 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:43:55 INFO - 2015-11-17 02:43:55,377 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2673.852938088405;2748.3953530223357;2762.074704973834;2771.6396868407105;2773.528500154974;4624.514425985273;4772.475027746949;4782.354382158407;4792.089502994433;4803.327534145218;4717.669763116583;4729.21967875301;4792.688475249106;4794.688345257565;4829.758512074391;4387.868363949086;4443.888902777424;4450.221211288012;4458.977705111486;4486.798094085758;4253.1281087377165;4480.350349199364;4486.618637415823;4527.162474942146;4531.728096314215;4226.091390351058;4274.059706864485;4340.891477713082;4368.803403846835;4384.802683879233;4437.711548749321;4437.933430998538;4454.10917816438;4458.308962110878;4508.864734057984;4176.812043458021;4273.50854651716;4427.645788336926;4428.424304840382;4471.731696098244;4628.629709623222;4693.718376897397;4700.694454860423;4710.505396933307;4760.738159401231;5059.001694330719;5184.5593124584075;5195.610329225323;5201.713905735183;5223.843284701465;4892.535209155125;5007.574356179729;5013;5202.06362854686;5208.635395522315;4685.835995740167;4742.644301677388;4751.691140075884;4758.904821903612;4804.111239420718;5284.392294886137;5321.016074420668;5321.122014867581;5328.333958255218;5365.704886231295;4829.082474329866;4932.161532539477;4937.876553086202;5099.643024988215;5101.107306221396;5037.773300201499;5127.230915362651;5127.820526281637;5127.974360128175;5148.2020286855595;5103.566196873233;5171.612129090333;5173.32746742921;5177.948220517822;5207.140821764367;4872.561469467765;5025.623078269145;5032.245163225545;5135.409427915837;5143.151380022329;4193.51774545925;4281.550437204049;4286.442762440863;4305.4187684662165;4317.460317460317;3715.758475699071;3715.7956312403076;3728.1425272187007;3753.1555400035318;3753.249350129985;4358.128374325148;4483.977580112144;4485.372047913294;4489.124620698998;4519.07358991406;5046.873828154326;5102.464241254689;5128.282040514331;5148.6910785353;5196.064708352457;4456.799444025027;4499.572540608637;4511.729296242236;4543.750093744876;4547.681662283609;4354.912901742011;4475.910481790411;4569.543045695404;4575.862724118282;4607.7004994675235;4762.119007983534;4854.611631069506;4859.805607775649;4870.805167793249;4877.219644856806;5161.922571161511;5164.147915593885;5167.354080739908;5171.741412929263;5206.661566998285;4742.644301677457;4878.292647566154;4898.902021959612;4901.215805471107;4906.411230652345;4981.526754958273;4998.925016124688;5047.192449208109;5054.1155297822;5058.974705126451;5185.818496352609;5189.558887494454;5199.272101905661;5199.272101905812;5245.89508209826;4760.857174284777;4891;5006.599472042155;5009.649324547392;5014.72419016943;4903.141950158779;4914.631402644887;4991.976644787883;5004.42449118356;5039.546440820343;4927.9507204927495;4931.112399767932;4931.950680493149;4934.28452874324;4983.202687569971;4838.177509823268;4958.950410495993;5039.622028347815;5059.342285502861;5102.387713474407;4840.709557426566;4867.294242334912;4921.729304888266;4924.606031517542;4946.826861059845 02:43:55 INFO - 2015-11-17 02:43:55,381 DEBUG : BROWSER_OUTPUT: |1;ext.html;571.6970005896874;572.8940146072979;575.5769509410584;583.4719578781202;589.4017572164252;27999.580006299922;28564.857175714118;36237.63762362372;36585.45121823168;36634.816825915834;39889.40165897507;40201.597984020154;40320.59679403205;40332.39501407481;40373.39439908396;7053.259407762188;7950.880736788968;8119.147489513604;8124.553149576771;8130.349572034253;7100.893486597705;7123.074000379969;7225.638718064076;7238.855222895565;10103.595856165744;10080.495975201211;10210.621566088557;10215.540300686487;10218.386896786216;10226.33528820628;10060.698179054603;10120.342177758423;10127.442990635513;10127.493625318704;10129.848052279222;7074.610896400696;7335.926640733578;9772.31593788435;10075.143612792921;10335.121514671262;36855;37193;37244.255114897824;37275.81362093199;37350.43974340387;2743.6570428696414;2793.7764978801647;2849.5440729483184;2850.643669541307;2873.468408344442;27223.45553088927;27591;27598;27690.446191076266;28029.85985070082;3130.4521708701113;3139.717425431722;3166.1609673436556;3170.984145079283;3191.4255434021866;225361;225910;226495;227925;228298;50335.24497132546;56249.43750562524;56513;56547;56550.43449565534;47612.5238747615;63142;63411.68294158499;64297;64316.35683643197;13508.392122354519;13754.381052852446;13769.380377883019;13785.793213101811;13790.65523361904;9705.320627556004;9741;9746.074122958307;9754.268429867647;9796.853047204298;18683.346082887307;18684.626307474045;18867.3396431127;18876.433706988813;18909.14908829106;7316.780496585111;7573.431992600577;7640.083190017233;7657.731979380695;7662.846743065107;824.3075816314205;879.7580665317089;903.2773780975193;964.4261664309724;976.8095221431895;26428.339291517867;26712.465750684878;27044.59433108505;27048;29326.413471730444;921.6221349246911;993.3014545127912;1010.7927874785652;1014.9137323327452;1062.4740753326998;13518.256495892623;13762.724745505035;13816.447342106405;13901.58295251144;13903.374348154357;340810;344653;345033;345308;346813;46011.30983035257;46501.767491162325;46519.5348046522;46657;46697.766511167225;1188.8751681073536;1196.0610920427423;1215.2404747033104;1216.3006271393983;1216.8600610929857;24640;25183.622245666695;26202.475950481265;28140.155795326173;28973.275668108465;41569.37645935253;41897.79051104847;41979.37030944599;42080;42172.57827421687;262213;263313;264091;265431;265669;23646.29061128169;24191.15330963408;24239.51520969606;29193.85403072971;30025.849870750506;35903;36001.63998360088;44034.55965440433;44948;45513.544864552256;34069.82965085258;34362.484562732076;34600.65399346075;34986.12534686653;36593.45109823302;33712.66287337095;33831.3233735319;34449.827750861084;34521;34580.30839383148;33885.15287117842;34396;34491.655083448844;34549.13627159341;34588.82705586456;30348.241293966945;30771.846140769154;31223.843880780452;31265.749370025853;31321.8433907829;23703.40741481408;23738;23851.52296954086;24138.155164569154;24177.758222418255 02:43:55 INFO - 2015-11-17 02:43:55,381 DEBUG : BROWSER_OUTPUT: |2;jquery.html;328.76000519620675;333.25849983786077;333.3516310775542;335.89657973556854;337.7770671356905;9338.206252468532;9586.760330991729;10823.350598964058;15322.923385383072;15706.35083316251;15443.073415595045;15540.145292008963;15540.456084037061;16327.428540001103;16911.91544042278;5227.895442091156;5507.834764957058;5727.11229759388;6645.634490103066;6658.334166583351;3889.649931506178;4016.959830401702;6428.067930150125;6689.665516724169;6690.598564086146;6092.177556029924;6600.306967768387;6626;6659.2008958925;6660.800175994728;6583.60498370097;6642.439026828692;6651.60090394573;6662.666866656672;6691.26396096429;6196.721147548326;6344.33384494626;6381.68091595423;6389.584676996027;6408.839779005562;20985.895070524548;21051.68422473664;21079.156833726633;21163.153473861028;21855.344339669835;1827.5065732252217;1829.7712785901763;1840.8527317814542;1887.1130568632857;1975.9922439555787;13444.260565668885;13823.930880345533;13982.161070335813;13985.230812305319;14094.365753541115;1836.173721825184;1878.3989123480492;1902.2295970132118;1907.9236830526902;1931;61198;61916;62278.37721622771;62551.37448625501;63924.68037659782;15082.924585377003;15533.4858672953;15611.531654050397;15629;15634.765478517831;22637.773622263896;22801.429964250696;22833.88583057074;22858;22924.770752292265;7888.48724832884;7918.366530677532;7930.5638189898955;8170.060443049007;8326.83346333082;6601.108850305147;6777.186737591521;6791.626460544619;6827.829304267433;6833.69248383814;6350.364963503613;7441.330280274801;7585.924140758521;7588.962055189689;7608.695652173851;1058.4440871918268;1079.1474734959452;1087.0162502934857;1094.9890501094887;2058.0121541659787;402.90330320722813;434.6392494229782;449.9797509112098;455.3670398146579;458.827939522679;10168.745781355525;10938.398388088732;10952.671419857417;11030.28303160292;11035.503402346914;432.52422335430776;433.9566043395698;436.49802726863726;453.88879724467716;458.3377020205837;4879.585235254972;5880.353161152269;6022.969885150546;6140.385961403824;6161.841128433556;473403;477245;480763;485528;500942;65882;66739;67467;67701;68829;486.41144215498934;490.2450226650989;493.62731137990585;494.0637491952729;494.56478299097284;9773.853392199266;9823.26325525574;10026;10483.213758967955;10494.475276236006;32402;33157.33685326328;34050.659493404746;34459.82770086234;34472.655273446944;39208.411873821344;39747.80126099351;40772.59227407688;40978.18043639051;41419.58580414278;5954.01758709808;6016.187814645142;6221.440070393686;6238.033104868752;6247.281562620356;10634.30876992993;10639.627613033506;10711.94644026775;10722.303050301705;10781.892181078088;9200.95399522998;9480.620775169193;9531.857022144535;9617.663381781604;9759;9732.221422286058;9756.268279878896;9862;9889.406635601887;10154.746131346776;10162.593496260066;10200.489975501343;10339.0694837465;10340.793184136426;10376.636817711344;5624.184493248538;5715.514181294637;6031;6144.324124346408;6147.293061297829;9919.504024798876;10070.44612546317;10094.646687365906;10269;10285.43430111351 02:43:55 INFO - 2015-11-17 02:43:55,382 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1506.8041154649893;1557.953261402158;1614.2251719174797;1622.521356199921;1657.2376706714904;6021.096835474681;6193.411625895533;7026.929730702692;7365.116186057668;7380.114386273648;6974.476914231427;7151.5351502152325;7221.097362829646;7234.204237533867;7243.348098671118;2043.9080241389136;2071.989640051798;2079.480129967508;2081.864678795881;2083.802038806311;1762.6915289824294;1821.8087100854418;2027.1789925080366;2040.7653119891254;2089.7387826521685;2031.8374530037636;2038.1949130093603;2041.7039529268247;2041.867278626892;2042.9284975025878;1995.4612254691224;2034.9593008139755;2039.5207126325377;2040.1125510403022;2042.2749923777142;2044.672852343618;2048.539078707294;2075.0351086744586;2091.288961752996;2097.25547430663;7147.356737893615;7341.706331746724;7359.558426494374;7362.742304019387;7371.741989030412;4060.796960151981;4075.4294398784195;4122.154958233555;4122.2786012447705;4125.092479654501;2768.280247135739;2812.1985234208355;2824.025711129657;2828.0243316056135;2852.6434195725533;907.5416914458223;917.5870858113875;936.5317341329335;940.6942743608287;957.5738796235678;9842.704718858446;9852.162566181883;9873.062059104373;9876.209903207726;9876.802463950753;3843.6925045996813;3891.0661441253897;3927.332353499855;3946.723729338919;3995.340768773178;8498.277646400002;8504.192101750325;8508.829823403497;8518.616662250213;8527.616257268437;4336.848210312624;4350.042990542076;4355.412019377407;4371.322445021026;4375.846845360397;3908.0620651043546;3934.4688467057154;3940.192260586573;3946.4080387941463;3946.940795888064;3524.7532672712664;3543.273628906068;3551.9699287206936;3551.982240088783;3578.534790477221;947.9004354948227;999.0109791306554;1126.5381193710539;1136.4885801389407;1140.0366690146814;945.3193700535603;945.5933948402253;1000.8298589239847;1004.3070281505737;1204.8975837053774;6933.237343892168;7007.684654190573;7016.228214896358;7021.1574611047;7025.367716905503;1015.4212099103588;1019.23557332001;1023.4064242739342;1039.7244730146517;1068.069504224446;5340.813071542478;5445.4752669252675;5451.209574611659;5458.4814442627885;5461.371942226615;8536.103709110454;8743.256823169975;8905.955470222607;9000.414973026733;9003.684871029482;8805.339599530062;8873.600687969058;8890.244329232088;8896.466212027299;8909.55452227386;6519.7392104315295;6670.399664030164;6673.866522669519;6703.631300278434;6762.661866906635;6631.270560238273;6633.933660663524;6634.469242460688;6646.169228846395;6660.83347916306;7724.884126738216;7733.342665873239;8003.599820009093;8038.959805200937;8044.436889417684;7685.077790665156;7785.92214077852;7827.334676552329;7938.04743430792;8182.67269309221;6348.492120630431;6372.8088157353495;6420.775272865614;6423.710933007932;6428.935710642833;5963.194968679173;6905.930940690529;6950.54821436605;6974.372306492237;6981.057557229912;5618.606697531133;6163.19878415803;6416.32628573993;6446.129772480655;6531.052997315458;6298.181236439417;6351.587146835441;6384.297727249906;6430.614163150226;6452.35476452351;6562.934370656423;6562.967185164043;6604.933950660432;6609;6613.702383392855;5850.678212698343;5883.441073098049;5884.440978107073;5886.264216972879;5886.705664716833;5766.798162064308;5822.7670893163795;5836.416358364299;6019.428154325332;6054.818355449167 02:43:55 INFO - 2015-11-17 02:43:55,383 DEBUG : BROWSER_OUTPUT: |4;prototype.html;292.15275700468646;299.6973057212216;299.88454445038656;304.8643353707601;306.3459513937742;5234.110201265785;5326.254324394583;5366.812161574341;5437.755301011454;5505.504504594585;5335.146376579748;5391.487808658181;5392.325959255093;5397.379301380332;5457.154141108134;3949.1311911379453;4172.874813755577;4173.394857745625;4174.31123864562;4177.540470548237;4024.074462873541;4024.9396259055993;4116.773577453254;4161.521425036114;4161.854335098272;4086.0602061525865;4113.300738874384;4114.382842573608;4118.546959834416;4122.299209134454;3886.591907849692;3947.644711975936;3981.3430783920617;4113.506379234481;4120.3201471757275;3510.824458777051;3517.8065206413635;3522.119470132467;3522.137076416269;3523.594786599548;5202.323697919284;5212.192110222922;5216.817411390583;5222.32109825724;5242.292290540767;4660.184467718136;4670.9065818683775;4679.204535229019;4681.180793361148;4681.695689780154;5533.529649979757;5575.498205161514;5618.297712785902;5646.011947909099;5652.604317697763;3886.6113388661192;3887.941680874789;3889.8833035008997;3891.241207964448;3893.5717071122153;5845.941540584582;5932.377100404482;5950.613210141327;5951.970240148815;5967.4629283364275;4004.799760011988;4008.7594744315434;4009.1179940413062;4011.29802284599;4012.297847876668;3947.940780888289;4071.3485842265095;4071.5521292657786;4075.857344992911;4078.1435898461655;4669.18289299378;4691.929621055687;4700.670953033323;4703.482616912137;4705.058988202373;5650.29371328584;5652.97173514138;5664.801731939362;5665.405132461115;5667.263255776805;1404.5786264120723;1430.141914851081;1445.1401416157369;1445.3062529985666;1445.3784872504714;945.5319616789595;948.5636607160645;964.9469279189711;969.4764826993486;979.9510024498746;5012.699238045729;5016.2224855147515;5020.824271150565;5021.4978502150225;5024.748762561857;5869.911951320648;5876.882462350729;5880.529557635379;5880.588358814842;5881.353051164454;5008.123578373843;5010.874728131826;5013;5015.548600625888;5016.297718319438;3103.581016562735;3146.6381366142728;3166.3350696353564;3177.3327601204005;3179.8728050878167;5564.749586268627;5566.053770858964;5573.972130139324;5575.609707320448;5578.888422231614;6037.18498002764;6037.849053773691;6042.516598672096;6046.032634778414;6048.395160484004;5566.749496272678;5567.66594004361;5573.554115670737;5577.386487486292;5579.358373786985;5709.429057094423;5901.675407852609;5939.07944268639;5960.105984102246;5960.105984102419;5791.942080579309;5795.333536643171;5797.623154494944;5800.854978625568;5803;5587.55299576041;5594.664320140804;5638.9436105638415;5644.88710225785;5649.20911072442;3944.15200731844;4017.0961533654695;4026.9597304026584;4038.0712436139265;4054.027033511995;5916.053431450947;5918.053111502139;5926.170336152856;5927.762889484372;5931.991561434653;5701.8859622806485;5703.429657034263;5711.057675483665;5712.11462223356;5719.656820590778;5560.082586373203;5691.288588926384;5703;5706.115552089433;5707.258056452634;5592.2170896075395;5598.020346439438;5601.383847776823;5603.159526071122;5603.32760068778;5468.48049435303;5560.916586251128;5742.741576629145;5744.138379243147;5746.195532625519;5470.316210473691;5581.776728930798;5600.915986260128;5611.410801865745;5613.550915926634 02:43:55 INFO - 2015-11-17 02:43:55,383 DEBUG : BROWSER_OUTPUT: |5;yui.html;671.6943790575289;713.1940906775343;746.1941103608103;772.4322622872191;774.7443343696581;11626.651200463979;11910.225835320698;11944.402779861004;11946.283223006603;11956;11937.522499100025;12062.457189426475;12062.819057714141;12066.396680166;12074.094442916772;602.1299222623311;610.2951091489315;745.3738859358139;751.2262369759129;767.33242079391;763.1414658509177;763.1833937686678;763.8625047491449;769.0195001373265;770.5569297653872;627.6171535363425;805.9113497515268;812.273015650992;812.9228771877257;813.7070654564352;629.7355110853453;783.1502819440914;795.8408318336355;796.358931060496;797.1908512859452;586.4458087107685;592.5348601347964;592.8992071347881;593.0215145010724;593.2139914613155;11293.153013523937;11328.943355283252;11487.540498380054;11506.539738410453;11525.19323647345;9974.650887218913;10036.749081272954;10157.136643385322;10246.9487652562;10279.383237005804;8856.867146992736;8935.553222338856;8982.056884027214;9003.054679258648;9086.727398178065;3162.256869635634;3193.505006723938;3193.584833971592;3222.9847598006554;3267.5425440438357;41599.37600935988;41675.37486937698;41736.582634173574;41857.37213941793;41911.7904410476;6929.653517324114;6970.268121847234;7016.403605693471;7026;7098;11011.504482298316;11125.276857004268;11136.443177841238;11138.665840024812;11140.665780026613;5673.177389278614;5680.602357834912;5692.9146062809095;5800.9129863052085;5887.175795388649;3459.3600183966046;3587.677109060197;3621.1309285771226;3652.561692596852;3696.094456858087;2377.429416939922;2412.6742889709662;2413.1312727418117;2413.8189635777035;2414.2395145529104;443.0607112920629;443.66503290016476;450.8399518171002;457.92902100174524;461.0295328333809;523.4085483403729;531.1262972410364;552.7733629212004;554.1134185303482;554.1244833163591;8009.118996910335;8086.23180797835;8330.083690794008;8441.662333506714;8601.182887625666;439.6614606752846;487.8536439068265;490.80122550367156;514.4289838279507;543.7254186635723;3485.75599708018;3502.0894567412147;3524.1365865362636;3570.964290357063;3690.446433035066;54433.1835022475;54855.45144548583;54861.725691372085;54866.451335486134;55062;40786.59213407828;43120.13759724788;47887.521124789004;48603.27095093577;49027;42093.78953105215;42128.57871421308;42742.78628606899;42811.143777124904;43227;7891.921080789119;8069.435139540175;8208.75373738765;8274.627641756015;8421.747347579583;31899.68100318967;32071.95316444934;32556;33237.667623323454;33336.666633334324;38224.617753823215;38237.235255295294;39236.2152756949;42376;42552.36171457492;6397.808065758035;6405.295417503978;6863.519553631198;6955.339242771928;6987.371136597731;10405.427701476188;10529.526171322155;10609.681709548726;10622.20333474977;10631.308964917256;9961.35251208669;10003.749906252402;10136.746581335525;10297.845532317171;10370.688879333633;9120.315976301936;9283.76790580241;9292.442453452815;9520.619175232912;9564.187044101329;9220.308476864127;9373.906260937303;9384.390014649027;9603.567839447382;9711.271654626073;8048.5975701215875;8146;8233.958830205811;8292.253697167283;8442.577871106543;8243.505389676639;8299.128591497805;8373.95813020931;8479.364047696325;8507.82984340322 02:43:55 INFO - 2015-11-17 02:43:55,383 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:43:55 INFO - 2015-11-17 02:43:55,384 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:43:55 INFO - 2015-11-17 02:43:55,384 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,965 02:43:55 INFO - 2015-11-17 02:43:55,384 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:43:55 INFO - 2015-11-17 02:43:55,384 DEBUG : BROWSER_OUTPUT: __startTimestamp1447757035374__endTimestamp 02:43:55 INFO - 2015-11-17 02:43:55,384 DEBUG : BROWSER_OUTPUT: 02:43:55 INFO - 2015-11-17 02:43:55,384 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:43:55 INFO - 2015-11-17 02:43:55,384 DEBUG : BROWSER_OUTPUT: Number of tests: 6 02:43:55 INFO - 2015-11-17 02:43:55,384 DEBUG : BROWSER_OUTPUT: 02:43:55 INFO - 2015-11-17 02:43:55,384 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4730.81 Median:4859.81 stddev:496.15 (10.2%) stddev-sans-first:470.70 02:43:55 INFO - 2015-11-17 02:43:55,385 DEBUG : BROWSER_OUTPUT: Values: 2673.9 2748.4 2762.1 2771.6 2773.5 4624.5 4772.5 4782.4 4792.1 4803.3 4717.7 4729.2 4792.7 4794.7 4829.8 4387.9 4443.9 4450.2 4459.0 4486.8 4253.1 4480.4 4486.6 4527.2 4531.7 4226.1 4274.1 4340.9 4368.8 4384.8 4437.7 4437.9 4454.1 4458.3 4508.9 4176.8 4273.5 4427.6 4428.4 4471.7 4628.6 4693.7 4700.7 4710.5 4760.7 5059.0 5184.6 5195.6 5201.7 5223.8 4892.5 5007.6 5013.0 5202.1 5208.6 4685.8 4742.6 4751.7 4758.9 4804.1 5284.4 5321.0 5321.1 5328.3 5365.7 4829.1 4932.2 4937.9 5099.6 5101.1 5037.8 5127.2 5127.8 5128.0 5148.2 5103.6 5171.6 5173.3 5177.9 5207.1 4872.6 5025.6 5032.2 5135.4 5143.2 4193.5 4281.6 4286.4 4305.4 4317.5 3715.8 3715.8 3728.1 3753.2 3753.2 4358.1 4484.0 4485.4 4489.1 4519.1 5046.9 5102.5 5128.3 5148.7 5196.1 4456.8 4499.6 4511.7 4543.8 4547.7 4354.9 4475.9 4569.5 4575.9 4607.7 4762.1 4854.6 4859.8 4870.8 4877.2 5161.9 5164.1 5167.4 5171.7 5206.7 4742.6 4878.3 4898.9 4901.2 4906.4 4981.5 4998.9 5047.2 5054.1 5059.0 5185.8 5189.6 5199.3 5199.3 5245.9 4760.9 4891.0 5006.6 5009.6 5014.7 4903.1 4914.6 4992.0 5004.4 5039.5 4928.0 4931.1 4932.0 4934.3 4983.2 4838.2 4959.0 5039.6 5059.3 5102.4 4840.7 4867.3 4921.7 4924.6 4946.8 02:43:55 INFO - 2015-11-17 02:43:55,386 DEBUG : BROWSER_OUTPUT: 02:43:55 INFO - 2015-11-17 02:43:55,386 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:43777.36 Median:33977.49 stddev:74141.42 (218.2%) stddev-sans-first:74278.44 02:43:55 INFO - 2015-11-17 02:43:55,386 DEBUG : BROWSER_OUTPUT: Values: 571.7 572.9 575.6 583.5 589.4 27999.6 28564.9 36237.6 36585.5 36634.8 39889.4 40201.6 40320.6 40332.4 40373.4 7053.3 7950.9 8119.1 8124.6 8130.3 7100.9 7123.1 7225.6 7238.9 10103.6 10080.5 10210.6 10215.5 10218.4 10226.3 10060.7 10120.3 10127.4 10127.5 10129.8 7074.6 7335.9 9772.3 10075.1 10335.1 36855.0 37193.0 37244.3 37275.8 37350.4 2743.7 2793.8 2849.5 2850.6 2873.5 27223.5 27591.0 27598.0 27690.4 28029.9 3130.5 3139.7 3166.2 3171.0 3191.4 225361.0 225910.0 226495.0 227925.0 228298.0 50335.2 56249.4 56513.0 56547.0 56550.4 47612.5 63142.0 63411.7 64297.0 64316.4 13508.4 13754.4 13769.4 13785.8 13790.7 9705.3 9741.0 9746.1 9754.3 9796.9 18683.3 18684.6 18867.3 18876.4 18909.1 7316.8 7573.4 7640.1 7657.7 7662.8 824.3 879.8 903.3 964.4 976.8 26428.3 26712.5 27044.6 27048.0 29326.4 921.6 993.3 1010.8 1014.9 1062.5 13518.3 13762.7 13816.4 13901.6 13903.4 340810.0 344653.0 345033.0 345308.0 346813.0 46011.3 46501.8 46519.5 46657.0 46697.8 1188.9 1196.1 1215.2 1216.3 1216.9 24640.0 25183.6 26202.5 28140.2 28973.3 41569.4 41897.8 41979.4 42080.0 42172.6 262213.0 263313.0 264091.0 265431.0 265669.0 23646.3 24191.2 24239.5 29193.9 30025.8 35903.0 36001.6 44034.6 44948.0 45513.5 34069.8 34362.5 34600.7 34986.1 36593.5 33712.7 33831.3 34449.8 34521.0 34580.3 33885.2 34396.0 34491.7 34549.1 34588.8 30348.2 30771.8 31223.8 31265.7 31321.8 23703.4 23738.0 23851.5 24138.2 24177.8 02:43:55 INFO - 2015-11-17 02:43:55,386 DEBUG : BROWSER_OUTPUT: 02:43:55 INFO - 2015-11-17 02:43:55,386 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26059.60 Median:456.85 stddev:79049.37 (17303.0%) stddev-sans-first:79247.52 02:43:55 INFO - 2015-11-17 02:43:55,386 DEBUG : BROWSER_OUTPUT: Values: 328.8 333.3 333.4 335.9 337.8 9338.2 9586.8 10823.4 15322.9 15706.4 15443.1 15540.1 15540.5 16327.4 16911.9 5227.9 5507.8 5727.1 6645.6 6658.3 3889.6 4017.0 6428.1 6689.7 6690.6 6092.2 6600.3 6626.0 6659.2 6660.8 6583.6 6642.4 6651.6 6662.7 6691.3 6196.7 6344.3 6381.7 6389.6 6408.8 20985.9 21051.7 21079.2 21163.2 21855.3 1827.5 1829.8 1840.9 1887.1 1976.0 13444.3 13823.9 13982.2 13985.2 14094.4 1836.2 1878.4 1902.2 1907.9 1931.0 61198.0 61916.0 62278.4 62551.4 63924.7 15082.9 15533.5 15611.5 15629.0 15634.8 22637.8 22801.4 22833.9 22858.0 22924.8 7888.5 7918.4 7930.6 8170.1 8326.8 6601.1 6777.2 6791.6 6827.8 6833.7 6350.4 7441.3 7585.9 7589.0 7608.7 1058.4 1079.1 1087.0 1095.0 2058.0 402.9 434.6 450.0 455.4 458.8 10168.7 10938.4 10952.7 11030.3 11035.5 432.5 434.0 436.5 453.9 458.3 4879.6 5880.4 6023.0 6140.4 6161.8 473403.0 477245.0 480763.0 485528.0 500942.0 65882.0 66739.0 67467.0 67701.0 68829.0 486.4 490.2 493.6 494.1 494.6 9773.9 9823.3 10026.0 10483.2 10494.5 32402.0 33157.3 34050.7 34459.8 34472.7 39208.4 39747.8 40772.6 40978.2 41419.6 5954.0 6016.2 6221.4 6238.0 6247.3 10634.3 10639.6 10711.9 10722.3 10781.9 9201.0 9480.6 9531.9 9617.7 9759.0 9732.2 9756.3 9862.0 9889.4 10154.7 10162.6 10200.5 10339.1 10340.8 10376.6 5624.2 5715.5 6031.0 6144.3 6147.3 9919.5 10070.4 10094.6 10269.0 10285.4 02:43:55 INFO - 2015-11-17 02:43:55,386 DEBUG : BROWSER_OUTPUT: 02:43:55 INFO - 2015-11-17 02:43:55,386 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5042.57 Median:6245.80 stddev:2633.96 (42.2%) stddev-sans-first:2627.95 02:43:55 INFO - 2015-11-17 02:43:55,387 DEBUG : BROWSER_OUTPUT: Values: 1506.8 1558.0 1614.2 1622.5 1657.2 6021.1 6193.4 7026.9 7365.1 7380.1 6974.5 7151.5 7221.1 7234.2 7243.3 2043.9 2072.0 2079.5 2081.9 2083.8 1762.7 1821.8 2027.2 2040.8 2089.7 2031.8 2038.2 2041.7 2041.9 2042.9 1995.5 2035.0 2039.5 2040.1 2042.3 2044.7 2048.5 2075.0 2091.3 2097.3 7147.4 7341.7 7359.6 7362.7 7371.7 4060.8 4075.4 4122.2 4122.3 4125.1 2768.3 2812.2 2824.0 2828.0 2852.6 907.5 917.6 936.5 940.7 957.6 9842.7 9852.2 9873.1 9876.2 9876.8 3843.7 3891.1 3927.3 3946.7 3995.3 8498.3 8504.2 8508.8 8518.6 8527.6 4336.8 4350.0 4355.4 4371.3 4375.8 3908.1 3934.5 3940.2 3946.4 3946.9 3524.8 3543.3 3552.0 3552.0 3578.5 947.9 999.0 1126.5 1136.5 1140.0 945.3 945.6 1000.8 1004.3 1204.9 6933.2 7007.7 7016.2 7021.2 7025.4 1015.4 1019.2 1023.4 1039.7 1068.1 5340.8 5445.5 5451.2 5458.5 5461.4 8536.1 8743.3 8906.0 9000.4 9003.7 8805.3 8873.6 8890.2 8896.5 8909.6 6519.7 6670.4 6673.9 6703.6 6762.7 6631.3 6633.9 6634.5 6646.2 6660.8 7724.9 7733.3 8003.6 8039.0 8044.4 7685.1 7785.9 7827.3 7938.0 8182.7 6348.5 6372.8 6420.8 6423.7 6428.9 5963.2 6905.9 6950.5 6974.4 6981.1 5618.6 6163.2 6416.3 6446.1 6531.1 6298.2 6351.6 6384.3 6430.6 6452.4 6562.9 6563.0 6604.9 6609.0 6613.7 5850.7 5883.4 5884.4 5886.3 5886.7 5766.8 5822.8 5836.4 6019.4 6054.8 02:43:55 INFO - 2015-11-17 02:43:55,387 DEBUG : BROWSER_OUTPUT: 02:43:55 INFO - 2015-11-17 02:43:55,387 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4688.36 Median:5394.85 stddev:1400.15 (26.0%) stddev-sans-first:1364.64 02:43:55 INFO - 2015-11-17 02:43:55,388 DEBUG : BROWSER_OUTPUT: Values: 292.2 299.7 299.9 304.9 306.3 5234.1 5326.3 5366.8 5437.8 5505.5 5335.1 5391.5 5392.3 5397.4 5457.2 3949.1 4172.9 4173.4 4174.3 4177.5 4024.1 4024.9 4116.8 4161.5 4161.9 4086.1 4113.3 4114.4 4118.5 4122.3 3886.6 3947.6 3981.3 4113.5 4120.3 3510.8 3517.8 3522.1 3522.1 3523.6 5202.3 5212.2 5216.8 5222.3 5242.3 4660.2 4670.9 4679.2 4681.2 4681.7 5533.5 5575.5 5618.3 5646.0 5652.6 3886.6 3887.9 3889.9 3891.2 3893.6 5845.9 5932.4 5950.6 5952.0 5967.5 4004.8 4008.8 4009.1 4011.3 4012.3 3947.9 4071.3 4071.6 4075.9 4078.1 4669.2 4691.9 4700.7 4703.5 4705.1 5650.3 5653.0 5664.8 5665.4 5667.3 1404.6 1430.1 1445.1 1445.3 1445.4 945.5 948.6 964.9 969.5 980.0 5012.7 5016.2 5020.8 5021.5 5024.7 5869.9 5876.9 5880.5 5880.6 5881.4 5008.1 5010.9 5013.0 5015.5 5016.3 3103.6 3146.6 3166.3 3177.3 3179.9 5564.7 5566.1 5574.0 5575.6 5578.9 6037.2 6037.8 6042.5 6046.0 6048.4 5566.7 5567.7 5573.6 5577.4 5579.4 5709.4 5901.7 5939.1 5960.1 5960.1 5791.9 5795.3 5797.6 5800.9 5803.0 5587.6 5594.7 5638.9 5644.9 5649.2 3944.2 4017.1 4027.0 4038.1 4054.0 5916.1 5918.1 5926.2 5927.8 5932.0 5701.9 5703.4 5711.1 5712.1 5719.7 5560.1 5691.3 5703.0 5706.1 5707.3 5592.2 5598.0 5601.4 5603.2 5603.3 5468.5 5560.9 5742.7 5744.1 5746.2 5470.3 5581.8 5600.9 5611.4 5613.6 02:43:55 INFO - 2015-11-17 02:43:55,388 DEBUG : BROWSER_OUTPUT: 02:43:55 INFO - 2015-11-17 02:43:55,388 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12056.73 Median:54644.32 stddev:14653.17 (26.8%) stddev-sans-first:14669.33 02:43:55 INFO - 2015-11-17 02:43:55,388 DEBUG : BROWSER_OUTPUT: Values: 671.7 713.2 746.2 772.4 774.7 11626.7 11910.2 11944.4 11946.3 11956.0 11937.5 12062.5 12062.8 12066.4 12074.1 602.1 610.3 745.4 751.2 767.3 763.1 763.2 763.9 769.0 770.6 627.6 805.9 812.3 812.9 813.7 629.7 783.2 795.8 796.4 797.2 586.4 592.5 592.9 593.0 593.2 11293.2 11328.9 11487.5 11506.5 11525.2 9974.7 10036.7 10157.1 10246.9 10279.4 8856.9 8935.6 8982.1 9003.1 9086.7 3162.3 3193.5 3193.6 3223.0 3267.5 41599.4 41675.4 41736.6 41857.4 41911.8 6929.7 6970.3 7016.4 7026.0 7098.0 11011.5 11125.3 11136.4 11138.7 11140.7 5673.2 5680.6 5692.9 5800.9 5887.2 3459.4 3587.7 3621.1 3652.6 3696.1 2377.4 2412.7 2413.1 2413.8 2414.2 443.1 443.7 450.8 457.9 461.0 523.4 531.1 552.8 554.1 554.1 8009.1 8086.2 8330.1 8441.7 8601.2 439.7 487.9 490.8 514.4 543.7 3485.8 3502.1 3524.1 3571.0 3690.4 54433.2 54855.5 54861.7 54866.5 55062.0 40786.6 43120.1 47887.5 48603.3 49027.0 42093.8 42128.6 42742.8 42811.1 43227.0 7891.9 8069.4 8208.8 8274.6 8421.7 31899.7 32072.0 32556.0 33237.7 33336.7 38224.6 38237.2 39236.2 42376.0 42552.4 6397.8 6405.3 6863.5 6955.3 6987.4 10405.4 10529.5 10609.7 10622.2 10631.3 9961.4 10003.7 10136.7 10297.8 10370.7 9120.3 9283.8 9292.4 9520.6 9564.2 9220.3 9373.9 9384.4 9603.6 9711.3 8048.6 8146.0 8234.0 8292.3 8442.6 8243.5 8299.1 8374.0 8479.4 8507.8 02:43:55 INFO - 2015-11-17 02:43:55,388 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:43:55 INFO - 2015-11-17 02:43:55,388 DEBUG : BROWSER_OUTPUT: 02:43:56 INFO - 2015-11-17 02:43:56,082 INFO : Browser exited with error code: 0 02:43:56 INFO - 2015-11-17 02:43:56,098 INFO : Completed test dromaeo_css (00:18:36) 02:43:56 INFO - 2015-11-17 02:43:56,098 INFO : Starting test kraken 02:43:56 INFO - 2015-11-17 02:43:56,098 DEBUG : operating with platform_type : linux_ 02:43:56 INFO - 2015-11-17 02:43:56,098 INFO : Initialising browser for kraken test... 02:43:56 INFO - 2015-11-17 02:43:56,104 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKMxUNu/profile http://localhost:43355/getInfo.html 02:43:59 INFO - 2015-11-17 02:43:59,760 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:43:59 INFO - 2015-11-17 02:43:59,760 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:43:59 INFO - 2015-11-17 02:43:59,760 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:43:59 INFO - 2015-11-17 02:43:59,760 DEBUG : BROWSER_OUTPUT: __metrics 02:43:59 INFO - 2015-11-17 02:43:59,881 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:44:00 INFO - 2015-11-17 02:44:00,975 INFO : Browser initialized. 02:44:00 INFO - 2015-11-17 02:44:00,975 INFO : Running cycle 1/1 for kraken test... 02:44:00 INFO - 2015-11-17 02:44:00,975 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKMxUNu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:44:12 INFO - 2015-11-17 02:44:12,891 DEBUG : BROWSER_OUTPUT: RSS: Main: 141885440 02:44:12 INFO - 2015-11-17 02:44:12,892 DEBUG : BROWSER_OUTPUT: 02:44:15 INFO - 2015-11-17 02:44:15,453 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43355/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43355/tests/kraken/driver.html?testName=audio-beat-detection) 02:44:16 INFO - 2015-11-17 02:44:16,034 DEBUG : BROWSER_OUTPUT: RSS: Main: 179404800 02:44:16 INFO - 2015-11-17 02:44:16,034 DEBUG : BROWSER_OUTPUT: 02:44:18 INFO - 2015-11-17 02:44:18,764 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43355/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43355/tests/kraken/driver.html?testName=audio-dft) 02:44:19 INFO - 2015-11-17 02:44:19,345 DEBUG : BROWSER_OUTPUT: RSS: Main: 168620032 02:44:19 INFO - 2015-11-17 02:44:19,346 DEBUG : BROWSER_OUTPUT: 02:44:22 INFO - 2015-11-17 02:44:22,345 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43355/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43355/tests/kraken/driver.html?testName=audio-fft) 02:44:22 INFO - 2015-11-17 02:44:22,917 DEBUG : BROWSER_OUTPUT: RSS: Main: 151531520 02:44:22 INFO - 2015-11-17 02:44:22,918 DEBUG : BROWSER_OUTPUT: 02:44:24 INFO - 2015-11-17 02:44:24,934 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43355/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43355/tests/kraken/driver.html?testName=audio-oscillator) 02:44:25 INFO - 2015-11-17 02:44:25,501 DEBUG : BROWSER_OUTPUT: RSS: Main: 154230784 02:44:25 INFO - 2015-11-17 02:44:25,501 DEBUG : BROWSER_OUTPUT: 02:44:27 INFO - 2015-11-17 02:44:27,720 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43355/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43355/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:44:28 INFO - 2015-11-17 02:44:28,289 DEBUG : BROWSER_OUTPUT: RSS: Main: 156667904 02:44:28 INFO - 2015-11-17 02:44:28,289 DEBUG : BROWSER_OUTPUT: 02:44:31 INFO - 2015-11-17 02:44:31,300 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43355/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43355/tests/kraken/driver.html?testName=imaging-darkroom) 02:44:31 INFO - 2015-11-17 02:44:31,882 DEBUG : BROWSER_OUTPUT: RSS: Main: 157044736 02:44:31 INFO - 2015-11-17 02:44:31,882 DEBUG : BROWSER_OUTPUT: 02:44:35 INFO - 2015-11-17 02:44:35,315 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43355/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43355/tests/kraken/driver.html?testName=imaging-desaturate) 02:44:35 INFO - 2015-11-17 02:44:35,888 DEBUG : BROWSER_OUTPUT: RSS: Main: 155705344 02:44:35 INFO - 2015-11-17 02:44:35,889 DEBUG : BROWSER_OUTPUT: 02:44:38 INFO - 2015-11-17 02:44:38,776 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43355/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43355/tests/kraken/driver.html?testName=json-parse-financial) 02:44:39 INFO - 2015-11-17 02:44:39,357 DEBUG : BROWSER_OUTPUT: RSS: Main: 157548544 02:44:39 INFO - 2015-11-17 02:44:39,358 DEBUG : BROWSER_OUTPUT: 02:44:41 INFO - 2015-11-17 02:44:41,168 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43355/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43355/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:44:41 INFO - 2015-11-17 02:44:41,741 DEBUG : BROWSER_OUTPUT: RSS: Main: 164708352 02:44:41 INFO - 2015-11-17 02:44:41,741 DEBUG : BROWSER_OUTPUT: 02:44:43 INFO - 2015-11-17 02:44:43,617 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43355/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43355/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:44:44 INFO - 2015-11-17 02:44:44,218 DEBUG : BROWSER_OUTPUT: RSS: Main: 165969920 02:44:44 INFO - 2015-11-17 02:44:44,219 DEBUG : BROWSER_OUTPUT: 02:44:46 INFO - 2015-11-17 02:44:46,343 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43355/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43355/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:44:46 INFO - 2015-11-17 02:44:46,916 DEBUG : BROWSER_OUTPUT: RSS: Main: 168357888 02:44:46 INFO - 2015-11-17 02:44:46,916 DEBUG : BROWSER_OUTPUT: 02:44:49 INFO - 2015-11-17 02:44:49,457 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43355/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43355/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:44:50 INFO - 2015-11-17 02:44:50,043 DEBUG : BROWSER_OUTPUT: RSS: Main: 178978816 02:44:50 INFO - 2015-11-17 02:44:50,043 DEBUG : BROWSER_OUTPUT: 02:44:52 INFO - 2015-11-17 02:44:52,651 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43355/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43355/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:44:53 INFO - 2015-11-17 02:44:53,232 DEBUG : BROWSER_OUTPUT: RSS: Main: 176480256 02:44:53 INFO - 2015-11-17 02:44:53,232 DEBUG : BROWSER_OUTPUT: 02:44:54 INFO - 2015-11-17 02:44:54,982 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43355/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43355/tests/kraken/driver.html?testName=ai-astar) 02:44:55 INFO - 2015-11-17 02:44:55,226 DEBUG : BROWSER_OUTPUT: RSS: Main: 236167168 02:44:55 INFO - 2015-11-17 02:44:55,226 DEBUG : BROWSER_OUTPUT: 02:44:55 INFO - 2015-11-17 02:44:55,229 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:44:55 INFO - 2015-11-17 02:44:55,229 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:44:55 INFO - 2015-11-17 02:44:55,230 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:44:55 INFO - 2015-11-17 02:44:55,230 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:44:55 INFO - 2015-11-17 02:44:55,230 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;111;105;113;111;112;101;112;113;111 02:44:55 INFO - 2015-11-17 02:44:55,230 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;159;132;159;170;134;152;162;131;174;129 02:44:55 INFO - 2015-11-17 02:44:55,230 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;162;162;160;161;160;164;164;162 02:44:55 INFO - 2015-11-17 02:44:55,230 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;87;92;72;72;73;87;90;72 02:44:55 INFO - 2015-11-17 02:44:55,230 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;92;129;92;92;92;132;92;92;124 02:44:55 INFO - 2015-11-17 02:44:55,230 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;111;110;110;109;109;109;110;110;109 02:44:55 INFO - 2015-11-17 02:44:55,231 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;147;148;148;148;148;147;148;147 02:44:55 INFO - 2015-11-17 02:44:55,231 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;97;95;95;96;96;96;95;95;95 02:44:55 INFO - 2015-11-17 02:44:55,231 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;69;72;72;72;71;72;77;69;68 02:44:55 INFO - 2015-11-17 02:44:55,231 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;69;69;70;70;69;71;69;70 02:44:55 INFO - 2015-11-17 02:44:55,231 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;83;84;84;86;86;83;83;84;83 02:44:55 INFO - 2015-11-17 02:44:55,231 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;134;121;121;123;123;129;128;130;120 02:44:55 INFO - 2015-11-17 02:44:55,231 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;147;149;138;146;148;147;148;148;145;138 02:44:55 INFO - 2015-11-17 02:44:55,232 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;70;69;69;70;70;69;68;70;68 02:44:55 INFO - 2015-11-17 02:44:55,232 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:44:55 INFO - 2015-11-17 02:44:55,232 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:44:55 INFO - 2015-11-17 02:44:55,232 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,987 02:44:55 INFO - 2015-11-17 02:44:55,232 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:44:55 INFO - 2015-11-17 02:44:55,232 DEBUG : BROWSER_OUTPUT: __startTimestamp1447757095228__endTimestamp 02:44:55 INFO - 2015-11-17 02:44:55,232 DEBUG : BROWSER_OUTPUT: 02:44:55 INFO - 2015-11-17 02:44:55,240 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:44:55 INFO - 2015-11-17 02:44:55,240 DEBUG : BROWSER_OUTPUT: Number of tests: 14 02:44:55 INFO - 2015-11-17 02:44:55,240 DEBUG : BROWSER_OUTPUT: 02:44:55 INFO - 2015-11-17 02:44:55,240 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.10 Median:112.00 stddev:3.93 (3.5%) stddev-sans-first:4.11 02:44:55 INFO - 2015-11-17 02:44:55,240 DEBUG : BROWSER_OUTPUT: Values: 112.0 111.0 105.0 113.0 111.0 112.0 101.0 112.0 113.0 111.0 02:44:55 INFO - 2015-11-17 02:44:55,240 DEBUG : BROWSER_OUTPUT: 02:44:55 INFO - 2015-11-17 02:44:55,240 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.20 Median:159.00 stddev:17.22 (10.8%) stddev-sans-first:17.96 02:44:55 INFO - 2015-11-17 02:44:55,240 DEBUG : BROWSER_OUTPUT: Values: 159.0 132.0 159.0 170.0 134.0 152.0 162.0 131.0 174.0 129.0 02:44:55 INFO - 2015-11-17 02:44:55,240 DEBUG : BROWSER_OUTPUT: 02:44:55 INFO - 2015-11-17 02:44:55,241 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.42 (0.9%) stddev-sans-first:1.48 02:44:55 INFO - 2015-11-17 02:44:55,241 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 162.0 162.0 160.0 161.0 160.0 164.0 164.0 162.0 02:44:55 INFO - 2015-11-17 02:44:55,241 DEBUG : BROWSER_OUTPUT: 02:44:55 INFO - 2015-11-17 02:44:55,241 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.00 Median:80.00 stddev:8.73 (10.9%) stddev-sans-first:8.89 02:44:55 INFO - 2015-11-17 02:44:55,241 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 87.0 92.0 72.0 72.0 73.0 87.0 90.0 72.0 02:44:55 INFO - 2015-11-17 02:44:55,241 DEBUG : BROWSER_OUTPUT: 02:44:55 INFO - 2015-11-17 02:44:55,241 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.90 Median:92.00 stddev:17.65 (19.2%) stddev-sans-first:18.28 02:44:55 INFO - 2015-11-17 02:44:55,241 DEBUG : BROWSER_OUTPUT: Values: 92.0 92.0 129.0 92.0 92.0 92.0 132.0 92.0 92.0 124.0 02:44:55 INFO - 2015-11-17 02:44:55,241 DEBUG : BROWSER_OUTPUT: 02:44:55 INFO - 2015-11-17 02:44:55,241 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 02:44:55 INFO - 2015-11-17 02:44:55,241 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 110.0 110.0 109.0 109.0 109.0 110.0 110.0 109.0 02:44:55 INFO - 2015-11-17 02:44:55,241 DEBUG : BROWSER_OUTPUT: 02:44:55 INFO - 2015-11-17 02:44:55,241 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.52 (0.3%) stddev-sans-first:0.53 02:44:55 INFO - 2015-11-17 02:44:55,241 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 147.0 148.0 148.0 148.0 148.0 147.0 148.0 147.0 02:44:55 INFO - 2015-11-17 02:44:55,241 DEBUG : BROWSER_OUTPUT: 02:44:55 INFO - 2015-11-17 02:44:55,242 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 02:44:55 INFO - 2015-11-17 02:44:55,242 DEBUG : BROWSER_OUTPUT: Values: 95.0 97.0 95.0 95.0 96.0 96.0 96.0 95.0 95.0 95.0 02:44:55 INFO - 2015-11-17 02:44:55,242 DEBUG : BROWSER_OUTPUT: 02:44:55 INFO - 2015-11-17 02:44:55,242 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.30 Median:72.00 stddev:2.50 (3.5%) stddev-sans-first:2.65 02:44:55 INFO - 2015-11-17 02:44:55,242 DEBUG : BROWSER_OUTPUT: Values: 71.0 69.0 72.0 72.0 72.0 71.0 72.0 77.0 69.0 68.0 02:44:55 INFO - 2015-11-17 02:44:55,242 DEBUG : BROWSER_OUTPUT: 02:44:55 INFO - 2015-11-17 02:44:55,242 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:69.50 stddev:0.84 (1.2%) stddev-sans-first:0.73 02:44:55 INFO - 2015-11-17 02:44:55,242 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 69.0 70.0 70.0 69.0 71.0 69.0 70.0 02:44:55 INFO - 2015-11-17 02:44:55,242 DEBUG : BROWSER_OUTPUT: 02:44:55 INFO - 2015-11-17 02:44:55,242 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:84.00 stddev:1.20 (1.4%) stddev-sans-first:1.22 02:44:55 INFO - 2015-11-17 02:44:55,242 DEBUG : BROWSER_OUTPUT: Values: 83.0 83.0 84.0 84.0 86.0 86.0 83.0 83.0 84.0 83.0 02:44:55 INFO - 2015-11-17 02:44:55,242 DEBUG : BROWSER_OUTPUT: 02:44:55 INFO - 2015-11-17 02:44:55,242 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.70 Median:128.00 stddev:4.72 (3.7%) stddev-sans-first:4.93 02:44:55 INFO - 2015-11-17 02:44:55,242 DEBUG : BROWSER_OUTPUT: Values: 128.0 134.0 121.0 121.0 123.0 123.0 129.0 128.0 130.0 120.0 02:44:55 INFO - 2015-11-17 02:44:55,242 DEBUG : BROWSER_OUTPUT: 02:44:55 INFO - 2015-11-17 02:44:55,243 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.40 Median:147.50 stddev:4.06 (2.8%) stddev-sans-first:4.27 02:44:55 INFO - 2015-11-17 02:44:55,243 DEBUG : BROWSER_OUTPUT: Values: 147.0 149.0 138.0 146.0 148.0 147.0 148.0 148.0 145.0 138.0 02:44:55 INFO - 2015-11-17 02:44:55,243 DEBUG : BROWSER_OUTPUT: 02:44:55 INFO - 2015-11-17 02:44:55,243 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.50 stddev:0.79 (1.1%) stddev-sans-first:0.83 02:44:55 INFO - 2015-11-17 02:44:55,243 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 69.0 69.0 70.0 70.0 69.0 68.0 70.0 68.0 02:44:55 INFO - 2015-11-17 02:44:55,243 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:44:55 INFO - 2015-11-17 02:44:55,243 DEBUG : BROWSER_OUTPUT: 02:44:56 INFO - 2015-11-17 02:44:56,141 INFO : Browser exited with error code: 0 02:44:56 INFO - 2015-11-17 02:44:56,200 INFO : Completed test kraken (00:01:00) 02:44:56 INFO - 2015-11-17 02:44:56,200 INFO : Starting test v8_7 02:44:56 INFO - 2015-11-17 02:44:56,200 DEBUG : operating with platform_type : linux_ 02:44:56 INFO - 2015-11-17 02:44:56,200 INFO : Initialising browser for v8_7 test... 02:44:56 INFO - 2015-11-17 02:44:56,206 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJXk1CO/profile http://localhost:43355/getInfo.html 02:44:59 INFO - 2015-11-17 02:44:59,904 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:44:59 INFO - 2015-11-17 02:44:59,904 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:44:59 INFO - 2015-11-17 02:44:59,904 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:44:59 INFO - 2015-11-17 02:44:59,904 DEBUG : BROWSER_OUTPUT: __metrics 02:44:59 INFO - 2015-11-17 02:44:59,992 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:45:01 INFO - 2015-11-17 02:45:01,211 INFO : Browser initialized. 02:45:01 INFO - 2015-11-17 02:45:01,212 INFO : Running cycle 1/1 for v8_7 test... 02:45:01 INFO - 2015-11-17 02:45:01,212 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJXk1CO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:45:13 INFO - 2015-11-17 02:45:13,135 DEBUG : BROWSER_OUTPUT: RSS: Main: 141574144 02:45:13 INFO - 2015-11-17 02:45:13,136 DEBUG : BROWSER_OUTPUT: 02:45:34 INFO - 2015-11-17 02:45:34,556 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43355/tests/v8_7/run.html (next: http://localhost:43355/tests/v8_7/run.html) 02:45:34 INFO - 2015-11-17 02:45:34,813 DEBUG : BROWSER_OUTPUT: RSS: Main: 431661056 02:45:34 INFO - 2015-11-17 02:45:34,814 DEBUG : BROWSER_OUTPUT: 02:45:34 INFO - 2015-11-17 02:45:34,814 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:45:34 INFO - 2015-11-17 02:45:34,814 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:45:34 INFO - 2015-11-17 02:45:34,814 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:45:34 INFO - 2015-11-17 02:45:34,814 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:45:34 INFO - 2015-11-17 02:45:34,814 DEBUG : BROWSER_OUTPUT: |0;Richards;162.78691193228065 02:45:34 INFO - 2015-11-17 02:45:34,814 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.3238308179616 02:45:34 INFO - 2015-11-17 02:45:34,814 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.97780275358247 02:45:34 INFO - 2015-11-17 02:45:34,814 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5045.226130653266 02:45:34 INFO - 2015-11-17 02:45:34,814 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2066.115702479339 02:45:34 INFO - 2015-11-17 02:45:34,814 DEBUG : BROWSER_OUTPUT: |5;Earley;809.7165991902834 02:45:34 INFO - 2015-11-17 02:45:34,814 DEBUG : BROWSER_OUTPUT: |6;Boyer;11952.941176470587 02:45:34 INFO - 2015-11-17 02:45:34,814 DEBUG : BROWSER_OUTPUT: |7;RegExp;26842.105263157893 02:45:34 INFO - 2015-11-17 02:45:34,814 DEBUG : BROWSER_OUTPUT: |8;Splay;609.2513694461351 02:45:34 INFO - 2015-11-17 02:45:34,814 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4817.307692307692 02:45:34 INFO - 2015-11-17 02:45:34,815 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:45:34 INFO - 2015-11-17 02:45:34,815 DEBUG : BROWSER_OUTPUT: __startTimestamp1447757134807__endTimestamp 02:45:34 INFO - 2015-11-17 02:45:34,815 DEBUG : BROWSER_OUTPUT: 02:45:34 INFO - 2015-11-17 02:45:34,815 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:45:34 INFO - 2015-11-17 02:45:34,815 DEBUG : BROWSER_OUTPUT: Number of tests: 10 02:45:34 INFO - 2015-11-17 02:45:34,815 DEBUG : BROWSER_OUTPUT: 02:45:34 INFO - 2015-11-17 02:45:34,815 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.79 Median:162.79 stddev:0.00 (0.0%) 02:45:34 INFO - 2015-11-17 02:45:34,816 DEBUG : BROWSER_OUTPUT: Values: 162.8 02:45:34 INFO - 2015-11-17 02:45:34,816 DEBUG : BROWSER_OUTPUT: 02:45:34 INFO - 2015-11-17 02:45:34,816 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.32 Median:186.32 stddev:0.00 (0.0%) 02:45:34 INFO - 2015-11-17 02:45:34,816 DEBUG : BROWSER_OUTPUT: Values: 186.3 02:45:34 INFO - 2015-11-17 02:45:34,816 DEBUG : BROWSER_OUTPUT: 02:45:34 INFO - 2015-11-17 02:45:34,816 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.98 Median:280.98 stddev:0.00 (0.0%) 02:45:34 INFO - 2015-11-17 02:45:34,816 DEBUG : BROWSER_OUTPUT: Values: 281.0 02:45:34 INFO - 2015-11-17 02:45:34,816 DEBUG : BROWSER_OUTPUT: 02:45:34 INFO - 2015-11-17 02:45:34,816 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5045.23 Median:5045.23 stddev:0.00 (0.0%) 02:45:34 INFO - 2015-11-17 02:45:34,816 DEBUG : BROWSER_OUTPUT: Values: 5045.2 02:45:34 INFO - 2015-11-17 02:45:34,816 DEBUG : BROWSER_OUTPUT: 02:45:34 INFO - 2015-11-17 02:45:34,816 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2066.12 Median:2066.12 stddev:0.00 (0.0%) 02:45:34 INFO - 2015-11-17 02:45:34,816 DEBUG : BROWSER_OUTPUT: Values: 2066.1 02:45:34 INFO - 2015-11-17 02:45:34,817 DEBUG : BROWSER_OUTPUT: 02:45:34 INFO - 2015-11-17 02:45:34,817 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:809.72 Median:809.72 stddev:0.00 (0.0%) 02:45:34 INFO - 2015-11-17 02:45:34,817 DEBUG : BROWSER_OUTPUT: Values: 809.7 02:45:34 INFO - 2015-11-17 02:45:34,817 DEBUG : BROWSER_OUTPUT: 02:45:34 INFO - 2015-11-17 02:45:34,817 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11952.94 Median:11952.94 stddev:0.00 (0.0%) 02:45:34 INFO - 2015-11-17 02:45:34,817 DEBUG : BROWSER_OUTPUT: Values: 11952.9 02:45:34 INFO - 2015-11-17 02:45:34,817 DEBUG : BROWSER_OUTPUT: 02:45:34 INFO - 2015-11-17 02:45:34,817 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26842.11 Median:26842.11 stddev:0.00 (0.0%) 02:45:34 INFO - 2015-11-17 02:45:34,817 DEBUG : BROWSER_OUTPUT: Values: 26842.1 02:45:34 INFO - 2015-11-17 02:45:34,817 DEBUG : BROWSER_OUTPUT: 02:45:34 INFO - 2015-11-17 02:45:34,817 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:609.25 Median:609.25 stddev:0.00 (0.0%) 02:45:34 INFO - 2015-11-17 02:45:34,817 DEBUG : BROWSER_OUTPUT: Values: 609.3 02:45:34 INFO - 2015-11-17 02:45:34,817 DEBUG : BROWSER_OUTPUT: 02:45:34 INFO - 2015-11-17 02:45:34,817 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4817.31 Median:4817.31 stddev:0.00 (0.0%) 02:45:34 INFO - 2015-11-17 02:45:34,818 DEBUG : BROWSER_OUTPUT: Values: 4817.3 02:45:34 INFO - 2015-11-17 02:45:34,818 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:45:34 INFO - 2015-11-17 02:45:34,818 DEBUG : BROWSER_OUTPUT: 02:45:35 INFO - 2015-11-17 02:45:35,766 INFO : Browser exited with error code: 0 02:45:35 INFO - 2015-11-17 02:45:35,778 INFO : Completed test v8_7 (00:00:39) 02:45:35 INFO - 2015-11-17 02:45:35,803 INFO : Completed test suite (00:20:16) 02:45:35 INFO - 2015-11-17 02:45:35,803 DEBUG : Working with test: dromaeo_css 02:45:35 INFO - 2015-11-17 02:45:35,803 DEBUG : Generating results file: dromaeo_css 02:45:35 INFO - 2015-11-17 02:45:35,805 DEBUG : Working with test: kraken 02:45:35 INFO - 2015-11-17 02:45:35,805 DEBUG : Generating results file: kraken 02:45:35 INFO - 2015-11-17 02:45:35,805 INFO : javascript benchmark 02:45:35 INFO - 2015-11-17 02:45:35,805 DEBUG : Working with test: v8_7 02:45:35 INFO - 2015-11-17 02:45:35,805 DEBUG : Generating results file: v8_7 02:45:35 INFO - 2015-11-17 02:45:35,806 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:45:35 INFO - 2015-11-17 02:45:35,938 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 02:45:35 INFO - 2015-11-17 02:45:35,938 DEBUG : process_Request line: dromaeo_css 6233.68 graph.html#tests=[[72,132,35]] 02:45:35 INFO - 2015-11-17 02:45:35,939 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:45:35 INFO - 2015-11-17 02:45:35,978 DEBUG : process_Request line: kraken 1521.60 graph.html#tests=[[232,132,35]] 02:45:35 INFO - 2015-11-17 02:45:35,979 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:45:36 INFO - 2015-11-17 02:45:36,017 DEBUG : process_Request line: v8_7 19783.97 graph.html#tests=[[230,132,35]] 02:45:36 INFO - 2015-11-17 02:45:36,018 INFO : javascript benchmark 02:45:36 INFO - 2015-11-17 02:45:36,022 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [328.76000519620675, 333.25849983786077, 333.3516310775542, 335.89657973556854, 337.7770671356905, 9338.206252468532, 9586.760330991729, 10823.350598964058, 15322.923385383072, 15706.35083316251, 15443.073415595045, 15540.145292008963, 15540.456084037061, 16327.428540001103, 16911.91544042278, 5227.895442091156, 5507.834764957058, 5727.11229759388, 6645.634490103066, 6658.334166583351, 3889.649931506178, 4016.959830401702, 6428.067930150125, 6689.665516724169, 6690.598564086146, 6092.177556029924, 6600.306967768387, 6626.0, 6659.2008958925, 6660.800175994728, 6583.60498370097, 6642.439026828692, 6651.60090394573, 6662.666866656672, 6691.26396096429, 6196.721147548326, 6344.33384494626, 6381.68091595423, 6389.584676996027, 6408.839779005562, 20985.895070524548, 21051.68422473664, 21079.156833726633, 21163.153473861028, 21855.344339669835, 1827.5065732252217, 1829.7712785901763, 1840.8527317814542, 1887.1130568632857, 1975.9922439555787, 13444.260565668885, 13823.930880345533, 13982.161070335813, 13985.230812305319, 14094.365753541115, 1836.173721825184, 1878.3989123480492, 1902.2295970132118, 1907.9236830526902, 1931.0, 61198.0, 61916.0, 62278.37721622771, 62551.37448625501, 63924.68037659782, 15082.924585377003, 15533.4858672953, 15611.531654050397, 15629.0, 15634.765478517831, 22637.773622263896, 22801.429964250696, 22833.88583057074, 22858.0, 22924.770752292265, 7888.48724832884, 7918.366530677532, 7930.5638189898955, 8170.060443049007, 8326.83346333082, 6601.108850305147, 6777.186737591521, 6791.626460544619, 6827.829304267433, 6833.69248383814, 6350.364963503613, 7441.330280274801, 7585.924140758521, 7588.962055189689, 7608.695652173851, 1058.4440871918268, 1079.1474734959452, 1087.0162502934857, 1094.9890501094887, 2058.0121541659787, 402.90330320722813, 434.6392494229782, 449.9797509112098, 455.3670398146579, 458.827939522679, 10168.745781355525, 10938.398388088732, 10952.671419857417, 11030.28303160292, 11035.503402346914, 432.52422335430776, 433.9566043395698, 436.49802726863726, 453.88879724467716, 458.3377020205837, 4879.585235254972, 5880.353161152269, 6022.969885150546, 6140.385961403824, 6161.841128433556, 473403.0, 477245.0, 480763.0, 485528.0, 500942.0, 65882.0, 66739.0, 67467.0, 67701.0, 68829.0, 486.41144215498934, 490.2450226650989, 493.62731137990585, 494.0637491952729, 494.56478299097284, 9773.853392199266, 9823.26325525574, 10026.0, 10483.213758967955, 10494.475276236006, 32402.0, 33157.33685326328, 34050.659493404746, 34459.82770086234, 34472.655273446944, 39208.411873821344, 39747.80126099351, 40772.59227407688, 40978.18043639051, 41419.58580414278, 5954.01758709808, 6016.187814645142, 6221.440070393686, 6238.033104868752, 6247.281562620356, 10634.30876992993, 10639.627613033506, 10711.94644026775, 10722.303050301705, 10781.892181078088, 9200.95399522998, 9480.620775169193, 9531.857022144535, 9617.663381781604, 9759.0, 9732.221422286058, 9756.268279878896, 9862.0, 9889.406635601887, 10154.746131346776, 10162.593496260066, 10200.489975501343, 10339.0694837465, 10340.793184136426, 10376.636817711344, 5624.184493248538, 5715.514181294637, 6031.0, 6144.324124346408, 6147.293061297829, 9919.504024798876, 10070.44612546317, 10094.646687365906, 10269.0, 10285.43430111351], "dojo.html": [2673.852938088405, 2748.3953530223357, 2762.074704973834, 2771.6396868407105, 2773.528500154974, 4624.514425985273, 4772.475027746949, 4782.354382158407, 4792.089502994433, 4803.327534145218, 4717.669763116583, 4729.21967875301, 4792.688475249106, 4794.688345257565, 4829.758512074391, 4387.868363949086, 4443.888902777424, 4450.221211288012, 4458.977705111486, 4486.798094085758, 4253.1281087377165, 4480.350349199364, 4486.618637415823, 4527.162474942146, 4531.728096314215, 4226.091390351058, 4274.059706864485, 4340.891477713082, 4368.803403846835, 4384.802683879233, 4437.711548749321, 4437.933430998538, 4454.10917816438, 4458.308962110878, 4508.864734057984, 4176.812043458021, 4273.50854651716, 4427.645788336926, 4428.424304840382, 4471.731696098244, 4628.629709623222, 4693.718376897397, 4700.694454860423, 4710.505396933307, 4760.738159401231, 5059.001694330719, 5184.5593124584075, 5195.610329225323, 5201.713905735183, 5223.843284701465, 4892.535209155125, 5007.574356179729, 5013.0, 5202.06362854686, 5208.635395522315, 4685.835995740167, 4742.644301677388, 4751.691140075884, 4758.904821903612, 4804.111239420718, 5284.392294886137, 5321.016074420668, 5321.122014867581, 5328.333958255218, 5365.704886231295, 4829.082474329866, 4932.161532539477, 4937.876553086202, 5099.643024988215, 5101.107306221396, 5037.773300201499, 5127.230915362651, 5127.820526281637, 5127.974360128175, 5148.2020286855595, 5103.566196873233, 5171.612129090333, 5173.32746742921, 5177.948220517822, 5207.140821764367, 4872.561469467765, 5025.623078269145, 5032.245163225545, 5135.409427915837, 5143.151380022329, 4193.51774545925, 4281.550437204049, 4286.442762440863, 4305.4187684662165, 4317.460317460317, 3715.758475699071, 3715.7956312403076, 3728.1425272187007, 3753.1555400035318, 3753.249350129985, 4358.128374325148, 4483.977580112144, 4485.372047913294, 4489.124620698998, 4519.07358991406, 5046.873828154326, 5102.464241254689, 5128.282040514331, 5148.6910785353, 5196.064708352457, 4456.799444025027, 4499.572540608637, 4511.729296242236, 4543.750093744876, 4547.681662283609, 4354.912901742011, 4475.910481790411, 4569.543045695404, 4575.862724118282, 4607.7004994675235, 4762.119007983534, 4854.611631069506, 4859.805607775649, 4870.805167793249, 4877.219644856806, 5161.922571161511, 5164.147915593885, 5167.354080739908, 5171.741412929263, 5206.661566998285, 4742.644301677457, 4878.292647566154, 4898.902021959612, 4901.215805471107, 4906.411230652345, 4981.526754958273, 4998.925016124688, 5047.192449208109, 5054.1155297822, 5058.974705126451, 5185.818496352609, 5189.558887494454, 5199.272101905661, 5199.272101905812, 5245.89508209826, 4760.857174284777, 4891.0, 5006.599472042155, 5009.649324547392, 5014.72419016943, 4903.141950158779, 4914.631402644887, 4991.976644787883, 5004.42449118356, 5039.546440820343, 4927.9507204927495, 4931.112399767932, 4931.950680493149, 4934.28452874324, 4983.202687569971, 4838.177509823268, 4958.950410495993, 5039.622028347815, 5059.342285502861, 5102.387713474407, 4840.709557426566, 4867.294242334912, 4921.729304888266, 4924.606031517542, 4946.826861059845], "mootools.html": [1506.8041154649893, 1557.953261402158, 1614.2251719174797, 1622.521356199921, 1657.2376706714904, 6021.096835474681, 6193.411625895533, 7026.929730702692, 7365.116186057668, 7380.114386273648, 6974.476914231427, 7151.5351502152325, 7221.097362829646, 7234.204237533867, 7243.348098671118, 2043.9080241389136, 2071.989640051798, 2079.480129967508, 2081.864678795881, 2083.802038806311, 1762.6915289824294, 1821.8087100854418, 2027.1789925080366, 2040.7653119891254, 2089.7387826521685, 2031.8374530037636, 2038.1949130093603, 2041.7039529268247, 2041.867278626892, 2042.9284975025878, 1995.4612254691224, 2034.9593008139755, 2039.5207126325377, 2040.1125510403022, 2042.2749923777142, 2044.672852343618, 2048.539078707294, 2075.0351086744586, 2091.288961752996, 2097.25547430663, 7147.356737893615, 7341.706331746724, 7359.558426494374, 7362.742304019387, 7371.741989030412, 4060.796960151981, 4075.4294398784195, 4122.154958233555, 4122.2786012447705, 4125.092479654501, 2768.280247135739, 2812.1985234208355, 2824.025711129657, 2828.0243316056135, 2852.6434195725533, 907.5416914458223, 917.5870858113875, 936.5317341329335, 940.6942743608287, 957.5738796235678, 9842.704718858446, 9852.162566181883, 9873.062059104373, 9876.209903207726, 9876.802463950753, 3843.6925045996813, 3891.0661441253897, 3927.332353499855, 3946.723729338919, 3995.340768773178, 8498.277646400002, 8504.192101750325, 8508.829823403497, 8518.616662250213, 8527.616257268437, 4336.848210312624, 4350.042990542076, 4355.412019377407, 4371.322445021026, 4375.846845360397, 3908.0620651043546, 3934.4688467057154, 3940.192260586573, 3946.4080387941463, 3946.940795888064, 3524.7532672712664, 3543.273628906068, 3551.9699287206936, 3551.982240088783, 3578.534790477221, 947.9004354948227, 999.0109791306554, 1126.5381193710539, 1136.4885801389407, 1140.0366690146814, 945.3193700535603, 945.5933948402253, 1000.8298589239847, 1004.3070281505737, 1204.8975837053774, 6933.237343892168, 7007.684654190573, 7016.228214896358, 7021.1574611047, 7025.367716905503, 1015.4212099103588, 1019.23557332001, 1023.4064242739342, 1039.7244730146517, 1068.069504224446, 5340.813071542478, 5445.4752669252675, 5451.209574611659, 5458.4814442627885, 5461.371942226615, 8536.103709110454, 8743.256823169975, 8905.955470222607, 9000.414973026733, 9003.684871029482, 8805.339599530062, 8873.600687969058, 8890.244329232088, 8896.466212027299, 8909.55452227386, 6519.7392104315295, 6670.399664030164, 6673.866522669519, 6703.631300278434, 6762.661866906635, 6631.270560238273, 6633.933660663524, 6634.469242460688, 6646.169228846395, 6660.83347916306, 7724.884126738216, 7733.342665873239, 8003.599820009093, 8038.959805200937, 8044.436889417684, 7685.077790665156, 7785.92214077852, 7827.334676552329, 7938.04743430792, 8182.67269309221, 6348.492120630431, 6372.8088157353495, 6420.775272865614, 6423.710933007932, 6428.935710642833, 5963.194968679173, 6905.930940690529, 6950.54821436605, 6974.372306492237, 6981.057557229912, 5618.606697531133, 6163.19878415803, 6416.32628573993, 6446.129772480655, 6531.052997315458, 6298.181236439417, 6351.587146835441, 6384.297727249906, 6430.614163150226, 6452.35476452351, 6562.934370656423, 6562.967185164043, 6604.933950660432, 6609.0, 6613.702383392855, 5850.678212698343, 5883.441073098049, 5884.440978107073, 5886.264216972879, 5886.705664716833, 5766.798162064308, 5822.7670893163795, 5836.416358364299, 6019.428154325332, 6054.818355449167], "ext.html": [571.6970005896874, 572.8940146072979, 575.5769509410584, 583.4719578781202, 589.4017572164252, 27999.580006299922, 28564.857175714118, 36237.63762362372, 36585.45121823168, 36634.816825915834, 39889.40165897507, 40201.597984020154, 40320.59679403205, 40332.39501407481, 40373.39439908396, 7053.259407762188, 7950.880736788968, 8119.147489513604, 8124.553149576771, 8130.349572034253, 7100.893486597705, 7123.074000379969, 7225.638718064076, 7238.855222895565, 10103.595856165744, 10080.495975201211, 10210.621566088557, 10215.540300686487, 10218.386896786216, 10226.33528820628, 10060.698179054603, 10120.342177758423, 10127.442990635513, 10127.493625318704, 10129.848052279222, 7074.610896400696, 7335.926640733578, 9772.31593788435, 10075.143612792921, 10335.121514671262, 36855.0, 37193.0, 37244.255114897824, 37275.81362093199, 37350.43974340387, 2743.6570428696414, 2793.7764978801647, 2849.5440729483184, 2850.643669541307, 2873.468408344442, 27223.45553088927, 27591.0, 27598.0, 27690.446191076266, 28029.85985070082, 3130.4521708701113, 3139.717425431722, 3166.1609673436556, 3170.984145079283, 3191.4255434021866, 225361.0, 225910.0, 226495.0, 227925.0, 228298.0, 50335.24497132546, 56249.43750562524, 56513.0, 56547.0, 56550.43449565534, 47612.5238747615, 63142.0, 63411.68294158499, 64297.0, 64316.35683643197, 13508.392122354519, 13754.381052852446, 13769.380377883019, 13785.793213101811, 13790.65523361904, 9705.320627556004, 9741.0, 9746.074122958307, 9754.268429867647, 9796.853047204298, 18683.346082887307, 18684.626307474045, 18867.3396431127, 18876.433706988813, 18909.14908829106, 7316.780496585111, 7573.431992600577, 7640.083190017233, 7657.731979380695, 7662.846743065107, 824.3075816314205, 879.7580665317089, 903.2773780975193, 964.4261664309724, 976.8095221431895, 26428.339291517867, 26712.465750684878, 27044.59433108505, 27048.0, 29326.413471730444, 921.6221349246911, 993.3014545127912, 1010.7927874785652, 1014.9137323327452, 1062.4740753326998, 13518.256495892623, 13762.724745505035, 13816.447342106405, 13901.58295251144, 13903.374348154357, 340810.0, 344653.0, 345033.0, 345308.0, 346813.0, 46011.30983035257, 46501.767491162325, 46519.5348046522, 46657.0, 46697.766511167225, 1188.8751681073536, 1196.0610920427423, 1215.2404747033104, 1216.3006271393983, 1216.8600610929857, 24640.0, 25183.622245666695, 26202.475950481265, 28140.155795326173, 28973.275668108465, 41569.37645935253, 41897.79051104847, 41979.37030944599, 42080.0, 42172.57827421687, 262213.0, 263313.0, 264091.0, 265431.0, 265669.0, 23646.29061128169, 24191.15330963408, 24239.51520969606, 29193.85403072971, 30025.849870750506, 35903.0, 36001.63998360088, 44034.55965440433, 44948.0, 45513.544864552256, 34069.82965085258, 34362.484562732076, 34600.65399346075, 34986.12534686653, 36593.45109823302, 33712.66287337095, 33831.3233735319, 34449.827750861084, 34521.0, 34580.30839383148, 33885.15287117842, 34396.0, 34491.655083448844, 34549.13627159341, 34588.82705586456, 30348.241293966945, 30771.846140769154, 31223.843880780452, 31265.749370025853, 31321.8433907829, 23703.40741481408, 23738.0, 23851.52296954086, 24138.155164569154, 24177.758222418255], "prototype.html": [292.15275700468646, 299.6973057212216, 299.88454445038656, 304.8643353707601, 306.3459513937742, 5234.110201265785, 5326.254324394583, 5366.812161574341, 5437.755301011454, 5505.504504594585, 5335.146376579748, 5391.487808658181, 5392.325959255093, 5397.379301380332, 5457.154141108134, 3949.1311911379453, 4172.874813755577, 4173.394857745625, 4174.31123864562, 4177.540470548237, 4024.074462873541, 4024.9396259055993, 4116.773577453254, 4161.521425036114, 4161.854335098272, 4086.0602061525865, 4113.300738874384, 4114.382842573608, 4118.546959834416, 4122.299209134454, 3886.591907849692, 3947.644711975936, 3981.3430783920617, 4113.506379234481, 4120.3201471757275, 3510.824458777051, 3517.8065206413635, 3522.119470132467, 3522.137076416269, 3523.594786599548, 5202.323697919284, 5212.192110222922, 5216.817411390583, 5222.32109825724, 5242.292290540767, 4660.184467718136, 4670.9065818683775, 4679.204535229019, 4681.180793361148, 4681.695689780154, 5533.529649979757, 5575.498205161514, 5618.297712785902, 5646.011947909099, 5652.604317697763, 3886.6113388661192, 3887.941680874789, 3889.8833035008997, 3891.241207964448, 3893.5717071122153, 5845.941540584582, 5932.377100404482, 5950.613210141327, 5951.970240148815, 5967.4629283364275, 4004.799760011988, 4008.7594744315434, 4009.1179940413062, 4011.29802284599, 4012.297847876668, 3947.940780888289, 4071.3485842265095, 4071.5521292657786, 4075.857344992911, 4078.1435898461655, 4669.18289299378, 4691.929621055687, 4700.670953033323, 4703.482616912137, 4705.058988202373, 5650.29371328584, 5652.97173514138, 5664.801731939362, 5665.405132461115, 5667.263255776805, 1404.5786264120723, 1430.141914851081, 1445.1401416157369, 1445.3062529985666, 1445.3784872504714, 945.5319616789595, 948.5636607160645, 964.9469279189711, 969.4764826993486, 979.9510024498746, 5012.699238045729, 5016.2224855147515, 5020.824271150565, 5021.4978502150225, 5024.748762561857, 5869.911951320648, 5876.882462350729, 5880.529557635379, 5880.588358814842, 5881.353051164454, 5008.123578373843, 5010.874728131826, 5013.0, 5015.548600625888, 5016.297718319438, 3103.581016562735, 3146.6381366142728, 3166.3350696353564, 3177.3327601204005, 3179.8728050878167, 5564.749586268627, 5566.053770858964, 5573.972130139324, 5575.609707320448, 5578.888422231614, 6037.18498002764, 6037.849053773691, 6042.516598672096, 6046.032634778414, 6048.395160484004, 5566.749496272678, 5567.66594004361, 5573.554115670737, 5577.386487486292, 5579.358373786985, 5709.429057094423, 5901.675407852609, 5939.07944268639, 5960.105984102246, 5960.105984102419, 5791.942080579309, 5795.333536643171, 5797.623154494944, 5800.854978625568, 5803.0, 5587.55299576041, 5594.664320140804, 5638.9436105638415, 5644.88710225785, 5649.20911072442, 3944.15200731844, 4017.0961533654695, 4026.9597304026584, 4038.0712436139265, 4054.027033511995, 5916.053431450947, 5918.053111502139, 5926.170336152856, 5927.762889484372, 5931.991561434653, 5701.8859622806485, 5703.429657034263, 5711.057675483665, 5712.11462223356, 5719.656820590778, 5560.082586373203, 5691.288588926384, 5703.0, 5706.115552089433, 5707.258056452634, 5592.2170896075395, 5598.020346439438, 5601.383847776823, 5603.159526071122, 5603.32760068778, 5468.48049435303, 5560.916586251128, 5742.741576629145, 5744.138379243147, 5746.195532625519, 5470.316210473691, 5581.776728930798, 5600.915986260128, 5611.410801865745, 5613.550915926634], "yui.html": [671.6943790575289, 713.1940906775343, 746.1941103608103, 772.4322622872191, 774.7443343696581, 11626.651200463979, 11910.225835320698, 11944.402779861004, 11946.283223006603, 11956.0, 11937.522499100025, 12062.457189426475, 12062.819057714141, 12066.396680166, 12074.094442916772, 602.1299222623311, 610.2951091489315, 745.3738859358139, 751.2262369759129, 767.33242079391, 763.1414658509177, 763.1833937686678, 763.8625047491449, 769.0195001373265, 770.5569297653872, 627.6171535363425, 805.9113497515268, 812.273015650992, 812.9228771877257, 813.7070654564352, 629.7355110853453, 783.1502819440914, 795.8408318336355, 796.358931060496, 797.1908512859452, 586.4458087107685, 592.5348601347964, 592.8992071347881, 593.0215145010724, 593.2139914613155, 11293.153013523937, 11328.943355283252, 11487.540498380054, 11506.539738410453, 11525.19323647345, 9974.650887218913, 10036.749081272954, 10157.136643385322, 10246.9487652562, 10279.383237005804, 8856.867146992736, 8935.553222338856, 8982.056884027214, 9003.054679258648, 9086.727398178065, 3162.256869635634, 3193.505006723938, 3193.584833971592, 3222.9847598006554, 3267.5425440438357, 41599.37600935988, 41675.37486937698, 41736.582634173574, 41857.37213941793, 41911.7904410476, 6929.653517324114, 6970.268121847234, 7016.403605693471, 7026.0, 7098.0, 11011.504482298316, 11125.276857004268, 11136.443177841238, 11138.665840024812, 11140.665780026613, 5673.177389278614, 5680.602357834912, 5692.9146062809095, 5800.9129863052085, 5887.175795388649, 3459.3600183966046, 3587.677109060197, 3621.1309285771226, 3652.561692596852, 3696.094456858087, 2377.429416939922, 2412.6742889709662, 2413.1312727418117, 2413.8189635777035, 2414.2395145529104, 443.0607112920629, 443.66503290016476, 450.8399518171002, 457.92902100174524, 461.0295328333809, 523.4085483403729, 531.1262972410364, 552.7733629212004, 554.1134185303482, 554.1244833163591, 8009.118996910335, 8086.23180797835, 8330.083690794008, 8441.662333506714, 8601.182887625666, 439.6614606752846, 487.8536439068265, 490.80122550367156, 514.4289838279507, 543.7254186635723, 3485.75599708018, 3502.0894567412147, 3524.1365865362636, 3570.964290357063, 3690.446433035066, 54433.1835022475, 54855.45144548583, 54861.725691372085, 54866.451335486134, 55062.0, 40786.59213407828, 43120.13759724788, 47887.521124789004, 48603.27095093577, 49027.0, 42093.78953105215, 42128.57871421308, 42742.78628606899, 42811.143777124904, 43227.0, 7891.921080789119, 8069.435139540175, 8208.75373738765, 8274.627641756015, 8421.747347579583, 31899.68100318967, 32071.95316444934, 32556.0, 33237.667623323454, 33336.666633334324, 38224.617753823215, 38237.235255295294, 39236.2152756949, 42376.0, 42552.36171457492, 6397.808065758035, 6405.295417503978, 6863.519553631198, 6955.339242771928, 6987.371136597731, 10405.427701476188, 10529.526171322155, 10609.681709548726, 10622.20333474977, 10631.308964917256, 9961.35251208669, 10003.749906252402, 10136.746581335525, 10297.845532317171, 10370.688879333633, 9120.315976301936, 9283.76790580241, 9292.442453452815, 9520.619175232912, 9564.187044101329, 9220.308476864127, 9373.906260937303, 9384.390014649027, 9603.567839447382, 9711.271654626073, 8048.5975701215875, 8146.0, 8233.958830205811, 8292.253697167283, 8442.577871106543, 8243.505389676639, 8299.128591497805, 8373.95813020931, 8479.364047696325, 8507.82984340322]}, "summary": {"lowerIsBetter": false, "suite": 6233.677503715622, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 7671.355283527181, "unit": "ms", "value": 7671.355283527181}, "dojo.html": {"lowerIsBetter": false, "filtered": 4699.935425682612, "unit": "ms", "value": 4699.935425682612}, "mootools.html": {"lowerIsBetter": false, "filtered": 4134.418224187441, "unit": "ms", "value": 4134.418224187441}, "ext.html": {"lowerIsBetter": false, "filtered": 17301.007634893096, "unit": "ms", "value": 17301.007634893096}, "prototype.html": {"lowerIsBetter": false, "filtered": 4234.905553038711, "unit": "ms", "value": 4234.905553038711}, "yui.html": {"lowerIsBetter": false, "filtered": 5371.900129649786, "unit": "ms", "value": 5371.900129649786}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-017"}, "testrun": {"date": 1447755919, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151117013304", "branch": "Fx-Team-Non-PGO", "revision": "ab82ff5156bc1bd4281936310439f69e07073622"}}, {"talos_counters": {}, "results": {"audio-dft": [161.0, 161.0, 162.0, 162.0, 160.0, 161.0, 160.0, 164.0, 164.0, 162.0], "ai-astar": [112.0, 111.0, 105.0, 113.0, 111.0, 112.0, 101.0, 112.0, 113.0, 111.0], "imaging-gaussian-blur": [110.0, 111.0, 110.0, 110.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0], "audio-beat-detection": [159.0, 132.0, 159.0, 170.0, 134.0, 152.0, 162.0, 131.0, 174.0, 129.0], "json-stringify-tinderbox": [68.0, 69.0, 69.0, 69.0, 70.0, 70.0, 69.0, 71.0, 69.0, 70.0], "stanford-crypto-pbkdf2": [147.0, 149.0, 138.0, 146.0, 148.0, 147.0, 148.0, 148.0, 145.0, 138.0], "json-parse-financial": [71.0, 69.0, 72.0, 72.0, 72.0, 71.0, 72.0, 77.0, 69.0, 68.0], "stanford-crypto-sha256-iterative": [69.0, 70.0, 69.0, 69.0, 70.0, 70.0, 69.0, 68.0, 70.0, 68.0], "audio-fft": [72.0, 73.0, 87.0, 92.0, 72.0, 72.0, 73.0, 87.0, 90.0, 72.0], "imaging-darkroom": [148.0, 147.0, 147.0, 148.0, 148.0, 148.0, 148.0, 147.0, 148.0, 147.0], "stanford-crypto-ccm": [128.0, 134.0, 121.0, 121.0, 123.0, 123.0, 129.0, 128.0, 130.0, 120.0], "audio-oscillator": [92.0, 92.0, 129.0, 92.0, 92.0, 92.0, 132.0, 92.0, 92.0, 124.0], "stanford-crypto-aes": [83.0, 83.0, 84.0, 84.0, 86.0, 86.0, 83.0, 83.0, 84.0, 83.0], "imaging-desaturate": [95.0, 97.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0]}, "summary": {"lowerIsBetter": true, "suite": 1521.6000000000004, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 79.0, "unit": "ms", "value": 79.0}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 145.4, "unit": "ms", "value": 145.4}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 150.2, "unit": "ms", "value": 150.2}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 125.7, "unit": "ms", "value": 125.7}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 147.6, "unit": "ms", "value": 147.6}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 71.3, "unit": "ms", "value": 71.3}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 102.9, "unit": "ms", "value": 102.9}, "ai-astar": {"lowerIsBetter": true, "filtered": 110.1, "unit": "ms", "value": 110.1}, "audio-dft": {"lowerIsBetter": true, "filtered": 161.7, "unit": "ms", "value": 161.7}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 69.2, "unit": "ms", "value": 69.2}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 69.4, "unit": "ms", "value": 69.4}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.7, "unit": "ms", "value": 109.7}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 83.9, "unit": "ms", "value": 83.9}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.5, "unit": "ms", "value": 95.5}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-017"}, "testrun": {"date": 1447755919, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151117013304", "branch": "Fx-Team-Non-PGO", "revision": "ab82ff5156bc1bd4281936310439f69e07073622"}}, {"talos_counters": {}, "results": {"DeltaBlue": [186.3238308179616], "Encrypt": [280.97780275358247], "NavierStokes": [4817.307692307692], "Decrypt": [5045.226130653266], "Splay": [609.2513694461351], "Richards": [162.78691193228065], "RegExp": [26842.105263157893], "Earley": [809.7165991902834], "Boyer": [11952.941176470587], "RayTrace": [2066.115702479339]}, "summary": {"lowerIsBetter": false, "suite": 19783.96503982523, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 354.85530600000016, "unit": "score", "value": 354.85530600000016}, "Encrypt": {"lowerIsBetter": false, "filtered": 947.3381789999996, "unit": "score", "value": 947.3381789999996}, "NavierStokes": {"lowerIsBetter": false, "filtered": 308.055888223553, "unit": "score", "value": 308.055888223553}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.75898306772911, "unit": "score", "value": 52.75898306772911}, "Splay": {"lowerIsBetter": false, "filtered": 133.7559570429571, "unit": "score", "value": 133.7559570429571}, "RegExp": {"lowerIsBetter": false, "filtered": 33.93865686274513, "unit": "score", "value": 33.93865686274513}, "Richards": {"lowerIsBetter": false, "filtered": 216.86018600000003, "unit": "score", "value": 216.86018600000003}, "Earley": {"lowerIsBetter": false, "filtered": 823.0818049999997, "unit": "score", "value": 823.0818049999997}, "Boyer": {"lowerIsBetter": false, "filtered": 55.75723917322837, "unit": "score", "value": 55.75723917322837}, "RayTrace": {"lowerIsBetter": false, "filtered": 358.1546759999999, "unit": "score", "value": 358.1546759999999}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-017"}, "testrun": {"date": 1447755919, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151117013304", "branch": "Fx-Team-Non-PGO", "revision": "ab82ff5156bc1bd4281936310439f69e07073622"}}] 02:45:36 INFO - RETURN: dromaeo_css: 6233.68 02:45:36 INFO - RETURN: kraken: 1521.60 02:45:36 INFO - RETURN: v8_7: 19783.97 02:45:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19783.97"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1521.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6233.68"}}} 02:45:36 INFO - Return code: 0 02:45:36 INFO - # TBPL SUCCESS # 02:45:36 INFO - Running post-action listener: _resource_record_post_action 02:45:36 INFO - Running post-run listener: _resource_record_post_run 02:45:37 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 0; Write bytes: 511598592; Read time: 0; Write time: 638488 02:45:37 INFO - install - Wall time: 14s; CPU: 16.0%; Read bytes: 0; Write bytes: 220704768; Read time: 0; Write time: 396844 02:45:37 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 0; Write bytes: 281575424; Read time: 0; Write time: 215032 02:45:37 INFO - Running post-run listener: _upload_blobber_files 02:45:37 INFO - Blob upload gear active. 02:45:37 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 02:45:37 INFO - Copying logs to upload dir... 02:45:37 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1260.493662 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2015-11-17 02:45:36.655140) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 02:45:36.658301) ========= 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=6587686cb2da90a5f91b3170000001be-1447755266.291346-1169291835 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/WPQbHwwLQ2GFvdSuUDLyXA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009859 build_url: 'https://queue.taskcluster.net/v1/task/WPQbHwwLQ2GFvdSuUDLyXA/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-17 02:45:36.710146) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 02:45:36.710479) ========= 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=6587686cb2da90a5f91b3170000001be-1447755266.291346-1169291835 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004528 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 02:45:36.759721) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 02:45:36.760035) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 02:45:36.760319) ========= ========= Total master_lag: 0.24 =========