builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-068 starttime: 1447799434.35 results: success (0) buildid: 20151117132206 builduid: fdbcce7182a24f60a142e04b34c3f4bf revision: 8c3a0b58fd51c02c8aca138b0da58445becb037f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 14:30:34.348992) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 14:30:34.349443) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 14:30:34.349725) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1447799434.752014-1695511342 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006049 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 14:30:34.369244) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 14:30:34.369584) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 14:30:34.379270) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 14:30:34.379548) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1447799434.752014-1695511342 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004385 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 14:30:34.428128) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 14:30:34.428464) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 14:30:34.428861) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 14:30:34.429193) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1447799434.752014-1695511342 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-17 14:30:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|: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-17 14:30:35 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.186867 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 14:30:34.628348) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 14:30:34.628679) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1447799434.752014-1695511342 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021595 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 14:30:34.678439) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 14:30:34.678867) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8c3a0b58fd51c02c8aca138b0da58445becb037f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 8c3a0b58fd51c02c8aca138b0da58445becb037f --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=d7d9c069d1ebe471abe975fc000001d9-1447799434.752014-1695511342 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-17 14:30:35,834 truncating revision to first 12 chars 2015-11-17 14:30:35,834 Setting DEBUG logging. 2015-11-17 14:30:35,834 attempt 1/10 2015-11-17 14:30:35,834 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8c3a0b58fd51?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-17 14:30:36,059 unpacking tar archive at: mozilla-central-8c3a0b58fd51/testing/mozharness/ program finished with exit code 0 elapsedTime=0.543433 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 14:30:35.235328) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 14:30:35.235639) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 14:30:35.244185) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 14:30:35.244471) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 14:30:35.244859) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-11-17 14:30:35.245169) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=d7d9c069d1ebe471abe975fc000001d9-1447799434.752014-1695511342 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:30:36 INFO - MultiFileLogger online at 20151117 14:30:36 in /builds/slave/test 14:30:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 14:30:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:30:36 INFO - {'append_to_log': False, 14:30:36 INFO - 'base_work_dir': '/builds/slave/test', 14:30:36 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 14:30:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:30:36 INFO - 'branch': 'Firefox-Non-PGO', 14:30:36 INFO - 'buildbot_json_path': 'buildprops.json', 14:30:36 INFO - 'config_files': ('talos/linux_config.py',), 14:30:36 INFO - 'default_actions': ('clobber', 14:30:36 INFO - 'read-buildbot-config', 14:30:36 INFO - 'download-and-extract', 14:30:36 INFO - 'populate-webroot', 14:30:36 INFO - 'create-virtualenv', 14:30:36 INFO - 'install', 14:30:36 INFO - 'run-tests'), 14:30:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:30:36 INFO - 'download_minidump_stackwalk': True, 14:30:36 INFO - 'download_symbols': 'ondemand', 14:30:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:30:36 INFO - 'tooltool.py': '/tools/tooltool.py', 14:30:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:30:36 INFO - '/tools/misc-python/virtualenv.py')}, 14:30:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:30:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:30:36 INFO - 'installer_path': 'installer.exe', 14:30:36 INFO - 'log_level': 'info', 14:30:36 INFO - 'log_name': 'talos', 14:30:36 INFO - 'log_to_console': True, 14:30:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:30:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:30:36 INFO - 'opt_config_files': (), 14:30:36 INFO - 'pip_index': False, 14:30:36 INFO - 'sps_profile': False, 14:30:36 INFO - 'sps_profile_interval': 0, 14:30:36 INFO - 'suite': 'dromaeojs', 14:30:36 INFO - 'system_bits': '64', 14:30:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:30:36 INFO - 'title': 'talos-linux64-ix-068', 14:30:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:30:36 INFO - 'use_talos_json': True, 14:30:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:30:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:30:36 INFO - 'work_dir': 'build'} 14:30:36 INFO - ##### 14:30:36 INFO - ##### Running clobber step. 14:30:36 INFO - ##### 14:30:36 INFO - Running pre-action listener: _resource_record_pre_action 14:30:36 INFO - Running main action method: clobber 14:30:36 INFO - rmtree: /builds/slave/test/build 14:30:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:30:37 INFO - Running post-action listener: _resource_record_post_action 14:30:37 INFO - ##### 14:30:37 INFO - ##### Running read-buildbot-config step. 14:30:37 INFO - ##### 14:30:37 INFO - Running pre-action listener: _resource_record_pre_action 14:30:37 INFO - Running main action method: read_buildbot_config 14:30:37 INFO - Using buildbot properties: 14:30:37 INFO - { 14:30:37 INFO - "properties": { 14:30:37 INFO - "buildnumber": 357, 14:30:37 INFO - "product": "firefox", 14:30:37 INFO - "script_repo_revision": "production", 14:30:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 14:30:37 INFO - "repository": "", 14:30:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 14:30:37 INFO - "buildid": "20151117132206", 14:30:37 INFO - "slavename": "talos-linux64-ix-068", 14:30:37 INFO - "pgo_build": "False", 14:30:37 INFO - "basedir": "/builds/slave/test", 14:30:37 INFO - "project": "", 14:30:37 INFO - "platform": "ubuntu64_hw", 14:30:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:30:37 INFO - "slavebuilddir": "test", 14:30:37 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 14:30:37 INFO - "branch": "mozilla-central", 14:30:37 INFO - "repo_path": "mozilla-central", 14:30:37 INFO - "stage_platform": "linux64", 14:30:37 INFO - "builduid": "fdbcce7182a24f60a142e04b34c3f4bf", 14:30:37 INFO - "revision": "8c3a0b58fd51c02c8aca138b0da58445becb037f" 14:30:37 INFO - }, 14:30:37 INFO - "sourcestamp": { 14:30:37 INFO - "repository": "", 14:30:37 INFO - "hasPatch": false, 14:30:37 INFO - "project": "", 14:30:37 INFO - "branch": "mozilla-central-linux64-talos", 14:30:37 INFO - "changes": [ 14:30:37 INFO - { 14:30:37 INFO - "category": null, 14:30:37 INFO - "files": [ 14:30:37 INFO - { 14:30:37 INFO - "url": null, 14:30:37 INFO - "name": "https://queue.taskcluster.net/v1/task/Ydu7V1ZmQ_iZV5VoGfWoQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 14:30:37 INFO - } 14:30:37 INFO - ], 14:30:37 INFO - "repository": "", 14:30:37 INFO - "rev": "8c3a0b58fd51c02c8aca138b0da58445becb037f", 14:30:37 INFO - "who": "kwierso@gmail.com", 14:30:37 INFO - "when": 1447799394, 14:30:37 INFO - "number": 6674122, 14:30:37 INFO - "comments": "Merge b2ginbound to central, a=merge", 14:30:37 INFO - "project": "", 14:30:37 INFO - "at": "Tue 17 Nov 2015 14:29:54", 14:30:37 INFO - "branch": "mozilla-central-linux64-talos", 14:30:37 INFO - "revlink": "", 14:30:37 INFO - "properties": [ 14:30:37 INFO - [ 14:30:37 INFO - "buildid", 14:30:37 INFO - "20151117132206", 14:30:37 INFO - "Change" 14:30:37 INFO - ], 14:30:37 INFO - [ 14:30:37 INFO - "builduid", 14:30:37 INFO - "fdbcce7182a24f60a142e04b34c3f4bf", 14:30:37 INFO - "Change" 14:30:37 INFO - ], 14:30:37 INFO - [ 14:30:37 INFO - "pgo_build", 14:30:37 INFO - "False", 14:30:37 INFO - "Change" 14:30:37 INFO - ] 14:30:37 INFO - ], 14:30:37 INFO - "revision": "8c3a0b58fd51c02c8aca138b0da58445becb037f" 14:30:37 INFO - } 14:30:37 INFO - ], 14:30:37 INFO - "revision": "8c3a0b58fd51c02c8aca138b0da58445becb037f" 14:30:37 INFO - } 14:30:37 INFO - } 14:30:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ydu7V1ZmQ_iZV5VoGfWoQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 14:30:37 INFO - Running post-action listener: _resource_record_post_action 14:30:37 INFO - ##### 14:30:37 INFO - ##### Running download-and-extract step. 14:30:37 INFO - ##### 14:30:37 INFO - Running pre-action listener: _resource_record_pre_action 14:30:37 INFO - Running main action method: download_and_extract 14:30:37 INFO - mkdir: /builds/slave/test/build/tests 14:30:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:37 INFO - https://queue.taskcluster.net/v1/task/Ydu7V1ZmQ_iZV5VoGfWoQw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:30:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ydu7V1ZmQ_iZV5VoGfWoQw/artifacts/public/build/test_packages.json 14:30:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ydu7V1ZmQ_iZV5VoGfWoQw/artifacts/public/build/test_packages.json 14:30:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ydu7V1ZmQ_iZV5VoGfWoQw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 14:30:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ydu7V1ZmQ_iZV5VoGfWoQw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 14:30:38 INFO - Downloaded 1302 bytes. 14:30:38 INFO - Reading from file /builds/slave/test/build/test_packages.json 14:30:38 INFO - Using the following test package requirements: 14:30:38 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 14:30:38 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:30:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:30:38 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:30:38 INFO - u'jsshell-linux-x86_64.zip'], 14:30:38 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:30:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:30:38 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 14:30:38 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:30:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:30:38 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:30:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:30:38 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:30:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:30:38 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 14:30:38 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:30:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:30:38 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:30:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:38 INFO - https://queue.taskcluster.net/v1/task/Ydu7V1ZmQ_iZV5VoGfWoQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:30:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ydu7V1ZmQ_iZV5VoGfWoQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:30:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ydu7V1ZmQ_iZV5VoGfWoQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:30:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ydu7V1ZmQ_iZV5VoGfWoQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:30:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ydu7V1ZmQ_iZV5VoGfWoQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:30:40 INFO - Downloaded 21277513 bytes. 14:30:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 14:30:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:30:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 14:30:41 INFO - Return code: 0 14:30:41 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:30: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')]} 14:30:41 INFO - https://queue.taskcluster.net/v1/task/Ydu7V1ZmQ_iZV5VoGfWoQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:30:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ydu7V1ZmQ_iZV5VoGfWoQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:30:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ydu7V1ZmQ_iZV5VoGfWoQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:30:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ydu7V1ZmQ_iZV5VoGfWoQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:30:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ydu7V1ZmQ_iZV5VoGfWoQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:30:44 INFO - Downloaded 21277513 bytes. 14:30:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 14:30:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:30:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 14:30:45 INFO - Return code: 0 14:30: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')]} 14:30:45 INFO - https://queue.taskcluster.net/v1/task/Ydu7V1ZmQ_iZV5VoGfWoQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:30:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ydu7V1ZmQ_iZV5VoGfWoQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 14:30:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ydu7V1ZmQ_iZV5VoGfWoQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 14:30:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ydu7V1ZmQ_iZV5VoGfWoQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 14:30:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ydu7V1ZmQ_iZV5VoGfWoQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:30:47 INFO - Downloaded 11131693 bytes. 14:30:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 14:30:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 14:30:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 14:30:47 INFO - Return code: 0 14:30:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:47 INFO - https://queue.taskcluster.net/v1/task/Ydu7V1ZmQ_iZV5VoGfWoQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:30:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ydu7V1ZmQ_iZV5VoGfWoQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:30:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ydu7V1ZmQ_iZV5VoGfWoQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:30:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ydu7V1ZmQ_iZV5VoGfWoQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:30:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ydu7V1ZmQ_iZV5VoGfWoQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:30:51 INFO - Downloaded 55655456 bytes. 14:30:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ydu7V1ZmQ_iZV5VoGfWoQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:30:51 INFO - mkdir: /builds/slave/test/properties 14:30:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:30:51 INFO - Writing to file /builds/slave/test/properties/build_url 14:30:51 INFO - Contents: 14:30:51 INFO - build_url:https://queue.taskcluster.net/v1/task/Ydu7V1ZmQ_iZV5VoGfWoQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:30:51 INFO - Running post-action listener: _resource_record_post_action 14:30:51 INFO - Running post-action listener: set_extra_try_arguments 14:30:51 INFO - ##### 14:30:51 INFO - ##### Running populate-webroot step. 14:30:51 INFO - ##### 14:30:51 INFO - Running pre-action listener: _resource_record_pre_action 14:30:51 INFO - Running main action method: populate_webroot 14:30:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:30:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:30:51 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 14:30:51 INFO - '../fennec_ids.txt'], 14:30:51 INFO - 'tests': ['tcheck2']}, 14:30:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:30:51 INFO - '--tppagecycles', 14:30:51 INFO - '7'], 14:30:51 INFO - 'tests': ['tsvgm']}}, 14:30:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:30:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:30:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:30:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:30:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:30:51 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:30:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:30:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:51 INFO - 'talos_options': ['--e10s'], 14:30:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:30:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:51 INFO - 'tests': ['damp', 'tps']}, 14:30:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:51 INFO - 'talos_options': ['--e10s'], 14:30:51 INFO - 'tests': ['damp', 'tps']}, 14:30:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:30:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:30:51 INFO - 'other': {'tests': ['a11yr', 14:30:51 INFO - 'ts_paint', 14:30:51 INFO - 'tpaint', 14:30:51 INFO - 'sessionrestore', 14:30:51 INFO - 'sessionrestore_no_auto_restore']}, 14:30:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:30:51 INFO - 'tests': ['a11yr', 14:30:51 INFO - 'ts_paint', 14:30:51 INFO - 'tpaint', 14:30:51 INFO - 'sessionrestore', 14:30:51 INFO - 'sessionrestore_no_auto_restore']}, 14:30:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:30:51 INFO - 'tests': ['a11yr', 14:30:51 INFO - 'ts_paint', 14:30:51 INFO - 'tpaint', 14:30:51 INFO - 'sessionrestore', 14:30:51 INFO - 'sessionrestore_no_auto_restore']}, 14:30:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:30:51 INFO - 'tests': ['a11yr', 14:30:51 INFO - 'ts_paint', 14:30:51 INFO - 'tpaint', 14:30:51 INFO - 'sessionrestore', 14:30:51 INFO - 'sessionrestore_no_auto_restore']}, 14:30:51 INFO - 'other_l64': {'tests': ['a11yr', 14:30:51 INFO - 'ts_paint', 14:30:51 INFO - 'tpaint', 14:30:51 INFO - 'sessionrestore', 14:30:51 INFO - 'sessionrestore_no_auto_restore']}, 14:30:51 INFO - 'other_nol64': {'tests': ['a11yr', 14:30:51 INFO - 'ts_paint', 14:30:51 INFO - 'tpaint', 14:30:51 INFO - 'sessionrestore', 14:30:51 INFO - 'sessionrestore_no_auto_restore']}, 14:30:51 INFO - 'svgr': {'tests': ['tsvgx', 14:30:51 INFO - 'tsvgr_opacity', 14:30:51 INFO - 'tart', 14:30:51 INFO - 'tscrollx', 14:30:51 INFO - 'cart']}, 14:30:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:30:51 INFO - 'tests': ['tsvgx', 14:30:51 INFO - 'tsvgr_opacity', 14:30:51 INFO - 'tart', 14:30:51 INFO - 'tscrollx', 14:30:51 INFO - 'cart']}, 14:30:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:51 INFO - 'tests': ['tp5o']}, 14:30:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:51 INFO - 'talos_options': ['--e10s'], 14:30:51 INFO - 'tests': ['tp5o']}, 14:30:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:51 INFO - 'talos_options': ['--xperf_path', 14:30:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:30:51 INFO - 'tests': ['tp5n']}, 14:30:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:51 INFO - 'talos_options': ['--e10s', 14:30:51 INFO - '--xperf_path', 14:30:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:30:51 INFO - 'tests': ['tp5n']}}, 14:30:51 INFO - 'talos.zip': {'path': '', 14:30:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:30:51 INFO - Running post-action listener: _resource_record_post_action 14:30:51 INFO - ##### 14:30:51 INFO - ##### Running create-virtualenv step. 14:30:51 INFO - ##### 14:30:51 INFO - Running pre-action listener: _resource_record_pre_action 14:30:51 INFO - Running main action method: create_virtualenv 14:30:51 INFO - Creating virtualenv /builds/slave/test/build/venv 14:30:51 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:30:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:30:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:30:51 INFO - Using real prefix '/usr' 14:30:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:30:51 INFO - Installing distribute.............................................................................................................................................................................................done. 14:30:53 INFO - Installing pip.................done. 14:30:53 INFO - Return code: 0 14:30:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:30: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')]} 14:30:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30: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')]} 14:30:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:53 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 0x7f06583d7c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc756c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd269a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb5ac0>, '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 0xdb69a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb6e50>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1447799434.752014-1695511342', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:30:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:30:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:30:53 INFO - Using env: {'DISPLAY': ':0', 14:30:53 INFO - 'HOME': '/home/cltbld', 14:30:53 INFO - 'LANG': 'en_US.UTF-8', 14:30:53 INFO - 'LANGUAGE': 'en_US:en', 14:30:53 INFO - 'LOGNAME': 'cltbld', 14:30:53 INFO - 'MAIL': '/var/mail/cltbld', 14:30:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:53 INFO - 'MOZ_NO_REMOTE': '1', 14:30:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:53 INFO - 'NO_EM_RESTART': '1', 14:30:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:53 INFO - 'PWD': '/builds/slave/test', 14:30:53 INFO - 'SHELL': '/bin/bash', 14:30:53 INFO - 'SHLVL': '1', 14:30:53 INFO - 'TERM': 'linux', 14:30:53 INFO - 'TMOUT': '86400', 14:30:53 INFO - 'USER': 'cltbld', 14:30:53 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1447799434.752014-1695511342', 14:30:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:53 INFO - '_': '/tools/buildbot/bin/python'} 14:30:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:53 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:30:53 INFO - Cleaning up... 14:30:53 INFO - Return code: 0 14:30:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:30: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')]} 14:30:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30: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')]} 14:30:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:53 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 0x7f06583d7c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc756c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd269a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb5ac0>, '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 0xdb69a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb6e50>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1447799434.752014-1695511342', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:30:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 14:30:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:30:53 INFO - Using env: {'DISPLAY': ':0', 14:30:53 INFO - 'HOME': '/home/cltbld', 14:30:53 INFO - 'LANG': 'en_US.UTF-8', 14:30:53 INFO - 'LANGUAGE': 'en_US:en', 14:30:53 INFO - 'LOGNAME': 'cltbld', 14:30:53 INFO - 'MAIL': '/var/mail/cltbld', 14:30:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:53 INFO - 'MOZ_NO_REMOTE': '1', 14:30:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:53 INFO - 'NO_EM_RESTART': '1', 14:30:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:53 INFO - 'PWD': '/builds/slave/test', 14:30:53 INFO - 'SHELL': '/bin/bash', 14:30:53 INFO - 'SHLVL': '1', 14:30:53 INFO - 'TERM': 'linux', 14:30:53 INFO - 'TMOUT': '86400', 14:30:53 INFO - 'USER': 'cltbld', 14:30:53 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1447799434.752014-1695511342', 14:30:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:53 INFO - '_': '/tools/buildbot/bin/python'} 14:30:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:54 INFO - Downloading/unpacking psutil>=0.7.1 14:30:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:55 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 14:30:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 14:30:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:30:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:30:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:30:55 INFO - Installing collected packages: psutil 14:30:55 INFO - Running setup.py install for psutil 14:30:56 INFO - building 'psutil._psutil_linux' extension 14:30:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:30:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:30:56 INFO - building 'psutil._psutil_posix' extension 14:30:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:30:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:30:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:30:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:30:56 INFO - Successfully installed psutil 14:30:56 INFO - Cleaning up... 14:30:56 INFO - Return code: 0 14:30:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:30: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')]} 14:30:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30: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')]} 14:30:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30: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', '--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 0x7f06583d7c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc756c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd269a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb5ac0>, '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 0xdb69a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb6e50>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1447799434.752014-1695511342', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:30:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 14:30:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:30:56 INFO - Using env: {'DISPLAY': ':0', 14:30:56 INFO - 'HOME': '/home/cltbld', 14:30:56 INFO - 'LANG': 'en_US.UTF-8', 14:30:56 INFO - 'LANGUAGE': 'en_US:en', 14:30:56 INFO - 'LOGNAME': 'cltbld', 14:30:56 INFO - 'MAIL': '/var/mail/cltbld', 14:30:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:56 INFO - 'MOZ_NO_REMOTE': '1', 14:30:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:56 INFO - 'NO_EM_RESTART': '1', 14:30:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:56 INFO - 'PWD': '/builds/slave/test', 14:30:56 INFO - 'SHELL': '/bin/bash', 14:30:56 INFO - 'SHLVL': '1', 14:30:56 INFO - 'TERM': 'linux', 14:30:56 INFO - 'TMOUT': '86400', 14:30:56 INFO - 'USER': 'cltbld', 14:30:56 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1447799434.752014-1695511342', 14:30:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:56 INFO - '_': '/tools/buildbot/bin/python'} 14:30:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:30:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:30:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 14:30:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:30:58 INFO - Installing collected packages: mozsystemmonitor 14:30:58 INFO - Running setup.py install for mozsystemmonitor 14:30:58 INFO - Successfully installed mozsystemmonitor 14:30:58 INFO - Cleaning up... 14:30:58 INFO - Return code: 0 14:30:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:30:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:58 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 0x7f06583d7c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc756c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd269a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb5ac0>, '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 0xdb69a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb6e50>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1447799434.752014-1695511342', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:30:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:30:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:30:58 INFO - Using env: {'DISPLAY': ':0', 14:30:58 INFO - 'HOME': '/home/cltbld', 14:30:58 INFO - 'LANG': 'en_US.UTF-8', 14:30:58 INFO - 'LANGUAGE': 'en_US:en', 14:30:58 INFO - 'LOGNAME': 'cltbld', 14:30:58 INFO - 'MAIL': '/var/mail/cltbld', 14:30:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:58 INFO - 'MOZ_NO_REMOTE': '1', 14:30:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:58 INFO - 'NO_EM_RESTART': '1', 14:30:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:58 INFO - 'PWD': '/builds/slave/test', 14:30:58 INFO - 'SHELL': '/bin/bash', 14:30:58 INFO - 'SHLVL': '1', 14:30:58 INFO - 'TERM': 'linux', 14:30:58 INFO - 'TMOUT': '86400', 14:30:58 INFO - 'USER': 'cltbld', 14:30:58 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1447799434.752014-1695511342', 14:30:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:58 INFO - '_': '/tools/buildbot/bin/python'} 14:30:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:58 INFO - Downloading/unpacking blobuploader==1.2.4 14:30: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 14:30: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 14:30: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 14:30: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 14:30: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 14:30: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 14:31:00 INFO - Downloading blobuploader-1.2.4.tar.gz 14:31:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 14:31:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:31:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 14:31:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:31:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:01 INFO - Downloading docopt-0.6.1.tar.gz 14:31:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 14:31:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:31:01 INFO - Installing collected packages: blobuploader, requests, docopt 14:31:01 INFO - Running setup.py install for blobuploader 14:31:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:31:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:31:01 INFO - Running setup.py install for requests 14:31:01 INFO - Running setup.py install for docopt 14:31:01 INFO - Successfully installed blobuploader requests docopt 14:31:01 INFO - Cleaning up... 14:31:01 INFO - Return code: 0 14:31:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:31:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:01 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 0x7f06583d7c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc756c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd269a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb5ac0>, '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 0xdb69a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb6e50>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1447799434.752014-1695511342', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:31:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:31:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:31:01 INFO - Using env: {'DISPLAY': ':0', 14:31:01 INFO - 'HOME': '/home/cltbld', 14:31:01 INFO - 'LANG': 'en_US.UTF-8', 14:31:01 INFO - 'LANGUAGE': 'en_US:en', 14:31:01 INFO - 'LOGNAME': 'cltbld', 14:31:01 INFO - 'MAIL': '/var/mail/cltbld', 14:31:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:01 INFO - 'MOZ_NO_REMOTE': '1', 14:31:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:01 INFO - 'NO_EM_RESTART': '1', 14:31:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:01 INFO - 'PWD': '/builds/slave/test', 14:31:01 INFO - 'SHELL': '/bin/bash', 14:31:01 INFO - 'SHLVL': '1', 14:31:01 INFO - 'TERM': 'linux', 14:31:01 INFO - 'TMOUT': '86400', 14:31:01 INFO - 'USER': 'cltbld', 14:31:01 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1447799434.752014-1695511342', 14:31:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:01 INFO - '_': '/tools/buildbot/bin/python'} 14:31:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:31:01 INFO - Running setup.py (path:/tmp/pip-YlPqKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:31:02 INFO - Running setup.py (path:/tmp/pip-JLdhw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:31:02 INFO - Running setup.py (path:/tmp/pip-LFYHjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:31:02 INFO - Running setup.py (path:/tmp/pip-JHeIN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:31:02 INFO - Running setup.py (path:/tmp/pip-CQtN9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:31:02 INFO - Running setup.py (path:/tmp/pip-YPe53m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:31:02 INFO - Running setup.py (path:/tmp/pip-pzNl8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:31:02 INFO - Running setup.py (path:/tmp/pip-IBbVly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:31:02 INFO - Running setup.py (path:/tmp/pip-ag5t6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:31:02 INFO - Running setup.py (path:/tmp/pip-IGjOcc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:31:02 INFO - Running setup.py (path:/tmp/pip-oIQckv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:31:02 INFO - Running setup.py (path:/tmp/pip-5PnJlu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:31:02 INFO - Running setup.py (path:/tmp/pip-UTRCZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:31:02 INFO - Running setup.py (path:/tmp/pip-nUZTHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:31:02 INFO - Running setup.py (path:/tmp/pip-qBhyIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:31:03 INFO - Running setup.py (path:/tmp/pip-qTsFuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:31:03 INFO - Running setup.py (path:/tmp/pip-k_n2Az-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:31:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:31:03 INFO - Running setup.py install for manifestparser 14:31:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:31:03 INFO - Running setup.py install for mozcrash 14:31:03 INFO - Running setup.py install for mozdebug 14:31:03 INFO - Running setup.py install for mozdevice 14:31:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:31:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:31:03 INFO - Running setup.py install for mozfile 14:31:03 INFO - Running setup.py install for mozhttpd 14:31:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:31:03 INFO - Running setup.py install for mozinfo 14:31:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:31:03 INFO - Running setup.py install for mozInstall 14:31:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:31:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:31:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:31:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:31:03 INFO - Running setup.py install for mozleak 14:31:04 INFO - Running setup.py install for mozlog 14:31:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:31:04 INFO - Running setup.py install for moznetwork 14:31:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:31:04 INFO - Running setup.py install for mozprocess 14:31:04 INFO - Running setup.py install for mozprofile 14:31:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:31:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:31:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:31:04 INFO - Running setup.py install for mozrunner 14:31:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:31:04 INFO - Running setup.py install for mozscreenshot 14:31:04 INFO - Running setup.py install for moztest 14:31:04 INFO - Running setup.py install for mozversion 14:31:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:31:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:31:04 INFO - Cleaning up... 14:31:04 INFO - Return code: 0 14:31:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:31:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x7f06583d7c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc756c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd269a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb5ac0>, '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 0xdb69a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb6e50>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1447799434.752014-1695511342', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:31:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:31:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:31:04 INFO - Using env: {'DISPLAY': ':0', 14:31:04 INFO - 'HOME': '/home/cltbld', 14:31:04 INFO - 'LANG': 'en_US.UTF-8', 14:31:04 INFO - 'LANGUAGE': 'en_US:en', 14:31:04 INFO - 'LOGNAME': 'cltbld', 14:31:04 INFO - 'MAIL': '/var/mail/cltbld', 14:31:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:04 INFO - 'MOZ_NO_REMOTE': '1', 14:31:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:04 INFO - 'NO_EM_RESTART': '1', 14:31:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:04 INFO - 'PWD': '/builds/slave/test', 14:31:04 INFO - 'SHELL': '/bin/bash', 14:31:04 INFO - 'SHLVL': '1', 14:31:04 INFO - 'TERM': 'linux', 14:31:04 INFO - 'TMOUT': '86400', 14:31:04 INFO - 'USER': 'cltbld', 14:31:04 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1447799434.752014-1695511342', 14:31:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:04 INFO - '_': '/tools/buildbot/bin/python'} 14:31:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:31:05 INFO - Running setup.py (path:/tmp/pip-YYTU7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:31:05 INFO - Running setup.py (path:/tmp/pip-AGkHmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:31:05 INFO - Running setup.py (path:/tmp/pip-h7pJsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:31:05 INFO - Running setup.py (path:/tmp/pip-hv8zxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:31:05 INFO - Running setup.py (path:/tmp/pip-xE4vww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:31:05 INFO - Running setup.py (path:/tmp/pip-k7C4EF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:31:05 INFO - Running setup.py (path:/tmp/pip-k8IJqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:31:05 INFO - Running setup.py (path:/tmp/pip-QJYkZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:31:05 INFO - Running setup.py (path:/tmp/pip-grKSnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:31:05 INFO - Running setup.py (path:/tmp/pip-qLw8J4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:31:05 INFO - Running setup.py (path:/tmp/pip-uuUTI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:31:05 INFO - Running setup.py (path:/tmp/pip-pK7Gu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:31:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:31:06 INFO - Running setup.py (path:/tmp/pip-_FhiIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:31:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:31:06 INFO - Running setup.py (path:/tmp/pip-TQTrmR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:31:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:31:06 INFO - Running setup.py (path:/tmp/pip-9xQfo2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:31:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:31:06 INFO - Running setup.py (path:/tmp/pip-CoiqHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:31:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:31:06 INFO - Running setup.py (path:/tmp/pip-mu2EHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:31:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:31:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:31:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:31:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:31:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:31:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:31:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:08 INFO - Downloading blessings-1.5.1.tar.gz 14:31:08 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 14:31:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:31:08 INFO - Installing collected packages: blessings 14:31:08 INFO - Running setup.py install for blessings 14:31:08 INFO - Successfully installed blessings 14:31:08 INFO - Cleaning up... 14:31:08 INFO - Return code: 0 14:31:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:31:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:31:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:31:08 INFO - Reading from file tmpfile_stdout 14:31:08 INFO - Current package versions: 14:31:08 INFO - argparse == 1.2.1 14:31:08 INFO - blessings == 1.5.1 14:31:08 INFO - blobuploader == 1.2.4 14:31:08 INFO - docopt == 0.6.1 14:31:08 INFO - manifestparser == 1.1 14:31:08 INFO - mozInstall == 1.12 14:31:08 INFO - mozcrash == 0.16 14:31:08 INFO - mozdebug == 0.1 14:31:08 INFO - mozdevice == 0.47 14:31:08 INFO - mozfile == 1.2 14:31:08 INFO - mozhttpd == 0.7 14:31:08 INFO - mozinfo == 0.9 14:31:08 INFO - mozleak == 0.1 14:31:08 INFO - mozlog == 3.0 14:31:08 INFO - moznetwork == 0.27 14:31:08 INFO - mozprocess == 0.22 14:31:08 INFO - mozprofile == 0.27 14:31:08 INFO - mozrunner == 6.11 14:31:08 INFO - mozscreenshot == 0.1 14:31:08 INFO - mozsystemmonitor == 0.0 14:31:08 INFO - moztest == 0.7 14:31:08 INFO - mozversion == 1.4 14:31:08 INFO - psutil == 3.1.1 14:31:08 INFO - requests == 1.2.3 14:31:08 INFO - wsgiref == 0.1.2 14:31:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:31:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f06583d7c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc756c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd269a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb5ac0>, '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 0xdb69a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb6e50>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1447799434.752014-1695511342', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:31:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:31:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:31:08 INFO - Using env: {'DISPLAY': ':0', 14:31:08 INFO - 'HOME': '/home/cltbld', 14:31:08 INFO - 'LANG': 'en_US.UTF-8', 14:31:08 INFO - 'LANGUAGE': 'en_US:en', 14:31:08 INFO - 'LOGNAME': 'cltbld', 14:31:08 INFO - 'MAIL': '/var/mail/cltbld', 14:31:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:08 INFO - 'MOZ_NO_REMOTE': '1', 14:31:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:08 INFO - 'NO_EM_RESTART': '1', 14:31:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:08 INFO - 'PWD': '/builds/slave/test', 14:31:08 INFO - 'SHELL': '/bin/bash', 14:31:08 INFO - 'SHLVL': '1', 14:31:08 INFO - 'TERM': 'linux', 14:31:08 INFO - 'TMOUT': '86400', 14:31:08 INFO - 'USER': 'cltbld', 14:31:08 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1447799434.752014-1695511342', 14:31:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:08 INFO - '_': '/tools/buildbot/bin/python'} 14:31:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:31:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:31:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:31:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:31:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:31:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:31:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:31:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:31:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:31:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:31:08 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:31:08 INFO - Cleaning up... 14:31:08 INFO - Return code: 0 14:31:08 INFO - Running post-action listener: _resource_record_post_action 14:31:08 INFO - Running post-action listener: _start_resource_monitoring 14:31:08 INFO - Starting resource monitoring. 14:31:08 INFO - ##### 14:31:08 INFO - ##### Running install step. 14:31:08 INFO - ##### 14:31:08 INFO - Running pre-action listener: _resource_record_pre_action 14:31:08 INFO - Running main action method: install 14:31:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:31:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:31:08 INFO - Reading from file tmpfile_stdout 14:31:08 INFO - Detecting whether we're running mozinstall >=1.0... 14:31:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:31:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:31:09 INFO - Reading from file tmpfile_stdout 14:31:09 INFO - Output received: 14:31:09 INFO - Usage: mozinstall [options] installer 14:31:09 INFO - Options: 14:31:09 INFO - -h, --help show this help message and exit 14:31:09 INFO - -d DEST, --destination=DEST 14:31:09 INFO - Directory to install application into. [default: 14:31:09 INFO - "/builds/slave/test"] 14:31:09 INFO - --app=APP Application being installed. [default: firefox] 14:31:09 INFO - mkdir: /builds/slave/test/build/application 14:31:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:31:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:31:23 INFO - Reading from file tmpfile_stdout 14:31:23 INFO - Output received: 14:31:23 INFO - /builds/slave/test/build/application/firefox/firefox 14:31:23 INFO - Running post-action listener: _resource_record_post_action 14:31:23 INFO - ##### 14:31:23 INFO - ##### Running run-tests step. 14:31:23 INFO - ##### 14:31:23 INFO - Running pre-action listener: _resource_record_pre_action 14:31:23 INFO - Running main action method: run_tests 14:31:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:31:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:31:23 INFO - Python 2.7.3 14:31:23 INFO - Return code: 0 14:31:23 INFO - grabbing minidump binary from tooltool 14:31:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:23 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 0xdb5ac0>, '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 0xdb69a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb6e50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:31:23 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:31:23 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:31:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:31:23 INFO - Return code: 0 14:31:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:31:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:31:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:31:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:31:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:31:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ydu7V1ZmQ_iZV5VoGfWoQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost'] in /builds/slave/test/build 14:31:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ydu7V1ZmQ_iZV5VoGfWoQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --webServer localhost 14:31:23 INFO - Using env: {'DISPLAY': ':0', 14:31:23 INFO - 'HOME': '/home/cltbld', 14:31:23 INFO - 'LANG': 'en_US.UTF-8', 14:31:23 INFO - 'LANGUAGE': 'en_US:en', 14:31:23 INFO - 'LOGNAME': 'cltbld', 14:31:23 INFO - 'MAIL': '/var/mail/cltbld', 14:31:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:31:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:31:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:23 INFO - 'MOZ_NO_REMOTE': '1', 14:31:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:31:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:23 INFO - 'NO_EM_RESTART': '1', 14:31:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:23 INFO - 'PWD': '/builds/slave/test', 14:31:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:31:23 INFO - 'SHELL': '/bin/bash', 14:31:23 INFO - 'SHLVL': '1', 14:31:23 INFO - 'TERM': 'linux', 14:31:23 INFO - 'TMOUT': '86400', 14:31:23 INFO - 'USER': 'cltbld', 14:31:23 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1447799434.752014-1695511342', 14:31:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:23 INFO - '_': '/tools/buildbot/bin/python'} 14:31:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ydu7V1ZmQ_iZV5VoGfWoQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost'] with output_timeout 3600 14:31:23 INFO - mozversion INFO | application_buildid: 20151117132206 14:31:23 INFO - mozversion INFO | application_changeset: 8c3a0b58fd51c02c8aca138b0da58445becb037f 14:31:23 INFO - mozversion INFO | application_display_name: Nightly 14:31:23 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:31:23 INFO - mozversion INFO | application_name: Firefox 14:31:23 INFO - mozversion INFO | application_remotingname: firefox 14:31:23 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 14:31:23 INFO - mozversion INFO | application_vendor: Mozilla 14:31:23 INFO - mozversion INFO | application_version: 45.0a1 14:31:23 INFO - mozversion INFO | platform_buildid: 20151117132206 14:31:23 INFO - mozversion INFO | platform_changeset: 8c3a0b58fd51c02c8aca138b0da58445becb037f 14:31:23 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 14:31:23 INFO - mozversion INFO | platform_version: 45.0a1 14:31:23 INFO - 2015-11-17 14:31:23,387 DEBUG : using testdate: 1447799483 14:31:23 INFO - 2015-11-17 14:31:23,387 DEBUG : actual date: 1447799483 14:31:23 INFO - 2015-11-17 14:31:23,396 INFO : starting webserver on 'localhost:36709' 14:31:23 INFO - 2015-11-17 14:31:23,397 INFO : Starting test suite talos-linux64-ix-068 14:31:23 INFO - 2015-11-17 14:31:23,397 INFO : Starting test dromaeo_css 14:31:23 INFO - 2015-11-17 14:31:23,397 DEBUG : operating with platform_type : linux_ 14:31:23 INFO - 2015-11-17 14:31:23,398 INFO : Initialising browser for dromaeo_css test... 14:31:23 INFO - 2015-11-17 14:31:23,415 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY8wGKf/profile http://localhost:36709/getInfo.html 14:31:27 INFO - 2015-11-17 14:31:27,558 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:31:27 INFO - 2015-11-17 14:31:27,559 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:31:27 INFO - 2015-11-17 14:31:27,559 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:31:27 INFO - 2015-11-17 14:31:27,559 DEBUG : BROWSER_OUTPUT: __metrics 14:31:27 INFO - 2015-11-17 14:31:27,635 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:31:28 INFO - 2015-11-17 14:31:28,935 INFO : Browser initialized. 14:31:28 INFO - 2015-11-17 14:31:28,936 INFO : Running cycle 1/1 for dromaeo_css test... 14:31:28 INFO - 2015-11-17 14:31:28,936 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY8wGKf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:31:40 INFO - 2015-11-17 14:31:40,896 DEBUG : BROWSER_OUTPUT: RSS: Main: 141746176 14:31:40 INFO - 2015-11-17 14:31:40,897 DEBUG : BROWSER_OUTPUT: 14:32:32 INFO - 2015-11-17 14:32:32,330 DEBUG : BROWSER_OUTPUT: 1447799552326 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:34:44 INFO - 2015-11-17 14:34:44,054 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36709/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36709/tests/dromaeo/cssquery-ext.html) 14:34:45 INFO - 2015-11-17 14:34:45,069 DEBUG : BROWSER_OUTPUT: RSS: Main: 222097408 14:34:45 INFO - 2015-11-17 14:34:45,069 DEBUG : BROWSER_OUTPUT: 14:37:47 INFO - 2015-11-17 14:37:47,520 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36709/tests/dromaeo/cssquery-ext.html (next: http://localhost:36709/tests/dromaeo/cssquery-jquery.html) 14:37:48 INFO - 2015-11-17 14:37:48,093 DEBUG : BROWSER_OUTPUT: RSS: Main: 228532224 14:37:48 INFO - 2015-11-17 14:37:48,094 DEBUG : BROWSER_OUTPUT: 14:40:50 INFO - 2015-11-17 14:40:50,117 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36709/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36709/tests/dromaeo/cssquery-mootools.html) 14:40:50 INFO - 2015-11-17 14:40:50,691 DEBUG : BROWSER_OUTPUT: RSS: Main: 212021248 14:40:50 INFO - 2015-11-17 14:40:50,691 DEBUG : BROWSER_OUTPUT: 14:43:52 INFO - 2015-11-17 14:43:52,626 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36709/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36709/tests/dromaeo/cssquery-prototype.html) 14:43:53 INFO - 2015-11-17 14:43:53,207 DEBUG : BROWSER_OUTPUT: RSS: Main: 201871360 14:43:53 INFO - 2015-11-17 14:43:53,208 DEBUG : BROWSER_OUTPUT: 14:46:55 INFO - 2015-11-17 14:46:55,901 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36709/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36709/tests/dromaeo/cssquery-yui.html) 14:46:56 INFO - 2015-11-17 14:46:56,487 DEBUG : BROWSER_OUTPUT: RSS: Main: 181633024 14:46:56 INFO - 2015-11-17 14:46:56,487 DEBUG : BROWSER_OUTPUT: 14:49:58 INFO - 2015-11-17 14:49:58,971 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36709/tests/dromaeo/cssquery-yui.html (next: http://localhost:36709/tests/dromaeo/cssquery-dojo.html) 14:49:59 INFO - 2015-11-17 14:49:59,217 DEBUG : BROWSER_OUTPUT: RSS: Main: 249430016 14:49:59 INFO - 2015-11-17 14:49:59,217 DEBUG : BROWSER_OUTPUT: 14:49:59 INFO - 2015-11-17 14:49:59,218 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:49:59 INFO - 2015-11-17 14:49:59,218 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:49:59 INFO - 2015-11-17 14:49:59,219 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:49:59 INFO - 2015-11-17 14:49:59,219 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:49:59 INFO - 2015-11-17 14:49:59,220 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2664.6669166354204;2766.626505421769;2777.2223777342347;2789.302674331417;2792.734690204431;4563.224251877181;4678.602318802898;4788.3535722677425;4835.85492435227;4855.4416242132165;4715.41057367829;4716.245400735883;4733.029728905574;4787.904241915159;4800.207965685658;4388.5830846069575;4459.665525085632;4481.395011673431;4509.075639493913;4523.525029871866;4296.591823776736;4510.774461276939;4540.7502587357685;4543.250363690004;4572.382728331682;4341.5441378655105;4404.251277282853;4445.110977804452;4446.888827779299;4452.443444569429;4425.446819147606;4425.8229670813125;4436.7116137451285;4437.889052773674;4486.237339652267;4185.183889141618;4284.2930916398755;4409.272470042439;4411.889702757425;4453.421055262795;4572.3827283317;4607.35497030416;4708.529147085298;4713.6229101672125;4726.952730472685;5129.563987061104;5165.560927321182;5176.120059589879;5176.844694659167;5177.8187763428095;5205.193195054772;5205.193195054772;5207.6354655174155;5208.401033881114;5220.895582088337;4595.03504264105;4675.322078298662;4684.297355396718;4690.226112691436;4693.366395536559;5268.262443257947;5399.379071406838;5414.214938833926;5432.076546986943;5434.184872269191;5061.670991385548;5071.442141364447;5072.467390923974;5075.314832497639;5087.389513258433;4943.65394422387;5162.174052151638;5164.92252616211;5172.508611681884;5176.689398636094;5002.399712034579;5024.899502010013;5032.018756342552;5032.421271553818;5041.621878359138;5078.923816142761;5105.923411148836;5141.76862041209;5143.8456846294675;5156.484351564814;3958.6833053355663;3960.2277555876326;3977.940330895039;3994.380870965005;4002.079521709965;3320.4853247746637;3446.4485682291215;3462.826858657057;3524.594671612746;3577.69589584883;4336.176126535948;4400.647948164139;4411.933820992687;4449.17690227309;4450.065486247924;5132.486751324912;5220.347456567929;5235.240890070994;5236.083685355047;5238;4265.210935976854;4364.476262848415;4365.323374876899;4467.642588592905;4490.259107247268;4393.6704747144095;4501.864944051684;4524.117797029613;4547.249703798836;4556.749378784199;4857.4171099467585;4946;4948.257761335828;4952.1581331173065;4986.202207646759;5011.373578302712;5160.174372100446;5209.947900520946;5219.1388420910125;5266.762995665281;4817.807287708452;4835.734034627989;4928.876778080433;4932.975335123301;4949.678270912379;5048.268001139888;5056.974715126401;5067.113255180402;5068.721220332917;5100.362454693163;4791.616670666408;4902.754862256802;5135.537801597874;5140.331756871583;5150.330457040561;4898.559129678346;4930.531599498042;5011.84964451067;5012.799488020439;5021.246812978083;5020.49795020495;5033.0688822567945;5043;5048.066107770074;5071.416787069535;4656.976715116402;4758.571728544448;4879.804807807648;4933.876653083558;4970.229614409773;4870.659053866196;4880.072786170758;5000.024995125916;5000.224965130411;5026.447090819934;4988.476209997898;4991.176455884738;4995.825146119869;4996.750162491788;5035.84892453227 14:49:59 INFO - 2015-11-17 14:49:59,221 DEBUG : BROWSER_OUTPUT: |1;ext.html;563.4309347558966;572.3075079154222;573.5383016671581;577.532198918876;579.8753268047369;24519.14183003595;37447.625523744755;37640;37698.24603507928;37713;39334.60665393345;39862.601373986254;39896.60103398965;39953.80023099888;39957.40063899044;6782.762603308885;6931.653417329138;7935.484193527431;8094.797630059266;8119.472234304781;10305.536250868729;10483.73790655232;10538.315009524395;10539.52572134252;10554.155667546616;10207.846882296772;10306.175505959543;10310.587576496931;10314.742131446736;10317.43254121023;6957.65211739411;7132.5007249492555;10077.69766906994;10215.693529194135;10505.894941050568;10011.849822252672;10170.084692377648;10181.643642472478;10186.439745813977;10192.694219173436;36757;36998.63001369979;37257;37259.4411083834;37326.44010339847;2689.623452716621;2759.8758055887533;2845.8719357628956;2899.3331533747146;2901.7968742188054;27196.32009199766;27465.17604471869;28175.295617609725;28180.436391272266;29656.555151672743;2993.52103663415;3044.9086527404215;3084.0439463766306;3143.5441860930036;3232.6282477514915;226037;227253;227999;228174;228197.99999999834;41670.1665966679;55908;56251;56253;56323.71838140865;47422;65783;67215;67231.66384168145;67272.32727672759;12029;12133.939330303292;12181.634550963485;12264.264144151379;12266;9246;9310.487923164155;9310.767230819149;9321.766955826159;9353.438793672402;19281.710774338397;19311.324103656305;19456;19462;19496.80503194978;7525.924740752632;7813.374930005586;7842.255435461578;7912.993062636161;7984.161663025298;705.0411440440996;725.9020032295679;747.3871425431203;808.8382323535317;900.3877363392825;26300.8684956574;30168.24579385489;31033.68966310308;31080.689193108232;31576;871.847426700325;889.9243564296978;893.1961234888652;903.0382642485731;914.2685851318919;13815.516456923959;14080.788788168185;14344.56966291013;14371;14399.208043557705;318154;323828;323964;327686;328364;48614.756926215145;49035;49097.50902491001;49131.263031054565;49222.261666075035;1114.4650567727374;1123.3877536742496;1130.2935665209245;1152.688774031007;1154.3593305715408;23383.649245260993;25776.484470310865;26537.203883883514;30150.84924575363;30719.846400767852;43719.125617488105;44232.33651495166;44281;44327.67542434395;44421.11157776762;252891;254761;254914;254937;255324;24327.51344973126;25553.48893022166;28303.575446367908;28581.28546786347;29829.850850745606;34640.30719385648;34804.65195348014;34924.65075349214;35453.29093418066;35668.64331356757;29426.852865735535;29834;29888.85055574708;30385.392292154476;30464.390712186076;30743.385132297677;32409.513857291688;32471.675283246866;32528.18679532936;35508;33617.495737564444;34469;34489.482657759654;34634.653653463145;34730;28504.598160735044;30683.693163068085;31214;31223.843880780452;31274.843625781727;23057.423564411023;23909.641355379335;24188.274351769476;25975.480490390466;26778 14:49:59 INFO - 2015-11-17 14:49:59,222 DEBUG : BROWSER_OUTPUT: |2;jquery.html;326.1032161555722;326.464598059183;327.69851736402507;330.50919384713694;331.27781436468496;8542.402031857773;8703.173198546145;10465.162786977033;15812.84187158128;16381.836181638195;8335.95832020839;10348.534315955781;10503;10640.255182137253;11082.445877706103;4146.958530414695;4259.2546304396765;4264.339027450735;4264.59486348798;4267.975685835393;3075.7078077582705;3166.936661266773;4221.831126754926;4260.552641972595;6221.751129954796;6460.257070436913;6517.576357536768;6520.435095577075;6521.706523206467;6528.41244288014;6394.520410969173;6512.413882750528;6534.117894084286;6566.047923051155;6569;6045.183900173508;6117.6023558469005;6262.12330273762;6274.843128921768;6294.685265736741;20320.593588128155;20915.267965621282;21046.473838154016;21341.359759207247;21869.12523499058;1853.6014756827346;1856.5637075287298;1904.1812020831037;1955.071341112974;2028.2799606139756;13683.931580342134;13840.446382144803;14007.64980875476;14050.297485125806;14052.227127507984;1832.8350448459703;1863;1871.3917976657506;1909.5321646196633;1962.7939066397964;62828;62959;63203.68398158026;63914.36085639131;64403;14655.48705795292;15409.614759630875;15426.845731542766;15433;15434.845651543565;22742.431439213822;22800;22924.656130158062;22965.96653150612;23059;7187.64061796908;7239.457040721967;7252.1297444305965;7413.703451861865;7635.427342949301;5859.150423188614;5925.496332811673;5945.256842894638;6052.818415447544;6081.996470582304;7373.5944523050675;7505.362044226193;7511.812204694927;7541.095068591804;7542.773716788505;1307.405130665545;1310.4823594680047;1322.8809407153403;1336.7861142217198;2039.7965200531758;351.5447495493342;355.4348585748672;363.6527116603637;376.8417264748812;383.82535946144435;8944.821103578022;9453.952730236304;9572.47351395666;9709.465979371202;9803.852942205873;378.50226951558614;379.6090027271914;414.8029685899174;418.7194579631654;454.13034039813385;4942.654014219042;5506.972465137648;5758.971205143947;5854.121881717776;5968.552358573124;455019;458841;459200;466847;468485;64532.677336613015;65818;66315;67193.3280667187;67362.66318668376;484.9345338379344;491.8081948040267;491.842610364687;492.45337675179803;492.5517778821255;10082.092611664986;10082.344647597884;10108.191344692259;10132.949335253277;10271.537780800032;31130.84434577903;32213.677863221066;32942.67057329396;32959.67040329566;33198.5020224692;41553.79223103865;42248.36627450652;43137.13725725405;43564;43585.34621980736;5874.647521148745;5884.382139875252;5888.764449422147;5898;5903.439173278532;10463.895361046596;10799.190060745319;10827.891721083004;10860.511276992396;10985.395803230898;9250.259979201783;9456.290778191526;9656.082672146134;9877.06167914047;9905.306628535933;9141.177294043568;9391.577379018097;9425.19885809714;9525.333226674065;9649.565769540528;9533.761655958657;9591.472469014272;9669.806603867743;9671.226301895973;9687.612495500101;5363.946360536344;5383.353997520323;6160.7535698571555;6207.844803879939;6301.023341382093;9254.814903701754;9437.480938548446;9464.858027129736;9553.283503737108;9613.903860961302 14:49:59 INFO - 2015-11-17 14:49:59,224 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1046.1317106801355;1613.1772795874103;1643.3083546474813;1666.2002238925315;1689.2145152504088;6168.352323006082;6694.06283120363;6793.388595026447;6799.830004249896;6804.761833335834;6987.441004719623;7081.433485321175;7082.468814838895;7089.397401220903;7104.360607545333;2086.426232785981;2114.6616541353387;2114.830813534921;2115.672070829024;2118.046878904491;2082.2295750572234;2106.947326316839;2111.6832475128776;2111.873287602741;2113.6406810842195;2035.216441669953;2056.033664177834;2069.244725675133;2070.1201989154624;2072.8652637578584;2049.723287356203;2067.9069441875154;2075.3773867839586;2080.8335333173386;2082.2816128435743;2048.682454219598;2052.2611859730487;2074.9066292016896;2081.6149012432597;2083.802038806311;6050.939490605082;6195.28754193269;6969.23338432772;6985.511014229006;7026.824329391755;3965.9801700991597;4035.3543433050572;4058;4063;4070.043539768152;2783.3598272397257;2792.2600510864636;2842.786790990684;2847.786416018786;2887.595736596878;900.045951291633;902.2421166220341;903.75146834621;936.8173206224789;1733.6186039071383;9508.952455237748;9618.615255389775;9633.566489507988;9639;9639.951800241024;3870.1679138985255;3886.240407177217;3893.922121557553;3932.528096628423;3970.06703424695;7806.648700808477;7852.411069169721;7865.842683146419;7868.095169055632;7873.409494287951;4195.58044195578;4208.053188032668;4211.663066954637;4217.00900288432;4218.514870789837;3773.415120656303;3789.829457674411;3795.070207799107;3804.3722785740597;3814.6376094271;3155.2111972006996;3159.9684003160132;3165.113768144923;3179.0621766578915;3189.378071276079;954.4130359828794;957.6360982826482;961.6393852305386;966.9516524173763;969.9224062075017;1138.8633363996373;1142.1433924556582;1152.982705259422;1155.9826602600967;1168;6598.835029124214;6652.70062847173;6676.732930682815;6713.362230588086;6714.429273511806;402.56724021676814;416.2569812883988;418.9224993376235;419.38769396681187;419.47984499220746;4707.105649926503;4944.92582611254;4948.505149485023;4963.503649635008;4967.90064198714;7750.534967901944;8283.29591984676;8457.873131903027;8535.615897284637;8548.444351117158;8296.875546866802;8339.874901876477;8355.791105222417;8425.4944703318;8429.789255268668;6548.443382312556;6671.966640166768;6676.098726671934;6683.866322673519;6685.8997115044285;6527.813182583698;6552.410283074546;6576.80269591913;6601.306862779531;6628.53600247978;7508.249175082448;7609.239076092568;7657.119431265476;7674.117476490275;7684.346830519468;7533;7738.071431428265;7763.262490063435;7854.607269636381;7857.607119643881;6257.53068519872;6284.622922624657;6334.8733025338315;6353.5870168438905;6354.3963323484195;6356;6431.774887878902;6437.742490300336;6447.548671593131;6452.387023232785;5990.161377407254;6035.094735789667;6071.574989750675;6259.3427690091885;6290.21372328459;6149.108379285068;6186.319504854372;6203.31763506005;6300.716467759054;6352.047192921099;6051;6091.0558863376245;6091.451769340781;6094.75620975156;6099.4815440688035;5822.592418530662;5827.9417205829095;5835.066389377679;5845.1232315153065;5845.152452894392;5654.575906807088;5765.91351129725;5767.855803604775;5771.480566749013;5774.740136693943 14:49:59 INFO - 2015-11-17 14:49:59,224 DEBUG : BROWSER_OUTPUT: |4;prototype.html;292.2270594278134;299.8126171143036;301.2003131685375;301.7812086237477;304.3092180749697;5246.7901283948695;5342.866428339294;5350.785968561263;5390.21841832934;5495.505404513593;5340.225667278252;5414.242006119137;5425.6202065855305;5430.294061771974;5437.456254374561;3940.9605903941024;4190.308599081148;4190.413342132104;4193.580641935812;4195.5594662560525;4023.054582173187;4092.85675001375;4168.7081904266715;4177.791110444481;4185.644220241283;4109.198706252282;4131;4134.793260336986;4135.8759237222785;4153.024039350766;3945.230680017398;4024.6981476389387;4037.4953130858644;4145.170965806836;4152.667786577066;3662.3957047087197;3691.7969511676847;3693.741438099334;3697.334479793636;3699.223163135745;5181.1969144782615;5185.818496352609;5187.766550505236;5190.143626301656;5214.5306922376785;4794.424669039703;4796.712197268175;4812.951870481285;4813.951860481386;4816.060868130716;5574.358948720868;5675.489205971482;5694.9179655865255;5700;5709.8287051388525;4023.034471726794;4023.97988010061;4025.4565633639377;4031.737937034083;4033.2740106780766;5905.2323197984415;5957.285125784891;5961.314448838396;5971.731272092767;5977.402259773988;4145.191687620885;4146.419501269825;4150.750954942713;4153.044799696087;4153.439285696392;4117.876463706094;4187.6440502557625;4211.284081706117;4216.6626669866955;4218.704690671623;4765.618750499952;4775.832845850448;4780.976095119502;4784.330193772875;4791.425028996473;5602.159676048625;5631.662100273997;5643.52030077448;5658.207850900877;5662.065759149694;1466.1935935235579;1487.3084015932643;1494.1110039526463;1495.7008598280388;1495.7158139953374;995.183949161695;1005.2058873490007;1008.7377281906757;1013.4881884648205;1026.630413051301;4996.650234483552;5029.974850125726;5030.622703297267;5031.622628302819;5033.597312215014;5910.172575839386;5911.852203694942;5914.674692891932;5918.733656985446;5922.082077278029;5016.398032236155;5018.021485810232;5018.5985121190215;5023.447420783711;5023.974880125649;3113.408452394038;3163.1459505933267;3183.2996740717003;3184.824834634071;3192.2657788708725;5582.720863956786;5590.440955904377;5593.468620481048;5594.860128496739;5597.328320601554;6058.485028772516;6070.150178974947;6071.150038994544;6077.270727512727;6079;5457.372402173642;5586.636868603528;5588.273524441796;5593.664380137124;5595.636283641632;5888.94111058901;5893.263342082239;5893.911591326219;5896.7936122235515;5901.144334071621;5753.683547404933;5759.049756790083;5759.683217423082;5760.135979603093;5771.220885180447;5582.106862901916;5589.776408943597;5591.664500130005;5591.748371323381;5592.804251851166;3871.0902937810156;4046.352583586612;4066.573009833925;4120.526139493996;4128.422020917014;5901.468867801918;5904.380040095728;5907.675077870758;5911.586188966903;5914.201582786441;5680.318361796611;5682.77268909239;5688.260526131577;5691.800786972602;5692.6299790513485;5574.749136288796;5680.062789639664;5682.289713785777;5684.488396044376;5687.374388817309;5611.270534830446;5612.354579223442;5614.494695477427;5615.466530679579;5616.326040875121;5472.972635136799;5592.245046918614;5765.798197063083;5766.048601980794;5773.336066352255;5467.4532546745;5547.833564993057;5588.888222235614;5609.607327487037;5629.662220266797 14:49:59 INFO - 2015-11-17 14:49:59,225 DEBUG : BROWSER_OUTPUT: |5;yui.html;546.4671944853768;550.4165584480451;561.2871653000686;582.9387914269001;609.4332270987982;10828.296160749556;10992.615258465956;11010.284331518445;11028.834567481494;11065.280756750826;11457;11520.481578328974;11769.941150294258;11930.64208073757;11939.34333611651;602.1810337940398;608.5162295974711;755.7166062726492;762.6987340000696;772.1274959295988;747.9139898911641;772.3203580848873;772.7140957845605;772.82997740497;773.8955241042472;802.0976401548259;804.264098350009;811.6753298680516;811.9715809946653;812.8333691593209;616.4575173847009;625.3059104394118;791.9208079192092;798.9480683755537;802.1136644008375;599.5503372470647;599.8950183717832;600.1328080923068;600.3486217454067;601.2784658409926;11117.110631149488;11230.213885028052;11249.887501125047;11253.099752019818;11262.605808796734;10466.895331046668;11248.831267530912;11443;11672.766544669059;11819.290842549388;9053.773655658595;9065.637374505011;9204;9223.538823058887;9307.34848560601;3131.780775345727;3133.2480204750923;3189.2824114574037;3193.281511659858;3198;34062.318753624786;34596;34626.82686586576;40815.183696325905;41305.79347103275;6442.903356449657;6579.374959378852;6638.6680665966505;6754.392104710501;6759.256481787;10772.838407423895;10864.837027444595;10875.184361172944;10889.128869690407;10915.235933484739;5555.2500412444615;5607.467290607386;5713.485786279255;5725.141228815711;5836.941630583725;3501.072215862798;3513.6135025147214;3541.610422853484;3570.5179800727087;3619.367209971241;2413.0227257960555;2445.15642103474;2450.424150324672;2451.852888826676;2452.2152911068288;387.3086540525149;389.93566061600086;391.44805823788323;391.72774921429334;392.3604524624843;415.85445094217386;427.6706935659587;445.59228306099556;467.5721714631142;473.6921001349082;6228.844278893064;6281.089242059876;6335.524835637253;6543.051257567626;6686.431653309426;460.82949308755974;468.6906641616517;471.90561887622613;490.4188536584159;492.44599825196656;3161.1780936956557;3222.113918672384;3236.530703048045;3300.818454984999;3508.8421021054114;52083;52123.73938130361;52324.738376307876;52445.213321800205;52518.737406313485;41156.588434115874;41276;41529;41788;41905.1618967625;35996.82001589975;42259.36610950838;42499.787501062296;43237.783811081375;43399.349009764876;7175.928240717526;7442.9255707442235;7445.4043676506835;7488.625568721651;7652;31840.363192735553;32096.518552222202;32218;32707.509387358732;32792.344153116326;38332;39789.80105099456;40693.593064068984;41234.762957111336;41500.37749433701;6431;6595.736170553124;6688.431483323972;6774.627395493098;6889.724411023503;10203.132733717717;10282.588696452058;10346.689599312032;10512.106470950055;10692.83960740574;9165.404248723811;9166;9371.671991480265;9405.670801521914;9715.222782177267;9384.483853387856;9446.574904129193;9661.420314781135;9854.507274636097;9896.802063958825;7936.246056624612;7999.480033798018;9504;9580.329376943548;9897.35667181631;8540.40217184816;8773.956130219309;9097.636094556143;9210.585523651585;9345.345825792401;8141.267285944294;8142.7557173284895;8835.911640883509;8971.147740964598;9168.816623667355 14:49:59 INFO - 2015-11-17 14:49:59,225 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:49:59 INFO - 2015-11-17 14:49:59,225 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:49:59 INFO - 2015-11-17 14:49:59,226 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,810 14:49:59 INFO - 2015-11-17 14:49:59,226 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:49:59 INFO - 2015-11-17 14:49:59,226 DEBUG : BROWSER_OUTPUT: __startTimestamp1447800599217__endTimestamp 14:49:59 INFO - 2015-11-17 14:49:59,226 DEBUG : BROWSER_OUTPUT: 14:49:59 INFO - 2015-11-17 14:49:59,226 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:49:59 INFO - 2015-11-17 14:49:59,226 DEBUG : BROWSER_OUTPUT: Number of tests: 6 14:49:59 INFO - 2015-11-17 14:49:59,226 DEBUG : BROWSER_OUTPUT: 14:49:59 INFO - 2015-11-17 14:49:59,226 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4719.68 Median:4879.80 stddev:531.74 (10.9%) stddev-sans-first:508.35 14:49:59 INFO - 2015-11-17 14:49:59,228 DEBUG : BROWSER_OUTPUT: Values: 2664.7 2766.6 2777.2 2789.3 2792.7 4563.2 4678.6 4788.4 4835.9 4855.4 4715.4 4716.2 4733.0 4787.9 4800.2 4388.6 4459.7 4481.4 4509.1 4523.5 4296.6 4510.8 4540.8 4543.3 4572.4 4341.5 4404.3 4445.1 4446.9 4452.4 4425.4 4425.8 4436.7 4437.9 4486.2 4185.2 4284.3 4409.3 4411.9 4453.4 4572.4 4607.4 4708.5 4713.6 4727.0 5129.6 5165.6 5176.1 5176.8 5177.8 5205.2 5205.2 5207.6 5208.4 5220.9 4595.0 4675.3 4684.3 4690.2 4693.4 5268.3 5399.4 5414.2 5432.1 5434.2 5061.7 5071.4 5072.5 5075.3 5087.4 4943.7 5162.2 5164.9 5172.5 5176.7 5002.4 5024.9 5032.0 5032.4 5041.6 5078.9 5105.9 5141.8 5143.8 5156.5 3958.7 3960.2 3977.9 3994.4 4002.1 3320.5 3446.4 3462.8 3524.6 3577.7 4336.2 4400.6 4411.9 4449.2 4450.1 5132.5 5220.3 5235.2 5236.1 5238.0 4265.2 4364.5 4365.3 4467.6 4490.3 4393.7 4501.9 4524.1 4547.2 4556.7 4857.4 4946.0 4948.3 4952.2 4986.2 5011.4 5160.2 5209.9 5219.1 5266.8 4817.8 4835.7 4928.9 4933.0 4949.7 5048.3 5057.0 5067.1 5068.7 5100.4 4791.6 4902.8 5135.5 5140.3 5150.3 4898.6 4930.5 5011.8 5012.8 5021.2 5020.5 5033.1 5043.0 5048.1 5071.4 4657.0 4758.6 4879.8 4933.9 4970.2 4870.7 4880.1 5000.0 5000.2 5026.4 4988.5 4991.2 4995.8 4996.8 5035.8 14:49:59 INFO - 2015-11-17 14:49:59,228 DEBUG : BROWSER_OUTPUT: 14:49:59 INFO - 2015-11-17 14:49:59,228 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42998.90 Median:31249.34 stddev:71150.27 (227.7%) stddev-sans-first:71278.53 14:49:59 INFO - 2015-11-17 14:49:59,228 DEBUG : BROWSER_OUTPUT: Values: 563.4 572.3 573.5 577.5 579.9 24519.1 37447.6 37640.0 37698.2 37713.0 39334.6 39862.6 39896.6 39953.8 39957.4 6782.8 6931.7 7935.5 8094.8 8119.5 10305.5 10483.7 10538.3 10539.5 10554.2 10207.8 10306.2 10310.6 10314.7 10317.4 6957.7 7132.5 10077.7 10215.7 10505.9 10011.8 10170.1 10181.6 10186.4 10192.7 36757.0 36998.6 37257.0 37259.4 37326.4 2689.6 2759.9 2845.9 2899.3 2901.8 27196.3 27465.2 28175.3 28180.4 29656.6 2993.5 3044.9 3084.0 3143.5 3232.6 226037.0 227253.0 227999.0 228174.0 228198.0 41670.2 55908.0 56251.0 56253.0 56323.7 47422.0 65783.0 67215.0 67231.7 67272.3 12029.0 12133.9 12181.6 12264.3 12266.0 9246.0 9310.5 9310.8 9321.8 9353.4 19281.7 19311.3 19456.0 19462.0 19496.8 7525.9 7813.4 7842.3 7913.0 7984.2 705.0 725.9 747.4 808.8 900.4 26300.9 30168.2 31033.7 31080.7 31576.0 871.8 889.9 893.2 903.0 914.3 13815.5 14080.8 14344.6 14371.0 14399.2 318154.0 323828.0 323964.0 327686.0 328364.0 48614.8 49035.0 49097.5 49131.3 49222.3 1114.5 1123.4 1130.3 1152.7 1154.4 23383.6 25776.5 26537.2 30150.8 30719.8 43719.1 44232.3 44281.0 44327.7 44421.1 252891.0 254761.0 254914.0 254937.0 255324.0 24327.5 25553.5 28303.6 28581.3 29829.9 34640.3 34804.7 34924.7 35453.3 35668.6 29426.9 29834.0 29888.9 30385.4 30464.4 30743.4 32409.5 32471.7 32528.2 35508.0 33617.5 34469.0 34489.5 34634.7 34730.0 28504.6 30683.7 31214.0 31223.8 31274.8 23057.4 23909.6 24188.3 25975.5 26778.0 14:49:59 INFO - 2015-11-17 14:49:59,228 DEBUG : BROWSER_OUTPUT: 14:49:59 INFO - 2015-11-17 14:49:59,228 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25092.59 Median:234484.97 stddev:75590.97 (32.2%) stddev-sans-first:75780.15 14:49:59 INFO - 2015-11-17 14:49:59,229 DEBUG : BROWSER_OUTPUT: Values: 326.1 326.5 327.7 330.5 331.3 8542.4 8703.2 10465.2 15812.8 16381.8 8336.0 10348.5 10503.0 10640.3 11082.4 4147.0 4259.3 4264.3 4264.6 4268.0 3075.7 3166.9 4221.8 4260.6 6221.8 6460.3 6517.6 6520.4 6521.7 6528.4 6394.5 6512.4 6534.1 6566.0 6569.0 6045.2 6117.6 6262.1 6274.8 6294.7 20320.6 20915.3 21046.5 21341.4 21869.1 1853.6 1856.6 1904.2 1955.1 2028.3 13683.9 13840.4 14007.6 14050.3 14052.2 1832.8 1863.0 1871.4 1909.5 1962.8 62828.0 62959.0 63203.7 63914.4 64403.0 14655.5 15409.6 15426.8 15433.0 15434.8 22742.4 22800.0 22924.7 22966.0 23059.0 7187.6 7239.5 7252.1 7413.7 7635.4 5859.2 5925.5 5945.3 6052.8 6082.0 7373.6 7505.4 7511.8 7541.1 7542.8 1307.4 1310.5 1322.9 1336.8 2039.8 351.5 355.4 363.7 376.8 383.8 8944.8 9454.0 9572.5 9709.5 9803.9 378.5 379.6 414.8 418.7 454.1 4942.7 5507.0 5759.0 5854.1 5968.6 455019.0 458841.0 459200.0 466847.0 468485.0 64532.7 65818.0 66315.0 67193.3 67362.7 484.9 491.8 491.8 492.5 492.6 10082.1 10082.3 10108.2 10132.9 10271.5 31130.8 32213.7 32942.7 32959.7 33198.5 41553.8 42248.4 43137.1 43564.0 43585.3 5874.6 5884.4 5888.8 5898.0 5903.4 10463.9 10799.2 10827.9 10860.5 10985.4 9250.3 9456.3 9656.1 9877.1 9905.3 9141.2 9391.6 9425.2 9525.3 9649.6 9533.8 9591.5 9669.8 9671.2 9687.6 5363.9 5383.4 6160.8 6207.8 6301.0 9254.8 9437.5 9464.9 9553.3 9613.9 14:49:59 INFO - 2015-11-17 14:49:59,230 DEBUG : BROWSER_OUTPUT: 14:49:59 INFO - 2015-11-17 14:49:59,230 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4860.57 Median:6081.32 stddev:2518.94 (41.4%) stddev-sans-first:2509.69 14:49:59 INFO - 2015-11-17 14:49:59,230 DEBUG : BROWSER_OUTPUT: Values: 1046.1 1613.2 1643.3 1666.2 1689.2 6168.4 6694.1 6793.4 6799.8 6804.8 6987.4 7081.4 7082.5 7089.4 7104.4 2086.4 2114.7 2114.8 2115.7 2118.0 2082.2 2106.9 2111.7 2111.9 2113.6 2035.2 2056.0 2069.2 2070.1 2072.9 2049.7 2067.9 2075.4 2080.8 2082.3 2048.7 2052.3 2074.9 2081.6 2083.8 6050.9 6195.3 6969.2 6985.5 7026.8 3966.0 4035.4 4058.0 4063.0 4070.0 2783.4 2792.3 2842.8 2847.8 2887.6 900.0 902.2 903.8 936.8 1733.6 9509.0 9618.6 9633.6 9639.0 9640.0 3870.2 3886.2 3893.9 3932.5 3970.1 7806.6 7852.4 7865.8 7868.1 7873.4 4195.6 4208.1 4211.7 4217.0 4218.5 3773.4 3789.8 3795.1 3804.4 3814.6 3155.2 3160.0 3165.1 3179.1 3189.4 954.4 957.6 961.6 967.0 969.9 1138.9 1142.1 1153.0 1156.0 1168.0 6598.8 6652.7 6676.7 6713.4 6714.4 402.6 416.3 418.9 419.4 419.5 4707.1 4944.9 4948.5 4963.5 4967.9 7750.5 8283.3 8457.9 8535.6 8548.4 8296.9 8339.9 8355.8 8425.5 8429.8 6548.4 6672.0 6676.1 6683.9 6685.9 6527.8 6552.4 6576.8 6601.3 6628.5 7508.2 7609.2 7657.1 7674.1 7684.3 7533.0 7738.1 7763.3 7854.6 7857.6 6257.5 6284.6 6334.9 6353.6 6354.4 6356.0 6431.8 6437.7 6447.5 6452.4 5990.2 6035.1 6071.6 6259.3 6290.2 6149.1 6186.3 6203.3 6300.7 6352.0 6051.0 6091.1 6091.5 6094.8 6099.5 5822.6 5827.9 5835.1 5845.1 5845.2 5654.6 5765.9 5767.9 5771.5 5774.7 14:49:59 INFO - 2015-11-17 14:49:59,230 DEBUG : BROWSER_OUTPUT: 14:49:59 INFO - 2015-11-17 14:49:59,230 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4719.39 Median:5341.55 stddev:1383.09 (25.9%) stddev-sans-first:1346.46 14:49:59 INFO - 2015-11-17 14:49:59,230 DEBUG : BROWSER_OUTPUT: Values: 292.2 299.8 301.2 301.8 304.3 5246.8 5342.9 5350.8 5390.2 5495.5 5340.2 5414.2 5425.6 5430.3 5437.5 3941.0 4190.3 4190.4 4193.6 4195.6 4023.1 4092.9 4168.7 4177.8 4185.6 4109.2 4131.0 4134.8 4135.9 4153.0 3945.2 4024.7 4037.5 4145.2 4152.7 3662.4 3691.8 3693.7 3697.3 3699.2 5181.2 5185.8 5187.8 5190.1 5214.5 4794.4 4796.7 4813.0 4814.0 4816.1 5574.4 5675.5 5694.9 5700.0 5709.8 4023.0 4024.0 4025.5 4031.7 4033.3 5905.2 5957.3 5961.3 5971.7 5977.4 4145.2 4146.4 4150.8 4153.0 4153.4 4117.9 4187.6 4211.3 4216.7 4218.7 4765.6 4775.8 4781.0 4784.3 4791.4 5602.2 5631.7 5643.5 5658.2 5662.1 1466.2 1487.3 1494.1 1495.7 1495.7 995.2 1005.2 1008.7 1013.5 1026.6 4996.7 5030.0 5030.6 5031.6 5033.6 5910.2 5911.9 5914.7 5918.7 5922.1 5016.4 5018.0 5018.6 5023.4 5024.0 3113.4 3163.1 3183.3 3184.8 3192.3 5582.7 5590.4 5593.5 5594.9 5597.3 6058.5 6070.2 6071.2 6077.3 6079.0 5457.4 5586.6 5588.3 5593.7 5595.6 5888.9 5893.3 5893.9 5896.8 5901.1 5753.7 5759.0 5759.7 5760.1 5771.2 5582.1 5589.8 5591.7 5591.7 5592.8 3871.1 4046.4 4066.6 4120.5 4128.4 5901.5 5904.4 5907.7 5911.6 5914.2 5680.3 5682.8 5688.3 5691.8 5692.6 5574.7 5680.1 5682.3 5684.5 5687.4 5611.3 5612.4 5614.5 5615.5 5616.3 5473.0 5592.2 5765.8 5766.0 5773.3 5467.5 5547.8 5588.9 5609.6 5629.7 14:49:59 INFO - 2015-11-17 14:49:59,230 DEBUG : BROWSER_OUTPUT: 14:49:59 INFO - 2015-11-17 14:49:59,231 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11587.93 Median:52103.37 stddev:13896.58 (26.7%) stddev-sans-first:13910.82 14:49:59 INFO - 2015-11-17 14:49:59,231 DEBUG : BROWSER_OUTPUT: Values: 546.5 550.4 561.3 582.9 609.4 10828.3 10992.6 11010.3 11028.8 11065.3 11457.0 11520.5 11769.9 11930.6 11939.3 602.2 608.5 755.7 762.7 772.1 747.9 772.3 772.7 772.8 773.9 802.1 804.3 811.7 812.0 812.8 616.5 625.3 791.9 798.9 802.1 599.6 599.9 600.1 600.3 601.3 11117.1 11230.2 11249.9 11253.1 11262.6 10466.9 11248.8 11443.0 11672.8 11819.3 9053.8 9065.6 9204.0 9223.5 9307.3 3131.8 3133.2 3189.3 3193.3 3198.0 34062.3 34596.0 34626.8 40815.2 41305.8 6442.9 6579.4 6638.7 6754.4 6759.3 10772.8 10864.8 10875.2 10889.1 10915.2 5555.3 5607.5 5713.5 5725.1 5836.9 3501.1 3513.6 3541.6 3570.5 3619.4 2413.0 2445.2 2450.4 2451.9 2452.2 387.3 389.9 391.4 391.7 392.4 415.9 427.7 445.6 467.6 473.7 6228.8 6281.1 6335.5 6543.1 6686.4 460.8 468.7 471.9 490.4 492.4 3161.2 3222.1 3236.5 3300.8 3508.8 52083.0 52123.7 52324.7 52445.2 52518.7 41156.6 41276.0 41529.0 41788.0 41905.2 35996.8 42259.4 42499.8 43237.8 43399.3 7175.9 7442.9 7445.4 7488.6 7652.0 31840.4 32096.5 32218.0 32707.5 32792.3 38332.0 39789.8 40693.6 41234.8 41500.4 6431.0 6595.7 6688.4 6774.6 6889.7 10203.1 10282.6 10346.7 10512.1 10692.8 9165.4 9166.0 9371.7 9405.7 9715.2 9384.5 9446.6 9661.4 9854.5 9896.8 7936.2 7999.5 9504.0 9580.3 9897.4 8540.4 8774.0 9097.6 9210.6 9345.3 8141.3 8142.8 8835.9 8971.1 9168.8 14:49:59 INFO - 2015-11-17 14:49:59,231 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:49:59 INFO - 2015-11-17 14:49:59,231 DEBUG : BROWSER_OUTPUT: 14:49:59 INFO - 2015-11-17 14:49:59,992 INFO : Browser exited with error code: 0 14:50:00 INFO - 2015-11-17 14:50:00,010 INFO : Completed test dromaeo_css (00:18:36) 14:50:00 INFO - 2015-11-17 14:50:00,010 INFO : Starting test kraken 14:50:00 INFO - 2015-11-17 14:50:00,010 DEBUG : operating with platform_type : linux_ 14:50:00 INFO - 2015-11-17 14:50:00,010 INFO : Initialising browser for kraken test... 14:50:00 INFO - 2015-11-17 14:50:00,016 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptJiUHb/profile http://localhost:36709/getInfo.html 14:50:04 INFO - 2015-11-17 14:50:04,020 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:50:04 INFO - 2015-11-17 14:50:04,020 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:50:04 INFO - 2015-11-17 14:50:04,020 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:50:04 INFO - 2015-11-17 14:50:04,020 DEBUG : BROWSER_OUTPUT: __metrics 14:50:04 INFO - 2015-11-17 14:50:04,157 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:50:05 INFO - 2015-11-17 14:50:05,436 INFO : Browser initialized. 14:50:05 INFO - 2015-11-17 14:50:05,436 INFO : Running cycle 1/1 for kraken test... 14:50:05 INFO - 2015-11-17 14:50:05,436 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptJiUHb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:50:17 INFO - 2015-11-17 14:50:17,433 DEBUG : BROWSER_OUTPUT: RSS: Main: 141488128 14:50:17 INFO - 2015-11-17 14:50:17,434 DEBUG : BROWSER_OUTPUT: 14:50:20 INFO - 2015-11-17 14:50:20,050 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36709/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36709/tests/kraken/driver.html?testName=audio-beat-detection) 14:50:20 INFO - 2015-11-17 14:50:20,636 DEBUG : BROWSER_OUTPUT: RSS: Main: 180977664 14:50:20 INFO - 2015-11-17 14:50:20,636 DEBUG : BROWSER_OUTPUT: 14:50:23 INFO - 2015-11-17 14:50:23,380 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36709/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36709/tests/kraken/driver.html?testName=audio-dft) 14:50:23 INFO - 2015-11-17 14:50:23,961 DEBUG : BROWSER_OUTPUT: RSS: Main: 170192896 14:50:23 INFO - 2015-11-17 14:50:23,961 DEBUG : BROWSER_OUTPUT: 14:50:26 INFO - 2015-11-17 14:50:26,971 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36709/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36709/tests/kraken/driver.html?testName=audio-fft) 14:50:27 INFO - 2015-11-17 14:50:27,537 DEBUG : BROWSER_OUTPUT: RSS: Main: 152952832 14:50:27 INFO - 2015-11-17 14:50:27,537 DEBUG : BROWSER_OUTPUT: 14:50:29 INFO - 2015-11-17 14:50:29,576 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36709/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36709/tests/kraken/driver.html?testName=audio-oscillator) 14:50:30 INFO - 2015-11-17 14:50:30,145 DEBUG : BROWSER_OUTPUT: RSS: Main: 153153536 14:50:30 INFO - 2015-11-17 14:50:30,145 DEBUG : BROWSER_OUTPUT: 14:50:32 INFO - 2015-11-17 14:50:32,346 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36709/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36709/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:50:32 INFO - 2015-11-17 14:50:32,912 DEBUG : BROWSER_OUTPUT: RSS: Main: 155713536 14:50:32 INFO - 2015-11-17 14:50:32,912 DEBUG : BROWSER_OUTPUT: 14:50:35 INFO - 2015-11-17 14:50:35,956 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36709/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36709/tests/kraken/driver.html?testName=imaging-darkroom) 14:50:36 INFO - 2015-11-17 14:50:36,529 DEBUG : BROWSER_OUTPUT: RSS: Main: 155942912 14:50:36 INFO - 2015-11-17 14:50:36,529 DEBUG : BROWSER_OUTPUT: 14:50:39 INFO - 2015-11-17 14:50:39,963 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36709/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36709/tests/kraken/driver.html?testName=imaging-desaturate) 14:50:40 INFO - 2015-11-17 14:50:40,549 DEBUG : BROWSER_OUTPUT: RSS: Main: 156184576 14:50:40 INFO - 2015-11-17 14:50:40,549 DEBUG : BROWSER_OUTPUT: 14:50:43 INFO - 2015-11-17 14:50:43,407 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36709/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36709/tests/kraken/driver.html?testName=json-parse-financial) 14:50:43 INFO - 2015-11-17 14:50:43,989 DEBUG : BROWSER_OUTPUT: RSS: Main: 156139520 14:50:43 INFO - 2015-11-17 14:50:43,989 DEBUG : BROWSER_OUTPUT: 14:50:45 INFO - 2015-11-17 14:50:45,738 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36709/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36709/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:50:46 INFO - 2015-11-17 14:50:46,320 DEBUG : BROWSER_OUTPUT: RSS: Main: 163635200 14:50:46 INFO - 2015-11-17 14:50:46,320 DEBUG : BROWSER_OUTPUT: 14:50:48 INFO - 2015-11-17 14:50:48,218 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36709/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36709/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:50:48 INFO - 2015-11-17 14:50:48,803 DEBUG : BROWSER_OUTPUT: RSS: Main: 163823616 14:50:48 INFO - 2015-11-17 14:50:48,803 DEBUG : BROWSER_OUTPUT: 14:50:50 INFO - 2015-11-17 14:50:50,964 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36709/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36709/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:50:51 INFO - 2015-11-17 14:50:51,545 DEBUG : BROWSER_OUTPUT: RSS: Main: 171847680 14:50:51 INFO - 2015-11-17 14:50:51,545 DEBUG : BROWSER_OUTPUT: 14:50:54 INFO - 2015-11-17 14:50:54,066 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36709/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36709/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:50:54 INFO - 2015-11-17 14:50:54,656 DEBUG : BROWSER_OUTPUT: RSS: Main: 178089984 14:50:54 INFO - 2015-11-17 14:50:54,656 DEBUG : BROWSER_OUTPUT: 14:50:57 INFO - 2015-11-17 14:50:57,191 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36709/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36709/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:50:57 INFO - 2015-11-17 14:50:57,772 DEBUG : BROWSER_OUTPUT: RSS: Main: 175767552 14:50:57 INFO - 2015-11-17 14:50:57,772 DEBUG : BROWSER_OUTPUT: 14:50:59 INFO - 2015-11-17 14:50:59,542 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36709/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36709/tests/kraken/driver.html?testName=ai-astar) 14:50:59 INFO - 2015-11-17 14:50:59,792 DEBUG : BROWSER_OUTPUT: RSS: Main: 234504192 14:50:59 INFO - 2015-11-17 14:50:59,792 DEBUG : BROWSER_OUTPUT: 14:50:59 INFO - 2015-11-17 14:50:59,792 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:50:59 INFO - 2015-11-17 14:50:59,793 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:50:59 INFO - 2015-11-17 14:50:59,793 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:50:59 INFO - 2015-11-17 14:50:59,793 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:50:59 INFO - 2015-11-17 14:50:59,793 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;112;106;111;113;114;102;113;114;112 14:50:59 INFO - 2015-11-17 14:50:59,794 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;149;131;153;168;130;162;159;130;165;131 14:50:59 INFO - 2015-11-17 14:50:59,794 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;161;161;160;160;164;163;162;162;161 14:50:59 INFO - 2015-11-17 14:50:59,794 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;74;83;90;74;73;72;101;91;73 14:50:59 INFO - 2015-11-17 14:50:59,794 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;92;130;91;92;91;126;90;91;134 14:50:59 INFO - 2015-11-17 14:50:59,794 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;110;111;110;109;109;109;109 14:50:59 INFO - 2015-11-17 14:50:59,794 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;148;147;148;148;148;148;148;148;148 14:50:59 INFO - 2015-11-17 14:50:59,795 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;97;96;97;97;96;95;96;95 14:50:59 INFO - 2015-11-17 14:50:59,795 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;69;69;68;69;69;69;69;76;67;66 14:50:59 INFO - 2015-11-17 14:50:59,795 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;70;69;70;70;70;71;70;70;71 14:50:59 INFO - 2015-11-17 14:50:59,795 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;84;83;92;83;83;83;84;84;100 14:50:59 INFO - 2015-11-17 14:50:59,795 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;118;122;123;125;117;120;125;127;117;120 14:50:59 INFO - 2015-11-17 14:50:59,795 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;146;134;145;144;158;133;150;136;138;134 14:50:59 INFO - 2015-11-17 14:50:59,795 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;72;71;70;69;71;69;69;72;71 14:50:59 INFO - 2015-11-17 14:50:59,796 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:50:59 INFO - 2015-11-17 14:50:59,796 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:50:59 INFO - 2015-11-17 14:50:59,796 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,993 14:50:59 INFO - 2015-11-17 14:50:59,796 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:50:59 INFO - 2015-11-17 14:50:59,796 DEBUG : BROWSER_OUTPUT: __startTimestamp1447800659791__endTimestamp 14:50:59 INFO - 2015-11-17 14:50:59,796 DEBUG : BROWSER_OUTPUT: 14:50:59 INFO - 2015-11-17 14:50:59,804 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:50:59 INFO - 2015-11-17 14:50:59,804 DEBUG : BROWSER_OUTPUT: Number of tests: 14 14:50:59 INFO - 2015-11-17 14:50:59,804 DEBUG : BROWSER_OUTPUT: 14:50:59 INFO - 2015-11-17 14:50:59,804 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.90 Median:112.50 stddev:3.87 (3.4%) stddev-sans-first:4.09 14:50:59 INFO - 2015-11-17 14:50:59,804 DEBUG : BROWSER_OUTPUT: Values: 112.0 112.0 106.0 111.0 113.0 114.0 102.0 113.0 114.0 112.0 14:50:59 INFO - 2015-11-17 14:50:59,804 DEBUG : BROWSER_OUTPUT: 14:50:59 INFO - 2015-11-17 14:50:59,804 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.80 Median:156.00 stddev:15.84 (10.2%) stddev-sans-first:16.79 14:50:59 INFO - 2015-11-17 14:50:59,805 DEBUG : BROWSER_OUTPUT: Values: 149.0 131.0 153.0 168.0 130.0 162.0 159.0 130.0 165.0 131.0 14:50:59 INFO - 2015-11-17 14:50:59,805 DEBUG : BROWSER_OUTPUT: 14:50:59 INFO - 2015-11-17 14:50:59,805 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.26 (0.8%) stddev-sans-first:1.33 14:50:59 INFO - 2015-11-17 14:50:59,805 DEBUG : BROWSER_OUTPUT: Values: 162.0 161.0 161.0 160.0 160.0 164.0 163.0 162.0 162.0 161.0 14:50:59 INFO - 2015-11-17 14:50:59,805 DEBUG : BROWSER_OUTPUT: 14:50:59 INFO - 2015-11-17 14:50:59,805 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.30 Median:74.00 stddev:10.37 (14.0%) stddev-sans-first:10.56 14:50:59 INFO - 2015-11-17 14:50:59,805 DEBUG : BROWSER_OUTPUT: Values: 72.0 74.0 83.0 90.0 74.0 73.0 72.0 101.0 91.0 73.0 14:50:59 INFO - 2015-11-17 14:50:59,805 DEBUG : BROWSER_OUTPUT: 14:50:59 INFO - 2015-11-17 14:50:59,805 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.90 Median:91.00 stddev:18.81 (20.7%) stddev-sans-first:19.53 14:50:59 INFO - 2015-11-17 14:50:59,805 DEBUG : BROWSER_OUTPUT: Values: 92.0 92.0 130.0 91.0 92.0 91.0 126.0 90.0 91.0 134.0 14:50:59 INFO - 2015-11-17 14:50:59,805 DEBUG : BROWSER_OUTPUT: 14:50:59 INFO - 2015-11-17 14:50:59,805 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:109.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 14:50:59 INFO - 2015-11-17 14:50:59,805 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 110.0 111.0 110.0 109.0 109.0 109.0 109.0 14:50:59 INFO - 2015-11-17 14:50:59,805 DEBUG : BROWSER_OUTPUT: 14:50:59 INFO - 2015-11-17 14:50:59,805 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 14:50:59 INFO - 2015-11-17 14:50:59,805 DEBUG : BROWSER_OUTPUT: Values: 148.0 148.0 147.0 148.0 148.0 148.0 148.0 148.0 148.0 148.0 14:50:59 INFO - 2015-11-17 14:50:59,806 DEBUG : BROWSER_OUTPUT: 14:50:59 INFO - 2015-11-17 14:50:59,806 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 14:50:59 INFO - 2015-11-17 14:50:59,806 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 97.0 96.0 97.0 97.0 96.0 95.0 96.0 95.0 14:50:59 INFO - 2015-11-17 14:50:59,806 DEBUG : BROWSER_OUTPUT: 14:50:59 INFO - 2015-11-17 14:50:59,806 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:69.10 Median:69.00 stddev:2.64 (3.8%) stddev-sans-first:2.80 14:50:59 INFO - 2015-11-17 14:50:59,806 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 68.0 69.0 69.0 69.0 69.0 76.0 67.0 66.0 14:50:59 INFO - 2015-11-17 14:50:59,806 DEBUG : BROWSER_OUTPUT: 14:50:59 INFO - 2015-11-17 14:50:59,806 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:70.00 Median:70.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 14:50:59 INFO - 2015-11-17 14:50:59,806 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 69.0 70.0 70.0 70.0 71.0 70.0 70.0 71.0 14:50:59 INFO - 2015-11-17 14:50:59,806 DEBUG : BROWSER_OUTPUT: 14:50:59 INFO - 2015-11-17 14:50:59,806 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:83.50 stddev:5.81 (7.0%) stddev-sans-first:5.91 14:50:59 INFO - 2015-11-17 14:50:59,806 DEBUG : BROWSER_OUTPUT: Values: 81.0 84.0 83.0 92.0 83.0 83.0 83.0 84.0 84.0 100.0 14:50:59 INFO - 2015-11-17 14:50:59,806 DEBUG : BROWSER_OUTPUT: 14:50:59 INFO - 2015-11-17 14:50:59,806 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.40 Median:122.50 stddev:3.57 (2.9%) stddev-sans-first:3.56 14:50:59 INFO - 2015-11-17 14:50:59,806 DEBUG : BROWSER_OUTPUT: Values: 118.0 122.0 123.0 125.0 117.0 120.0 125.0 127.0 117.0 120.0 14:50:59 INFO - 2015-11-17 14:50:59,807 DEBUG : BROWSER_OUTPUT: 14:50:59 INFO - 2015-11-17 14:50:59,807 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.80 Median:144.50 stddev:8.23 (5.7%) stddev-sans-first:8.59 14:50:59 INFO - 2015-11-17 14:50:59,807 DEBUG : BROWSER_OUTPUT: Values: 146.0 134.0 145.0 144.0 158.0 133.0 150.0 136.0 138.0 134.0 14:50:59 INFO - 2015-11-17 14:50:59,807 DEBUG : BROWSER_OUTPUT: 14:50:59 INFO - 2015-11-17 14:50:59,807 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.30 Median:71.00 stddev:1.25 (1.8%) stddev-sans-first:1.24 14:50:59 INFO - 2015-11-17 14:50:59,807 DEBUG : BROWSER_OUTPUT: Values: 69.0 72.0 71.0 70.0 69.0 71.0 69.0 69.0 72.0 71.0 14:50:59 INFO - 2015-11-17 14:50:59,807 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:50:59 INFO - 2015-11-17 14:50:59,807 DEBUG : BROWSER_OUTPUT: 14:51:00 INFO - 2015-11-17 14:51:00,704 INFO : Browser exited with error code: 0 14:51:00 INFO - 2015-11-17 14:51:00,755 INFO : Completed test kraken (00:01:00) 14:51:00 INFO - 2015-11-17 14:51:00,756 INFO : Starting test v8_7 14:51:00 INFO - 2015-11-17 14:51:00,756 DEBUG : operating with platform_type : linux_ 14:51:00 INFO - 2015-11-17 14:51:00,756 INFO : Initialising browser for v8_7 test... 14:51:00 INFO - 2015-11-17 14:51:00,762 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO0Lj_7/profile http://localhost:36709/getInfo.html 14:51:04 INFO - 2015-11-17 14:51:04,748 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:51:04 INFO - 2015-11-17 14:51:04,748 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:51:04 INFO - 2015-11-17 14:51:04,748 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:51:04 INFO - 2015-11-17 14:51:04,749 DEBUG : BROWSER_OUTPUT: __metrics 14:51:04 INFO - 2015-11-17 14:51:04,905 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:51:06 INFO - 2015-11-17 14:51:06,131 INFO : Browser initialized. 14:51:06 INFO - 2015-11-17 14:51:06,132 INFO : Running cycle 1/1 for v8_7 test... 14:51:06 INFO - 2015-11-17 14:51:06,132 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO0Lj_7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:51:18 INFO - 2015-11-17 14:51:18,050 DEBUG : BROWSER_OUTPUT: RSS: Main: 141176832 14:51:18 INFO - 2015-11-17 14:51:18,050 DEBUG : BROWSER_OUTPUT: 14:51:39 INFO - 2015-11-17 14:51:39,412 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36709/tests/v8_7/run.html (next: http://localhost:36709/tests/v8_7/run.html) 14:51:39 INFO - 2015-11-17 14:51:39,656 DEBUG : BROWSER_OUTPUT: RSS: Main: 441843712 14:51:39 INFO - 2015-11-17 14:51:39,656 DEBUG : BROWSER_OUTPUT: 14:51:39 INFO - 2015-11-17 14:51:39,657 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:51:39 INFO - 2015-11-17 14:51:39,658 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:51:39 INFO - 2015-11-17 14:51:39,658 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:51:39 INFO - 2015-11-17 14:51:39,658 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:51:39 INFO - 2015-11-17 14:51:39,658 DEBUG : BROWSER_OUTPUT: |0;Richards;162.91951775822744 14:51:39 INFO - 2015-11-17 14:51:39,658 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.27773527161438 14:51:39 INFO - 2015-11-17 14:51:39,658 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.97780275358247 14:51:39 INFO - 2015-11-17 14:51:39,659 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5091.370558375635 14:51:39 INFO - 2015-11-17 14:51:39,659 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2008.0321285140562 14:51:39 INFO - 2015-11-17 14:51:39,659 DEBUG : BROWSER_OUTPUT: |5;Earley;794.912559618442 14:51:39 INFO - 2015-11-17 14:51:39,659 DEBUG : BROWSER_OUTPUT: |6;Boyer;12268.292682926829 14:51:39 INFO - 2015-11-17 14:51:39,660 DEBUG : BROWSER_OUTPUT: |7;RegExp;26205.128205128207 14:51:39 INFO - 2015-11-17 14:51:39,660 DEBUG : BROWSER_OUTPUT: |8;Splay;623.6024844720497 14:51:39 INFO - 2015-11-17 14:51:39,660 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 14:51:39 INFO - 2015-11-17 14:51:39,660 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:51:39 INFO - 2015-11-17 14:51:39,661 DEBUG : BROWSER_OUTPUT: __startTimestamp1447800699656__endTimestamp 14:51:39 INFO - 2015-11-17 14:51:39,661 DEBUG : BROWSER_OUTPUT: 14:51:39 INFO - 2015-11-17 14:51:39,661 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:51:39 INFO - 2015-11-17 14:51:39,661 DEBUG : BROWSER_OUTPUT: Number of tests: 10 14:51:39 INFO - 2015-11-17 14:51:39,662 DEBUG : BROWSER_OUTPUT: 14:51:39 INFO - 2015-11-17 14:51:39,662 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.92 Median:162.92 stddev:0.00 (0.0%) 14:51:39 INFO - 2015-11-17 14:51:39,662 DEBUG : BROWSER_OUTPUT: Values: 162.9 14:51:39 INFO - 2015-11-17 14:51:39,662 DEBUG : BROWSER_OUTPUT: 14:51:39 INFO - 2015-11-17 14:51:39,663 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.28 Median:191.28 stddev:0.00 (0.0%) 14:51:39 INFO - 2015-11-17 14:51:39,663 DEBUG : BROWSER_OUTPUT: Values: 191.3 14:51:39 INFO - 2015-11-17 14:51:39,663 DEBUG : BROWSER_OUTPUT: 14:51:39 INFO - 2015-11-17 14:51:39,663 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.98 Median:280.98 stddev:0.00 (0.0%) 14:51:39 INFO - 2015-11-17 14:51:39,663 DEBUG : BROWSER_OUTPUT: Values: 281.0 14:51:39 INFO - 2015-11-17 14:51:39,664 DEBUG : BROWSER_OUTPUT: 14:51:39 INFO - 2015-11-17 14:51:39,664 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5091.37 Median:5091.37 stddev:0.00 (0.0%) 14:51:39 INFO - 2015-11-17 14:51:39,664 DEBUG : BROWSER_OUTPUT: Values: 5091.4 14:51:39 INFO - 2015-11-17 14:51:39,664 DEBUG : BROWSER_OUTPUT: 14:51:39 INFO - 2015-11-17 14:51:39,664 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2008.03 Median:2008.03 stddev:0.00 (0.0%) 14:51:39 INFO - 2015-11-17 14:51:39,664 DEBUG : BROWSER_OUTPUT: Values: 2008.0 14:51:39 INFO - 2015-11-17 14:51:39,664 DEBUG : BROWSER_OUTPUT: 14:51:39 INFO - 2015-11-17 14:51:39,664 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:794.91 Median:794.91 stddev:0.00 (0.0%) 14:51:39 INFO - 2015-11-17 14:51:39,664 DEBUG : BROWSER_OUTPUT: Values: 794.9 14:51:39 INFO - 2015-11-17 14:51:39,665 DEBUG : BROWSER_OUTPUT: 14:51:39 INFO - 2015-11-17 14:51:39,665 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12268.29 Median:12268.29 stddev:0.00 (0.0%) 14:51:39 INFO - 2015-11-17 14:51:39,665 DEBUG : BROWSER_OUTPUT: Values: 12268.3 14:51:39 INFO - 2015-11-17 14:51:39,665 DEBUG : BROWSER_OUTPUT: 14:51:39 INFO - 2015-11-17 14:51:39,665 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26205.13 Median:26205.13 stddev:0.00 (0.0%) 14:51:39 INFO - 2015-11-17 14:51:39,665 DEBUG : BROWSER_OUTPUT: Values: 26205.1 14:51:39 INFO - 2015-11-17 14:51:39,665 DEBUG : BROWSER_OUTPUT: 14:51:39 INFO - 2015-11-17 14:51:39,665 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:623.60 Median:623.60 stddev:0.00 (0.0%) 14:51:39 INFO - 2015-11-17 14:51:39,665 DEBUG : BROWSER_OUTPUT: Values: 623.6 14:51:39 INFO - 2015-11-17 14:51:39,666 DEBUG : BROWSER_OUTPUT: 14:51:39 INFO - 2015-11-17 14:51:39,666 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 14:51:39 INFO - 2015-11-17 14:51:39,666 DEBUG : BROWSER_OUTPUT: Values: 4840.6 14:51:39 INFO - 2015-11-17 14:51:39,666 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:51:39 INFO - 2015-11-17 14:51:39,666 DEBUG : BROWSER_OUTPUT: 14:51:40 INFO - 2015-11-17 14:51:40,604 INFO : Browser exited with error code: 0 14:51:40 INFO - 2015-11-17 14:51:40,618 INFO : Completed test v8_7 (00:00:39) 14:51:40 INFO - 2015-11-17 14:51:40,721 INFO : Completed test suite (00:20:17) 14:51:40 INFO - 2015-11-17 14:51:40,721 DEBUG : Working with test: dromaeo_css 14:51:40 INFO - 2015-11-17 14:51:40,721 DEBUG : Generating results file: dromaeo_css 14:51:40 INFO - 2015-11-17 14:51:40,722 DEBUG : Working with test: kraken 14:51:40 INFO - 2015-11-17 14:51:40,722 DEBUG : Generating results file: kraken 14:51:40 INFO - 2015-11-17 14:51:40,723 INFO : javascript benchmark 14:51:40 INFO - 2015-11-17 14:51:40,723 DEBUG : Working with test: v8_7 14:51:40 INFO - 2015-11-17 14:51:40,723 DEBUG : Generating results file: v8_7 14:51:40 INFO - 2015-11-17 14:51:40,723 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:51:40 INFO - 2015-11-17 14:51:40,779 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 14:51:40 INFO - 2015-11-17 14:51:40,779 DEBUG : process_Request line: dromaeo_css 6091.61 graph.html#tests=[[72,94,35]] 14:51:40 INFO - 2015-11-17 14:51:40,780 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:51:40 INFO - 2015-11-17 14:51:40,809 DEBUG : process_Request line: kraken 1515.30 graph.html#tests=[[232,94,35]] 14:51:40 INFO - 2015-11-17 14:51:40,809 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:51:40 INFO - 2015-11-17 14:51:40,833 DEBUG : process_Request line: v8_7 19745.84 graph.html#tests=[[230,94,35]] 14:51:40 INFO - 2015-11-17 14:51:40,835 INFO : javascript benchmark 14:51:40 INFO - 2015-11-17 14:51:40,839 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [326.1032161555722, 326.464598059183, 327.69851736402507, 330.50919384713694, 331.27781436468496, 8542.402031857773, 8703.173198546145, 10465.162786977033, 15812.84187158128, 16381.836181638195, 8335.95832020839, 10348.534315955781, 10503.0, 10640.255182137253, 11082.445877706103, 4146.958530414695, 4259.2546304396765, 4264.339027450735, 4264.59486348798, 4267.975685835393, 3075.7078077582705, 3166.936661266773, 4221.831126754926, 4260.552641972595, 6221.751129954796, 6460.257070436913, 6517.576357536768, 6520.435095577075, 6521.706523206467, 6528.41244288014, 6394.520410969173, 6512.413882750528, 6534.117894084286, 6566.047923051155, 6569.0, 6045.183900173508, 6117.6023558469005, 6262.12330273762, 6274.843128921768, 6294.685265736741, 20320.593588128155, 20915.267965621282, 21046.473838154016, 21341.359759207247, 21869.12523499058, 1853.6014756827346, 1856.5637075287298, 1904.1812020831037, 1955.071341112974, 2028.2799606139756, 13683.931580342134, 13840.446382144803, 14007.64980875476, 14050.297485125806, 14052.227127507984, 1832.8350448459703, 1863.0, 1871.3917976657506, 1909.5321646196633, 1962.7939066397964, 62828.0, 62959.0, 63203.68398158026, 63914.36085639131, 64403.0, 14655.48705795292, 15409.614759630875, 15426.845731542766, 15433.0, 15434.845651543565, 22742.431439213822, 22800.0, 22924.656130158062, 22965.96653150612, 23059.0, 7187.64061796908, 7239.457040721967, 7252.1297444305965, 7413.703451861865, 7635.427342949301, 5859.150423188614, 5925.496332811673, 5945.256842894638, 6052.818415447544, 6081.996470582304, 7373.5944523050675, 7505.362044226193, 7511.812204694927, 7541.095068591804, 7542.773716788505, 1307.405130665545, 1310.4823594680047, 1322.8809407153403, 1336.7861142217198, 2039.7965200531758, 351.5447495493342, 355.4348585748672, 363.6527116603637, 376.8417264748812, 383.82535946144435, 8944.821103578022, 9453.952730236304, 9572.47351395666, 9709.465979371202, 9803.852942205873, 378.50226951558614, 379.6090027271914, 414.8029685899174, 418.7194579631654, 454.13034039813385, 4942.654014219042, 5506.972465137648, 5758.971205143947, 5854.121881717776, 5968.552358573124, 455019.0, 458841.0, 459200.0, 466847.0, 468485.0, 64532.677336613015, 65818.0, 66315.0, 67193.3280667187, 67362.66318668376, 484.9345338379344, 491.8081948040267, 491.842610364687, 492.45337675179803, 492.5517778821255, 10082.092611664986, 10082.344647597884, 10108.191344692259, 10132.949335253277, 10271.537780800032, 31130.84434577903, 32213.677863221066, 32942.67057329396, 32959.67040329566, 33198.5020224692, 41553.79223103865, 42248.36627450652, 43137.13725725405, 43564.0, 43585.34621980736, 5874.647521148745, 5884.382139875252, 5888.764449422147, 5898.0, 5903.439173278532, 10463.895361046596, 10799.190060745319, 10827.891721083004, 10860.511276992396, 10985.395803230898, 9250.259979201783, 9456.290778191526, 9656.082672146134, 9877.06167914047, 9905.306628535933, 9141.177294043568, 9391.577379018097, 9425.19885809714, 9525.333226674065, 9649.565769540528, 9533.761655958657, 9591.472469014272, 9669.806603867743, 9671.226301895973, 9687.612495500101, 5363.946360536344, 5383.353997520323, 6160.7535698571555, 6207.844803879939, 6301.023341382093, 9254.814903701754, 9437.480938548446, 9464.858027129736, 9553.283503737108, 9613.903860961302], "dojo.html": [2664.6669166354204, 2766.626505421769, 2777.2223777342347, 2789.302674331417, 2792.734690204431, 4563.224251877181, 4678.602318802898, 4788.3535722677425, 4835.85492435227, 4855.4416242132165, 4715.41057367829, 4716.245400735883, 4733.029728905574, 4787.904241915159, 4800.207965685658, 4388.5830846069575, 4459.665525085632, 4481.395011673431, 4509.075639493913, 4523.525029871866, 4296.591823776736, 4510.774461276939, 4540.7502587357685, 4543.250363690004, 4572.382728331682, 4341.5441378655105, 4404.251277282853, 4445.110977804452, 4446.888827779299, 4452.443444569429, 4425.446819147606, 4425.8229670813125, 4436.7116137451285, 4437.889052773674, 4486.237339652267, 4185.183889141618, 4284.2930916398755, 4409.272470042439, 4411.889702757425, 4453.421055262795, 4572.3827283317, 4607.35497030416, 4708.529147085298, 4713.6229101672125, 4726.952730472685, 5129.563987061104, 5165.560927321182, 5176.120059589879, 5176.844694659167, 5177.8187763428095, 5205.193195054772, 5205.193195054772, 5207.6354655174155, 5208.401033881114, 5220.895582088337, 4595.03504264105, 4675.322078298662, 4684.297355396718, 4690.226112691436, 4693.366395536559, 5268.262443257947, 5399.379071406838, 5414.214938833926, 5432.076546986943, 5434.184872269191, 5061.670991385548, 5071.442141364447, 5072.467390923974, 5075.314832497639, 5087.389513258433, 4943.65394422387, 5162.174052151638, 5164.92252616211, 5172.508611681884, 5176.689398636094, 5002.399712034579, 5024.899502010013, 5032.018756342552, 5032.421271553818, 5041.621878359138, 5078.923816142761, 5105.923411148836, 5141.76862041209, 5143.8456846294675, 5156.484351564814, 3958.6833053355663, 3960.2277555876326, 3977.940330895039, 3994.380870965005, 4002.079521709965, 3320.4853247746637, 3446.4485682291215, 3462.826858657057, 3524.594671612746, 3577.69589584883, 4336.176126535948, 4400.647948164139, 4411.933820992687, 4449.17690227309, 4450.065486247924, 5132.486751324912, 5220.347456567929, 5235.240890070994, 5236.083685355047, 5238.0, 4265.210935976854, 4364.476262848415, 4365.323374876899, 4467.642588592905, 4490.259107247268, 4393.6704747144095, 4501.864944051684, 4524.117797029613, 4547.249703798836, 4556.749378784199, 4857.4171099467585, 4946.0, 4948.257761335828, 4952.1581331173065, 4986.202207646759, 5011.373578302712, 5160.174372100446, 5209.947900520946, 5219.1388420910125, 5266.762995665281, 4817.807287708452, 4835.734034627989, 4928.876778080433, 4932.975335123301, 4949.678270912379, 5048.268001139888, 5056.974715126401, 5067.113255180402, 5068.721220332917, 5100.362454693163, 4791.616670666408, 4902.754862256802, 5135.537801597874, 5140.331756871583, 5150.330457040561, 4898.559129678346, 4930.531599498042, 5011.84964451067, 5012.799488020439, 5021.246812978083, 5020.49795020495, 5033.0688822567945, 5043.0, 5048.066107770074, 5071.416787069535, 4656.976715116402, 4758.571728544448, 4879.804807807648, 4933.876653083558, 4970.229614409773, 4870.659053866196, 4880.072786170758, 5000.024995125916, 5000.224965130411, 5026.447090819934, 4988.476209997898, 4991.176455884738, 4995.825146119869, 4996.750162491788, 5035.84892453227], "mootools.html": [1046.1317106801355, 1613.1772795874103, 1643.3083546474813, 1666.2002238925315, 1689.2145152504088, 6168.352323006082, 6694.06283120363, 6793.388595026447, 6799.830004249896, 6804.761833335834, 6987.441004719623, 7081.433485321175, 7082.468814838895, 7089.397401220903, 7104.360607545333, 2086.426232785981, 2114.6616541353387, 2114.830813534921, 2115.672070829024, 2118.046878904491, 2082.2295750572234, 2106.947326316839, 2111.6832475128776, 2111.873287602741, 2113.6406810842195, 2035.216441669953, 2056.033664177834, 2069.244725675133, 2070.1201989154624, 2072.8652637578584, 2049.723287356203, 2067.9069441875154, 2075.3773867839586, 2080.8335333173386, 2082.2816128435743, 2048.682454219598, 2052.2611859730487, 2074.9066292016896, 2081.6149012432597, 2083.802038806311, 6050.939490605082, 6195.28754193269, 6969.23338432772, 6985.511014229006, 7026.824329391755, 3965.9801700991597, 4035.3543433050572, 4058.0, 4063.0, 4070.043539768152, 2783.3598272397257, 2792.2600510864636, 2842.786790990684, 2847.786416018786, 2887.595736596878, 900.045951291633, 902.2421166220341, 903.75146834621, 936.8173206224789, 1733.6186039071383, 9508.952455237748, 9618.615255389775, 9633.566489507988, 9639.0, 9639.951800241024, 3870.1679138985255, 3886.240407177217, 3893.922121557553, 3932.528096628423, 3970.06703424695, 7806.648700808477, 7852.411069169721, 7865.842683146419, 7868.095169055632, 7873.409494287951, 4195.58044195578, 4208.053188032668, 4211.663066954637, 4217.00900288432, 4218.514870789837, 3773.415120656303, 3789.829457674411, 3795.070207799107, 3804.3722785740597, 3814.6376094271, 3155.2111972006996, 3159.9684003160132, 3165.113768144923, 3179.0621766578915, 3189.378071276079, 954.4130359828794, 957.6360982826482, 961.6393852305386, 966.9516524173763, 969.9224062075017, 1138.8633363996373, 1142.1433924556582, 1152.982705259422, 1155.9826602600967, 1168.0, 6598.835029124214, 6652.70062847173, 6676.732930682815, 6713.362230588086, 6714.429273511806, 402.56724021676814, 416.2569812883988, 418.9224993376235, 419.38769396681187, 419.47984499220746, 4707.105649926503, 4944.92582611254, 4948.505149485023, 4963.503649635008, 4967.90064198714, 7750.534967901944, 8283.29591984676, 8457.873131903027, 8535.615897284637, 8548.444351117158, 8296.875546866802, 8339.874901876477, 8355.791105222417, 8425.4944703318, 8429.789255268668, 6548.443382312556, 6671.966640166768, 6676.098726671934, 6683.866322673519, 6685.8997115044285, 6527.813182583698, 6552.410283074546, 6576.80269591913, 6601.306862779531, 6628.53600247978, 7508.249175082448, 7609.239076092568, 7657.119431265476, 7674.117476490275, 7684.346830519468, 7533.0, 7738.071431428265, 7763.262490063435, 7854.607269636381, 7857.607119643881, 6257.53068519872, 6284.622922624657, 6334.8733025338315, 6353.5870168438905, 6354.3963323484195, 6356.0, 6431.774887878902, 6437.742490300336, 6447.548671593131, 6452.387023232785, 5990.161377407254, 6035.094735789667, 6071.574989750675, 6259.3427690091885, 6290.21372328459, 6149.108379285068, 6186.319504854372, 6203.31763506005, 6300.716467759054, 6352.047192921099, 6051.0, 6091.0558863376245, 6091.451769340781, 6094.75620975156, 6099.4815440688035, 5822.592418530662, 5827.9417205829095, 5835.066389377679, 5845.1232315153065, 5845.152452894392, 5654.575906807088, 5765.91351129725, 5767.855803604775, 5771.480566749013, 5774.740136693943], "ext.html": [563.4309347558966, 572.3075079154222, 573.5383016671581, 577.532198918876, 579.8753268047369, 24519.14183003595, 37447.625523744755, 37640.0, 37698.24603507928, 37713.0, 39334.60665393345, 39862.601373986254, 39896.60103398965, 39953.80023099888, 39957.40063899044, 6782.762603308885, 6931.653417329138, 7935.484193527431, 8094.797630059266, 8119.472234304781, 10305.536250868729, 10483.73790655232, 10538.315009524395, 10539.52572134252, 10554.155667546616, 10207.846882296772, 10306.175505959543, 10310.587576496931, 10314.742131446736, 10317.43254121023, 6957.65211739411, 7132.5007249492555, 10077.69766906994, 10215.693529194135, 10505.894941050568, 10011.849822252672, 10170.084692377648, 10181.643642472478, 10186.439745813977, 10192.694219173436, 36757.0, 36998.63001369979, 37257.0, 37259.4411083834, 37326.44010339847, 2689.623452716621, 2759.8758055887533, 2845.8719357628956, 2899.3331533747146, 2901.7968742188054, 27196.32009199766, 27465.17604471869, 28175.295617609725, 28180.436391272266, 29656.555151672743, 2993.52103663415, 3044.9086527404215, 3084.0439463766306, 3143.5441860930036, 3232.6282477514915, 226037.0, 227253.0, 227999.0, 228174.0, 228197.99999999834, 41670.1665966679, 55908.0, 56251.0, 56253.0, 56323.71838140865, 47422.0, 65783.0, 67215.0, 67231.66384168145, 67272.32727672759, 12029.0, 12133.939330303292, 12181.634550963485, 12264.264144151379, 12266.0, 9246.0, 9310.487923164155, 9310.767230819149, 9321.766955826159, 9353.438793672402, 19281.710774338397, 19311.324103656305, 19456.0, 19462.0, 19496.80503194978, 7525.924740752632, 7813.374930005586, 7842.255435461578, 7912.993062636161, 7984.161663025298, 705.0411440440996, 725.9020032295679, 747.3871425431203, 808.8382323535317, 900.3877363392825, 26300.8684956574, 30168.24579385489, 31033.68966310308, 31080.689193108232, 31576.0, 871.847426700325, 889.9243564296978, 893.1961234888652, 903.0382642485731, 914.2685851318919, 13815.516456923959, 14080.788788168185, 14344.56966291013, 14371.0, 14399.208043557705, 318154.0, 323828.0, 323964.0, 327686.0, 328364.0, 48614.756926215145, 49035.0, 49097.50902491001, 49131.263031054565, 49222.261666075035, 1114.4650567727374, 1123.3877536742496, 1130.2935665209245, 1152.688774031007, 1154.3593305715408, 23383.649245260993, 25776.484470310865, 26537.203883883514, 30150.84924575363, 30719.846400767852, 43719.125617488105, 44232.33651495166, 44281.0, 44327.67542434395, 44421.11157776762, 252891.0, 254761.0, 254914.0, 254937.0, 255324.0, 24327.51344973126, 25553.48893022166, 28303.575446367908, 28581.28546786347, 29829.850850745606, 34640.30719385648, 34804.65195348014, 34924.65075349214, 35453.29093418066, 35668.64331356757, 29426.852865735535, 29834.0, 29888.85055574708, 30385.392292154476, 30464.390712186076, 30743.385132297677, 32409.513857291688, 32471.675283246866, 32528.18679532936, 35508.0, 33617.495737564444, 34469.0, 34489.482657759654, 34634.653653463145, 34730.0, 28504.598160735044, 30683.693163068085, 31214.0, 31223.843880780452, 31274.843625781727, 23057.423564411023, 23909.641355379335, 24188.274351769476, 25975.480490390466, 26778.0], "prototype.html": [292.2270594278134, 299.8126171143036, 301.2003131685375, 301.7812086237477, 304.3092180749697, 5246.7901283948695, 5342.866428339294, 5350.785968561263, 5390.21841832934, 5495.505404513593, 5340.225667278252, 5414.242006119137, 5425.6202065855305, 5430.294061771974, 5437.456254374561, 3940.9605903941024, 4190.308599081148, 4190.413342132104, 4193.580641935812, 4195.5594662560525, 4023.054582173187, 4092.85675001375, 4168.7081904266715, 4177.791110444481, 4185.644220241283, 4109.198706252282, 4131.0, 4134.793260336986, 4135.8759237222785, 4153.024039350766, 3945.230680017398, 4024.6981476389387, 4037.4953130858644, 4145.170965806836, 4152.667786577066, 3662.3957047087197, 3691.7969511676847, 3693.741438099334, 3697.334479793636, 3699.223163135745, 5181.1969144782615, 5185.818496352609, 5187.766550505236, 5190.143626301656, 5214.5306922376785, 4794.424669039703, 4796.712197268175, 4812.951870481285, 4813.951860481386, 4816.060868130716, 5574.358948720868, 5675.489205971482, 5694.9179655865255, 5700.0, 5709.8287051388525, 4023.034471726794, 4023.97988010061, 4025.4565633639377, 4031.737937034083, 4033.2740106780766, 5905.2323197984415, 5957.285125784891, 5961.314448838396, 5971.731272092767, 5977.402259773988, 4145.191687620885, 4146.419501269825, 4150.750954942713, 4153.044799696087, 4153.439285696392, 4117.876463706094, 4187.6440502557625, 4211.284081706117, 4216.6626669866955, 4218.704690671623, 4765.618750499952, 4775.832845850448, 4780.976095119502, 4784.330193772875, 4791.425028996473, 5602.159676048625, 5631.662100273997, 5643.52030077448, 5658.207850900877, 5662.065759149694, 1466.1935935235579, 1487.3084015932643, 1494.1110039526463, 1495.7008598280388, 1495.7158139953374, 995.183949161695, 1005.2058873490007, 1008.7377281906757, 1013.4881884648205, 1026.630413051301, 4996.650234483552, 5029.974850125726, 5030.622703297267, 5031.622628302819, 5033.597312215014, 5910.172575839386, 5911.852203694942, 5914.674692891932, 5918.733656985446, 5922.082077278029, 5016.398032236155, 5018.021485810232, 5018.5985121190215, 5023.447420783711, 5023.974880125649, 3113.408452394038, 3163.1459505933267, 3183.2996740717003, 3184.824834634071, 3192.2657788708725, 5582.720863956786, 5590.440955904377, 5593.468620481048, 5594.860128496739, 5597.328320601554, 6058.485028772516, 6070.150178974947, 6071.150038994544, 6077.270727512727, 6079.0, 5457.372402173642, 5586.636868603528, 5588.273524441796, 5593.664380137124, 5595.636283641632, 5888.94111058901, 5893.263342082239, 5893.911591326219, 5896.7936122235515, 5901.144334071621, 5753.683547404933, 5759.049756790083, 5759.683217423082, 5760.135979603093, 5771.220885180447, 5582.106862901916, 5589.776408943597, 5591.664500130005, 5591.748371323381, 5592.804251851166, 3871.0902937810156, 4046.352583586612, 4066.573009833925, 4120.526139493996, 4128.422020917014, 5901.468867801918, 5904.380040095728, 5907.675077870758, 5911.586188966903, 5914.201582786441, 5680.318361796611, 5682.77268909239, 5688.260526131577, 5691.800786972602, 5692.6299790513485, 5574.749136288796, 5680.062789639664, 5682.289713785777, 5684.488396044376, 5687.374388817309, 5611.270534830446, 5612.354579223442, 5614.494695477427, 5615.466530679579, 5616.326040875121, 5472.972635136799, 5592.245046918614, 5765.798197063083, 5766.048601980794, 5773.336066352255, 5467.4532546745, 5547.833564993057, 5588.888222235614, 5609.607327487037, 5629.662220266797], "yui.html": [546.4671944853768, 550.4165584480451, 561.2871653000686, 582.9387914269001, 609.4332270987982, 10828.296160749556, 10992.615258465956, 11010.284331518445, 11028.834567481494, 11065.280756750826, 11457.0, 11520.481578328974, 11769.941150294258, 11930.64208073757, 11939.34333611651, 602.1810337940398, 608.5162295974711, 755.7166062726492, 762.6987340000696, 772.1274959295988, 747.9139898911641, 772.3203580848873, 772.7140957845605, 772.82997740497, 773.8955241042472, 802.0976401548259, 804.264098350009, 811.6753298680516, 811.9715809946653, 812.8333691593209, 616.4575173847009, 625.3059104394118, 791.9208079192092, 798.9480683755537, 802.1136644008375, 599.5503372470647, 599.8950183717832, 600.1328080923068, 600.3486217454067, 601.2784658409926, 11117.110631149488, 11230.213885028052, 11249.887501125047, 11253.099752019818, 11262.605808796734, 10466.895331046668, 11248.831267530912, 11443.0, 11672.766544669059, 11819.290842549388, 9053.773655658595, 9065.637374505011, 9204.0, 9223.538823058887, 9307.34848560601, 3131.780775345727, 3133.2480204750923, 3189.2824114574037, 3193.281511659858, 3198.0, 34062.318753624786, 34596.0, 34626.82686586576, 40815.183696325905, 41305.79347103275, 6442.903356449657, 6579.374959378852, 6638.6680665966505, 6754.392104710501, 6759.256481787, 10772.838407423895, 10864.837027444595, 10875.184361172944, 10889.128869690407, 10915.235933484739, 5555.2500412444615, 5607.467290607386, 5713.485786279255, 5725.141228815711, 5836.941630583725, 3501.072215862798, 3513.6135025147214, 3541.610422853484, 3570.5179800727087, 3619.367209971241, 2413.0227257960555, 2445.15642103474, 2450.424150324672, 2451.852888826676, 2452.2152911068288, 387.3086540525149, 389.93566061600086, 391.44805823788323, 391.72774921429334, 392.3604524624843, 415.85445094217386, 427.6706935659587, 445.59228306099556, 467.5721714631142, 473.6921001349082, 6228.844278893064, 6281.089242059876, 6335.524835637253, 6543.051257567626, 6686.431653309426, 460.82949308755974, 468.6906641616517, 471.90561887622613, 490.4188536584159, 492.44599825196656, 3161.1780936956557, 3222.113918672384, 3236.530703048045, 3300.818454984999, 3508.8421021054114, 52083.0, 52123.73938130361, 52324.738376307876, 52445.213321800205, 52518.737406313485, 41156.588434115874, 41276.0, 41529.0, 41788.0, 41905.1618967625, 35996.82001589975, 42259.36610950838, 42499.787501062296, 43237.783811081375, 43399.349009764876, 7175.928240717526, 7442.9255707442235, 7445.4043676506835, 7488.625568721651, 7652.0, 31840.363192735553, 32096.518552222202, 32218.0, 32707.509387358732, 32792.344153116326, 38332.0, 39789.80105099456, 40693.593064068984, 41234.762957111336, 41500.37749433701, 6431.0, 6595.736170553124, 6688.431483323972, 6774.627395493098, 6889.724411023503, 10203.132733717717, 10282.588696452058, 10346.689599312032, 10512.106470950055, 10692.83960740574, 9165.404248723811, 9166.0, 9371.671991480265, 9405.670801521914, 9715.222782177267, 9384.483853387856, 9446.574904129193, 9661.420314781135, 9854.507274636097, 9896.802063958825, 7936.246056624612, 7999.480033798018, 9504.0, 9580.329376943548, 9897.35667181631, 8540.40217184816, 8773.956130219309, 9097.636094556143, 9210.585523651585, 9345.345825792401, 8141.267285944294, 8142.7557173284895, 8835.911640883509, 8971.147740964598, 9168.816623667355]}, "summary": {"lowerIsBetter": false, "suite": 6091.609114190242, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 7286.281668163919, "unit": "ms", "value": 7286.281668163919}, "dojo.html": {"lowerIsBetter": false, "filtered": 4684.485130119078, "unit": "ms", "value": 4684.485130119078}, "mootools.html": {"lowerIsBetter": false, "filtered": 3948.8716930750124, "unit": "ms", "value": 3948.8716930750124}, "ext.html": {"lowerIsBetter": false, "filtered": 17180.022083488875, "unit": "ms", "value": 17180.022083488875}, "prototype.html": {"lowerIsBetter": false, "filtered": 4273.664009769715, "unit": "ms", "value": 4273.664009769715}, "yui.html": {"lowerIsBetter": false, "filtered": 5162.7571073455965, "unit": "ms", "value": 5162.7571073455965}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-068"}, "testrun": {"date": 1447799483, "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": "20151117132206", "branch": "Firefox-Non-PGO", "revision": "8c3a0b58fd51c02c8aca138b0da58445becb037f"}}, {"talos_counters": {}, "results": {"audio-dft": [162.0, 161.0, 161.0, 160.0, 160.0, 164.0, 163.0, 162.0, 162.0, 161.0], "ai-astar": [112.0, 112.0, 106.0, 111.0, 113.0, 114.0, 102.0, 113.0, 114.0, 112.0], "imaging-gaussian-blur": [109.0, 110.0, 109.0, 110.0, 111.0, 110.0, 109.0, 109.0, 109.0, 109.0], "audio-beat-detection": [149.0, 131.0, 153.0, 168.0, 130.0, 162.0, 159.0, 130.0, 165.0, 131.0], "json-stringify-tinderbox": [69.0, 70.0, 69.0, 70.0, 70.0, 70.0, 71.0, 70.0, 70.0, 71.0], "stanford-crypto-pbkdf2": [146.0, 134.0, 145.0, 144.0, 158.0, 133.0, 150.0, 136.0, 138.0, 134.0], "json-parse-financial": [69.0, 69.0, 68.0, 69.0, 69.0, 69.0, 69.0, 76.0, 67.0, 66.0], "stanford-crypto-sha256-iterative": [69.0, 72.0, 71.0, 70.0, 69.0, 71.0, 69.0, 69.0, 72.0, 71.0], "audio-fft": [72.0, 74.0, 83.0, 90.0, 74.0, 73.0, 72.0, 101.0, 91.0, 73.0], "imaging-darkroom": [148.0, 148.0, 147.0, 148.0, 148.0, 148.0, 148.0, 148.0, 148.0, 148.0], "stanford-crypto-ccm": [118.0, 122.0, 123.0, 125.0, 117.0, 120.0, 125.0, 127.0, 117.0, 120.0], "audio-oscillator": [92.0, 92.0, 130.0, 91.0, 92.0, 91.0, 126.0, 90.0, 91.0, 134.0], "stanford-crypto-aes": [81.0, 84.0, 83.0, 92.0, 83.0, 83.0, 83.0, 84.0, 84.0, 100.0], "imaging-desaturate": [96.0, 96.0, 97.0, 96.0, 97.0, 97.0, 96.0, 95.0, 96.0, 95.0]}, "summary": {"lowerIsBetter": true, "suite": 1515.3000000000002, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 80.3, "unit": "ms", "value": 80.3}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 141.8, "unit": "ms", "value": 141.8}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 147.8, "unit": "ms", "value": 147.8}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 121.4, "unit": "ms", "value": 121.4}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 147.9, "unit": "ms", "value": 147.9}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 69.1, "unit": "ms", "value": 69.1}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 102.9, "unit": "ms", "value": 102.9}, "ai-astar": {"lowerIsBetter": true, "filtered": 110.9, "unit": "ms", "value": 110.9}, "audio-dft": {"lowerIsBetter": true, "filtered": 161.6, "unit": "ms", "value": 161.6}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 70.3, "unit": "ms", "value": 70.3}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 70.0, "unit": "ms", "value": 70.0}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.5, "unit": "ms", "value": 109.5}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 85.7, "unit": "ms", "value": 85.7}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 96.1, "unit": "ms", "value": 96.1}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-068"}, "testrun": {"date": 1447799483, "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": "20151117132206", "branch": "Firefox-Non-PGO", "revision": "8c3a0b58fd51c02c8aca138b0da58445becb037f"}}, {"talos_counters": {}, "results": {"DeltaBlue": [191.27773527161438], "Encrypt": [280.97780275358247], "NavierStokes": [4840.579710144928], "Decrypt": [5091.370558375635], "Splay": [623.6024844720497], "Richards": [162.91951775822744], "RegExp": [26205.128205128207], "Earley": [794.912559618442], "Boyer": [12268.292682926829], "RayTrace": [2008.0321285140562]}, "summary": {"lowerIsBetter": false, "suite": 19745.8372479466, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 345.66490400000004, "unit": "score", "value": 345.66490400000004}, "Encrypt": {"lowerIsBetter": false, "filtered": 947.3381789999996, "unit": "score", "value": 947.3381789999996}, "NavierStokes": {"lowerIsBetter": false, "filtered": 306.5748502994012, "unit": "score", "value": 306.5748502994012}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.280814556330995, "unit": "score", "value": 52.280814556330995}, "Splay": {"lowerIsBetter": false, "filtered": 130.67779880478085, "unit": "score", "value": 130.67779880478085}, "RegExp": {"lowerIsBetter": false, "filtered": 34.76361545988257, "unit": "score", "value": 34.76361545988257}, "Richards": {"lowerIsBetter": false, "filtered": 216.6836759999999, "unit": "score", "value": 216.6836759999999}, "Earley": {"lowerIsBetter": false, "filtered": 838.4104539999996, "unit": "score", "value": 838.4104539999996}, "Boyer": {"lowerIsBetter": false, "filtered": 54.32402186878729, "unit": "score", "value": 54.32402186878729}, "RayTrace": {"lowerIsBetter": false, "filtered": 368.51452200000006, "unit": "score", "value": 368.51452200000006}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-068"}, "testrun": {"date": 1447799483, "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": "20151117132206", "branch": "Firefox-Non-PGO", "revision": "8c3a0b58fd51c02c8aca138b0da58445becb037f"}}] 14:51:40 INFO - RETURN: dromaeo_css: 6091.61 14:51:40 INFO - RETURN: kraken: 1515.30 14:51:40 INFO - RETURN: v8_7: 19745.84 14:51:40 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "19745.84"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1515.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "6091.61"}}} 14:51:40 INFO - Return code: 0 14:51:40 INFO - # TBPL SUCCESS # 14:51:40 INFO - Running post-action listener: _resource_record_post_action 14:51:40 INFO - Running post-run listener: _resource_record_post_run 14:51:42 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 4096; Write bytes: 503025664; Read time: 20; Write time: 568944 14:51:42 INFO - install - Wall time: 14s; CPU: 15.0%; Read bytes: 4096; Write bytes: 220774400; Read time: 20; Write time: 393416 14:51:42 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 0; Write bytes: 282251264; Read time: 0; Write time: 175528 14:51:42 INFO - Running post-run listener: _upload_blobber_files 14:51:42 INFO - Blob upload gear active. 14:51:42 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 14:51:42 INFO - Copying logs to upload dir... 14:51:42 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1265.705955 ========= master_lag: -0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-11-17 14:51:40.931775) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 14:51:40.935540) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1447799434.752014-1695511342 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/Ydu7V1ZmQ_iZV5VoGfWoQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010108 build_url: 'https://queue.taskcluster.net/v1/task/Ydu7V1ZmQ_iZV5VoGfWoQw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 14:51:40.985985) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 14:51:40.986331) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1447799434.752014-1695511342 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004651 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 14:51:41.036227) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 14:51:41.036554) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 14:51:41.036879) ========= ========= Total master_lag: 0.18 =========