builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-007 starttime: 1447517668.56 results: success (0) buildid: 20151114075932 builduid: 209b7a66f1f541e2893ae16af346779a revision: 5e3e0fe5e172ee904385ef141c32da65befb6fc1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-14 08:14:28.556790) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-14 08:14:28.557312) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-14 08:14:28.557611) ========= 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=6ef107882637bc5fc02d78b7000001c2-1447495769.677145-1085508765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.007777 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-14 08:14:28.592837) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-14 08:14:28.593215) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-14 08:14:28.645936) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 08:14:28.646188) ========= 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=6ef107882637bc5fc02d78b7000001c2-1447495769.677145-1085508765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004684 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 08:14:28.700642) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-14 08:14:28.700971) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-14 08:14:28.701332) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 08:14:28.701604) ========= 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=6ef107882637bc5fc02d78b7000001c2-1447495769.677145-1085508765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-14 08:14:30-- 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% 220M=0s 2015-11-14 08:14:30 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131834 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 08:14:28.867336) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 08:14:28.867645) ========= 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=6ef107882637bc5fc02d78b7000001c2-1447495769.677145-1085508765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019531 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 08:14:28.931204) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 08:14:28.931532) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 5e3e0fe5e172ee904385ef141c32da65befb6fc1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 5e3e0fe5e172ee904385ef141c32da65befb6fc1 --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=6ef107882637bc5fc02d78b7000001c2-1447495769.677145-1085508765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-14 08:14:30,641 truncating revision to first 12 chars 2015-11-14 08:14:30,641 Setting DEBUG logging. 2015-11-14 08:14:30,641 attempt 1/10 2015-11-14 08:14:30,641 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/5e3e0fe5e172?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-14 08:14:31,220 unpacking tar archive at: mozilla-inbound-5e3e0fe5e172/testing/mozharness/ program finished with exit code 0 elapsedTime=0.864884 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 08:14:29.821598) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-14 08:14:29.821886) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-14 08:14:29.857981) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-14 08:14:29.858227) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-14 08:14:29.858600) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-11-14 08:14:29.858902) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6ef107882637bc5fc02d78b7000001c2-1447495769.677145-1085508765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:14:31 INFO - MultiFileLogger online at 20151114 08:14:31 in /builds/slave/test 08:14:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound-Non-PGO 08:14:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:14:31 INFO - {'append_to_log': False, 08:14:31 INFO - 'base_work_dir': '/builds/slave/test', 08:14:31 INFO - 'blob_upload_branch': 'Mozilla-Inbound-Non-PGO', 08:14:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:14:31 INFO - 'branch': 'Mozilla-Inbound-Non-PGO', 08:14:31 INFO - 'buildbot_json_path': 'buildprops.json', 08:14:31 INFO - 'config_files': ('talos/linux_config.py',), 08:14:31 INFO - 'default_actions': ('clobber', 08:14:31 INFO - 'read-buildbot-config', 08:14:31 INFO - 'download-and-extract', 08:14:31 INFO - 'populate-webroot', 08:14:31 INFO - 'create-virtualenv', 08:14:31 INFO - 'install', 08:14:31 INFO - 'run-tests'), 08:14:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:14:31 INFO - 'download_minidump_stackwalk': True, 08:14:31 INFO - 'download_symbols': 'ondemand', 08:14:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:14:31 INFO - 'tooltool.py': '/tools/tooltool.py', 08:14:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:14:31 INFO - '/tools/misc-python/virtualenv.py')}, 08:14:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:14:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:14:31 INFO - 'installer_path': 'installer.exe', 08:14:31 INFO - 'log_level': 'info', 08:14:31 INFO - 'log_name': 'talos', 08:14:31 INFO - 'log_to_console': True, 08:14:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:14:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:14:31 INFO - 'opt_config_files': (), 08:14:31 INFO - 'pip_index': False, 08:14:31 INFO - 'sps_profile': False, 08:14:31 INFO - 'sps_profile_interval': 0, 08:14:31 INFO - 'suite': 'dromaeojs', 08:14:31 INFO - 'system_bits': '64', 08:14:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:14:31 INFO - 'title': 'talos-linux64-ix-007', 08:14:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:14:31 INFO - 'use_talos_json': True, 08:14:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:14:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:14:31 INFO - 'work_dir': 'build'} 08:14:31 INFO - ##### 08:14:31 INFO - ##### Running clobber step. 08:14:31 INFO - ##### 08:14:31 INFO - Running pre-action listener: _resource_record_pre_action 08:14:31 INFO - Running main action method: clobber 08:14:31 INFO - rmtree: /builds/slave/test/build 08:14:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:14:32 INFO - Running post-action listener: _resource_record_post_action 08:14:32 INFO - ##### 08:14:32 INFO - ##### Running read-buildbot-config step. 08:14:32 INFO - ##### 08:14:32 INFO - Running pre-action listener: _resource_record_pre_action 08:14:32 INFO - Running main action method: read_buildbot_config 08:14:32 INFO - Using buildbot properties: 08:14:32 INFO - { 08:14:32 INFO - "properties": { 08:14:32 INFO - "buildnumber": 2547, 08:14:32 INFO - "product": "firefox", 08:14:32 INFO - "script_repo_revision": "production", 08:14:32 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 08:14:32 INFO - "repository": "", 08:14:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound talos dromaeojs", 08:14:32 INFO - "buildid": "20151114075932", 08:14:32 INFO - "slavename": "talos-linux64-ix-007", 08:14:32 INFO - "pgo_build": "False", 08:14:32 INFO - "basedir": "/builds/slave/test", 08:14:32 INFO - "project": "", 08:14:32 INFO - "platform": "ubuntu64_hw", 08:14:32 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:14:32 INFO - "slavebuilddir": "test", 08:14:32 INFO - "scheduler": "tests-mozilla-inbound-linux64-talos", 08:14:32 INFO - "branch": "mozilla-inbound", 08:14:32 INFO - "repo_path": "integration/mozilla-inbound", 08:14:32 INFO - "stage_platform": "linux64", 08:14:32 INFO - "builduid": "209b7a66f1f541e2893ae16af346779a", 08:14:32 INFO - "revision": "5e3e0fe5e172ee904385ef141c32da65befb6fc1" 08:14:32 INFO - }, 08:14:32 INFO - "sourcestamp": { 08:14:32 INFO - "repository": "", 08:14:32 INFO - "hasPatch": false, 08:14:32 INFO - "project": "", 08:14:32 INFO - "branch": "mozilla-inbound-linux64-talos", 08:14:32 INFO - "changes": [ 08:14:32 INFO - { 08:14:32 INFO - "category": null, 08:14:32 INFO - "files": [ 08:14:32 INFO - { 08:14:32 INFO - "url": null, 08:14:32 INFO - "name": "https://queue.taskcluster.net/v1/task/otJoFawjQWqL5atyDqz7Mw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 08:14:32 INFO - } 08:14:32 INFO - ], 08:14:32 INFO - "repository": "", 08:14:32 INFO - "rev": "5e3e0fe5e172ee904385ef141c32da65befb6fc1", 08:14:32 INFO - "who": "jmuizelaar@mozilla.com", 08:14:32 INFO - "when": 1447517598, 08:14:32 INFO - "number": 6662269, 08:14:32 INFO - "comments": "Bug 1218939. Fixup GetTransformFeedbackVarying. r=jgilbert\n", 08:14:32 INFO - "project": "", 08:14:32 INFO - "at": "Sat 14 Nov 2015 08:13:18", 08:14:32 INFO - "branch": "mozilla-inbound-linux64-talos", 08:14:32 INFO - "revlink": "", 08:14:32 INFO - "properties": [ 08:14:32 INFO - [ 08:14:32 INFO - "buildid", 08:14:32 INFO - "20151114075932", 08:14:32 INFO - "Change" 08:14:32 INFO - ], 08:14:32 INFO - [ 08:14:32 INFO - "builduid", 08:14:32 INFO - "209b7a66f1f541e2893ae16af346779a", 08:14:32 INFO - "Change" 08:14:32 INFO - ], 08:14:32 INFO - [ 08:14:32 INFO - "pgo_build", 08:14:32 INFO - "False", 08:14:32 INFO - "Change" 08:14:32 INFO - ] 08:14:32 INFO - ], 08:14:32 INFO - "revision": "5e3e0fe5e172ee904385ef141c32da65befb6fc1" 08:14:32 INFO - } 08:14:32 INFO - ], 08:14:32 INFO - "revision": "5e3e0fe5e172ee904385ef141c32da65befb6fc1" 08:14:32 INFO - } 08:14:32 INFO - } 08:14:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/otJoFawjQWqL5atyDqz7Mw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 08:14:32 INFO - Running post-action listener: _resource_record_post_action 08:14:32 INFO - ##### 08:14:32 INFO - ##### Running download-and-extract step. 08:14:32 INFO - ##### 08:14:32 INFO - Running pre-action listener: _resource_record_pre_action 08:14:32 INFO - Running main action method: download_and_extract 08:14:32 INFO - mkdir: /builds/slave/test/build/tests 08:14:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:32 INFO - https://queue.taskcluster.net/v1/task/otJoFawjQWqL5atyDqz7Mw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:14:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/otJoFawjQWqL5atyDqz7Mw/artifacts/public/build/test_packages.json 08:14:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/otJoFawjQWqL5atyDqz7Mw/artifacts/public/build/test_packages.json 08:14:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/otJoFawjQWqL5atyDqz7Mw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 08:14:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/otJoFawjQWqL5atyDqz7Mw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 08:14:35 INFO - Downloaded 1302 bytes. 08:14:35 INFO - Reading from file /builds/slave/test/build/test_packages.json 08:14:35 INFO - Using the following test package requirements: 08:14:35 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 08:14:35 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:14:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:14:35 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:14:35 INFO - u'jsshell-linux-x86_64.zip'], 08:14:35 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:14:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:14:35 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 08:14:35 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:14:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:14:35 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:14:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:14:35 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:14:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:14:35 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 08:14:35 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:14:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:14:35 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:14:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:35 INFO - https://queue.taskcluster.net/v1/task/otJoFawjQWqL5atyDqz7Mw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:14:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/otJoFawjQWqL5atyDqz7Mw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:14:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/otJoFawjQWqL5atyDqz7Mw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:14:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/otJoFawjQWqL5atyDqz7Mw/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 08:14:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/otJoFawjQWqL5atyDqz7Mw/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 08:14:37 INFO - Downloaded 21277341 bytes. 08:14:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 08:14:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:14:37 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 08:14:38 INFO - Return code: 0 08:14:38 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:14: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')]} 08:14:38 INFO - https://queue.taskcluster.net/v1/task/otJoFawjQWqL5atyDqz7Mw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:14:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/otJoFawjQWqL5atyDqz7Mw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:14:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/otJoFawjQWqL5atyDqz7Mw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:14:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/otJoFawjQWqL5atyDqz7Mw/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 08:14:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/otJoFawjQWqL5atyDqz7Mw/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 08:14:39 INFO - Downloaded 21277341 bytes. 08:14: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 08:14:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:14: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 08:14:40 INFO - Return code: 0 08:14:40 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')]} 08:14:40 INFO - https://queue.taskcluster.net/v1/task/otJoFawjQWqL5atyDqz7Mw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:14:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/otJoFawjQWqL5atyDqz7Mw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 08:14:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/otJoFawjQWqL5atyDqz7Mw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 08:14:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/otJoFawjQWqL5atyDqz7Mw/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 08:14:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/otJoFawjQWqL5atyDqz7Mw/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 08:14:41 INFO - Downloaded 11131693 bytes. 08:14:41 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 08:14:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 08:14:41 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 08:14:41 INFO - Return code: 0 08:14: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')]} 08:14:41 INFO - https://queue.taskcluster.net/v1/task/otJoFawjQWqL5atyDqz7Mw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:14:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/otJoFawjQWqL5atyDqz7Mw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:14:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/otJoFawjQWqL5atyDqz7Mw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:14:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/otJoFawjQWqL5atyDqz7Mw/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 08:14:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/otJoFawjQWqL5atyDqz7Mw/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 08:14:42 INFO - Downloaded 55621799 bytes. 08:14:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/otJoFawjQWqL5atyDqz7Mw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:14:42 INFO - mkdir: /builds/slave/test/properties 08:14:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:14:42 INFO - Writing to file /builds/slave/test/properties/build_url 08:14:42 INFO - Contents: 08:14:42 INFO - build_url:https://queue.taskcluster.net/v1/task/otJoFawjQWqL5atyDqz7Mw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:14:42 INFO - Running post-action listener: _resource_record_post_action 08:14:42 INFO - Running post-action listener: set_extra_try_arguments 08:14:42 INFO - ##### 08:14:42 INFO - ##### Running populate-webroot step. 08:14:42 INFO - ##### 08:14:42 INFO - Running pre-action listener: _resource_record_pre_action 08:14:42 INFO - Running main action method: populate_webroot 08:14:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:14:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:14:42 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 08:14:42 INFO - '../fennec_ids.txt'], 08:14:42 INFO - 'tests': ['tcheck2']}, 08:14:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:14:42 INFO - '--tppagecycles', 08:14:42 INFO - '7'], 08:14:42 INFO - 'tests': ['tsvgm']}}, 08:14:42 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:14:42 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:14:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:14:42 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:14:42 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:14:42 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:14:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:14:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:42 INFO - 'talos_options': ['--e10s'], 08:14:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:14:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:42 INFO - 'tests': ['damp', 'tps']}, 08:14:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:42 INFO - 'talos_options': ['--e10s'], 08:14:42 INFO - 'tests': ['damp', 'tps']}, 08:14:42 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:14:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:14:42 INFO - 'other': {'tests': ['a11yr', 08:14:42 INFO - 'ts_paint', 08:14:42 INFO - 'tpaint', 08:14:42 INFO - 'sessionrestore', 08:14:42 INFO - 'sessionrestore_no_auto_restore']}, 08:14:42 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:14:42 INFO - 'tests': ['a11yr', 08:14:42 INFO - 'ts_paint', 08:14:42 INFO - 'tpaint', 08:14:42 INFO - 'sessionrestore', 08:14:42 INFO - 'sessionrestore_no_auto_restore']}, 08:14:42 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:14:42 INFO - 'tests': ['a11yr', 08:14:42 INFO - 'ts_paint', 08:14:42 INFO - 'tpaint', 08:14:42 INFO - 'sessionrestore', 08:14:42 INFO - 'sessionrestore_no_auto_restore']}, 08:14:42 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:14:42 INFO - 'tests': ['a11yr', 08:14:42 INFO - 'ts_paint', 08:14:42 INFO - 'tpaint', 08:14:42 INFO - 'sessionrestore', 08:14:42 INFO - 'sessionrestore_no_auto_restore']}, 08:14:42 INFO - 'other_l64': {'tests': ['a11yr', 08:14:42 INFO - 'ts_paint', 08:14:42 INFO - 'tpaint', 08:14:42 INFO - 'sessionrestore', 08:14:42 INFO - 'sessionrestore_no_auto_restore']}, 08:14:42 INFO - 'other_nol64': {'tests': ['a11yr', 08:14:42 INFO - 'ts_paint', 08:14:42 INFO - 'tpaint', 08:14:42 INFO - 'sessionrestore', 08:14:42 INFO - 'sessionrestore_no_auto_restore']}, 08:14:42 INFO - 'svgr': {'tests': ['tsvgx', 08:14:42 INFO - 'tsvgr_opacity', 08:14:42 INFO - 'tart', 08:14:42 INFO - 'tscrollx', 08:14:42 INFO - 'cart']}, 08:14:42 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:14:42 INFO - 'tests': ['tsvgx', 08:14:42 INFO - 'tsvgr_opacity', 08:14:42 INFO - 'tart', 08:14:42 INFO - 'tscrollx', 08:14:42 INFO - 'cart']}, 08:14:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:42 INFO - 'tests': ['tp5o']}, 08:14:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:42 INFO - 'talos_options': ['--e10s'], 08:14:42 INFO - 'tests': ['tp5o']}, 08:14:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:42 INFO - 'talos_options': ['--xperf_path', 08:14:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:14:42 INFO - 'tests': ['tp5n']}, 08:14:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:42 INFO - 'talos_options': ['--e10s', 08:14:42 INFO - '--xperf_path', 08:14:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:14:42 INFO - 'tests': ['tp5n']}}, 08:14:42 INFO - 'talos.zip': {'path': '', 08:14:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:14:42 INFO - Running post-action listener: _resource_record_post_action 08:14:42 INFO - ##### 08:14:42 INFO - ##### Running create-virtualenv step. 08:14:42 INFO - ##### 08:14:42 INFO - Running pre-action listener: _resource_record_pre_action 08:14:42 INFO - Running main action method: create_virtualenv 08:14:42 INFO - Creating virtualenv /builds/slave/test/build/venv 08:14:42 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 08:14:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:14:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:14:42 INFO - Using real prefix '/usr' 08:14:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:14:43 INFO - Installing distribute.............................................................................................................................................................................................done. 08:14:45 INFO - Installing pip.................done. 08:14:45 INFO - Return code: 0 08:14:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:14: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')]} 08:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14: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')]} 08:14:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:45 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 0x7f40a416bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x173d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ccac0>, '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 0x17cd9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17cde50>, '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': '6ef107882637bc5fc02d78b7000001c2-1447495769.677145-1085508765', '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 08:14:45 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 08:14:45 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 08:14:45 INFO - Using env: {'DISPLAY': ':0', 08:14:45 INFO - 'HOME': '/home/cltbld', 08:14:45 INFO - 'LANG': 'en_US.UTF-8', 08:14:45 INFO - 'LANGUAGE': 'en_US:en', 08:14:45 INFO - 'LOGNAME': 'cltbld', 08:14:45 INFO - 'MAIL': '/var/mail/cltbld', 08:14:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:45 INFO - 'MOZ_NO_REMOTE': '1', 08:14:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:45 INFO - 'NO_EM_RESTART': '1', 08:14:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:45 INFO - 'PWD': '/builds/slave/test', 08:14:45 INFO - 'SHELL': '/bin/bash', 08:14:45 INFO - 'SHLVL': '1', 08:14:45 INFO - 'TERM': 'linux', 08:14:45 INFO - 'TMOUT': '86400', 08:14:45 INFO - 'USER': 'cltbld', 08:14:45 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1447495769.677145-1085508765', 08:14:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:45 INFO - '_': '/tools/buildbot/bin/python'} 08:14:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:45 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 08:14:45 INFO - Cleaning up... 08:14:45 INFO - Return code: 0 08:14:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:14: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')]} 08:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14: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')]} 08:14:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:45 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 0x7f40a416bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x173d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ccac0>, '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 0x17cd9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17cde50>, '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': '6ef107882637bc5fc02d78b7000001c2-1447495769.677145-1085508765', '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 08:14:45 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 08:14:45 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 08:14:45 INFO - Using env: {'DISPLAY': ':0', 08:14:45 INFO - 'HOME': '/home/cltbld', 08:14:45 INFO - 'LANG': 'en_US.UTF-8', 08:14:45 INFO - 'LANGUAGE': 'en_US:en', 08:14:45 INFO - 'LOGNAME': 'cltbld', 08:14:45 INFO - 'MAIL': '/var/mail/cltbld', 08:14:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:45 INFO - 'MOZ_NO_REMOTE': '1', 08:14:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:45 INFO - 'NO_EM_RESTART': '1', 08:14:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:45 INFO - 'PWD': '/builds/slave/test', 08:14:45 INFO - 'SHELL': '/bin/bash', 08:14:45 INFO - 'SHLVL': '1', 08:14:45 INFO - 'TERM': 'linux', 08:14:45 INFO - 'TMOUT': '86400', 08:14:45 INFO - 'USER': 'cltbld', 08:14:45 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1447495769.677145-1085508765', 08:14:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:45 INFO - '_': '/tools/buildbot/bin/python'} 08:14:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:45 INFO - Downloading/unpacking psutil>=0.7.1 08:14:45 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 08:14:45 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 08:14:45 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 08:14:45 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 08:14:45 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 08:14:45 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 08:14:47 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 08:14:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:14:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:14:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:14:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:14:47 INFO - Installing collected packages: psutil 08:14:47 INFO - Running setup.py install for psutil 08:14:47 INFO - building 'psutil._psutil_linux' extension 08:14:47 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 08:14:47 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 08:14:47 INFO - building 'psutil._psutil_posix' extension 08:14:47 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 08:14:47 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 08:14:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:14:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:14:48 INFO - Successfully installed psutil 08:14:48 INFO - Cleaning up... 08:14:48 INFO - Return code: 0 08:14:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:48 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 0x7f40a416bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x173d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ccac0>, '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 0x17cd9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17cde50>, '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': '6ef107882637bc5fc02d78b7000001c2-1447495769.677145-1085508765', '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 08:14:48 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 08:14:48 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 08:14:48 INFO - Using env: {'DISPLAY': ':0', 08:14:48 INFO - 'HOME': '/home/cltbld', 08:14:48 INFO - 'LANG': 'en_US.UTF-8', 08:14:48 INFO - 'LANGUAGE': 'en_US:en', 08:14:48 INFO - 'LOGNAME': 'cltbld', 08:14:48 INFO - 'MAIL': '/var/mail/cltbld', 08:14:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:48 INFO - 'MOZ_NO_REMOTE': '1', 08:14:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:48 INFO - 'NO_EM_RESTART': '1', 08:14:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:48 INFO - 'PWD': '/builds/slave/test', 08:14:48 INFO - 'SHELL': '/bin/bash', 08:14:48 INFO - 'SHLVL': '1', 08:14:48 INFO - 'TERM': 'linux', 08:14:48 INFO - 'TMOUT': '86400', 08:14:48 INFO - 'USER': 'cltbld', 08:14:48 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1447495769.677145-1085508765', 08:14:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:48 INFO - '_': '/tools/buildbot/bin/python'} 08:14:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:14:48 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 08:14:48 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 08:14:48 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 08:14:48 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 08:14:48 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 08:14:48 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 08:14:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:14:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:14:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:14:50 INFO - Installing collected packages: mozsystemmonitor 08:14:50 INFO - Running setup.py install for mozsystemmonitor 08:14:50 INFO - Successfully installed mozsystemmonitor 08:14:50 INFO - Cleaning up... 08:14:50 INFO - Return code: 0 08:14:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:14: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')]} 08:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14: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')]} 08:14:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14: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', '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 0x7f40a416bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x173d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ccac0>, '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 0x17cd9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17cde50>, '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': '6ef107882637bc5fc02d78b7000001c2-1447495769.677145-1085508765', '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 08:14: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:14: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 blobuploader==1.2.4 08:14:50 INFO - Using env: {'DISPLAY': ':0', 08:14:50 INFO - 'HOME': '/home/cltbld', 08:14:50 INFO - 'LANG': 'en_US.UTF-8', 08:14:50 INFO - 'LANGUAGE': 'en_US:en', 08:14:50 INFO - 'LOGNAME': 'cltbld', 08:14:50 INFO - 'MAIL': '/var/mail/cltbld', 08:14:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:50 INFO - 'MOZ_NO_REMOTE': '1', 08:14:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:50 INFO - 'NO_EM_RESTART': '1', 08:14:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:50 INFO - 'PWD': '/builds/slave/test', 08:14:50 INFO - 'SHELL': '/bin/bash', 08:14:50 INFO - 'SHLVL': '1', 08:14:50 INFO - 'TERM': 'linux', 08:14:50 INFO - 'TMOUT': '86400', 08:14:50 INFO - 'USER': 'cltbld', 08:14:50 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1447495769.677145-1085508765', 08:14:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:50 INFO - '_': '/tools/buildbot/bin/python'} 08:14:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:50 INFO - Downloading/unpacking blobuploader==1.2.4 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14:52 INFO - Downloading blobuploader-1.2.4.tar.gz 08:14:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:14:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:14:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:14:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:14:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14:52 INFO - Downloading docopt-0.6.1.tar.gz 08:14:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:14:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:14:52 INFO - Installing collected packages: blobuploader, requests, docopt 08:14:52 INFO - Running setup.py install for blobuploader 08:14:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:14:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:14:52 INFO - Running setup.py install for requests 08:14:53 INFO - Running setup.py install for docopt 08:14:53 INFO - Successfully installed blobuploader requests docopt 08:14:53 INFO - Cleaning up... 08:14:53 INFO - Return code: 0 08:14:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14:53 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')]} 08:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:53 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')]} 08:14:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:53 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 0x7f40a416bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x173d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ccac0>, '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 0x17cd9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17cde50>, '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': '6ef107882637bc5fc02d78b7000001c2-1447495769.677145-1085508765', '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 08:14:53 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 08:14:53 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 08:14:53 INFO - Using env: {'DISPLAY': ':0', 08:14:53 INFO - 'HOME': '/home/cltbld', 08:14:53 INFO - 'LANG': 'en_US.UTF-8', 08:14:53 INFO - 'LANGUAGE': 'en_US:en', 08:14:53 INFO - 'LOGNAME': 'cltbld', 08:14:53 INFO - 'MAIL': '/var/mail/cltbld', 08:14:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:53 INFO - 'MOZ_NO_REMOTE': '1', 08:14:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:53 INFO - 'NO_EM_RESTART': '1', 08:14:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:53 INFO - 'PWD': '/builds/slave/test', 08:14:53 INFO - 'SHELL': '/bin/bash', 08:14:53 INFO - 'SHLVL': '1', 08:14:53 INFO - 'TERM': 'linux', 08:14:53 INFO - 'TMOUT': '86400', 08:14:53 INFO - 'USER': 'cltbld', 08:14:53 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1447495769.677145-1085508765', 08:14:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:53 INFO - '_': '/tools/buildbot/bin/python'} 08:14:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:14:53 INFO - Running setup.py (path:/tmp/pip-kbtcq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:14:53 INFO - Running setup.py (path:/tmp/pip-adncIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:14:53 INFO - Running setup.py (path:/tmp/pip-SWGymD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:14:53 INFO - Running setup.py (path:/tmp/pip-S8IZGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:14:53 INFO - Running setup.py (path:/tmp/pip-VSgNbo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:14:53 INFO - Running setup.py (path:/tmp/pip-8fqiyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:14:53 INFO - Running setup.py (path:/tmp/pip-fDbglY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:14:54 INFO - Running setup.py (path:/tmp/pip-CZNAsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:14:54 INFO - Running setup.py (path:/tmp/pip-cKiDLQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:14:54 INFO - Running setup.py (path:/tmp/pip-ZMiLc_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:14:54 INFO - Running setup.py (path:/tmp/pip-1M5hyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:14:54 INFO - Running setup.py (path:/tmp/pip-y7iwtk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:14:54 INFO - Running setup.py (path:/tmp/pip-_HI0qB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:14:54 INFO - Running setup.py (path:/tmp/pip-1KQutj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:54 INFO - Running setup.py (path:/tmp/pip-yv5yGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:14:54 INFO - Running setup.py (path:/tmp/pip-HUYeRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:14:54 INFO - Running setup.py (path:/tmp/pip-biL6v_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:14:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:14:54 INFO - Running setup.py install for manifestparser 08:14:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:14:54 INFO - Running setup.py install for mozcrash 08:14:54 INFO - Running setup.py install for mozdebug 08:14:55 INFO - Running setup.py install for mozdevice 08:14:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:14:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:14:55 INFO - Running setup.py install for mozfile 08:14:55 INFO - Running setup.py install for mozhttpd 08:14:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:14:55 INFO - Running setup.py install for mozinfo 08:14:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:14:55 INFO - Running setup.py install for mozInstall 08:14:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:14:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:14:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:14:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:14:55 INFO - Running setup.py install for mozleak 08:14:55 INFO - Running setup.py install for mozlog 08:14:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:14:55 INFO - Running setup.py install for moznetwork 08:14:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:14:55 INFO - Running setup.py install for mozprocess 08:14:55 INFO - Running setup.py install for mozprofile 08:14:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:14:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:14:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:14:56 INFO - Running setup.py install for mozrunner 08:14:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:14:56 INFO - Running setup.py install for mozscreenshot 08:14:56 INFO - Running setup.py install for moztest 08:14:56 INFO - Running setup.py install for mozversion 08:14:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:14:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:14:56 INFO - Cleaning up... 08:14:56 INFO - Return code: 0 08:14:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:56 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 0x7f40a416bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x173d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ccac0>, '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 0x17cd9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17cde50>, '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': '6ef107882637bc5fc02d78b7000001c2-1447495769.677145-1085508765', '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 08:14:56 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 08:14:56 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 08:14:56 INFO - Using env: {'DISPLAY': ':0', 08:14:56 INFO - 'HOME': '/home/cltbld', 08:14:56 INFO - 'LANG': 'en_US.UTF-8', 08:14:56 INFO - 'LANGUAGE': 'en_US:en', 08:14:56 INFO - 'LOGNAME': 'cltbld', 08:14:56 INFO - 'MAIL': '/var/mail/cltbld', 08:14:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:56 INFO - 'MOZ_NO_REMOTE': '1', 08:14:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:56 INFO - 'NO_EM_RESTART': '1', 08:14:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:56 INFO - 'PWD': '/builds/slave/test', 08:14:56 INFO - 'SHELL': '/bin/bash', 08:14:56 INFO - 'SHLVL': '1', 08:14:56 INFO - 'TERM': 'linux', 08:14:56 INFO - 'TMOUT': '86400', 08:14:56 INFO - 'USER': 'cltbld', 08:14:56 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1447495769.677145-1085508765', 08:14:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:56 INFO - '_': '/tools/buildbot/bin/python'} 08:14:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:14:56 INFO - Running setup.py (path:/tmp/pip-NMG2SH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:14:56 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)) 08:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:14:56 INFO - Running setup.py (path:/tmp/pip-ZcfD_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:14:56 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)) 08:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:14:56 INFO - Running setup.py (path:/tmp/pip-m9hMzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:14:56 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)) 08:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:14:56 INFO - Running setup.py (path:/tmp/pip-qPdtww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:14:57 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)) 08:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:14:57 INFO - Running setup.py (path:/tmp/pip-TwTNsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:14:57 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)) 08:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:14:57 INFO - Running setup.py (path:/tmp/pip-JpeYVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:14:57 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)) 08:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:14:57 INFO - Running setup.py (path:/tmp/pip-Y230h2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:14:57 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)) 08:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:14:57 INFO - Running setup.py (path:/tmp/pip-w5bb86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:14:57 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)) 08:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:14:57 INFO - Running setup.py (path:/tmp/pip-mQcnmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:14:57 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)) 08:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:14:57 INFO - Running setup.py (path:/tmp/pip-Guup0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:14:57 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)) 08:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:14:57 INFO - Running setup.py (path:/tmp/pip-tGu1sd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:14:57 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)) 08:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:14:57 INFO - Running setup.py (path:/tmp/pip-mjQIQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:14:57 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)) 08:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:14:57 INFO - Running setup.py (path:/tmp/pip-42p3uz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:14:57 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)) 08:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:14:57 INFO - Running setup.py (path:/tmp/pip-2z820T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:14:57 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)) 08:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:57 INFO - Running setup.py (path:/tmp/pip-7GMlys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:57 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)) 08:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:14:57 INFO - Running setup.py (path:/tmp/pip-VPSyFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:14:57 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)) 08:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:14:57 INFO - Running setup.py (path:/tmp/pip-EUbyaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:14:57 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)) 08:14:57 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)) 08:14:57 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)) 08:14:57 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)) 08:14:57 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)) 08:14:57 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)) 08:14:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:14:58 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 08:14:58 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 08:14:58 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 08:14:58 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 08:14:58 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 08:14:58 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 08:14:59 INFO - Downloading blessings-1.5.1.tar.gz 08:14:59 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 08:14:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:14:59 INFO - Installing collected packages: blessings 08:14:59 INFO - Running setup.py install for blessings 08:14:59 INFO - Successfully installed blessings 08:14:59 INFO - Cleaning up... 08:14:59 INFO - Return code: 0 08:14:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:14:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:14:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:15:00 INFO - Reading from file tmpfile_stdout 08:15:00 INFO - Current package versions: 08:15:00 INFO - argparse == 1.2.1 08:15:00 INFO - blessings == 1.5.1 08:15:00 INFO - blobuploader == 1.2.4 08:15:00 INFO - docopt == 0.6.1 08:15:00 INFO - manifestparser == 1.1 08:15:00 INFO - mozInstall == 1.12 08:15:00 INFO - mozcrash == 0.16 08:15:00 INFO - mozdebug == 0.1 08:15:00 INFO - mozdevice == 0.47 08:15:00 INFO - mozfile == 1.2 08:15:00 INFO - mozhttpd == 0.7 08:15:00 INFO - mozinfo == 0.9 08:15:00 INFO - mozleak == 0.1 08:15:00 INFO - mozlog == 3.0 08:15:00 INFO - moznetwork == 0.27 08:15:00 INFO - mozprocess == 0.22 08:15:00 INFO - mozprofile == 0.27 08:15:00 INFO - mozrunner == 6.11 08:15:00 INFO - mozscreenshot == 0.1 08:15:00 INFO - mozsystemmonitor == 0.0 08:15:00 INFO - moztest == 0.7 08:15:00 INFO - mozversion == 1.4 08:15:00 INFO - psutil == 3.1.1 08:15:00 INFO - requests == 1.2.3 08:15:00 INFO - wsgiref == 0.1.2 08:15:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:15:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:15:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x7f40a416bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x173d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ccac0>, '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 0x17cd9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17cde50>, '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': '6ef107882637bc5fc02d78b7000001c2-1447495769.677145-1085508765', '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 08:15:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 08:15:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/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 08:15:00 INFO - Using env: {'DISPLAY': ':0', 08:15:00 INFO - 'HOME': '/home/cltbld', 08:15:00 INFO - 'LANG': 'en_US.UTF-8', 08:15:00 INFO - 'LANGUAGE': 'en_US:en', 08:15:00 INFO - 'LOGNAME': 'cltbld', 08:15:00 INFO - 'MAIL': '/var/mail/cltbld', 08:15:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:00 INFO - 'MOZ_NO_REMOTE': '1', 08:15:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:00 INFO - 'NO_EM_RESTART': '1', 08:15:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:00 INFO - 'PWD': '/builds/slave/test', 08:15:00 INFO - 'SHELL': '/bin/bash', 08:15:00 INFO - 'SHLVL': '1', 08:15:00 INFO - 'TERM': 'linux', 08:15:00 INFO - 'TMOUT': '86400', 08:15:00 INFO - 'USER': 'cltbld', 08:15:00 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1447495769.677145-1085508765', 08:15:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:00 INFO - '_': '/tools/buildbot/bin/python'} 08:15:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:00 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)) 08:15:00 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)) 08:15:00 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)) 08:15:00 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)) 08:15:00 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)) 08:15:00 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)) 08:15:00 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)) 08:15:00 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)) 08:15:00 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)) 08:15:00 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)) 08:15:00 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)) 08:15:00 INFO - Cleaning up... 08:15:00 INFO - Return code: 0 08:15:00 INFO - Running post-action listener: _resource_record_post_action 08:15:00 INFO - Running post-action listener: _start_resource_monitoring 08:15:00 INFO - Starting resource monitoring. 08:15:00 INFO - ##### 08:15:00 INFO - ##### Running install step. 08:15:00 INFO - ##### 08:15:00 INFO - Running pre-action listener: _resource_record_pre_action 08:15:00 INFO - Running main action method: install 08:15:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:15:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:15:00 INFO - Reading from file tmpfile_stdout 08:15:00 INFO - Detecting whether we're running mozinstall >=1.0... 08:15:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:15:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:15:00 INFO - Reading from file tmpfile_stdout 08:15:00 INFO - Output received: 08:15:00 INFO - Usage: mozinstall [options] installer 08:15:00 INFO - Options: 08:15:00 INFO - -h, --help show this help message and exit 08:15:00 INFO - -d DEST, --destination=DEST 08:15:00 INFO - Directory to install application into. [default: 08:15:00 INFO - "/builds/slave/test"] 08:15:00 INFO - --app=APP Application being installed. [default: firefox] 08:15:00 INFO - mkdir: /builds/slave/test/build/application 08:15:00 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'] 08:15:00 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 08:15:14 INFO - Reading from file tmpfile_stdout 08:15:14 INFO - Output received: 08:15:14 INFO - /builds/slave/test/build/application/firefox/firefox 08:15:14 INFO - Running post-action listener: _resource_record_post_action 08:15:14 INFO - ##### 08:15:14 INFO - ##### Running run-tests step. 08:15:14 INFO - ##### 08:15:14 INFO - Running pre-action listener: _resource_record_pre_action 08:15:14 INFO - Running main action method: run_tests 08:15:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:15:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:15:14 INFO - Python 2.7.3 08:15:14 INFO - Return code: 0 08:15:14 INFO - grabbing minidump binary from tooltool 08:15:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:15:14 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 0x17ccac0>, '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 0x17cd9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17cde50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:15:14 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 08:15:14 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 08:15:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:15:14 INFO - Return code: 0 08:15:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:15:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:15:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:15:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:15:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:15:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/otJoFawjQWqL5atyDqz7Mw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost'] in /builds/slave/test/build 08:15:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/otJoFawjQWqL5atyDqz7Mw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --webServer localhost 08:15:14 INFO - Using env: {'DISPLAY': ':0', 08:15:14 INFO - 'HOME': '/home/cltbld', 08:15:14 INFO - 'LANG': 'en_US.UTF-8', 08:15:14 INFO - 'LANGUAGE': 'en_US:en', 08:15:14 INFO - 'LOGNAME': 'cltbld', 08:15:14 INFO - 'MAIL': '/var/mail/cltbld', 08:15:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:15:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:15:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:14 INFO - 'MOZ_NO_REMOTE': '1', 08:15:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:15:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:14 INFO - 'NO_EM_RESTART': '1', 08:15:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:14 INFO - 'PWD': '/builds/slave/test', 08:15:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:15:14 INFO - 'SHELL': '/bin/bash', 08:15:14 INFO - 'SHLVL': '1', 08:15:14 INFO - 'TERM': 'linux', 08:15:14 INFO - 'TMOUT': '86400', 08:15:14 INFO - 'USER': 'cltbld', 08:15:14 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1447495769.677145-1085508765', 08:15:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:14 INFO - '_': '/tools/buildbot/bin/python'} 08:15:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/otJoFawjQWqL5atyDqz7Mw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost'] with output_timeout 3600 08:15:14 INFO - mozversion INFO | application_buildid: 20151114075932 08:15:14 INFO - mozversion INFO | application_changeset: 5e3e0fe5e172ee904385ef141c32da65befb6fc1 08:15:14 INFO - mozversion INFO | application_display_name: Nightly 08:15:14 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:15:14 INFO - mozversion INFO | application_name: Firefox 08:15:14 INFO - mozversion INFO | application_remotingname: firefox 08:15:14 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 08:15:14 INFO - mozversion INFO | application_vendor: Mozilla 08:15:14 INFO - mozversion INFO | application_version: 45.0a1 08:15:14 INFO - mozversion INFO | platform_buildid: 20151114075932 08:15:14 INFO - mozversion INFO | platform_changeset: 5e3e0fe5e172ee904385ef141c32da65befb6fc1 08:15:14 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 08:15:14 INFO - mozversion INFO | platform_version: 45.0a1 08:15:14 INFO - 2015-11-14 08:15:14,967 DEBUG : using testdate: 1447517714 08:15:14 INFO - 2015-11-14 08:15:14,967 DEBUG : actual date: 1447517714 08:15:14 INFO - 2015-11-14 08:15:14,976 INFO : starting webserver on 'localhost:35817' 08:15:14 INFO - 2015-11-14 08:15:14,977 INFO : Starting test suite talos-linux64-ix-007 08:15:14 INFO - 2015-11-14 08:15:14,978 INFO : Starting test dromaeo_css 08:15:14 INFO - 2015-11-14 08:15:14,978 DEBUG : operating with platform_type : linux_ 08:15:14 INFO - 2015-11-14 08:15:14,978 INFO : Initialising browser for dromaeo_css test... 08:15:14 INFO - 2015-11-14 08:15:14,995 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph55AhS/profile http://localhost:35817/getInfo.html 08:15:19 INFO - 2015-11-14 08:15:19,949 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:15:19 INFO - 2015-11-14 08:15:19,950 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:15:19 INFO - 2015-11-14 08:15:19,950 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:15:19 INFO - 2015-11-14 08:15:19,950 DEBUG : BROWSER_OUTPUT: __metrics 08:15:20 INFO - 2015-11-14 08:15:20,071 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:15:21 INFO - 2015-11-14 08:15:21,365 INFO : Browser initialized. 08:15:21 INFO - 2015-11-14 08:15:21,365 INFO : Running cycle 1/1 for dromaeo_css test... 08:15:21 INFO - 2015-11-14 08:15:21,366 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph55AhS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:15:33 INFO - 2015-11-14 08:15:33,302 DEBUG : BROWSER_OUTPUT: RSS: Main: 141164544 08:15:33 INFO - 2015-11-14 08:15:33,303 DEBUG : BROWSER_OUTPUT: 08:16:25 INFO - 2015-11-14 08:16:25,027 DEBUG : BROWSER_OUTPUT: 1447517785019 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] 08:18:36 INFO - 2015-11-14 08:18:36,929 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35817/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35817/tests/dromaeo/cssquery-ext.html) 08:18:38 INFO - 2015-11-14 08:18:38,094 DEBUG : BROWSER_OUTPUT: RSS: Main: 252997632 08:18:38 INFO - 2015-11-14 08:18:38,094 DEBUG : BROWSER_OUTPUT: 08:21:40 INFO - 2015-11-14 08:21:40,632 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35817/tests/dromaeo/cssquery-ext.html (next: http://localhost:35817/tests/dromaeo/cssquery-jquery.html) 08:21:41 INFO - 2015-11-14 08:21:41,206 DEBUG : BROWSER_OUTPUT: RSS: Main: 212377600 08:21:41 INFO - 2015-11-14 08:21:41,206 DEBUG : BROWSER_OUTPUT: 08:24:43 INFO - 2015-11-14 08:24:43,251 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35817/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35817/tests/dromaeo/cssquery-mootools.html) 08:24:43 INFO - 2015-11-14 08:24:43,824 DEBUG : BROWSER_OUTPUT: RSS: Main: 206217216 08:24:43 INFO - 2015-11-14 08:24:43,824 DEBUG : BROWSER_OUTPUT: 08:27:45 INFO - 2015-11-14 08:27:45,752 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35817/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35817/tests/dromaeo/cssquery-prototype.html) 08:27:46 INFO - 2015-11-14 08:27:46,337 DEBUG : BROWSER_OUTPUT: RSS: Main: 199213056 08:27:46 INFO - 2015-11-14 08:27:46,338 DEBUG : BROWSER_OUTPUT: 08:30:49 INFO - 2015-11-14 08:30:49,088 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35817/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35817/tests/dromaeo/cssquery-yui.html) 08:30:49 INFO - 2015-11-14 08:30:49,681 DEBUG : BROWSER_OUTPUT: RSS: Main: 202448896 08:30:49 INFO - 2015-11-14 08:30:49,681 DEBUG : BROWSER_OUTPUT: 08:33:51 INFO - 2015-11-14 08:33:51,955 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35817/tests/dromaeo/cssquery-yui.html (next: http://localhost:35817/tests/dromaeo/cssquery-dojo.html) 08:33:52 INFO - 2015-11-14 08:33:52,205 DEBUG : BROWSER_OUTPUT: RSS: Main: 245637120 08:33:52 INFO - 2015-11-14 08:33:52,205 DEBUG : BROWSER_OUTPUT: 08:33:52 INFO - 2015-11-14 08:33:52,206 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:33:52 INFO - 2015-11-14 08:33:52,206 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:33:52 INFO - 2015-11-14 08:33:52,206 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:33:52 INFO - 2015-11-14 08:33:52,206 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:33:52 INFO - 2015-11-14 08:33:52,207 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2661.853598052107;2742.9451410971783;2764.3089227693076;2771.8198317109386;2775.0426102994466;4600.35595016698;4760.143174228638;4777.737224452654;4842.757862106894;4860.65975381723;4709.952900470994;4773.355596994405;4775.952240477594;4781.689190202643;4917.778699958501;4376.759278239696;4383.452068491439;4387.3418987151945;4505.819767209307;4512.255477846152;4459.397981272519;4482.596566309048;4512.255477846152;4524.253498172798;4540.364348991144;4236.195122926634;4244.575542445762;4347.891302717426;4356.607905288508;4359.149965756678;4384.824607015716;4385.101054283896;4398.80205390755;4411.2941929291155;4418.447694038246;4255.87232383029;4384.868453946387;4386.495553011413;4394.2969124939855;4408.448943882015;4636.374089497908;4660.137874493195;4719.07977944301;4761.285807128924;4775;5142.228665700138;5153.819616313411;5163.845084647466;5166.04428180784;5195.402528709209;4931.65478416511;5068.290439338495;5168.095583272912;5184.766685499161;5191.714455704935;4603.815847366135;4660.370849935283;4671.159191345522;4704.223803072455;4723.267893476516;5236.476352364809;5244.292020577173;5244.5279924806955;5244.6328756987405;5287.286216360742;4792.832250871203;4900.14247506692;5037;5038.84883453497;5080.542751152414;5091.3381260436645;5095.8980820383385;5189.532942035235;5193.272941788153;5209.7916083356995;5068.771905264272;5087.923681144785;5090.872728181825;5092.770825312869;5113.616478764107;4852.272159176152;4977.228529577921;5076.923846142311;5078.568321692624;5080.695158290514;4076.0828813516723;4160.209560183616;4167.4790651168605;4168.7290326128705;4189.476315460567;3688.8708895189075;3689.4834723138783;3698.3712768829364;3706.2031663192543;3719.75388244941;4169.60388763067;4266.2960611499375;4356.891077723082;4360.040791025969;4399.802008909607;4930.778114984834;5019.84940451787;5103.18349064148;5107.157319042391;5149.742512874342;4354.346847972829;4380.759058251763;4389.18800021997;4392.824287028483;4419.381286619811;4275.0594869128745;4412.448443944507;4497.64018878489;4507.977460112678;4512.571305725951;4707.764611769329;4764.904701906012;4781.6891902026255;4800.0639875224;4837.637177211653;5108.259302401057;5159.793608255628;5164.561012313995;5167.689938603696;5208.088584497774;4679.321498382784;4807.519248075165;4887.120318342732;4903.583195428429;4940.086084074458;4932.827351042696;4969.602431805519;4985.4266759323145;4999.47505511916;5017.4731653175895;5057.69653820772;5061.544460998528;5062.038212739568;5090.160123579568;5108.157154069537;4706.199946009118;4836;4914.803407863646;4917.910037987562;4920.778564964514;4826.0830442215865;4862.270659401118;4954.157793175097;4954.603631709382;4957.876053098701;4845.515448455127;4851.151048566558;4852.053849499313;4865.951340486691;4884.316195732529;4776.116418462596;4910.975445122895;4937.259411088366;4945.604351651931;5002.574781143643;4733.668643194943;4763.7856296467435;4804.567588917014;4804.783784729626;4864.562189402971 08:33:52 INFO - 2015-11-14 08:33:52,208 DEBUG : BROWSER_OUTPUT: |1;ext.html;550.9849444541245;554.3154204557374;556.7828546866725;577.7544543568982;584.541135208861;27864.164075077755;36499.452508212366;36993.81503092481;37033.62966370335;37060.44409333862;40522;41094.58905410945;41116.17767644645;41138;41199.79400102995;6893.0694356261765;6990.720371185146;7969.561674107937;8137.349012079019;9607.855882161739;9660.661876834312;9678.128968392843;9711.223102151846;9733.270004749636;9771.462569558707;9785.02149785023;9894;9924.702258932244;9927.851082233772;9932.155766759834;7081.5396999195145;7244.71021159153;10156.085952264331;10451.268411211218;10483;10028.197744180448;10140.391576505433;10161.745956351077;10165.59337626494;10170.08469237772;37178.25643487142;37537;37603.43594846079;37606.62393376086;37611.62388376109;2792.2239347685736;2897.203269100993;3092.567040614316;3456.9308613827584;3583.8387272572795;28680.13959581195;28857.422851543062;28966.565501517493;29158.70841291581;29572.40855182906;3063.6476805167467;3112.7821052526333;3137.1529686984613;3141.371725654878;3186.060112266887;228287;230175;230440;231386;231655;47323.5267647326;48396.27405588919;52688;56714.71642641843;58377.70811146002;53359.199612005854;53531.46468535265;53556.196657050175;53685;54062.729686352104;12532.498700052078;12655.493780248871;12674.746505069847;12818.67953301175;12837.165584236995;9497.620095196115;9527.333086683866;9555.808883822285;9568.521573921276;9604.183644390305;17800.287988480315;17931.37240196613;18016.189271482814;18016.37852593273;18037.7294340585;6987.951807228855;7237.855242895218;7303.89044164338;7339.70599246271;7422;850.7702920211632;876.4828751036919;910.2945217456524;914.8399030169694;959.8512230604267;26436.471270574482;26588;26648.467030659667;26987;26988.73011269862;847.1570787066908;921.5438358012692;926.216718760135;949.534727983297;1014.8477728340661;12069.396530173632;12125.514979400901;12143.514259429523;12188.14682972201;12213.389330533615;210634;213674;214959;215094;215414;39753.60246397499;39883.40174897379;39966.600333996284;40075.398869016986;40122.1975560493;1076.520948178069;1159.3739380734478;1165.976680466403;1184.265755231762;1189.423129782055;19409.32067377635;23183.420414489774;23662.29013129609;23781.167659132538;23817.285481435585;43011.35482967695;43395.56604433915;43397.132057358045;43402.348964764926;43486;228375;232995;257755;260490;342469;27919;27974.72025279721;28004.85997569999;28437.431251374444;28450.715492844807;37894.81052594719;38163;39171.21657566776;39246.803765980985;39620;31586.842065790443;32153.517697235027;32669;33227.83386083054;33552.832235838665;32511;32517;32589.34821303608;32835;33002.17494562655;31735.627610901316;32180;32425.837870810494;32492.350152997282;32517;28791;29432.558511621915;29979.82703177665;30257.24356891095;30599.388012240077;23193.652095218247;23711.05155793818;23905.641415378435;23980.880095599412;24133.758662413853 08:33:52 INFO - 2015-11-14 08:33:52,210 DEBUG : BROWSER_OUTPUT: |2;jquery.html;326.82678180564307;329.5402912936452;338.50747162878014;342.3204938197677;343.6340297583074;11761.411929403539;12118.636440906765;15078;15091.169985650784;16467.176641167924;13744.93127534361;14017.36921838517;14281.07173033752;14469.493567725132;14492.565223043299;4488.5960263576435;4664.486906440289;4951.678140920838;5143.305653736735;5147.382314122292;3138.5449109879055;3251.561039259693;4601.148787474312;4726.881827954294;4735.431748190204;4665.486796452387;4666.510016448275;4669.439667239919;4672.579467847893;4673.579377855992;4647.140279048387;4658.25467925132;6459.967700161516;6602.834929126762;6707.1616047994;6241.188645476104;6375.10748495211;6387.776427825051;6414.069959855795;6421.133147025185;19401.417957461297;19477.12352944107;19552.413427597054;19598;20272.49318767028;1891.5933074389072;1919.1076149590367;1923.8749481283812;1932.7873933867263;1971.2312198242696;13451.66370840727;13470.461181552726;13586.456541738318;13785.241811700353;14111.294435278298;1823.6626224148442;1835.220031486613;1863.9068046597752;1908.065048126408;1941.5728539721238;59243;60055.39944600585;60865.695671521804;63095;63351.683241583494;15231.314590843216;15518.534443966699;15651;15679.294431750599;15685.86282743456;22361.888190558944;22460.663090053662;22693.319200424015;22803.543929121326;22838.657420138712;7938.483998540077;7959.323457506177;7980.600969951479;8050.5169689818795;8075.717349892726;6708.396244338033;6728.461723062143;6748.898766518506;6761.357671021246;6764.120664313607;7500.699972001168;7573.962130189314;7576.7348142814735;7602.315791578674;7635.083789945131;1053.3311347294523;1058.5659879449388;2031.7809314411236;2885.30752619374;3008.909732708022;419.59928268503506;424.6814888833375;444.9822007119744;447.3759106047046;454.66127734837755;10578.418186999636;10781.245312828027;10900.454977251105;11061.446927653586;11159;440.8523144746512;442.15327647555216;447.1928169653806;451.345548954018;467.02392000718663;5984.820455386345;6099.20710307666;6118.541109416811;6169.2288463942;6216.906746398808;330789;440286;449570;462257;506024;68668;70448;70635.2936470639;71015;71359;448.44616898130784;458.6628827811556;458.7155963302774;459.88732760473897;460.2429004287928;9762.02379762018;9912;10262.794744105226;10332.276740628084;10370.688879333633;31857;32938.17654558559;33475.83262083771;33725.66274337225;33846.323073538886;43877.831331318324;44557.77721111374;44659.33011004903;45123.32315015343;45764.771176143906;5708.57185711065;5757.971210143923;5816.418358164319;6081.543884208791;6165.383461653978;10758.892411075789;11047.83428248593;11137.944310278397;11226.887731122584;11469.942650287028;9482.336236463381;9518.286128540525;9568.421210500468;10051.59277701137;10173.389596624227;8890.199882010651;9196.54017299119;9382.765430864283;9390.718278451657;9577.23382129414;9176.322894975588;9253.53732313395;9265.166135047879;9523.809523809623;9635.807283854143;5744.224529688438;5853.209816674695;5865.618734782396;5876.764929402776;5883.499902508334;7975.282224599814;9247.167754901822;9314.717894115985;9522.523873806143;9578.952105239428 08:33:52 INFO - 2015-11-14 08:33:52,213 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1431.7065001674657;1547.7833103365526;1607.397226040235;1629.6659184867103;1641.8686505079588;5955.731992060357;6986;7231.746888858891;7231.783046508606;7234.927650723491;7076.964615176929;7130.144382674073;7155.212926578085;7155.391791697712;7194.460415468848;2062.350359636713;2082.1151010820417;2082.9062692178813;2088.289981406329;2088.3108574170487;2112.0812446585705;2122.3738996995844;2133.4026472587702;2163.7836216378396;2166.729158855143;2038.8368930485526;2041.622299874528;2059.7219375384357;2061.124022290528;2062.1545166481746;2086.7182930304443;2099.601075795594;2101.873887566743;2102.190656597206;2102.915883364671;2081.718967939339;2098.1083039708064;2108.4096452993185;2108.5888251790907;2109.303929703194;5866.266716660418;6010.609310394811;7046;7085.822854428629;7088.964555177191;4095.1604920991126;4239.554846741079;4271.9359209611885;4273.465816772903;4277.2087163874785;2784.401353708942;2866.8279903205666;2887.4658188235244;2907.418516296749;2916.0522830080095;875.6234819027816;912.7124955639019;917.4403613795579;926.1849572376266;936.5036530638772;8956.820863582692;9007.189352958265;9050.27597792175;9053.04942980984;9060.093990600953;3749.081475038633;3752.4934133891575;3815.847366105325;3820.025893397166;3824.7322687411615;7957.641906114239;7966.243206895336;7999.640016199285;8002.51984880909;8006.439549231614;4068.105016896278;4088.652464540488;4088.6729061674996;4092.2224777292217;4094.5700701426517;3705.7591256568235;3707.332680117605;3708.2027364116843;3713.997220750436;3715.8142092895246;3203.7757356985253;3218.3724173785886;3237.4496335623003;3258.6904244096772;3268.084936217863;1096.5997410944947;1101.493313075994;1103.5806393570551;1113.2930589075995;1115.7712668902855;919.6873063158558;965.3435663748718;1171.1743221029324;1178.2871362825538;1181.6809461445362;6669.466442684574;6706;6717.865642687118;6739.494537909676;6751.122354093936;991.8413053911339;1026.2098184397971;1028.2596530498029;1047.1884289675563;1054.704682688833;4771.379720636295;5363.839084827461;5404.270423492857;5429.891402171935;5437.32033495813;7383.741569045165;8189.099199088096;8392.874106888401;8439.535825529532;8462.957685211657;8317.41778075529;8480;8489.066202717697;8490.533020683923;8497.277731392776;6161.075838624242;6315.5894866833505;6354.205724284465;6419.775307864203;6470.09418681385;6488.805335839932;6626.469882409492;6640.070390145287;6643.40209381158;6645.335466453316;7186.60473673932;7468.887966680395;7563.168051514219;7590.278923502258;7596.164421913474;7639.159692433939;7708.344790692854;7730.342920851791;7838.059432868093;7852.450328476952;6047;6329.968350158404;6353.809385718436;6391.2330520337855;6448.548601597843;6875.965620171867;6881.965590172017;6884.552504087218;6887.827804304932;6904.792856214322;6394.6482943436695;6447.9355206447335;6472.320406357265;6541.411272985454;6549.7380104795275;6258.374162583706;6415.582987105823;6503.349665033459;6528.086067950396;6548.476121910331;6572.474202063919;6608.504362172953;6623.105880706043;6628.602283862983;6644.269130395749;5663.631863928831;5826.70866456684;5830.854228644318;6060.939390606214;6118.571699981137;5858.384869588632;5918.141869428995;5930.733117009831;5937.406259374028;5937.703114844327 08:33:52 INFO - 2015-11-14 08:33:52,215 DEBUG : BROWSER_OUTPUT: |4;prototype.html;300.1206465057382;303.5689321163947;306.65041852288397;306.7070947245381;307.43585520569746;5298.337707786527;5300.9204861927055;5366.463353664636;5412.161115027172;5435.42927992561;5194.584433245341;5336.519713225809;5371.946280537193;5386.596005299599;5387.272718183044;4119.19675663245;4147.6474499667565;4151.460310159675;4151.667866570667;4163.68772342074;3977.164795392971;4034.0721634024194;4041.0301527633305;4123.731957422773;4154.273002224613;4105.712600117993;4109.753414795122;4116.567760385146;4119.732217405874;4122.319817230168;4116.485439320085;4117.826419470452;4117.97941010296;4119.196756632443;4139.482564679415;3599.1541987632886;3602.423612222058;3605.855765769366;3609.5127157833617;3610.223801882608;5064.518870707314;5177.844664660066;5180.481951804827;5195.870103247411;5198.220266959948;4716.056788642285;4745.691530050535;4747.311639812242;4750.61995040396;4750.904981900378;5628.296462942132;5634.211210430543;5648;5650.152477128422;5657.886842263173;3743.2513497300647;3801.163743976321;3884.3008258513455;3940.1528671335514;4002.039510517484;5929.881402371929;5949.286085669747;5953.940460595382;5954.374790646963;5956.7319470623925;4126.711130220856;4126.731762435432;4127.2570937231585;4128.3601041838565;4129.442525259112;4169.332906734908;4178.39413285072;4183.3515805050265;4187.790610469464;4190.120074784269;4663.370444989951;4765.213739732905;4769.14155452015;4777.331173635694;4785.641076919245;5641.80253691127;5664.85837854057;5665.1502274658305;5667.376588575254;5667.376588575254;1459.5767227503904;1473.1676602719429;1479.1790556241174;1482.2885015192553;1482.3403585404608;998.3111652959435;999.3554157568328;1001.2940876682068;1003.3377970539555;1025.0415861169681;4908.141075311878;4930.482299358588;4936.407631084293;4937.222599864118;4952.613268284886;5808.215890854681;5820.156077368758;5827.038538641162;5830.970845145832;5831.825045248649;4915.410150781929;4927.926081108786;4930.161872481687;4942.406911170682;4944.332515110486;3079.784415090967;3136.325689976666;3146.9300437850784;3158.289384888428;3164.8101113932776;5531.889362212733;5539.639923404966;5541.362743284493;5550.222968784374;5553.944460555424;5944.048952167633;6008.24896887889;6008.669523176267;6012.368701286302;6013.789517366871;5534.723263836872;5539.390667026624;5541.972290138524;5542.722863856791;5548.195511650869;5699.772009119754;5880.411958804086;5883.676397798162;5889.617174883619;5901;5525.392206857162;5628.015097357864;5677.460641239076;5755.107958266475;5767.221425107557;5564.972175139098;5581.776728930798;5589.049861523469;5593.720313984203;5612;3930.9803450982563;3962;3962.7424217425773;3965.9405108923966;3972.9205415892097;5870.031444811559;5870.26621672291;5870.970645146917;5882.705864706833;5883.499902508163;5485.725713714219;5650.689212093374;5695.345035320991;5696.658200507983;5703.515201207943;5686.886262274814;5692.203091567101;5701.315842098975;5703.116017017369;5703.771849125988;5579.8884022320135;5581.441855814549;5583.748731307182;5584.078627026495;5585.636933599466;5583.860403489945;5724.599278050497;5726.74229659658;5727.11229759388;5730.885382292414;5534.7786088556;5544.085225937675;5550.47270509301;5551.167324901297;5551.22282880389 08:33:52 INFO - 2015-11-14 08:33:52,216 DEBUG : BROWSER_OUTPUT: |5;yui.html;672.8015235505526;673.7978606418075;676.5602358466996;678.8574399376131;685.0751485494579;10878.347299162046;11097.611583594577;11115.333080015185;11126.276792008513;11134.33194008358;12096.33470159141;12338.44476998535;12363.443645035972;12366.876331236685;12373.876261237385;585.3356440440089;593.4777395891631;729.0959210578884;741.5106030020188;741.8812989921614;734.1997223026926;740.655595148256;744.0290421000592;744.5607091815828;744.6128013433012;771.2518856709012;777.4790890103616;779.9727009554666;780.1457404142454;781.4256521456725;600.7957294519863;608.6287364707503;760.5208718507361;764.5909438450431;768.6080099149418;561.1330494386183;563.0512586292111;565.5532129617598;567.1577707104946;567.2597260574948;11369.260998035184;11414.258073225297;11420.086393088533;11421.029212516945;11490;8625.482471051695;8769.693060742844;8896.644134234622;8929;9305.720828375159;8343.916560834376;8541.231289183941;8566.61450234741;9161.358704890661;9279.628814847398;2817.81684190529;2817.943641127166;2849.6437945256844;2852.47229262585;2868.3116052147543;39278.60721392778;39652;39705;39729.20541589181;39833.00417489557;6474.935250647527;6511.479081673455;6598.04328372393;6652.800415987528;6752.324767523209;10647;10649.84025239622;10652.786944261072;10657.094146997437;10669.253152279265;5478.890422191534;5481.643693159932;5524.640898341595;5669.348024977098;5733.197352370671;3456.5679290088738;3492.214251793326;3580.677739003502;3634.636536346397;3646.197836476024;2269.0810221860174;2297.8161747060194;2302.8963696633355;2304.297189357262;2305.5043165719453;386.07534953786086;390.7421102072618;397.437625759547;398.63325740318396;399.9600039995977;424.8406847432213;460.7281703794777;462.2303864066359;490.6859609849699;543.4864053469512;7232.746853860195;7379;7464.402847772165;7556.4710470266555;7700.9614951926005;443.691634314155;485.2236421725211;486.83447627806714;573.243318819163;602.8281939647179;3504.404251277289;3689.3039976563364;3723.0296116263967;3775.2826962876966;3790.8673196437994;57652;58255.41744582585;58369.70815145897;58461.12308315378;58492.70753646205;48484.27273590899;48654.75672621614;48985.510144898806;49087.50912490901;49187.50812491901;44611;45002.54997450049;45356.77321613437;45770;46229.537704623195;6944.409725173215;6987.96506017487;7014.123234595676;7071.82320441993;7255.4921155518605;32737.18157046093;33242;33445.83277083599;33488.81856223655;33543.83228083844;39071.609283907936;39301.80349098236;42409;42476.36285455659;42854.35718464288;6287.308396076336;6320.968395157995;6334.144890439732;6484.837879053061;6559.967200163968;9608;9710.223182145553;9792.755181120529;9858.30991830565;9901.306908516335;8407.53758543286;8599.785005374915;8625.39622226438;8627.525486098073;8630.619100943819;8916.821663566821;9066.727998160066;9068.909310906807;9077.09229077087;9099.954500227457;8072.636731346986;8823;8950.418222815497;9003.63985440575;9325.673601423918;8721.56392180401;8904.73285801427;8964.462132272085;9004.729858104267;9204.861927070966;8713.782155445911;8771.342149338698;8969.551522423983;9011.568906027978;9209.76975575616 08:33:52 INFO - 2015-11-14 08:33:52,216 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:33:52 INFO - 2015-11-14 08:33:52,216 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:33:52 INFO - 2015-11-14 08:33:52,216 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,991 08:33:52 INFO - 2015-11-14 08:33:52,216 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:33:52 INFO - 2015-11-14 08:33:52,216 DEBUG : BROWSER_OUTPUT: __startTimestamp1447518832204__endTimestamp 08:33:52 INFO - 2015-11-14 08:33:52,217 DEBUG : BROWSER_OUTPUT: 08:33:52 INFO - 2015-11-14 08:33:52,217 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:33:52 INFO - 2015-11-14 08:33:52,217 DEBUG : BROWSER_OUTPUT: Number of tests: 6 08:33:52 INFO - 2015-11-14 08:33:52,217 DEBUG : BROWSER_OUTPUT: 08:33:52 INFO - 2015-11-14 08:33:52,217 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4687.43 Median:4804.57 stddev:493.71 (10.3%) stddev-sans-first:468.95 08:33:52 INFO - 2015-11-14 08:33:52,217 DEBUG : BROWSER_OUTPUT: Values: 2661.9 2742.9 2764.3 2771.8 2775.0 4600.4 4760.1 4777.7 4842.8 4860.7 4710.0 4773.4 4776.0 4781.7 4917.8 4376.8 4383.5 4387.3 4505.8 4512.3 4459.4 4482.6 4512.3 4524.3 4540.4 4236.2 4244.6 4347.9 4356.6 4359.1 4384.8 4385.1 4398.8 4411.3 4418.4 4255.9 4384.9 4386.5 4394.3 4408.4 4636.4 4660.1 4719.1 4761.3 4775.0 5142.2 5153.8 5163.8 5166.0 5195.4 4931.7 5068.3 5168.1 5184.8 5191.7 4603.8 4660.4 4671.2 4704.2 4723.3 5236.5 5244.3 5244.5 5244.6 5287.3 4792.8 4900.1 5037.0 5038.8 5080.5 5091.3 5095.9 5189.5 5193.3 5209.8 5068.8 5087.9 5090.9 5092.8 5113.6 4852.3 4977.2 5076.9 5078.6 5080.7 4076.1 4160.2 4167.5 4168.7 4189.5 3688.9 3689.5 3698.4 3706.2 3719.8 4169.6 4266.3 4356.9 4360.0 4399.8 4930.8 5019.8 5103.2 5107.2 5149.7 4354.3 4380.8 4389.2 4392.8 4419.4 4275.1 4412.4 4497.6 4508.0 4512.6 4707.8 4764.9 4781.7 4800.1 4837.6 5108.3 5159.8 5164.6 5167.7 5208.1 4679.3 4807.5 4887.1 4903.6 4940.1 4932.8 4969.6 4985.4 4999.5 5017.5 5057.7 5061.5 5062.0 5090.2 5108.2 4706.2 4836.0 4914.8 4917.9 4920.8 4826.1 4862.3 4954.2 4954.6 4957.9 4845.5 4851.2 4852.1 4866.0 4884.3 4776.1 4911.0 4937.3 4945.6 5002.6 4733.7 4763.8 4804.6 4804.8 4864.6 08:33:52 INFO - 2015-11-14 08:33:52,217 DEBUG : BROWSER_OUTPUT: 08:33:52 INFO - 2015-11-14 08:33:52,217 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39581.61 Median:32553.17 stddev:62041.19 (190.6%) stddev-sans-first:62146.01 08:33:52 INFO - 2015-11-14 08:33:52,217 DEBUG : BROWSER_OUTPUT: Values: 551.0 554.3 556.8 577.8 584.5 27864.2 36499.5 36993.8 37033.6 37060.4 40522.0 41094.6 41116.2 41138.0 41199.8 6893.1 6990.7 7969.6 8137.3 9607.9 9660.7 9678.1 9711.2 9733.3 9771.5 9785.0 9894.0 9924.7 9927.9 9932.2 7081.5 7244.7 10156.1 10451.3 10483.0 10028.2 10140.4 10161.7 10165.6 10170.1 37178.3 37537.0 37603.4 37606.6 37611.6 2792.2 2897.2 3092.6 3456.9 3583.8 28680.1 28857.4 28966.6 29158.7 29572.4 3063.6 3112.8 3137.2 3141.4 3186.1 228287.0 230175.0 230440.0 231386.0 231655.0 47323.5 48396.3 52688.0 56714.7 58377.7 53359.2 53531.5 53556.2 53685.0 54062.7 12532.5 12655.5 12674.7 12818.7 12837.2 9497.6 9527.3 9555.8 9568.5 9604.2 17800.3 17931.4 18016.2 18016.4 18037.7 6988.0 7237.9 7303.9 7339.7 7422.0 850.8 876.5 910.3 914.8 959.9 26436.5 26588.0 26648.5 26987.0 26988.7 847.2 921.5 926.2 949.5 1014.8 12069.4 12125.5 12143.5 12188.1 12213.4 210634.0 213674.0 214959.0 215094.0 215414.0 39753.6 39883.4 39966.6 40075.4 40122.2 1076.5 1159.4 1166.0 1184.3 1189.4 19409.3 23183.4 23662.3 23781.2 23817.3 43011.4 43395.6 43397.1 43402.3 43486.0 228375.0 232995.0 257755.0 260490.0 342469.0 27919.0 27974.7 28004.9 28437.4 28450.7 37894.8 38163.0 39171.2 39246.8 39620.0 31586.8 32153.5 32669.0 33227.8 33552.8 32511.0 32517.0 32589.3 32835.0 33002.2 31735.6 32180.0 32425.8 32492.4 32517.0 28791.0 29432.6 29979.8 30257.2 30599.4 23193.7 23711.1 23905.6 23980.9 24133.8 08:33:52 INFO - 2015-11-14 08:33:52,218 DEBUG : BROWSER_OUTPUT: 08:33:52 INFO - 2015-11-14 08:33:52,218 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24736.89 Median:23111.72 stddev:72405.40 (313.3%) stddev-sans-first:72585.32 08:33:52 INFO - 2015-11-14 08:33:52,219 DEBUG : BROWSER_OUTPUT: Values: 326.8 329.5 338.5 342.3 343.6 11761.4 12118.6 15078.0 15091.2 16467.2 13744.9 14017.4 14281.1 14469.5 14492.6 4488.6 4664.5 4951.7 5143.3 5147.4 3138.5 3251.6 4601.1 4726.9 4735.4 4665.5 4666.5 4669.4 4672.6 4673.6 4647.1 4658.3 6460.0 6602.8 6707.2 6241.2 6375.1 6387.8 6414.1 6421.1 19401.4 19477.1 19552.4 19598.0 20272.5 1891.6 1919.1 1923.9 1932.8 1971.2 13451.7 13470.5 13586.5 13785.2 14111.3 1823.7 1835.2 1863.9 1908.1 1941.6 59243.0 60055.4 60865.7 63095.0 63351.7 15231.3 15518.5 15651.0 15679.3 15685.9 22361.9 22460.7 22693.3 22803.5 22838.7 7938.5 7959.3 7980.6 8050.5 8075.7 6708.4 6728.5 6748.9 6761.4 6764.1 7500.7 7574.0 7576.7 7602.3 7635.1 1053.3 1058.6 2031.8 2885.3 3008.9 419.6 424.7 445.0 447.4 454.7 10578.4 10781.2 10900.5 11061.4 11159.0 440.9 442.2 447.2 451.3 467.0 5984.8 6099.2 6118.5 6169.2 6216.9 330789.0 440286.0 449570.0 462257.0 506024.0 68668.0 70448.0 70635.3 71015.0 71359.0 448.4 458.7 458.7 459.9 460.2 9762.0 9912.0 10262.8 10332.3 10370.7 31857.0 32938.2 33475.8 33725.7 33846.3 43877.8 44557.8 44659.3 45123.3 45764.8 5708.6 5758.0 5816.4 6081.5 6165.4 10758.9 11047.8 11137.9 11226.9 11469.9 9482.3 9518.3 9568.4 10051.6 10173.4 8890.2 9196.5 9382.8 9390.7 9577.2 9176.3 9253.5 9265.2 9523.8 9635.8 5744.2 5853.2 5865.6 5876.8 5883.5 7975.3 9247.2 9314.7 9522.5 9579.0 08:33:52 INFO - 2015-11-14 08:33:52,219 DEBUG : BROWSER_OUTPUT: 08:33:52 INFO - 2015-11-14 08:33:52,219 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4921.92 Median:6139.82 stddev:2495.21 (40.6%) stddev-sans-first:2488.42 08:33:52 INFO - 2015-11-14 08:33:52,220 DEBUG : BROWSER_OUTPUT: Values: 1431.7 1547.8 1607.4 1629.7 1641.9 5955.7 6986.0 7231.7 7231.8 7234.9 7077.0 7130.1 7155.2 7155.4 7194.5 2062.4 2082.1 2082.9 2088.3 2088.3 2112.1 2122.4 2133.4 2163.8 2166.7 2038.8 2041.6 2059.7 2061.1 2062.2 2086.7 2099.6 2101.9 2102.2 2102.9 2081.7 2098.1 2108.4 2108.6 2109.3 5866.3 6010.6 7046.0 7085.8 7089.0 4095.2 4239.6 4271.9 4273.5 4277.2 2784.4 2866.8 2887.5 2907.4 2916.1 875.6 912.7 917.4 926.2 936.5 8956.8 9007.2 9050.3 9053.0 9060.1 3749.1 3752.5 3815.8 3820.0 3824.7 7957.6 7966.2 7999.6 8002.5 8006.4 4068.1 4088.7 4088.7 4092.2 4094.6 3705.8 3707.3 3708.2 3714.0 3715.8 3203.8 3218.4 3237.4 3258.7 3268.1 1096.6 1101.5 1103.6 1113.3 1115.8 919.7 965.3 1171.2 1178.3 1181.7 6669.5 6706.0 6717.9 6739.5 6751.1 991.8 1026.2 1028.3 1047.2 1054.7 4771.4 5363.8 5404.3 5429.9 5437.3 7383.7 8189.1 8392.9 8439.5 8463.0 8317.4 8480.0 8489.1 8490.5 8497.3 6161.1 6315.6 6354.2 6419.8 6470.1 6488.8 6626.5 6640.1 6643.4 6645.3 7186.6 7468.9 7563.2 7590.3 7596.2 7639.2 7708.3 7730.3 7838.1 7852.5 6047.0 6330.0 6353.8 6391.2 6448.5 6876.0 6882.0 6884.6 6887.8 6904.8 6394.6 6447.9 6472.3 6541.4 6549.7 6258.4 6415.6 6503.3 6528.1 6548.5 6572.5 6608.5 6623.1 6628.6 6644.3 5663.6 5826.7 5830.9 6060.9 6118.6 5858.4 5918.1 5930.7 5937.4 5937.7 08:33:52 INFO - 2015-11-14 08:33:52,220 DEBUG : BROWSER_OUTPUT: 08:33:52 INFO - 2015-11-14 08:33:52,220 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4684.95 Median:5318.72 stddev:1378.13 (25.9%) stddev-sans-first:1342.13 08:33:52 INFO - 2015-11-14 08:33:52,220 DEBUG : BROWSER_OUTPUT: Values: 300.1 303.6 306.7 306.7 307.4 5298.3 5300.9 5366.5 5412.2 5435.4 5194.6 5336.5 5371.9 5386.6 5387.3 4119.2 4147.6 4151.5 4151.7 4163.7 3977.2 4034.1 4041.0 4123.7 4154.3 4105.7 4109.8 4116.6 4119.7 4122.3 4116.5 4117.8 4118.0 4119.2 4139.5 3599.2 3602.4 3605.9 3609.5 3610.2 5064.5 5177.8 5180.5 5195.9 5198.2 4716.1 4745.7 4747.3 4750.6 4750.9 5628.3 5634.2 5648.0 5650.2 5657.9 3743.3 3801.2 3884.3 3940.2 4002.0 5929.9 5949.3 5953.9 5954.4 5956.7 4126.7 4126.7 4127.3 4128.4 4129.4 4169.3 4178.4 4183.4 4187.8 4190.1 4663.4 4765.2 4769.1 4777.3 4785.6 5641.8 5664.9 5665.2 5667.4 5667.4 1459.6 1473.2 1479.2 1482.3 1482.3 998.3 999.4 1001.3 1003.3 1025.0 4908.1 4930.5 4936.4 4937.2 4952.6 5808.2 5820.2 5827.0 5831.0 5831.8 4915.4 4927.9 4930.2 4942.4 4944.3 3079.8 3136.3 3146.9 3158.3 3164.8 5531.9 5539.6 5541.4 5550.2 5553.9 5944.0 6008.2 6008.7 6012.4 6013.8 5534.7 5539.4 5542.0 5542.7 5548.2 5699.8 5880.4 5883.7 5889.6 5901.0 5525.4 5628.0 5677.5 5755.1 5767.2 5565.0 5581.8 5589.0 5593.7 5612.0 3931.0 3962.0 3962.7 3965.9 3972.9 5870.0 5870.3 5871.0 5882.7 5883.5 5485.7 5650.7 5695.3 5696.7 5703.5 5686.9 5692.2 5701.3 5703.1 5703.8 5579.9 5581.4 5583.7 5584.1 5585.6 5583.9 5724.6 5726.7 5727.1 5730.9 5534.8 5544.1 5550.5 5551.2 5551.2 08:33:52 INFO - 2015-11-14 08:33:52,220 DEBUG : BROWSER_OUTPUT: 08:33:52 INFO - 2015-11-14 08:33:52,220 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12082.30 Median:58312.56 stddev:15315.94 (26.3%) stddev-sans-first:15334.94 08:33:52 INFO - 2015-11-14 08:33:52,222 DEBUG : BROWSER_OUTPUT: Values: 672.8 673.8 676.6 678.9 685.1 10878.3 11097.6 11115.3 11126.3 11134.3 12096.3 12338.4 12363.4 12366.9 12373.9 585.3 593.5 729.1 741.5 741.9 734.2 740.7 744.0 744.6 744.6 771.3 777.5 780.0 780.1 781.4 600.8 608.6 760.5 764.6 768.6 561.1 563.1 565.6 567.2 567.3 11369.3 11414.3 11420.1 11421.0 11490.0 8625.5 8769.7 8896.6 8929.0 9305.7 8343.9 8541.2 8566.6 9161.4 9279.6 2817.8 2817.9 2849.6 2852.5 2868.3 39278.6 39652.0 39705.0 39729.2 39833.0 6474.9 6511.5 6598.0 6652.8 6752.3 10647.0 10649.8 10652.8 10657.1 10669.3 5478.9 5481.6 5524.6 5669.3 5733.2 3456.6 3492.2 3580.7 3634.6 3646.2 2269.1 2297.8 2302.9 2304.3 2305.5 386.1 390.7 397.4 398.6 400.0 424.8 460.7 462.2 490.7 543.5 7232.7 7379.0 7464.4 7556.5 7701.0 443.7 485.2 486.8 573.2 602.8 3504.4 3689.3 3723.0 3775.3 3790.9 57652.0 58255.4 58369.7 58461.1 58492.7 48484.3 48654.8 48985.5 49087.5 49187.5 44611.0 45002.5 45356.8 45770.0 46229.5 6944.4 6988.0 7014.1 7071.8 7255.5 32737.2 33242.0 33445.8 33488.8 33543.8 39071.6 39301.8 42409.0 42476.4 42854.4 6287.3 6321.0 6334.1 6484.8 6560.0 9608.0 9710.2 9792.8 9858.3 9901.3 8407.5 8599.8 8625.4 8627.5 8630.6 8916.8 9066.7 9068.9 9077.1 9100.0 8072.6 8823.0 8950.4 9003.6 9325.7 8721.6 8904.7 8964.5 9004.7 9204.9 8713.8 8771.3 8969.6 9011.6 9209.8 08:33:52 INFO - 2015-11-14 08:33:52,222 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:33:52 INFO - 2015-11-14 08:33:52,222 DEBUG : BROWSER_OUTPUT: 08:33:52 INFO - 2015-11-14 08:33:52,916 INFO : Browser exited with error code: 0 08:33:52 INFO - 2015-11-14 08:33:52,939 INFO : Completed test dromaeo_css (00:18:37) 08:33:52 INFO - 2015-11-14 08:33:52,939 INFO : Starting test kraken 08:33:52 INFO - 2015-11-14 08:33:52,939 DEBUG : operating with platform_type : linux_ 08:33:52 INFO - 2015-11-14 08:33:52,940 INFO : Initialising browser for kraken test... 08:33:52 INFO - 2015-11-14 08:33:52,946 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbFZpwQ/profile http://localhost:35817/getInfo.html 08:33:57 INFO - 2015-11-14 08:33:57,094 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:33:57 INFO - 2015-11-14 08:33:57,095 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:33:57 INFO - 2015-11-14 08:33:57,095 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:33:57 INFO - 2015-11-14 08:33:57,095 DEBUG : BROWSER_OUTPUT: __metrics 08:33:57 INFO - 2015-11-14 08:33:57,191 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:33:58 INFO - 2015-11-14 08:33:58,566 INFO : Browser initialized. 08:33:58 INFO - 2015-11-14 08:33:58,566 INFO : Running cycle 1/1 for kraken test... 08:33:58 INFO - 2015-11-14 08:33:58,567 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbFZpwQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:34:10 INFO - 2015-11-14 08:34:10,561 DEBUG : BROWSER_OUTPUT: RSS: Main: 141754368 08:34:10 INFO - 2015-11-14 08:34:10,561 DEBUG : BROWSER_OUTPUT: 08:34:13 INFO - 2015-11-14 08:34:13,170 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35817/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35817/tests/kraken/driver.html?testName=audio-beat-detection) 08:34:13 INFO - 2015-11-14 08:34:13,755 DEBUG : BROWSER_OUTPUT: RSS: Main: 177881088 08:34:13 INFO - 2015-11-14 08:34:13,756 DEBUG : BROWSER_OUTPUT: 08:34:16 INFO - 2015-11-14 08:34:16,493 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35817/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35817/tests/kraken/driver.html?testName=audio-dft) 08:34:17 INFO - 2015-11-14 08:34:17,062 DEBUG : BROWSER_OUTPUT: RSS: Main: 166694912 08:34:17 INFO - 2015-11-14 08:34:17,062 DEBUG : BROWSER_OUTPUT: 08:34:20 INFO - 2015-11-14 08:34:20,090 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35817/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35817/tests/kraken/driver.html?testName=audio-fft) 08:34:20 INFO - 2015-11-14 08:34:20,656 DEBUG : BROWSER_OUTPUT: RSS: Main: 150614016 08:34:20 INFO - 2015-11-14 08:34:20,656 DEBUG : BROWSER_OUTPUT: 08:34:22 INFO - 2015-11-14 08:34:22,693 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35817/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35817/tests/kraken/driver.html?testName=audio-oscillator) 08:34:23 INFO - 2015-11-14 08:34:23,266 DEBUG : BROWSER_OUTPUT: RSS: Main: 153546752 08:34:23 INFO - 2015-11-14 08:34:23,266 DEBUG : BROWSER_OUTPUT: 08:34:25 INFO - 2015-11-14 08:34:25,480 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35817/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35817/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:34:26 INFO - 2015-11-14 08:34:26,041 DEBUG : BROWSER_OUTPUT: RSS: Main: 156057600 08:34:26 INFO - 2015-11-14 08:34:26,041 DEBUG : BROWSER_OUTPUT: 08:34:29 INFO - 2015-11-14 08:34:29,081 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35817/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35817/tests/kraken/driver.html?testName=imaging-darkroom) 08:34:29 INFO - 2015-11-14 08:34:29,650 DEBUG : BROWSER_OUTPUT: RSS: Main: 155881472 08:34:29 INFO - 2015-11-14 08:34:29,650 DEBUG : BROWSER_OUTPUT: 08:34:33 INFO - 2015-11-14 08:34:33,092 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35817/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35817/tests/kraken/driver.html?testName=imaging-desaturate) 08:34:33 INFO - 2015-11-14 08:34:33,673 DEBUG : BROWSER_OUTPUT: RSS: Main: 156426240 08:34:33 INFO - 2015-11-14 08:34:33,673 DEBUG : BROWSER_OUTPUT: 08:34:36 INFO - 2015-11-14 08:34:36,511 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35817/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35817/tests/kraken/driver.html?testName=json-parse-financial) 08:34:37 INFO - 2015-11-14 08:34:37,098 DEBUG : BROWSER_OUTPUT: RSS: Main: 155394048 08:34:37 INFO - 2015-11-14 08:34:37,098 DEBUG : BROWSER_OUTPUT: 08:34:38 INFO - 2015-11-14 08:34:38,868 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35817/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35817/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:34:39 INFO - 2015-11-14 08:34:39,435 DEBUG : BROWSER_OUTPUT: RSS: Main: 163459072 08:34:39 INFO - 2015-11-14 08:34:39,435 DEBUG : BROWSER_OUTPUT: 08:34:41 INFO - 2015-11-14 08:34:41,317 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35817/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35817/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:34:41 INFO - 2015-11-14 08:34:41,920 DEBUG : BROWSER_OUTPUT: RSS: Main: 164696064 08:34:41 INFO - 2015-11-14 08:34:41,920 DEBUG : BROWSER_OUTPUT: 08:34:44 INFO - 2015-11-14 08:34:44,036 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35817/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35817/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:34:44 INFO - 2015-11-14 08:34:44,617 DEBUG : BROWSER_OUTPUT: RSS: Main: 169463808 08:34:44 INFO - 2015-11-14 08:34:44,618 DEBUG : BROWSER_OUTPUT: 08:34:47 INFO - 2015-11-14 08:34:47,124 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35817/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35817/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:34:47 INFO - 2015-11-14 08:34:47,709 DEBUG : BROWSER_OUTPUT: RSS: Main: 176902144 08:34:47 INFO - 2015-11-14 08:34:47,710 DEBUG : BROWSER_OUTPUT: 08:34:50 INFO - 2015-11-14 08:34:50,330 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35817/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35817/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:34:50 INFO - 2015-11-14 08:34:50,903 DEBUG : BROWSER_OUTPUT: RSS: Main: 176504832 08:34:50 INFO - 2015-11-14 08:34:50,903 DEBUG : BROWSER_OUTPUT: 08:34:52 INFO - 2015-11-14 08:34:52,657 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35817/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35817/tests/kraken/driver.html?testName=ai-astar) 08:34:52 INFO - 2015-11-14 08:34:52,907 DEBUG : BROWSER_OUTPUT: RSS: Main: 236486656 08:34:52 INFO - 2015-11-14 08:34:52,907 DEBUG : BROWSER_OUTPUT: 08:34:52 INFO - 2015-11-14 08:34:52,911 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:34:52 INFO - 2015-11-14 08:34:52,911 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:34:52 INFO - 2015-11-14 08:34:52,911 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:34:52 INFO - 2015-11-14 08:34:52,911 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:34:52 INFO - 2015-11-14 08:34:52,911 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;113;106;113;113;114;101;113;107;114 08:34:52 INFO - 2015-11-14 08:34:52,912 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;139;163;167;133;153;165;130;173;131 08:34:52 INFO - 2015-11-14 08:34:52,912 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;162;161;161;161;161;162;164;162;163 08:34:52 INFO - 2015-11-14 08:34:52,912 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;86;89;72;74;74;106;88;73 08:34:52 INFO - 2015-11-14 08:34:52,912 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;93;132;91;92;92;130;90;92;129 08:34:52 INFO - 2015-11-14 08:34:52,912 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;110;110;109;110;109;109;109 08:34:52 INFO - 2015-11-14 08:34:52,912 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;148;149;148;147;149;148;149;148;148 08:34:52 INFO - 2015-11-14 08:34:52,912 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;95;95;95;96;95;95 08:34:52 INFO - 2015-11-14 08:34:52,912 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;69;70;70;69;70;69;69;79;68;68 08:34:52 INFO - 2015-11-14 08:34:52,913 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;68;69;69;69;70;68;69;69 08:34:52 INFO - 2015-11-14 08:34:52,913 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;94;83;83;84;82;83;83;84;96 08:34:52 INFO - 2015-11-14 08:34:52,913 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;129;118;117;121;121;121;121;121;121;119 08:34:52 INFO - 2015-11-14 08:34:52,913 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;152;143;151;149;150;140;151;156;156;139 08:34:52 INFO - 2015-11-14 08:34:52,913 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;69;74;68;69;69;68;69;71;69 08:34:52 INFO - 2015-11-14 08:34:52,913 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:34:52 INFO - 2015-11-14 08:34:52,913 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:34:52 INFO - 2015-11-14 08:34:52,913 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,990 08:34:52 INFO - 2015-11-14 08:34:52,913 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:34:52 INFO - 2015-11-14 08:34:52,914 DEBUG : BROWSER_OUTPUT: __startTimestamp1447518892909__endTimestamp 08:34:52 INFO - 2015-11-14 08:34:52,914 DEBUG : BROWSER_OUTPUT: 08:34:52 INFO - 2015-11-14 08:34:52,915 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:34:52 INFO - 2015-11-14 08:34:52,915 DEBUG : BROWSER_OUTPUT: Number of tests: 14 08:34:52 INFO - 2015-11-14 08:34:52,915 DEBUG : BROWSER_OUTPUT: 08:34:52 INFO - 2015-11-14 08:34:52,915 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.70 Median:113.00 stddev:4.45 (3.9%) stddev-sans-first:4.64 08:34:52 INFO - 2015-11-14 08:34:52,915 DEBUG : BROWSER_OUTPUT: Values: 113.0 113.0 106.0 113.0 113.0 114.0 101.0 113.0 107.0 114.0 08:34:52 INFO - 2015-11-14 08:34:52,916 DEBUG : BROWSER_OUTPUT: 08:34:52 INFO - 2015-11-14 08:34:52,916 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:151.00 Median:159.50 stddev:16.39 (10.3%) stddev-sans-first:17.29 08:34:52 INFO - 2015-11-14 08:34:52,916 DEBUG : BROWSER_OUTPUT: Values: 156.0 139.0 163.0 167.0 133.0 153.0 165.0 130.0 173.0 131.0 08:34:52 INFO - 2015-11-14 08:34:52,916 DEBUG : BROWSER_OUTPUT: 08:34:52 INFO - 2015-11-14 08:34:52,916 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.05 (0.7%) stddev-sans-first:1.05 08:34:52 INFO - 2015-11-14 08:34:52,916 DEBUG : BROWSER_OUTPUT: Values: 163.0 162.0 161.0 161.0 161.0 161.0 162.0 164.0 162.0 163.0 08:34:52 INFO - 2015-11-14 08:34:52,916 DEBUG : BROWSER_OUTPUT: 08:34:52 INFO - 2015-11-14 08:34:52,916 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.70 Median:74.00 stddev:11.30 (15.3%) stddev-sans-first:11.64 08:34:52 INFO - 2015-11-14 08:34:52,916 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 86.0 89.0 72.0 74.0 74.0 106.0 88.0 73.0 08:34:52 INFO - 2015-11-14 08:34:52,917 DEBUG : BROWSER_OUTPUT: 08:34:52 INFO - 2015-11-14 08:34:52,917 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.30 Median:92.00 stddev:18.68 (20.3%) stddev-sans-first:19.37 08:34:52 INFO - 2015-11-14 08:34:52,917 DEBUG : BROWSER_OUTPUT: Values: 92.0 93.0 132.0 91.0 92.0 92.0 130.0 90.0 92.0 129.0 08:34:52 INFO - 2015-11-14 08:34:52,917 DEBUG : BROWSER_OUTPUT: 08:34:52 INFO - 2015-11-14 08:34:52,917 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 08:34:52 INFO - 2015-11-14 08:34:52,917 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 110.0 110.0 109.0 110.0 109.0 109.0 109.0 08:34:52 INFO - 2015-11-14 08:34:52,917 DEBUG : BROWSER_OUTPUT: 08:34:52 INFO - 2015-11-14 08:34:52,918 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 08:34:52 INFO - 2015-11-14 08:34:52,918 DEBUG : BROWSER_OUTPUT: Values: 148.0 148.0 149.0 148.0 147.0 149.0 148.0 149.0 148.0 148.0 08:34:52 INFO - 2015-11-14 08:34:52,918 DEBUG : BROWSER_OUTPUT: 08:34:52 INFO - 2015-11-14 08:34:52,918 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:34:52 INFO - 2015-11-14 08:34:52,918 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 08:34:52 INFO - 2015-11-14 08:34:52,918 DEBUG : BROWSER_OUTPUT: 08:34:52 INFO - 2015-11-14 08:34:52,918 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:70.10 Median:69.50 stddev:3.21 (4.6%) stddev-sans-first:3.38 08:34:52 INFO - 2015-11-14 08:34:52,919 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 70.0 69.0 70.0 69.0 69.0 79.0 68.0 68.0 08:34:52 INFO - 2015-11-14 08:34:52,919 DEBUG : BROWSER_OUTPUT: 08:34:52 INFO - 2015-11-14 08:34:52,919 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:69.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 08:34:52 INFO - 2015-11-14 08:34:52,919 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 69.0 69.0 69.0 70.0 68.0 69.0 69.0 08:34:52 INFO - 2015-11-14 08:34:52,919 DEBUG : BROWSER_OUTPUT: 08:34:52 INFO - 2015-11-14 08:34:52,919 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:83.50 stddev:5.06 (6.1%) stddev-sans-first:5.29 08:34:52 INFO - 2015-11-14 08:34:52,920 DEBUG : BROWSER_OUTPUT: Values: 83.0 94.0 83.0 83.0 84.0 82.0 83.0 83.0 84.0 96.0 08:34:52 INFO - 2015-11-14 08:34:52,920 DEBUG : BROWSER_OUTPUT: 08:34:52 INFO - 2015-11-14 08:34:52,920 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.90 Median:121.00 stddev:3.21 (2.7%) stddev-sans-first:1.58 08:34:52 INFO - 2015-11-14 08:34:52,920 DEBUG : BROWSER_OUTPUT: Values: 129.0 118.0 117.0 121.0 121.0 121.0 121.0 121.0 121.0 119.0 08:34:52 INFO - 2015-11-14 08:34:52,920 DEBUG : BROWSER_OUTPUT: 08:34:52 INFO - 2015-11-14 08:34:52,920 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.70 Median:151.00 stddev:6.07 (4.0%) stddev-sans-first:6.32 08:34:52 INFO - 2015-11-14 08:34:52,920 DEBUG : BROWSER_OUTPUT: Values: 152.0 143.0 151.0 149.0 150.0 140.0 151.0 156.0 156.0 139.0 08:34:52 INFO - 2015-11-14 08:34:52,920 DEBUG : BROWSER_OUTPUT: 08:34:52 INFO - 2015-11-14 08:34:52,921 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:69.00 stddev:1.78 (2.6%) stddev-sans-first:1.88 08:34:52 INFO - 2015-11-14 08:34:52,921 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 74.0 68.0 69.0 69.0 68.0 69.0 71.0 69.0 08:34:52 INFO - 2015-11-14 08:34:52,921 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:34:52 INFO - 2015-11-14 08:34:52,921 DEBUG : BROWSER_OUTPUT: 08:34:53 INFO - 2015-11-14 08:34:53,796 INFO : Browser exited with error code: 0 08:34:53 INFO - 2015-11-14 08:34:53,850 INFO : Completed test kraken (00:01:00) 08:34:53 INFO - 2015-11-14 08:34:53,850 INFO : Starting test v8_7 08:34:53 INFO - 2015-11-14 08:34:53,850 DEBUG : operating with platform_type : linux_ 08:34:53 INFO - 2015-11-14 08:34:53,851 INFO : Initialising browser for v8_7 test... 08:34:53 INFO - 2015-11-14 08:34:53,857 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkePG5K/profile http://localhost:35817/getInfo.html 08:34:57 INFO - 2015-11-14 08:34:57,973 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:34:57 INFO - 2015-11-14 08:34:57,973 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:34:57 INFO - 2015-11-14 08:34:57,973 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:34:57 INFO - 2015-11-14 08:34:57,973 DEBUG : BROWSER_OUTPUT: __metrics 08:34:58 INFO - 2015-11-14 08:34:58,150 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:34:59 INFO - 2015-11-14 08:34:59,427 INFO : Browser initialized. 08:34:59 INFO - 2015-11-14 08:34:59,428 INFO : Running cycle 1/1 for v8_7 test... 08:34:59 INFO - 2015-11-14 08:34:59,428 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkePG5K/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:35:11 INFO - 2015-11-14 08:35:11,352 DEBUG : BROWSER_OUTPUT: RSS: Main: 141246464 08:35:11 INFO - 2015-11-14 08:35:11,352 DEBUG : BROWSER_OUTPUT: 08:35:32 INFO - 2015-11-14 08:35:32,747 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35817/tests/v8_7/run.html (next: http://localhost:35817/tests/v8_7/run.html) 08:35:33 INFO - 2015-11-14 08:35:33,005 DEBUG : BROWSER_OUTPUT: RSS: Main: 447225856 08:35:33 INFO - 2015-11-14 08:35:33,005 DEBUG : BROWSER_OUTPUT: 08:35:33 INFO - 2015-11-14 08:35:33,005 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:35:33 INFO - 2015-11-14 08:35:33,005 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:35:33 INFO - 2015-11-14 08:35:33,006 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:35:33 INFO - 2015-11-14 08:35:33,006 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:35:33 INFO - 2015-11-14 08:35:33,006 DEBUG : BROWSER_OUTPUT: |0;Richards;165.28925619834712 08:35:33 INFO - 2015-11-14 08:35:33,006 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.64430816404752 08:35:33 INFO - 2015-11-14 08:35:33,006 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.1120448179272 08:35:33 INFO - 2015-11-14 08:35:33,006 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5050.50505050505 08:35:33 INFO - 2015-11-14 08:35:33,006 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1984.126984126984 08:35:33 INFO - 2015-11-14 08:35:33,006 DEBUG : BROWSER_OUTPUT: |5;Earley;814.9959250203749 08:35:33 INFO - 2015-11-14 08:35:33,007 DEBUG : BROWSER_OUTPUT: |6;Boyer;12317.073170731708 08:35:33 INFO - 2015-11-14 08:35:33,007 DEBUG : BROWSER_OUTPUT: |7;RegExp;26868.42105263158 08:35:33 INFO - 2015-11-14 08:35:33,007 DEBUG : BROWSER_OUTPUT: |8;Splay;620.3473945409429 08:35:33 INFO - 2015-11-14 08:35:33,007 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 08:35:33 INFO - 2015-11-14 08:35:33,007 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:35:33 INFO - 2015-11-14 08:35:33,007 DEBUG : BROWSER_OUTPUT: __startTimestamp1447518932998__endTimestamp 08:35:33 INFO - 2015-11-14 08:35:33,007 DEBUG : BROWSER_OUTPUT: 08:35:33 INFO - 2015-11-14 08:35:33,008 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:35:33 INFO - 2015-11-14 08:35:33,008 DEBUG : BROWSER_OUTPUT: Number of tests: 10 08:35:33 INFO - 2015-11-14 08:35:33,008 DEBUG : BROWSER_OUTPUT: 08:35:33 INFO - 2015-11-14 08:35:33,008 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.29 Median:165.29 stddev:0.00 (0.0%) 08:35:33 INFO - 2015-11-14 08:35:33,008 DEBUG : BROWSER_OUTPUT: Values: 165.3 08:35:33 INFO - 2015-11-14 08:35:33,008 DEBUG : BROWSER_OUTPUT: 08:35:33 INFO - 2015-11-14 08:35:33,008 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.64 Median:191.64 stddev:0.00 (0.0%) 08:35:33 INFO - 2015-11-14 08:35:33,008 DEBUG : BROWSER_OUTPUT: Values: 191.6 08:35:33 INFO - 2015-11-14 08:35:33,009 DEBUG : BROWSER_OUTPUT: 08:35:33 INFO - 2015-11-14 08:35:33,009 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.11 Median:280.11 stddev:0.00 (0.0%) 08:35:33 INFO - 2015-11-14 08:35:33,009 DEBUG : BROWSER_OUTPUT: Values: 280.1 08:35:33 INFO - 2015-11-14 08:35:33,009 DEBUG : BROWSER_OUTPUT: 08:35:33 INFO - 2015-11-14 08:35:33,009 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5050.51 Median:5050.51 stddev:0.00 (0.0%) 08:35:33 INFO - 2015-11-14 08:35:33,009 DEBUG : BROWSER_OUTPUT: Values: 5050.5 08:35:33 INFO - 2015-11-14 08:35:33,009 DEBUG : BROWSER_OUTPUT: 08:35:33 INFO - 2015-11-14 08:35:33,010 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1984.13 Median:1984.13 stddev:0.00 (0.0%) 08:35:33 INFO - 2015-11-14 08:35:33,010 DEBUG : BROWSER_OUTPUT: Values: 1984.1 08:35:33 INFO - 2015-11-14 08:35:33,010 DEBUG : BROWSER_OUTPUT: 08:35:33 INFO - 2015-11-14 08:35:33,010 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:815.00 Median:815.00 stddev:0.00 (0.0%) 08:35:33 INFO - 2015-11-14 08:35:33,010 DEBUG : BROWSER_OUTPUT: Values: 815.0 08:35:33 INFO - 2015-11-14 08:35:33,010 DEBUG : BROWSER_OUTPUT: 08:35:33 INFO - 2015-11-14 08:35:33,010 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12317.07 Median:12317.07 stddev:0.00 (0.0%) 08:35:33 INFO - 2015-11-14 08:35:33,011 DEBUG : BROWSER_OUTPUT: Values: 12317.1 08:35:33 INFO - 2015-11-14 08:35:33,011 DEBUG : BROWSER_OUTPUT: 08:35:33 INFO - 2015-11-14 08:35:33,011 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26868.42 Median:26868.42 stddev:0.00 (0.0%) 08:35:33 INFO - 2015-11-14 08:35:33,011 DEBUG : BROWSER_OUTPUT: Values: 26868.4 08:35:33 INFO - 2015-11-14 08:35:33,011 DEBUG : BROWSER_OUTPUT: 08:35:33 INFO - 2015-11-14 08:35:33,011 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:620.35 Median:620.35 stddev:0.00 (0.0%) 08:35:33 INFO - 2015-11-14 08:35:33,011 DEBUG : BROWSER_OUTPUT: Values: 620.3 08:35:33 INFO - 2015-11-14 08:35:33,012 DEBUG : BROWSER_OUTPUT: 08:35:33 INFO - 2015-11-14 08:35:33,012 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 08:35:33 INFO - 2015-11-14 08:35:33,012 DEBUG : BROWSER_OUTPUT: Values: 4835.7 08:35:33 INFO - 2015-11-14 08:35:33,012 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:35:33 INFO - 2015-11-14 08:35:33,012 DEBUG : BROWSER_OUTPUT: 08:35:33 INFO - 2015-11-14 08:35:33,904 INFO : Browser exited with error code: 0 08:35:33 INFO - 2015-11-14 08:35:33,918 INFO : Completed test v8_7 (00:00:40) 08:35:34 INFO - 2015-11-14 08:35:34,061 INFO : Completed test suite (00:20:19) 08:35:34 INFO - 2015-11-14 08:35:34,061 DEBUG : Working with test: dromaeo_css 08:35:34 INFO - 2015-11-14 08:35:34,061 DEBUG : Generating results file: dromaeo_css 08:35:34 INFO - 2015-11-14 08:35:34,062 DEBUG : Working with test: kraken 08:35:34 INFO - 2015-11-14 08:35:34,062 DEBUG : Generating results file: kraken 08:35:34 INFO - 2015-11-14 08:35:34,063 INFO : javascript benchmark 08:35:34 INFO - 2015-11-14 08:35:34,063 DEBUG : Working with test: v8_7 08:35:34 INFO - 2015-11-14 08:35:34,063 DEBUG : Generating results file: v8_7 08:35:34 INFO - 2015-11-14 08:35:34,063 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:35:34 INFO - 2015-11-14 08:35:34,120 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,131,35]] 08:35:34 INFO - 2015-11-14 08:35:34,120 DEBUG : process_Request line: dromaeo_css 6121.80 graph.html#tests=[[72,131,35]] 08:35:34 INFO - 2015-11-14 08:35:34,120 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:35:34 INFO - 2015-11-14 08:35:34,223 DEBUG : process_Request line: kraken 1523.70 graph.html#tests=[[232,131,35]] 08:35:34 INFO - 2015-11-14 08:35:34,223 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:35:34 INFO - 2015-11-14 08:35:34,320 DEBUG : process_Request line: v8_7 19666.09 graph.html#tests=[[230,131,35]] 08:35:34 INFO - 2015-11-14 08:35:34,322 INFO : javascript benchmark 08:35:34 INFO - 2015-11-14 08:35:34,324 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [326.82678180564307, 329.5402912936452, 338.50747162878014, 342.3204938197677, 343.6340297583074, 11761.411929403539, 12118.636440906765, 15078.0, 15091.169985650784, 16467.176641167924, 13744.93127534361, 14017.36921838517, 14281.07173033752, 14469.493567725132, 14492.565223043299, 4488.5960263576435, 4664.486906440289, 4951.678140920838, 5143.305653736735, 5147.382314122292, 3138.5449109879055, 3251.561039259693, 4601.148787474312, 4726.881827954294, 4735.431748190204, 4665.486796452387, 4666.510016448275, 4669.439667239919, 4672.579467847893, 4673.579377855992, 4647.140279048387, 4658.25467925132, 6459.967700161516, 6602.834929126762, 6707.1616047994, 6241.188645476104, 6375.10748495211, 6387.776427825051, 6414.069959855795, 6421.133147025185, 19401.417957461297, 19477.12352944107, 19552.413427597054, 19598.0, 20272.49318767028, 1891.5933074389072, 1919.1076149590367, 1923.8749481283812, 1932.7873933867263, 1971.2312198242696, 13451.66370840727, 13470.461181552726, 13586.456541738318, 13785.241811700353, 14111.294435278298, 1823.6626224148442, 1835.220031486613, 1863.9068046597752, 1908.065048126408, 1941.5728539721238, 59243.0, 60055.39944600585, 60865.695671521804, 63095.0, 63351.683241583494, 15231.314590843216, 15518.534443966699, 15651.0, 15679.294431750599, 15685.86282743456, 22361.888190558944, 22460.663090053662, 22693.319200424015, 22803.543929121326, 22838.657420138712, 7938.483998540077, 7959.323457506177, 7980.600969951479, 8050.5169689818795, 8075.717349892726, 6708.396244338033, 6728.461723062143, 6748.898766518506, 6761.357671021246, 6764.120664313607, 7500.699972001168, 7573.962130189314, 7576.7348142814735, 7602.315791578674, 7635.083789945131, 1053.3311347294523, 1058.5659879449388, 2031.7809314411236, 2885.30752619374, 3008.909732708022, 419.59928268503506, 424.6814888833375, 444.9822007119744, 447.3759106047046, 454.66127734837755, 10578.418186999636, 10781.245312828027, 10900.454977251105, 11061.446927653586, 11159.0, 440.8523144746512, 442.15327647555216, 447.1928169653806, 451.345548954018, 467.02392000718663, 5984.820455386345, 6099.20710307666, 6118.541109416811, 6169.2288463942, 6216.906746398808, 330789.0, 440286.0, 449570.0, 462257.0, 506024.0, 68668.0, 70448.0, 70635.2936470639, 71015.0, 71359.0, 448.44616898130784, 458.6628827811556, 458.7155963302774, 459.88732760473897, 460.2429004287928, 9762.02379762018, 9912.0, 10262.794744105226, 10332.276740628084, 10370.688879333633, 31857.0, 32938.17654558559, 33475.83262083771, 33725.66274337225, 33846.323073538886, 43877.831331318324, 44557.77721111374, 44659.33011004903, 45123.32315015343, 45764.771176143906, 5708.57185711065, 5757.971210143923, 5816.418358164319, 6081.543884208791, 6165.383461653978, 10758.892411075789, 11047.83428248593, 11137.944310278397, 11226.887731122584, 11469.942650287028, 9482.336236463381, 9518.286128540525, 9568.421210500468, 10051.59277701137, 10173.389596624227, 8890.199882010651, 9196.54017299119, 9382.765430864283, 9390.718278451657, 9577.23382129414, 9176.322894975588, 9253.53732313395, 9265.166135047879, 9523.809523809623, 9635.807283854143, 5744.224529688438, 5853.209816674695, 5865.618734782396, 5876.764929402776, 5883.499902508334, 7975.282224599814, 9247.167754901822, 9314.717894115985, 9522.523873806143, 9578.952105239428], "dojo.html": [2661.853598052107, 2742.9451410971783, 2764.3089227693076, 2771.8198317109386, 2775.0426102994466, 4600.35595016698, 4760.143174228638, 4777.737224452654, 4842.757862106894, 4860.65975381723, 4709.952900470994, 4773.355596994405, 4775.952240477594, 4781.689190202643, 4917.778699958501, 4376.759278239696, 4383.452068491439, 4387.3418987151945, 4505.819767209307, 4512.255477846152, 4459.397981272519, 4482.596566309048, 4512.255477846152, 4524.253498172798, 4540.364348991144, 4236.195122926634, 4244.575542445762, 4347.891302717426, 4356.607905288508, 4359.149965756678, 4384.824607015716, 4385.101054283896, 4398.80205390755, 4411.2941929291155, 4418.447694038246, 4255.87232383029, 4384.868453946387, 4386.495553011413, 4394.2969124939855, 4408.448943882015, 4636.374089497908, 4660.137874493195, 4719.07977944301, 4761.285807128924, 4775.0, 5142.228665700138, 5153.819616313411, 5163.845084647466, 5166.04428180784, 5195.402528709209, 4931.65478416511, 5068.290439338495, 5168.095583272912, 5184.766685499161, 5191.714455704935, 4603.815847366135, 4660.370849935283, 4671.159191345522, 4704.223803072455, 4723.267893476516, 5236.476352364809, 5244.292020577173, 5244.5279924806955, 5244.6328756987405, 5287.286216360742, 4792.832250871203, 4900.14247506692, 5037.0, 5038.84883453497, 5080.542751152414, 5091.3381260436645, 5095.8980820383385, 5189.532942035235, 5193.272941788153, 5209.7916083356995, 5068.771905264272, 5087.923681144785, 5090.872728181825, 5092.770825312869, 5113.616478764107, 4852.272159176152, 4977.228529577921, 5076.923846142311, 5078.568321692624, 5080.695158290514, 4076.0828813516723, 4160.209560183616, 4167.4790651168605, 4168.7290326128705, 4189.476315460567, 3688.8708895189075, 3689.4834723138783, 3698.3712768829364, 3706.2031663192543, 3719.75388244941, 4169.60388763067, 4266.2960611499375, 4356.891077723082, 4360.040791025969, 4399.802008909607, 4930.778114984834, 5019.84940451787, 5103.18349064148, 5107.157319042391, 5149.742512874342, 4354.346847972829, 4380.759058251763, 4389.18800021997, 4392.824287028483, 4419.381286619811, 4275.0594869128745, 4412.448443944507, 4497.64018878489, 4507.977460112678, 4512.571305725951, 4707.764611769329, 4764.904701906012, 4781.6891902026255, 4800.0639875224, 4837.637177211653, 5108.259302401057, 5159.793608255628, 5164.561012313995, 5167.689938603696, 5208.088584497774, 4679.321498382784, 4807.519248075165, 4887.120318342732, 4903.583195428429, 4940.086084074458, 4932.827351042696, 4969.602431805519, 4985.4266759323145, 4999.47505511916, 5017.4731653175895, 5057.69653820772, 5061.544460998528, 5062.038212739568, 5090.160123579568, 5108.157154069537, 4706.199946009118, 4836.0, 4914.803407863646, 4917.910037987562, 4920.778564964514, 4826.0830442215865, 4862.270659401118, 4954.157793175097, 4954.603631709382, 4957.876053098701, 4845.515448455127, 4851.151048566558, 4852.053849499313, 4865.951340486691, 4884.316195732529, 4776.116418462596, 4910.975445122895, 4937.259411088366, 4945.604351651931, 5002.574781143643, 4733.668643194943, 4763.7856296467435, 4804.567588917014, 4804.783784729626, 4864.562189402971], "mootools.html": [1431.7065001674657, 1547.7833103365526, 1607.397226040235, 1629.6659184867103, 1641.8686505079588, 5955.731992060357, 6986.0, 7231.746888858891, 7231.783046508606, 7234.927650723491, 7076.964615176929, 7130.144382674073, 7155.212926578085, 7155.391791697712, 7194.460415468848, 2062.350359636713, 2082.1151010820417, 2082.9062692178813, 2088.289981406329, 2088.3108574170487, 2112.0812446585705, 2122.3738996995844, 2133.4026472587702, 2163.7836216378396, 2166.729158855143, 2038.8368930485526, 2041.622299874528, 2059.7219375384357, 2061.124022290528, 2062.1545166481746, 2086.7182930304443, 2099.601075795594, 2101.873887566743, 2102.190656597206, 2102.915883364671, 2081.718967939339, 2098.1083039708064, 2108.4096452993185, 2108.5888251790907, 2109.303929703194, 5866.266716660418, 6010.609310394811, 7046.0, 7085.822854428629, 7088.964555177191, 4095.1604920991126, 4239.554846741079, 4271.9359209611885, 4273.465816772903, 4277.2087163874785, 2784.401353708942, 2866.8279903205666, 2887.4658188235244, 2907.418516296749, 2916.0522830080095, 875.6234819027816, 912.7124955639019, 917.4403613795579, 926.1849572376266, 936.5036530638772, 8956.820863582692, 9007.189352958265, 9050.27597792175, 9053.04942980984, 9060.093990600953, 3749.081475038633, 3752.4934133891575, 3815.847366105325, 3820.025893397166, 3824.7322687411615, 7957.641906114239, 7966.243206895336, 7999.640016199285, 8002.51984880909, 8006.439549231614, 4068.105016896278, 4088.652464540488, 4088.6729061674996, 4092.2224777292217, 4094.5700701426517, 3705.7591256568235, 3707.332680117605, 3708.2027364116843, 3713.997220750436, 3715.8142092895246, 3203.7757356985253, 3218.3724173785886, 3237.4496335623003, 3258.6904244096772, 3268.084936217863, 1096.5997410944947, 1101.493313075994, 1103.5806393570551, 1113.2930589075995, 1115.7712668902855, 919.6873063158558, 965.3435663748718, 1171.1743221029324, 1178.2871362825538, 1181.6809461445362, 6669.466442684574, 6706.0, 6717.865642687118, 6739.494537909676, 6751.122354093936, 991.8413053911339, 1026.2098184397971, 1028.2596530498029, 1047.1884289675563, 1054.704682688833, 4771.379720636295, 5363.839084827461, 5404.270423492857, 5429.891402171935, 5437.32033495813, 7383.741569045165, 8189.099199088096, 8392.874106888401, 8439.535825529532, 8462.957685211657, 8317.41778075529, 8480.0, 8489.066202717697, 8490.533020683923, 8497.277731392776, 6161.075838624242, 6315.5894866833505, 6354.205724284465, 6419.775307864203, 6470.09418681385, 6488.805335839932, 6626.469882409492, 6640.070390145287, 6643.40209381158, 6645.335466453316, 7186.60473673932, 7468.887966680395, 7563.168051514219, 7590.278923502258, 7596.164421913474, 7639.159692433939, 7708.344790692854, 7730.342920851791, 7838.059432868093, 7852.450328476952, 6047.0, 6329.968350158404, 6353.809385718436, 6391.2330520337855, 6448.548601597843, 6875.965620171867, 6881.965590172017, 6884.552504087218, 6887.827804304932, 6904.792856214322, 6394.6482943436695, 6447.9355206447335, 6472.320406357265, 6541.411272985454, 6549.7380104795275, 6258.374162583706, 6415.582987105823, 6503.349665033459, 6528.086067950396, 6548.476121910331, 6572.474202063919, 6608.504362172953, 6623.105880706043, 6628.602283862983, 6644.269130395749, 5663.631863928831, 5826.70866456684, 5830.854228644318, 6060.939390606214, 6118.571699981137, 5858.384869588632, 5918.141869428995, 5930.733117009831, 5937.406259374028, 5937.703114844327], "ext.html": [550.9849444541245, 554.3154204557374, 556.7828546866725, 577.7544543568982, 584.541135208861, 27864.164075077755, 36499.452508212366, 36993.81503092481, 37033.62966370335, 37060.44409333862, 40522.0, 41094.58905410945, 41116.17767644645, 41138.0, 41199.79400102995, 6893.0694356261765, 6990.720371185146, 7969.561674107937, 8137.349012079019, 9607.855882161739, 9660.661876834312, 9678.128968392843, 9711.223102151846, 9733.270004749636, 9771.462569558707, 9785.02149785023, 9894.0, 9924.702258932244, 9927.851082233772, 9932.155766759834, 7081.5396999195145, 7244.71021159153, 10156.085952264331, 10451.268411211218, 10483.0, 10028.197744180448, 10140.391576505433, 10161.745956351077, 10165.59337626494, 10170.08469237772, 37178.25643487142, 37537.0, 37603.43594846079, 37606.62393376086, 37611.62388376109, 2792.2239347685736, 2897.203269100993, 3092.567040614316, 3456.9308613827584, 3583.8387272572795, 28680.13959581195, 28857.422851543062, 28966.565501517493, 29158.70841291581, 29572.40855182906, 3063.6476805167467, 3112.7821052526333, 3137.1529686984613, 3141.371725654878, 3186.060112266887, 228287.0, 230175.0, 230440.0, 231386.0, 231655.0, 47323.5267647326, 48396.27405588919, 52688.0, 56714.71642641843, 58377.70811146002, 53359.199612005854, 53531.46468535265, 53556.196657050175, 53685.0, 54062.729686352104, 12532.498700052078, 12655.493780248871, 12674.746505069847, 12818.67953301175, 12837.165584236995, 9497.620095196115, 9527.333086683866, 9555.808883822285, 9568.521573921276, 9604.183644390305, 17800.287988480315, 17931.37240196613, 18016.189271482814, 18016.37852593273, 18037.7294340585, 6987.951807228855, 7237.855242895218, 7303.89044164338, 7339.70599246271, 7422.0, 850.7702920211632, 876.4828751036919, 910.2945217456524, 914.8399030169694, 959.8512230604267, 26436.471270574482, 26588.0, 26648.467030659667, 26987.0, 26988.73011269862, 847.1570787066908, 921.5438358012692, 926.216718760135, 949.534727983297, 1014.8477728340661, 12069.396530173632, 12125.514979400901, 12143.514259429523, 12188.14682972201, 12213.389330533615, 210634.0, 213674.0, 214959.0, 215094.0, 215414.0, 39753.60246397499, 39883.40174897379, 39966.600333996284, 40075.398869016986, 40122.1975560493, 1076.520948178069, 1159.3739380734478, 1165.976680466403, 1184.265755231762, 1189.423129782055, 19409.32067377635, 23183.420414489774, 23662.29013129609, 23781.167659132538, 23817.285481435585, 43011.35482967695, 43395.56604433915, 43397.132057358045, 43402.348964764926, 43486.0, 228375.0, 232995.0, 257755.0, 260490.0, 342469.0, 27919.0, 27974.72025279721, 28004.85997569999, 28437.431251374444, 28450.715492844807, 37894.81052594719, 38163.0, 39171.21657566776, 39246.803765980985, 39620.0, 31586.842065790443, 32153.517697235027, 32669.0, 33227.83386083054, 33552.832235838665, 32511.0, 32517.0, 32589.34821303608, 32835.0, 33002.17494562655, 31735.627610901316, 32180.0, 32425.837870810494, 32492.350152997282, 32517.0, 28791.0, 29432.558511621915, 29979.82703177665, 30257.24356891095, 30599.388012240077, 23193.652095218247, 23711.05155793818, 23905.641415378435, 23980.880095599412, 24133.758662413853], "prototype.html": [300.1206465057382, 303.5689321163947, 306.65041852288397, 306.7070947245381, 307.43585520569746, 5298.337707786527, 5300.9204861927055, 5366.463353664636, 5412.161115027172, 5435.42927992561, 5194.584433245341, 5336.519713225809, 5371.946280537193, 5386.596005299599, 5387.272718183044, 4119.19675663245, 4147.6474499667565, 4151.460310159675, 4151.667866570667, 4163.68772342074, 3977.164795392971, 4034.0721634024194, 4041.0301527633305, 4123.731957422773, 4154.273002224613, 4105.712600117993, 4109.753414795122, 4116.567760385146, 4119.732217405874, 4122.319817230168, 4116.485439320085, 4117.826419470452, 4117.97941010296, 4119.196756632443, 4139.482564679415, 3599.1541987632886, 3602.423612222058, 3605.855765769366, 3609.5127157833617, 3610.223801882608, 5064.518870707314, 5177.844664660066, 5180.481951804827, 5195.870103247411, 5198.220266959948, 4716.056788642285, 4745.691530050535, 4747.311639812242, 4750.61995040396, 4750.904981900378, 5628.296462942132, 5634.211210430543, 5648.0, 5650.152477128422, 5657.886842263173, 3743.2513497300647, 3801.163743976321, 3884.3008258513455, 3940.1528671335514, 4002.039510517484, 5929.881402371929, 5949.286085669747, 5953.940460595382, 5954.374790646963, 5956.7319470623925, 4126.711130220856, 4126.731762435432, 4127.2570937231585, 4128.3601041838565, 4129.442525259112, 4169.332906734908, 4178.39413285072, 4183.3515805050265, 4187.790610469464, 4190.120074784269, 4663.370444989951, 4765.213739732905, 4769.14155452015, 4777.331173635694, 4785.641076919245, 5641.80253691127, 5664.85837854057, 5665.1502274658305, 5667.376588575254, 5667.376588575254, 1459.5767227503904, 1473.1676602719429, 1479.1790556241174, 1482.2885015192553, 1482.3403585404608, 998.3111652959435, 999.3554157568328, 1001.2940876682068, 1003.3377970539555, 1025.0415861169681, 4908.141075311878, 4930.482299358588, 4936.407631084293, 4937.222599864118, 4952.613268284886, 5808.215890854681, 5820.156077368758, 5827.038538641162, 5830.970845145832, 5831.825045248649, 4915.410150781929, 4927.926081108786, 4930.161872481687, 4942.406911170682, 4944.332515110486, 3079.784415090967, 3136.325689976666, 3146.9300437850784, 3158.289384888428, 3164.8101113932776, 5531.889362212733, 5539.639923404966, 5541.362743284493, 5550.222968784374, 5553.944460555424, 5944.048952167633, 6008.24896887889, 6008.669523176267, 6012.368701286302, 6013.789517366871, 5534.723263836872, 5539.390667026624, 5541.972290138524, 5542.722863856791, 5548.195511650869, 5699.772009119754, 5880.411958804086, 5883.676397798162, 5889.617174883619, 5901.0, 5525.392206857162, 5628.015097357864, 5677.460641239076, 5755.107958266475, 5767.221425107557, 5564.972175139098, 5581.776728930798, 5589.049861523469, 5593.720313984203, 5612.0, 3930.9803450982563, 3962.0, 3962.7424217425773, 3965.9405108923966, 3972.9205415892097, 5870.031444811559, 5870.26621672291, 5870.970645146917, 5882.705864706833, 5883.499902508163, 5485.725713714219, 5650.689212093374, 5695.345035320991, 5696.658200507983, 5703.515201207943, 5686.886262274814, 5692.203091567101, 5701.315842098975, 5703.116017017369, 5703.771849125988, 5579.8884022320135, 5581.441855814549, 5583.748731307182, 5584.078627026495, 5585.636933599466, 5583.860403489945, 5724.599278050497, 5726.74229659658, 5727.11229759388, 5730.885382292414, 5534.7786088556, 5544.085225937675, 5550.47270509301, 5551.167324901297, 5551.22282880389], "yui.html": [672.8015235505526, 673.7978606418075, 676.5602358466996, 678.8574399376131, 685.0751485494579, 10878.347299162046, 11097.611583594577, 11115.333080015185, 11126.276792008513, 11134.33194008358, 12096.33470159141, 12338.44476998535, 12363.443645035972, 12366.876331236685, 12373.876261237385, 585.3356440440089, 593.4777395891631, 729.0959210578884, 741.5106030020188, 741.8812989921614, 734.1997223026926, 740.655595148256, 744.0290421000592, 744.5607091815828, 744.6128013433012, 771.2518856709012, 777.4790890103616, 779.9727009554666, 780.1457404142454, 781.4256521456725, 600.7957294519863, 608.6287364707503, 760.5208718507361, 764.5909438450431, 768.6080099149418, 561.1330494386183, 563.0512586292111, 565.5532129617598, 567.1577707104946, 567.2597260574948, 11369.260998035184, 11414.258073225297, 11420.086393088533, 11421.029212516945, 11490.0, 8625.482471051695, 8769.693060742844, 8896.644134234622, 8929.0, 9305.720828375159, 8343.916560834376, 8541.231289183941, 8566.61450234741, 9161.358704890661, 9279.628814847398, 2817.81684190529, 2817.943641127166, 2849.6437945256844, 2852.47229262585, 2868.3116052147543, 39278.60721392778, 39652.0, 39705.0, 39729.20541589181, 39833.00417489557, 6474.935250647527, 6511.479081673455, 6598.04328372393, 6652.800415987528, 6752.324767523209, 10647.0, 10649.84025239622, 10652.786944261072, 10657.094146997437, 10669.253152279265, 5478.890422191534, 5481.643693159932, 5524.640898341595, 5669.348024977098, 5733.197352370671, 3456.5679290088738, 3492.214251793326, 3580.677739003502, 3634.636536346397, 3646.197836476024, 2269.0810221860174, 2297.8161747060194, 2302.8963696633355, 2304.297189357262, 2305.5043165719453, 386.07534953786086, 390.7421102072618, 397.437625759547, 398.63325740318396, 399.9600039995977, 424.8406847432213, 460.7281703794777, 462.2303864066359, 490.6859609849699, 543.4864053469512, 7232.746853860195, 7379.0, 7464.402847772165, 7556.4710470266555, 7700.9614951926005, 443.691634314155, 485.2236421725211, 486.83447627806714, 573.243318819163, 602.8281939647179, 3504.404251277289, 3689.3039976563364, 3723.0296116263967, 3775.2826962876966, 3790.8673196437994, 57652.0, 58255.41744582585, 58369.70815145897, 58461.12308315378, 58492.70753646205, 48484.27273590899, 48654.75672621614, 48985.510144898806, 49087.50912490901, 49187.50812491901, 44611.0, 45002.54997450049, 45356.77321613437, 45770.0, 46229.537704623195, 6944.409725173215, 6987.96506017487, 7014.123234595676, 7071.82320441993, 7255.4921155518605, 32737.18157046093, 33242.0, 33445.83277083599, 33488.81856223655, 33543.83228083844, 39071.609283907936, 39301.80349098236, 42409.0, 42476.36285455659, 42854.35718464288, 6287.308396076336, 6320.968395157995, 6334.144890439732, 6484.837879053061, 6559.967200163968, 9608.0, 9710.223182145553, 9792.755181120529, 9858.30991830565, 9901.306908516335, 8407.53758543286, 8599.785005374915, 8625.39622226438, 8627.525486098073, 8630.619100943819, 8916.821663566821, 9066.727998160066, 9068.909310906807, 9077.09229077087, 9099.954500227457, 8072.636731346986, 8823.0, 8950.418222815497, 9003.63985440575, 9325.673601423918, 8721.56392180401, 8904.73285801427, 8964.462132272085, 9004.729858104267, 9204.861927070966, 8713.782155445911, 8771.342149338698, 8969.551522423983, 9011.568906027978, 9209.76975575616]}, "summary": {"lowerIsBetter": false, "suite": 6121.802194411358, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 7511.0614742820435, "unit": "ms", "value": 7511.0614742820435}, "dojo.html": {"lowerIsBetter": false, "filtered": 4656.773705327257, "unit": "ms", "value": 4656.773705327257}, "mootools.html": {"lowerIsBetter": false, "filtered": 4079.2910577031685, "unit": "ms", "value": 4079.2910577031685}, "ext.html": {"lowerIsBetter": false, "filtered": 16763.158012792625, "unit": "ms", "value": 16763.158012792625}, "prototype.html": {"lowerIsBetter": false, "filtered": 4243.674819756222, "unit": "ms", "value": 4243.674819756222}, "yui.html": {"lowerIsBetter": false, "filtered": 5185.167541672934, "unit": "ms", "value": 5185.167541672934}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-007"}, "testrun": {"date": 1447517714, "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": "20151114075932", "branch": "Mozilla-Inbound-Non-PGO", "revision": "5e3e0fe5e172ee904385ef141c32da65befb6fc1"}}, {"talos_counters": {}, "results": {"audio-dft": [163.0, 162.0, 161.0, 161.0, 161.0, 161.0, 162.0, 164.0, 162.0, 163.0], "ai-astar": [113.0, 113.0, 106.0, 113.0, 113.0, 114.0, 101.0, 113.0, 107.0, 114.0], "imaging-gaussian-blur": [109.0, 109.0, 109.0, 110.0, 110.0, 109.0, 110.0, 109.0, 109.0, 109.0], "audio-beat-detection": [156.0, 139.0, 163.0, 167.0, 133.0, 153.0, 165.0, 130.0, 173.0, 131.0], "json-stringify-tinderbox": [68.0, 68.0, 68.0, 69.0, 69.0, 69.0, 70.0, 68.0, 69.0, 69.0], "stanford-crypto-pbkdf2": [152.0, 143.0, 151.0, 149.0, 150.0, 140.0, 151.0, 156.0, 156.0, 139.0], "json-parse-financial": [69.0, 70.0, 70.0, 69.0, 70.0, 69.0, 69.0, 79.0, 68.0, 68.0], "stanford-crypto-sha256-iterative": [69.0, 69.0, 74.0, 68.0, 69.0, 69.0, 68.0, 69.0, 71.0, 69.0], "audio-fft": [73.0, 72.0, 86.0, 89.0, 72.0, 74.0, 74.0, 106.0, 88.0, 73.0], "imaging-darkroom": [148.0, 148.0, 149.0, 148.0, 147.0, 149.0, 148.0, 149.0, 148.0, 148.0], "stanford-crypto-ccm": [129.0, 118.0, 117.0, 121.0, 121.0, 121.0, 121.0, 121.0, 121.0, 119.0], "audio-oscillator": [92.0, 93.0, 132.0, 91.0, 92.0, 92.0, 130.0, 90.0, 92.0, 129.0], "stanford-crypto-aes": [83.0, 94.0, 83.0, 83.0, 84.0, 82.0, 83.0, 83.0, 84.0, 96.0], "imaging-desaturate": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0]}, "summary": {"lowerIsBetter": true, "suite": 1523.7, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 80.7, "unit": "ms", "value": 80.7}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 148.7, "unit": "ms", "value": 148.7}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 151.0, "unit": "ms", "value": 151.0}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 120.9, "unit": "ms", "value": 120.9}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 148.2, "unit": "ms", "value": 148.2}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 70.1, "unit": "ms", "value": 70.1}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 103.3, "unit": "ms", "value": 103.3}, "ai-astar": {"lowerIsBetter": true, "filtered": 110.7, "unit": "ms", "value": 110.7}, "audio-dft": {"lowerIsBetter": true, "filtered": 162.0, "unit": "ms", "value": 162.0}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 69.5, "unit": "ms", "value": 69.5}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 68.7, "unit": "ms", "value": 68.7}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.3, "unit": "ms", "value": 109.3}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 85.5, "unit": "ms", "value": 85.5}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.1, "unit": "ms", "value": 95.1}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-007"}, "testrun": {"date": 1447517714, "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": "20151114075932", "branch": "Mozilla-Inbound-Non-PGO", "revision": "5e3e0fe5e172ee904385ef141c32da65befb6fc1"}}, {"talos_counters": {}, "results": {"DeltaBlue": [191.64430816404752], "Encrypt": [280.1120448179272], "NavierStokes": [4835.748792270531], "Decrypt": [5050.50505050505], "Splay": [620.3473945409429], "Richards": [165.28925619834712], "RegExp": [26868.42105263158], "Earley": [814.9959250203749], "Boyer": [12317.073170731708], "RayTrace": [1984.126984126984]}, "summary": {"lowerIsBetter": false, "suite": 19666.088051618284, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 345.00372400000015, "unit": "score", "value": 345.00372400000015}, "Encrypt": {"lowerIsBetter": false, "filtered": 950.2661699999999, "unit": "score", "value": 950.2661699999999}, "NavierStokes": {"lowerIsBetter": false, "filtered": 306.881118881119, "unit": "score", "value": 306.881118881119}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.70383799999996, "unit": "score", "value": 52.70383799999996}, "Splay": {"lowerIsBetter": false, "filtered": 131.363492, "unit": "score", "value": 131.363492}, "RegExp": {"lowerIsBetter": false, "filtered": 33.90541625857002, "unit": "score", "value": 33.90541625857002}, "Richards": {"lowerIsBetter": false, "filtered": 213.5771000000001, "unit": "score", "value": 213.5771000000001}, "Earley": {"lowerIsBetter": false, "filtered": 817.7501010000001, "unit": "score", "value": 817.7501010000001}, "Boyer": {"lowerIsBetter": false, "filtered": 54.108877227722786, "unit": "score", "value": 54.108877227722786}, "RayTrace": {"lowerIsBetter": false, "filtered": 372.9544560000001, "unit": "score", "value": 372.9544560000001}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-007"}, "testrun": {"date": 1447517714, "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": "20151114075932", "branch": "Mozilla-Inbound-Non-PGO", "revision": "5e3e0fe5e172ee904385ef141c32da65befb6fc1"}}] 08:35:34 INFO - RETURN: dromaeo_css: 6121.80 08:35:34 INFO - RETURN: kraken: 1523.70 08:35:34 INFO - RETURN: v8_7: 19666.09 08:35:34 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,131,35]]", "result": "19666.09"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,131,35]]", "result": "1523.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,131,35]]", "result": "6121.80"}}} 08:35:34 INFO - Return code: 0 08:35:34 INFO - # TBPL SUCCESS # 08:35:34 INFO - Running post-action listener: _resource_record_post_action 08:35:34 INFO - Running post-run listener: _resource_record_post_run 08:35:35 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 0; Write bytes: 515960832; Read time: 0; Write time: 480152 08:35:35 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 173092864; Read time: 0; Write time: 276620 08:35:35 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 0; Write bytes: 337571840; Read time: 0; Write time: 203100 08:35:35 INFO - Running post-run listener: _upload_blobber_files 08:35:35 INFO - Blob upload gear active. 08:35:35 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 08:35:35 INFO - Copying logs to upload dir... 08:35:35 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1264.013617 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-11-14 08:35:33.885044) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-14 08:35:33.888239) ========= 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=6ef107882637bc5fc02d78b7000001c2-1447495769.677145-1085508765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/otJoFawjQWqL5atyDqz7Mw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.008795 build_url: 'https://queue.taskcluster.net/v1/task/otJoFawjQWqL5atyDqz7Mw/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-14 08:35:33.937377) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 08:35:33.937729) ========= 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=6ef107882637bc5fc02d78b7000001c2-1447495769.677145-1085508765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004530 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 08:35:33.987700) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-14 08:35:33.988021) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-14 08:35:33.988331) ========= ========= Total master_lag: 0.28 =========