builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-014 starttime: 1448384497.68 results: success (0) buildid: 20151124082333 builduid: d00a46168ce74b29b284fd63de339268 revision: 0403cb97fb51eb7a05ae2f8091fe031d79ae6ae1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 09:01:37.681742) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 09:01:37.682252) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 09:01:37.682861) ========= 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=01deea79d00cc2c334834894000001d2-1448383093.687565-1158267869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006400 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 09:01:37.737335) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 09:01:37.737603) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 09:01:37.778498) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 09:01:37.778865) ========= 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=01deea79d00cc2c334834894000001d2-1448383093.687565-1158267869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004534 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 09:01:37.830594) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 09:01:37.830863) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 09:01:37.831217) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 09:01:37.831487) ========= 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=01deea79d00cc2c334834894000001d2-1448383093.687565-1158267869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-24 09:01:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2015-11-24 09:01:38 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.319465 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 09:01:38.165424) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 09:01:38.165762) ========= 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=01deea79d00cc2c334834894000001d2-1448383093.687565-1158267869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013339 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 09:01:38.215236) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 09:01:38.215574) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0403cb97fb51eb7a05ae2f8091fe031d79ae6ae1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 0403cb97fb51eb7a05ae2f8091fe031d79ae6ae1 --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=01deea79d00cc2c334834894000001d2-1448383093.687565-1158267869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-24 09:01:38,273 truncating revision to first 12 chars 2015-11-24 09:01:38,273 Setting DEBUG logging. 2015-11-24 09:01:38,273 attempt 1/10 2015-11-24 09:01:38,273 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0403cb97fb51?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-24 09:01:38,537 unpacking tar archive at: fx-team-0403cb97fb51/testing/mozharness/ program finished with exit code 0 elapsedTime=0.567576 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 09:01:38.796673) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 09:01:38.797013) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 09:01:38.807692) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 09:01:38.808066) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 09:01:38.808526) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-11-24 09:01:38.808826) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=01deea79d00cc2c334834894000001d2-1448383093.687565-1158267869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:01:39 INFO - MultiFileLogger online at 20151124 09:01:39 in /builds/slave/test 09:01:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 09:01:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:01:39 INFO - {'append_to_log': False, 09:01:39 INFO - 'base_work_dir': '/builds/slave/test', 09:01:39 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:01:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:01:39 INFO - 'branch': 'Fx-Team-Non-PGO', 09:01:39 INFO - 'buildbot_json_path': 'buildprops.json', 09:01:39 INFO - 'config_files': ('talos/linux_config.py',), 09:01:39 INFO - 'default_actions': ('clobber', 09:01:39 INFO - 'read-buildbot-config', 09:01:39 INFO - 'download-and-extract', 09:01:39 INFO - 'populate-webroot', 09:01:39 INFO - 'create-virtualenv', 09:01:39 INFO - 'install', 09:01:39 INFO - 'run-tests'), 09:01:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:01:39 INFO - 'download_minidump_stackwalk': True, 09:01:39 INFO - 'download_symbols': 'ondemand', 09:01:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:01:39 INFO - 'tooltool.py': '/tools/tooltool.py', 09:01:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:01:39 INFO - '/tools/misc-python/virtualenv.py')}, 09:01:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:01:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:01:39 INFO - 'installer_path': 'installer.exe', 09:01:39 INFO - 'log_level': 'info', 09:01:39 INFO - 'log_name': 'talos', 09:01:39 INFO - 'log_to_console': True, 09:01:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:01:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:01:39 INFO - 'opt_config_files': (), 09:01:39 INFO - 'pip_index': False, 09:01:39 INFO - 'sps_profile': False, 09:01:39 INFO - 'sps_profile_interval': 0, 09:01:39 INFO - 'suite': 'dromaeojs', 09:01:39 INFO - 'system_bits': '64', 09:01:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:01:39 INFO - 'title': 'talos-linux64-ix-014', 09:01:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:01:39 INFO - 'use_talos_json': True, 09:01:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:01:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:01:39 INFO - 'work_dir': 'build'} 09:01:39 INFO - ##### 09:01:39 INFO - ##### Running clobber step. 09:01:39 INFO - ##### 09:01:39 INFO - Running pre-action listener: _resource_record_pre_action 09:01:39 INFO - Running main action method: clobber 09:01:39 INFO - rmtree: /builds/slave/test/build 09:01:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:01:39 INFO - Running post-action listener: _resource_record_post_action 09:01:39 INFO - ##### 09:01:39 INFO - ##### Running read-buildbot-config step. 09:01:39 INFO - ##### 09:01:39 INFO - Running pre-action listener: _resource_record_pre_action 09:01:39 INFO - Running main action method: read_buildbot_config 09:01:39 INFO - Using buildbot properties: 09:01:39 INFO - { 09:01:39 INFO - "properties": { 09:01:39 INFO - "buildnumber": 2117, 09:01:39 INFO - "product": "firefox", 09:01:39 INFO - "script_repo_revision": "production", 09:01:39 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:01:39 INFO - "repository": "", 09:01:39 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 09:01:39 INFO - "buildid": "20151124082333", 09:01:39 INFO - "slavename": "talos-linux64-ix-014", 09:01:39 INFO - "pgo_build": "False", 09:01:39 INFO - "basedir": "/builds/slave/test", 09:01:39 INFO - "project": "", 09:01:39 INFO - "platform": "ubuntu64_hw", 09:01:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:01:39 INFO - "slavebuilddir": "test", 09:01:39 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:01:39 INFO - "branch": "fx-team", 09:01:39 INFO - "repo_path": "integration/fx-team", 09:01:39 INFO - "stage_platform": "linux64", 09:01:39 INFO - "builduid": "d00a46168ce74b29b284fd63de339268", 09:01:39 INFO - "revision": "0403cb97fb51eb7a05ae2f8091fe031d79ae6ae1" 09:01:39 INFO - }, 09:01:39 INFO - "sourcestamp": { 09:01:39 INFO - "repository": "", 09:01:39 INFO - "hasPatch": false, 09:01:39 INFO - "project": "", 09:01:39 INFO - "branch": "fx-team-linux64-talos", 09:01:39 INFO - "changes": [ 09:01:39 INFO - { 09:01:39 INFO - "category": null, 09:01:39 INFO - "files": [ 09:01:39 INFO - { 09:01:39 INFO - "url": null, 09:01:39 INFO - "name": "https://queue.taskcluster.net/v1/task/Y0MerU6WTcW46pJV-yH7Sg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 09:01:39 INFO - } 09:01:39 INFO - ], 09:01:39 INFO - "repository": "", 09:01:39 INFO - "rev": "0403cb97fb51eb7a05ae2f8091fe031d79ae6ae1", 09:01:39 INFO - "who": "jwein@mozilla.com", 09:01:39 INFO - "when": 1448384492, 09:01:39 INFO - "number": 6700790, 09:01:39 INFO - "comments": "Bug 1100662 - Fix browser_notification_tab_switching.js to work in e10s mode. r=MattN", 09:01:39 INFO - "project": "", 09:01:39 INFO - "at": "Tue 24 Nov 2015 09:01:32", 09:01:39 INFO - "branch": "fx-team-linux64-talos", 09:01:39 INFO - "revlink": "", 09:01:39 INFO - "properties": [ 09:01:39 INFO - [ 09:01:39 INFO - "buildid", 09:01:39 INFO - "20151124082333", 09:01:39 INFO - "Change" 09:01:39 INFO - ], 09:01:39 INFO - [ 09:01:39 INFO - "builduid", 09:01:39 INFO - "d00a46168ce74b29b284fd63de339268", 09:01:39 INFO - "Change" 09:01:39 INFO - ], 09:01:39 INFO - [ 09:01:39 INFO - "pgo_build", 09:01:39 INFO - "False", 09:01:39 INFO - "Change" 09:01:39 INFO - ] 09:01:39 INFO - ], 09:01:39 INFO - "revision": "0403cb97fb51eb7a05ae2f8091fe031d79ae6ae1" 09:01:39 INFO - } 09:01:39 INFO - ], 09:01:39 INFO - "revision": "0403cb97fb51eb7a05ae2f8091fe031d79ae6ae1" 09:01:39 INFO - } 09:01:39 INFO - } 09:01:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/Y0MerU6WTcW46pJV-yH7Sg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 09:01:39 INFO - Running post-action listener: _resource_record_post_action 09:01:39 INFO - ##### 09:01:39 INFO - ##### Running download-and-extract step. 09:01:39 INFO - ##### 09:01:39 INFO - Running pre-action listener: _resource_record_pre_action 09:01:39 INFO - Running main action method: download_and_extract 09:01:39 INFO - mkdir: /builds/slave/test/build/tests 09:01:39 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')]} 09:01:39 INFO - https://queue.taskcluster.net/v1/task/Y0MerU6WTcW46pJV-yH7Sg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:01:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y0MerU6WTcW46pJV-yH7Sg/artifacts/public/build/test_packages.json 09:01:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y0MerU6WTcW46pJV-yH7Sg/artifacts/public/build/test_packages.json 09:01:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y0MerU6WTcW46pJV-yH7Sg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:01:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y0MerU6WTcW46pJV-yH7Sg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:01:40 INFO - Downloaded 1302 bytes. 09:01:40 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:01:40 INFO - Using the following test package requirements: 09:01:40 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:01:40 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:01:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:01:40 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:01:40 INFO - u'jsshell-linux-x86_64.zip'], 09:01:40 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:01:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:01:40 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:01:40 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:01:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:01:40 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:01:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:01:40 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:01:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:01:40 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:01:40 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:01:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:01:40 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:01:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:40 INFO - https://queue.taskcluster.net/v1/task/Y0MerU6WTcW46pJV-yH7Sg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:01:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y0MerU6WTcW46pJV-yH7Sg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:01:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y0MerU6WTcW46pJV-yH7Sg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:01:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y0MerU6WTcW46pJV-yH7Sg/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 09:01:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y0MerU6WTcW46pJV-yH7Sg/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 09:01:41 INFO - Downloaded 21341306 bytes. 09:01:41 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 09:01:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:01:41 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 09:01:43 INFO - Return code: 0 09:01:43 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 09:01:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:43 INFO - https://queue.taskcluster.net/v1/task/Y0MerU6WTcW46pJV-yH7Sg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:01:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y0MerU6WTcW46pJV-yH7Sg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:01:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y0MerU6WTcW46pJV-yH7Sg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:01:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y0MerU6WTcW46pJV-yH7Sg/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 09:01:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y0MerU6WTcW46pJV-yH7Sg/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 09:01:45 INFO - Downloaded 21341306 bytes. 09:01:45 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 09:01:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:01:45 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 09:01:46 INFO - Return code: 0 09:01:46 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')]} 09:01:46 INFO - https://queue.taskcluster.net/v1/task/Y0MerU6WTcW46pJV-yH7Sg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:01:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y0MerU6WTcW46pJV-yH7Sg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:01:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y0MerU6WTcW46pJV-yH7Sg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:01:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y0MerU6WTcW46pJV-yH7Sg/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 09:01:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y0MerU6WTcW46pJV-yH7Sg/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 09:01:47 INFO - Downloaded 11130997 bytes. 09:01: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 09:01:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:01: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 09:01:48 INFO - Return code: 0 09:01:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:48 INFO - https://queue.taskcluster.net/v1/task/Y0MerU6WTcW46pJV-yH7Sg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:01:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y0MerU6WTcW46pJV-yH7Sg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:01:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y0MerU6WTcW46pJV-yH7Sg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:01:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y0MerU6WTcW46pJV-yH7Sg/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 09:01:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y0MerU6WTcW46pJV-yH7Sg/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 09:01:49 INFO - Downloaded 56073006 bytes. 09:01:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Y0MerU6WTcW46pJV-yH7Sg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:01:49 INFO - mkdir: /builds/slave/test/properties 09:01:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:01:49 INFO - Writing to file /builds/slave/test/properties/build_url 09:01:49 INFO - Contents: 09:01:49 INFO - build_url:https://queue.taskcluster.net/v1/task/Y0MerU6WTcW46pJV-yH7Sg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:01:49 INFO - Running post-action listener: _resource_record_post_action 09:01:49 INFO - Running post-action listener: set_extra_try_arguments 09:01:49 INFO - ##### 09:01:49 INFO - ##### Running populate-webroot step. 09:01:49 INFO - ##### 09:01:49 INFO - Running pre-action listener: _resource_record_pre_action 09:01:49 INFO - Running main action method: populate_webroot 09:01:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:01:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:01:49 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 09:01:49 INFO - '../fennec_ids.txt'], 09:01:49 INFO - 'tests': ['tcheck2']}, 09:01:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:01:49 INFO - '--tppagecycles', 09:01:49 INFO - '7'], 09:01:49 INFO - 'tests': ['tsvgm']}}, 09:01:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:01:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:01:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:01:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:01:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:01:49 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:01:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:01:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:49 INFO - 'talos_options': ['--e10s'], 09:01:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:01:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:49 INFO - 'tests': ['damp', 'tps']}, 09:01:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:49 INFO - 'talos_options': ['--e10s'], 09:01:49 INFO - 'tests': ['damp', 'tps']}, 09:01:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:01:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:01:49 INFO - 'other': {'tests': ['a11yr', 09:01:49 INFO - 'ts_paint', 09:01:49 INFO - 'tpaint', 09:01:49 INFO - 'sessionrestore', 09:01:49 INFO - 'sessionrestore_no_auto_restore']}, 09:01:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:01:49 INFO - 'tests': ['a11yr', 09:01:49 INFO - 'ts_paint', 09:01:49 INFO - 'tpaint', 09:01:49 INFO - 'sessionrestore', 09:01:49 INFO - 'sessionrestore_no_auto_restore']}, 09:01:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:01:49 INFO - 'tests': ['a11yr', 09:01:49 INFO - 'ts_paint', 09:01:49 INFO - 'tpaint', 09:01:49 INFO - 'sessionrestore', 09:01:49 INFO - 'sessionrestore_no_auto_restore']}, 09:01:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:01:49 INFO - 'tests': ['a11yr', 09:01:49 INFO - 'ts_paint', 09:01:49 INFO - 'tpaint', 09:01:49 INFO - 'sessionrestore', 09:01:49 INFO - 'sessionrestore_no_auto_restore']}, 09:01:49 INFO - 'other_l64': {'tests': ['a11yr', 09:01:49 INFO - 'ts_paint', 09:01:49 INFO - 'tpaint', 09:01:49 INFO - 'sessionrestore', 09:01:49 INFO - 'sessionrestore_no_auto_restore']}, 09:01:49 INFO - 'other_nol64': {'tests': ['a11yr', 09:01:49 INFO - 'ts_paint', 09:01:49 INFO - 'tpaint', 09:01:49 INFO - 'sessionrestore', 09:01:49 INFO - 'sessionrestore_no_auto_restore']}, 09:01:49 INFO - 'svgr': {'tests': ['tsvgx', 09:01:49 INFO - 'tsvgr_opacity', 09:01:49 INFO - 'tart', 09:01:49 INFO - 'tscrollx', 09:01:49 INFO - 'cart']}, 09:01:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:01:49 INFO - 'tests': ['tsvgx', 09:01:49 INFO - 'tsvgr_opacity', 09:01:49 INFO - 'tart', 09:01:49 INFO - 'tscrollx', 09:01:49 INFO - 'cart']}, 09:01:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:49 INFO - 'tests': ['tp5o']}, 09:01:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:49 INFO - 'talos_options': ['--e10s'], 09:01:49 INFO - 'tests': ['tp5o']}, 09:01:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:49 INFO - 'talos_options': ['--xperf_path', 09:01:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:01:49 INFO - 'tests': ['tp5n']}, 09:01:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:49 INFO - 'talos_options': ['--e10s', 09:01:49 INFO - '--xperf_path', 09:01:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:01:49 INFO - 'tests': ['tp5n']}}, 09:01:49 INFO - 'talos.zip': {'path': '', 09:01:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:01:49 INFO - Running post-action listener: _resource_record_post_action 09:01:49 INFO - ##### 09:01:49 INFO - ##### Running create-virtualenv step. 09:01:49 INFO - ##### 09:01:49 INFO - Running pre-action listener: _resource_record_pre_action 09:01:49 INFO - Running main action method: create_virtualenv 09:01:49 INFO - Creating virtualenv /builds/slave/test/build/venv 09:01:49 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 09:01:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:01:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:01:49 INFO - Using real prefix '/usr' 09:01:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:01:50 INFO - Installing distribute.............................................................................................................................................................................................done. 09:01:52 INFO - Installing pip.................done. 09:01:52 INFO - Return code: 0 09:01:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:01:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4391d6dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a7900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20edb70>, '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 0x213edc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213f250>, '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': '01deea79d00cc2c334834894000001d2-1448383093.687565-1158267869', '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 09:01:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:01:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:01:52 INFO - Using env: {'DISPLAY': ':0', 09:01:52 INFO - 'HOME': '/home/cltbld', 09:01:52 INFO - 'LANG': 'en_US.UTF-8', 09:01:52 INFO - 'LANGUAGE': 'en_US:en', 09:01:52 INFO - 'LOGNAME': 'cltbld', 09:01:52 INFO - 'MAIL': '/var/mail/cltbld', 09:01:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:52 INFO - 'MOZ_NO_REMOTE': '1', 09:01:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:52 INFO - 'NO_EM_RESTART': '1', 09:01:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:52 INFO - 'PWD': '/builds/slave/test', 09:01:52 INFO - 'SHELL': '/bin/bash', 09:01:52 INFO - 'SHLVL': '1', 09:01:52 INFO - 'TERM': 'linux', 09:01:52 INFO - 'TMOUT': '86400', 09:01:52 INFO - 'USER': 'cltbld', 09:01:52 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1448383093.687565-1158267869', 09:01:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:52 INFO - '_': '/tools/buildbot/bin/python'} 09:01:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01: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 09:01:53 INFO - Cleaning up... 09:01:53 INFO - Return code: 0 09:01:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:01: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')]} 09:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01: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')]} 09:01:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01: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 0x7f4391d6dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a7900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20edb70>, '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 0x213edc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213f250>, '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': '01deea79d00cc2c334834894000001d2-1448383093.687565-1158267869', '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 09:01: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 09:01: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 09:01:53 INFO - Using env: {'DISPLAY': ':0', 09:01:53 INFO - 'HOME': '/home/cltbld', 09:01:53 INFO - 'LANG': 'en_US.UTF-8', 09:01:53 INFO - 'LANGUAGE': 'en_US:en', 09:01:53 INFO - 'LOGNAME': 'cltbld', 09:01:53 INFO - 'MAIL': '/var/mail/cltbld', 09:01:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:53 INFO - 'MOZ_NO_REMOTE': '1', 09:01:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:53 INFO - 'NO_EM_RESTART': '1', 09:01:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:53 INFO - 'PWD': '/builds/slave/test', 09:01:53 INFO - 'SHELL': '/bin/bash', 09:01:53 INFO - 'SHLVL': '1', 09:01:53 INFO - 'TERM': 'linux', 09:01:53 INFO - 'TMOUT': '86400', 09:01:53 INFO - 'USER': 'cltbld', 09:01:53 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1448383093.687565-1158267869', 09:01:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:53 INFO - '_': '/tools/buildbot/bin/python'} 09:01:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:53 INFO - Downloading/unpacking psutil>=0.7.1 09:01:53 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 09:01:53 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 09:01:53 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 09:01:53 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 09:01:53 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 09:01:53 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 09:01:55 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 09:01:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:01:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:01:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:01:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:01:55 INFO - Installing collected packages: psutil 09:01:55 INFO - Running setup.py install for psutil 09:01:55 INFO - building 'psutil._psutil_linux' extension 09:01:55 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 09:01:57 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 09:01:57 INFO - building 'psutil._psutil_posix' extension 09:01:57 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 09:01:58 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 09:01:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:01:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:01:58 INFO - Successfully installed psutil 09:01:58 INFO - Cleaning up... 09:01:58 INFO - Return code: 0 09:01:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:01: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')]} 09:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01: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')]} 09:01:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01: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', '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 0x7f4391d6dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a7900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20edb70>, '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 0x213edc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213f250>, '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': '01deea79d00cc2c334834894000001d2-1448383093.687565-1158267869', '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 09:01: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:01: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 mozsystemmonitor==0.0.0 09:01:58 INFO - Using env: {'DISPLAY': ':0', 09:01:58 INFO - 'HOME': '/home/cltbld', 09:01:58 INFO - 'LANG': 'en_US.UTF-8', 09:01:58 INFO - 'LANGUAGE': 'en_US:en', 09:01:58 INFO - 'LOGNAME': 'cltbld', 09:01:58 INFO - 'MAIL': '/var/mail/cltbld', 09:01:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:58 INFO - 'MOZ_NO_REMOTE': '1', 09:01:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:58 INFO - 'NO_EM_RESTART': '1', 09:01:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:58 INFO - 'PWD': '/builds/slave/test', 09:01:58 INFO - 'SHELL': '/bin/bash', 09:01:58 INFO - 'SHLVL': '1', 09:01:58 INFO - 'TERM': 'linux', 09:01:58 INFO - 'TMOUT': '86400', 09:01:58 INFO - 'USER': 'cltbld', 09:01:58 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1448383093.687565-1158267869', 09:01:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:58 INFO - '_': '/tools/buildbot/bin/python'} 09:01:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:01: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 09:01: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 09:01: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 09:01: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 09:01: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 09:01: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 09:02:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:02:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:02:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:02:00 INFO - Installing collected packages: mozsystemmonitor 09:02:00 INFO - Running setup.py install for mozsystemmonitor 09:02:00 INFO - Successfully installed mozsystemmonitor 09:02:00 INFO - Cleaning up... 09:02:00 INFO - Return code: 0 09:02:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:02:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:02:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:02:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f4391d6dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a7900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20edb70>, '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 0x213edc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213f250>, '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': '01deea79d00cc2c334834894000001d2-1448383093.687565-1158267869', '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 09:02:00 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 09:02:00 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 09:02:00 INFO - Using env: {'DISPLAY': ':0', 09:02:00 INFO - 'HOME': '/home/cltbld', 09:02:00 INFO - 'LANG': 'en_US.UTF-8', 09:02:00 INFO - 'LANGUAGE': 'en_US:en', 09:02:00 INFO - 'LOGNAME': 'cltbld', 09:02:00 INFO - 'MAIL': '/var/mail/cltbld', 09:02:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:00 INFO - 'MOZ_NO_REMOTE': '1', 09:02:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:02:00 INFO - 'NO_EM_RESTART': '1', 09:02:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:02:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:02:00 INFO - 'PWD': '/builds/slave/test', 09:02:00 INFO - 'SHELL': '/bin/bash', 09:02:00 INFO - 'SHLVL': '1', 09:02:00 INFO - 'TERM': 'linux', 09:02:00 INFO - 'TMOUT': '86400', 09:02:00 INFO - 'USER': 'cltbld', 09:02:00 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1448383093.687565-1158267869', 09:02:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:00 INFO - '_': '/tools/buildbot/bin/python'} 09:02:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:02:00 INFO - Downloading/unpacking blobuploader==1.2.4 09:02: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 09:02: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 09:02: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 09:02: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 09:02: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 09:02: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 09:02:02 INFO - Downloading blobuploader-1.2.4.tar.gz 09:02:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:02:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:02:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:02:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:02:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:02:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:02:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:02:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:02:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:02:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:02:03 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 09:02:03 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 09:02:03 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 09:02:03 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 09:02:03 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 09:02:03 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 09:02:03 INFO - Downloading docopt-0.6.1.tar.gz 09:02:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:02:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:02:03 INFO - Installing collected packages: blobuploader, requests, docopt 09:02:03 INFO - Running setup.py install for blobuploader 09:02:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:02:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:02:03 INFO - Running setup.py install for requests 09:02:03 INFO - Running setup.py install for docopt 09:02:03 INFO - Successfully installed blobuploader requests docopt 09:02:03 INFO - Cleaning up... 09:02:03 INFO - Return code: 0 09:02:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:02:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:02:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:02:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:03 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 0x7f4391d6dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a7900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20edb70>, '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 0x213edc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213f250>, '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': '01deea79d00cc2c334834894000001d2-1448383093.687565-1158267869', '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 09:02:03 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 09:02:03 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 09:02:03 INFO - Using env: {'DISPLAY': ':0', 09:02:03 INFO - 'HOME': '/home/cltbld', 09:02:03 INFO - 'LANG': 'en_US.UTF-8', 09:02:03 INFO - 'LANGUAGE': 'en_US:en', 09:02:03 INFO - 'LOGNAME': 'cltbld', 09:02:03 INFO - 'MAIL': '/var/mail/cltbld', 09:02:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:03 INFO - 'MOZ_NO_REMOTE': '1', 09:02:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:02:03 INFO - 'NO_EM_RESTART': '1', 09:02:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:02:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:02:03 INFO - 'PWD': '/builds/slave/test', 09:02:03 INFO - 'SHELL': '/bin/bash', 09:02:03 INFO - 'SHLVL': '1', 09:02:03 INFO - 'TERM': 'linux', 09:02:03 INFO - 'TMOUT': '86400', 09:02:03 INFO - 'USER': 'cltbld', 09:02:03 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1448383093.687565-1158267869', 09:02:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:03 INFO - '_': '/tools/buildbot/bin/python'} 09:02:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:02:04 INFO - Running setup.py (path:/tmp/pip-B3CqEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:02:04 INFO - Running setup.py (path:/tmp/pip-NhoScc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:02:04 INFO - Running setup.py (path:/tmp/pip-R4tGcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:02:04 INFO - Running setup.py (path:/tmp/pip-v2AdbC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:02:04 INFO - Running setup.py (path:/tmp/pip-cLaF6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:02:04 INFO - Running setup.py (path:/tmp/pip-wtg3OR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:02:04 INFO - Running setup.py (path:/tmp/pip-QWsCxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:02:04 INFO - Running setup.py (path:/tmp/pip-I23Ekw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:02:04 INFO - Running setup.py (path:/tmp/pip-ZvUG4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:02:04 INFO - Running setup.py (path:/tmp/pip-u0fAy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:02:04 INFO - Running setup.py (path:/tmp/pip-S9F8G1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:02:04 INFO - Running setup.py (path:/tmp/pip-YG0Z9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:02:04 INFO - Running setup.py (path:/tmp/pip-0dNMO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:02:05 INFO - Running setup.py (path:/tmp/pip-eUnEA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:02:05 INFO - Running setup.py (path:/tmp/pip-G6rUye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:02:05 INFO - Running setup.py (path:/tmp/pip-eNfgZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:02:05 INFO - Running setup.py (path:/tmp/pip-YOyYDe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:02:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:02:05 INFO - Running setup.py install for manifestparser 09:02:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:02:05 INFO - Running setup.py install for mozcrash 09:02:05 INFO - Running setup.py install for mozdebug 09:02:05 INFO - Running setup.py install for mozdevice 09:02:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:02:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:02:05 INFO - Running setup.py install for mozfile 09:02:05 INFO - Running setup.py install for mozhttpd 09:02:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:02:05 INFO - Running setup.py install for mozinfo 09:02:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:02:06 INFO - Running setup.py install for mozInstall 09:02:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:02:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:02:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:02:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:02:06 INFO - Running setup.py install for mozleak 09:02:06 INFO - Running setup.py install for mozlog 09:02:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:02:06 INFO - Running setup.py install for moznetwork 09:02:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:02:06 INFO - Running setup.py install for mozprocess 09:02:06 INFO - Running setup.py install for mozprofile 09:02:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:02:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:02:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:02:06 INFO - Running setup.py install for mozrunner 09:02:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:02:06 INFO - Running setup.py install for mozscreenshot 09:02:06 INFO - Running setup.py install for moztest 09:02:06 INFO - Running setup.py install for mozversion 09:02:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:02:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:02:07 INFO - Cleaning up... 09:02:07 INFO - Return code: 0 09:02:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:02:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:02:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:02:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f4391d6dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a7900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20edb70>, '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 0x213edc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213f250>, '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': '01deea79d00cc2c334834894000001d2-1448383093.687565-1158267869', '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 09:02:07 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 09:02:07 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 09:02:07 INFO - Using env: {'DISPLAY': ':0', 09:02:07 INFO - 'HOME': '/home/cltbld', 09:02:07 INFO - 'LANG': 'en_US.UTF-8', 09:02:07 INFO - 'LANGUAGE': 'en_US:en', 09:02:07 INFO - 'LOGNAME': 'cltbld', 09:02:07 INFO - 'MAIL': '/var/mail/cltbld', 09:02:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:07 INFO - 'MOZ_NO_REMOTE': '1', 09:02:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:02:07 INFO - 'NO_EM_RESTART': '1', 09:02:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:02:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:02:07 INFO - 'PWD': '/builds/slave/test', 09:02:07 INFO - 'SHELL': '/bin/bash', 09:02:07 INFO - 'SHLVL': '1', 09:02:07 INFO - 'TERM': 'linux', 09:02:07 INFO - 'TMOUT': '86400', 09:02:07 INFO - 'USER': 'cltbld', 09:02:07 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1448383093.687565-1158267869', 09:02:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:07 INFO - '_': '/tools/buildbot/bin/python'} 09:02:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:02:07 INFO - Running setup.py (path:/tmp/pip-cZbMII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:02:07 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)) 09:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:02:07 INFO - Running setup.py (path:/tmp/pip-fJTuhu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:02:07 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)) 09:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:02:07 INFO - Running setup.py (path:/tmp/pip-_6QeAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:02:07 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)) 09:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:02:07 INFO - Running setup.py (path:/tmp/pip-DhXQaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:02:07 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)) 09:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:02:07 INFO - Running setup.py (path:/tmp/pip-7LvidS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:02:07 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)) 09:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:02:07 INFO - Running setup.py (path:/tmp/pip-fdrUEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:02:07 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)) 09:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:02:07 INFO - Running setup.py (path:/tmp/pip-rewHtV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:02:07 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)) 09:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:02:07 INFO - Running setup.py (path:/tmp/pip-5O8e4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:02:07 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)) 09:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:02:07 INFO - Running setup.py (path:/tmp/pip-tZZedG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:02:07 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)) 09:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:02:07 INFO - Running setup.py (path:/tmp/pip-dQW6vq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:02:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:02:08 INFO - Running setup.py (path:/tmp/pip-k7JoUy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:02:08 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)) 09:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:02:08 INFO - Running setup.py (path:/tmp/pip-7OWsgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:02:08 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)) 09:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:02:08 INFO - Running setup.py (path:/tmp/pip-JERsTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:02:08 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)) 09:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:02:08 INFO - Running setup.py (path:/tmp/pip-xELr2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:02:08 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)) 09:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:02:08 INFO - Running setup.py (path:/tmp/pip-jz40H3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:02:08 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)) 09:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:02:08 INFO - Running setup.py (path:/tmp/pip-ycl1aR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:02:08 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)) 09:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:02:08 INFO - Running setup.py (path:/tmp/pip-GZz6Q3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:02:08 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)) 09:02:08 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)) 09:02: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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:02:08 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)) 09:02:08 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)) 09:02:08 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)) 09:02:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:02:08 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 09:02:08 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 09:02:08 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 09:02:08 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 09:02:08 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 09:02:08 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 09:02:10 INFO - Downloading blessings-1.5.1.tar.gz 09:02:10 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 09:02:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:02:10 INFO - Installing collected packages: blessings 09:02:10 INFO - Running setup.py install for blessings 09:02:10 INFO - Successfully installed blessings 09:02:10 INFO - Cleaning up... 09:02:10 INFO - Return code: 0 09:02:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:02:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:02:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:02:10 INFO - Reading from file tmpfile_stdout 09:02:10 INFO - Current package versions: 09:02:10 INFO - argparse == 1.2.1 09:02:10 INFO - blessings == 1.5.1 09:02:10 INFO - blobuploader == 1.2.4 09:02:10 INFO - docopt == 0.6.1 09:02:10 INFO - manifestparser == 1.1 09:02:10 INFO - mozInstall == 1.12 09:02:10 INFO - mozcrash == 0.16 09:02:10 INFO - mozdebug == 0.1 09:02:10 INFO - mozdevice == 0.47 09:02:10 INFO - mozfile == 1.2 09:02:10 INFO - mozhttpd == 0.7 09:02:10 INFO - mozinfo == 0.9 09:02:10 INFO - mozleak == 0.1 09:02:10 INFO - mozlog == 3.1 09:02:10 INFO - moznetwork == 0.27 09:02:10 INFO - mozprocess == 0.22 09:02:10 INFO - mozprofile == 0.27 09:02:10 INFO - mozrunner == 6.11 09:02:10 INFO - mozscreenshot == 0.1 09:02:10 INFO - mozsystemmonitor == 0.0 09:02:10 INFO - moztest == 0.7 09:02:10 INFO - mozversion == 1.4 09:02:10 INFO - psutil == 3.1.1 09:02:10 INFO - requests == 1.2.3 09:02:10 INFO - wsgiref == 0.1.2 09:02:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:02:10 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')]} 09:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:02:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:10 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')]} 09:02:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:02:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:10 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 0x7f4391d6dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a7900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20edb70>, '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 0x213edc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213f250>, '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': '01deea79d00cc2c334834894000001d2-1448383093.687565-1158267869', '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 09:02:10 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 09:02:10 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 09:02:10 INFO - Using env: {'DISPLAY': ':0', 09:02:10 INFO - 'HOME': '/home/cltbld', 09:02:10 INFO - 'LANG': 'en_US.UTF-8', 09:02:10 INFO - 'LANGUAGE': 'en_US:en', 09:02:10 INFO - 'LOGNAME': 'cltbld', 09:02:10 INFO - 'MAIL': '/var/mail/cltbld', 09:02:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:10 INFO - 'MOZ_NO_REMOTE': '1', 09:02:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:02:10 INFO - 'NO_EM_RESTART': '1', 09:02:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:02:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:02:10 INFO - 'PWD': '/builds/slave/test', 09:02:10 INFO - 'SHELL': '/bin/bash', 09:02:10 INFO - 'SHLVL': '1', 09:02:10 INFO - 'TERM': 'linux', 09:02:10 INFO - 'TMOUT': '86400', 09:02:10 INFO - 'USER': 'cltbld', 09:02:10 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1448383093.687565-1158267869', 09:02:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:10 INFO - '_': '/tools/buildbot/bin/python'} 09:02:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:02:10 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)) 09:02:10 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)) 09:02:10 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)) 09:02:10 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)) 09:02:10 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)) 09:02:10 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)) 09:02:10 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)) 09:02:10 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)) 09:02:10 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)) 09:02:10 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)) 09:02:10 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)) 09:02:10 INFO - Cleaning up... 09:02:10 INFO - Return code: 0 09:02:10 INFO - Running post-action listener: _resource_record_post_action 09:02:10 INFO - Running post-action listener: _start_resource_monitoring 09:02:10 INFO - Starting resource monitoring. 09:02:10 INFO - ##### 09:02:10 INFO - ##### Running install step. 09:02:10 INFO - ##### 09:02:10 INFO - Running pre-action listener: _resource_record_pre_action 09:02:10 INFO - Running main action method: install 09:02:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:02:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:02:11 INFO - Reading from file tmpfile_stdout 09:02:11 INFO - Detecting whether we're running mozinstall >=1.0... 09:02:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:02:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:02:11 INFO - Reading from file tmpfile_stdout 09:02:11 INFO - Output received: 09:02:11 INFO - Usage: mozinstall [options] installer 09:02:11 INFO - Options: 09:02:11 INFO - -h, --help show this help message and exit 09:02:11 INFO - -d DEST, --destination=DEST 09:02:11 INFO - Directory to install application into. [default: 09:02:11 INFO - "/builds/slave/test"] 09:02:11 INFO - --app=APP Application being installed. [default: firefox] 09:02:11 INFO - mkdir: /builds/slave/test/build/application 09:02:11 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'] 09:02:11 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 09:02:25 INFO - Reading from file tmpfile_stdout 09:02:25 INFO - Output received: 09:02:25 INFO - /builds/slave/test/build/application/firefox/firefox 09:02:25 INFO - Running post-action listener: _resource_record_post_action 09:02:25 INFO - ##### 09:02:25 INFO - ##### Running run-tests step. 09:02:25 INFO - ##### 09:02:25 INFO - Running pre-action listener: _resource_record_pre_action 09:02:25 INFO - Running main action method: run_tests 09:02:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:02:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:02:25 INFO - Python 2.7.3 09:02:25 INFO - Return code: 0 09:02:25 INFO - grabbing minidump binary from tooltool 09:02:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:25 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 0x20edb70>, '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 0x213edc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213f250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:02:25 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 09:02:25 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 09:02:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:02:25 INFO - Return code: 0 09:02:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:02:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:02:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:02:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:02:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:02:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y0MerU6WTcW46pJV-yH7Sg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost'] in /builds/slave/test/build 09:02:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Y0MerU6WTcW46pJV-yH7Sg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost 09:02:25 INFO - Using env: {'DISPLAY': ':0', 09:02:25 INFO - 'HOME': '/home/cltbld', 09:02:25 INFO - 'LANG': 'en_US.UTF-8', 09:02:25 INFO - 'LANGUAGE': 'en_US:en', 09:02:25 INFO - 'LOGNAME': 'cltbld', 09:02:25 INFO - 'MAIL': '/var/mail/cltbld', 09:02:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:02:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:02:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:25 INFO - 'MOZ_NO_REMOTE': '1', 09:02:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:02:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:02:25 INFO - 'NO_EM_RESTART': '1', 09:02:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:02:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:02:25 INFO - 'PWD': '/builds/slave/test', 09:02:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:02:25 INFO - 'SHELL': '/bin/bash', 09:02:25 INFO - 'SHLVL': '1', 09:02:25 INFO - 'TERM': 'linux', 09:02:25 INFO - 'TMOUT': '86400', 09:02:25 INFO - 'USER': 'cltbld', 09:02:25 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1448383093.687565-1158267869', 09:02:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:25 INFO - '_': '/tools/buildbot/bin/python'} 09:02:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y0MerU6WTcW46pJV-yH7Sg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost'] with output_timeout 3600 09:02:25 INFO - mozversion INFO | application_buildid: 20151124082333 09:02:25 INFO - mozversion INFO | application_changeset: 0403cb97fb51eb7a05ae2f8091fe031d79ae6ae1 09:02:25 INFO - mozversion INFO | application_display_name: Nightly 09:02:25 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:02:25 INFO - mozversion INFO | application_name: Firefox 09:02:25 INFO - mozversion INFO | application_remotingname: firefox 09:02:25 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 09:02:25 INFO - mozversion INFO | application_vendor: Mozilla 09:02:25 INFO - mozversion INFO | application_version: 45.0a1 09:02:25 INFO - mozversion INFO | platform_buildid: 20151124082333 09:02:25 INFO - mozversion INFO | platform_changeset: 0403cb97fb51eb7a05ae2f8091fe031d79ae6ae1 09:02:25 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 09:02:25 INFO - mozversion INFO | platform_version: 45.0a1 09:02:25 INFO - 2015-11-24 09:02:25,813 DEBUG : using testdate: 1448384545 09:02:25 INFO - 2015-11-24 09:02:25,813 DEBUG : actual date: 1448384545 09:02:25 INFO - 2015-11-24 09:02:25,820 INFO : starting webserver on 'localhost:44660' 09:02:25 INFO - 2015-11-24 09:02:25,821 INFO : Starting test suite talos-linux64-ix-014 09:02:25 INFO - 2015-11-24 09:02:25,821 INFO : Starting test dromaeo_css 09:02:25 INFO - 2015-11-24 09:02:25,821 DEBUG : operating with platform_type : linux_ 09:02:25 INFO - 2015-11-24 09:02:25,822 INFO : Initialising browser for dromaeo_css test... 09:02:25 INFO - 2015-11-24 09:02:25,967 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0G9AU_/profile http://localhost:44660/getInfo.html 09:02:32 INFO - 2015-11-24 09:02:32,283 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:02:32 INFO - 2015-11-24 09:02:32,284 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:02:32 INFO - 2015-11-24 09:02:32,284 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:02:32 INFO - 2015-11-24 09:02:32,284 DEBUG : BROWSER_OUTPUT: __metrics 09:02:32 INFO - 2015-11-24 09:02:32,400 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:02:33 INFO - 2015-11-24 09:02:33,837 INFO : Browser initialized. 09:02:33 INFO - 2015-11-24 09:02:33,838 INFO : Running cycle 1/1 for dromaeo_css test... 09:02:33 INFO - 2015-11-24 09:02:33,838 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0G9AU_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:02:45 INFO - 2015-11-24 09:02:45,790 DEBUG : BROWSER_OUTPUT: RSS: Main: 139845632 09:02:45 INFO - 2015-11-24 09:02:45,790 DEBUG : BROWSER_OUTPUT: 09:03:36 INFO - 2015-11-24 09:03:36,964 DEBUG : BROWSER_OUTPUT: 1448384616962 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] 09:05:49 INFO - 2015-11-24 09:05:49,330 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44660/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44660/tests/dromaeo/cssquery-ext.html) 09:05:50 INFO - 2015-11-24 09:05:50,560 DEBUG : BROWSER_OUTPUT: RSS: Main: 260788224 09:05:50 INFO - 2015-11-24 09:05:50,561 DEBUG : BROWSER_OUTPUT: 09:08:53 INFO - 2015-11-24 09:08:53,110 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44660/tests/dromaeo/cssquery-ext.html (next: http://localhost:44660/tests/dromaeo/cssquery-jquery.html) 09:08:53 INFO - 2015-11-24 09:08:53,680 DEBUG : BROWSER_OUTPUT: RSS: Main: 224325632 09:08:53 INFO - 2015-11-24 09:08:53,680 DEBUG : BROWSER_OUTPUT: 09:11:55 INFO - 2015-11-24 09:11:55,808 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44660/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44660/tests/dromaeo/cssquery-mootools.html) 09:11:56 INFO - 2015-11-24 09:11:56,389 DEBUG : BROWSER_OUTPUT: RSS: Main: 211111936 09:11:56 INFO - 2015-11-24 09:11:56,390 DEBUG : BROWSER_OUTPUT: 09:14:58 INFO - 2015-11-24 09:14:58,297 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44660/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44660/tests/dromaeo/cssquery-prototype.html) 09:14:58 INFO - 2015-11-24 09:14:58,878 DEBUG : BROWSER_OUTPUT: RSS: Main: 205721600 09:14:58 INFO - 2015-11-24 09:14:58,879 DEBUG : BROWSER_OUTPUT: 09:18:01 INFO - 2015-11-24 09:18:01,620 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44660/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44660/tests/dromaeo/cssquery-yui.html) 09:18:02 INFO - 2015-11-24 09:18:02,213 DEBUG : BROWSER_OUTPUT: RSS: Main: 181882880 09:18:02 INFO - 2015-11-24 09:18:02,213 DEBUG : BROWSER_OUTPUT: 09:21:04 INFO - 2015-11-24 09:21:04,426 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44660/tests/dromaeo/cssquery-yui.html (next: http://localhost:44660/tests/dromaeo/cssquery-dojo.html) 09:21:04 INFO - 2015-11-24 09:21:04,677 DEBUG : BROWSER_OUTPUT: RSS: Main: 248184832 09:21:04 INFO - 2015-11-24 09:21:04,677 DEBUG : BROWSER_OUTPUT: 09:21:04 INFO - 2015-11-24 09:21:04,678 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:21:04 INFO - 2015-11-24 09:21:04,679 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:21:04 INFO - 2015-11-24 09:21:04,679 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:21:04 INFO - 2015-11-24 09:21:04,679 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:21:04 INFO - 2015-11-24 09:21:04,680 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2576.8136593045792;2617.084020592793;2626.606009098634;2633.4469761350115;2646.536856050192;4516;4523.38934243877;4555.681102322838;4643.721376717399;4652.953470465294;4575.565321294472;4596.954030459694;4646.674732768699;4653.3252678361705;4672;4279.144171165756;4352.238358287287;4367.847125350613;4369.279068953619;4403.691741578091;4188.5392606813375;4405.31717583775;4421.115776844628;4452.755098469583;4470.2177119004045;4264.402983582301;4288.807003684841;4306.074194048263;4340.045190058182;4369.191699535596;4329.1558146161515;4330.198913201068;4335.1979883721615;4336.522982471925;4367.781610919441;4307.07397909451;4307.396964424983;4313.805878735465;4346.217680817452;4356.760378179199;4490.2142125127975;4566.657500687428;4657.813687452498;4658.557437043475;4666.556677115668;4995.650304478688;5010.423801262865;5018.874528136826;5019.548240658358;5059.342285502861;5032.194848824171;5035.118854200537;5037.697738135724;5041.1682072458;5044.192929131358;4437.556244375537;4527.185106680763;4538.8865278367975;4634.351190833286;4751.596114330251;5128.076946149654;5153.484651534816;5153.922691159635;5173.81891633791;5195.792168313225;4962.330085438492;4967;4972.627052971042;5012.749362531858;5021.271915572294;4817.855464336076;4922.212446008622;4942.604591632661;4944.1100601892;4975.604898934567;4921.630877684116;4933.235348520985;4936.062148191832;4942.703437793743;4991.351124353883;4909.410870695539;4911;4914.680545764585;4915.606751459874;4958.330625365602;4003.279409706281;4071.633552980246;4107.507099148122;4110.794460277034;4113.4035564843525;3529.505869178317;3593.640635936438;3626.2747450510005;3628;3628.0385697790107;4197.790110494463;4249.638780703613;4254;4303.139372125587;4306.4832220133785;4934.6545741798445;4936.7284799336385;4937.925931111036;4946.431160416526;4989.675671081368;4245.490541135084;4248.235317642792;4248.915021699549;4248.9787551062045;4284.250256205151;4244.427002354704;4294.26997410441;4345.109252603209;4352;4396.736195828261;4760.047990401864;4765.9523404765505;4768.117898188846;4769.14155452015;4815.109204797123;4957.603391728581;5036.6726162799305;5043.445221025758;5043.52086551777;5046.53485517789;4552.294394368878;4658.464276608233;4659.860204193879;4662.626989840736;4805.087033463631;4815.181419158681;4883.267509873547;4893.1436998524405;4929.383827021622;4931.186354251508;4970.627202959865;4973.900521989613;4980.352554167935;4982.202847544376;5024.371953505812;4686.343911852412;4800.543948324904;4825.541573550507;4827.831025914076;4882.584980276574;4768.76156192196;4797.64017698681;4886.047220791911;4889.217725163957;4929.507049295042;4798.49615790337;4807.975960120177;4819.975900120477;4834.226523756182;4862.41651001882;4766.237402015661;4869.87825304356;4963.932754457809;4972.726500042532;4998.975005124951;4700.6239500839165;4722.504137065696;4751.50109238525;4778.713277203379;4802.063597598574 09:21:04 INFO - 2015-11-24 09:21:04,682 DEBUG : BROWSER_OUTPUT: |1;ext.html;561.5647872898505;567.8921005009046;568.437247125346;575.3843387575293;576.6251936241442;27674.86162569187;28205.576916346246;28342;28579.571306430422;28582.571261431043;28438.715612843866;36961.63038369615;37860.81069594648;37879;37922.4311635325;7876.409269304796;8018.198180181994;8023.077346105214;8023.31801796848;8029.879551806727;7051.365377116059;7245.927540724604;7750.302472777449;7862.135165131859;7863.410244231705;7054.753083642074;7157.6063316517575;7158.534695244818;10024.94987525065;10302.536385862617;9853.261005424585;9983.750406239866;9993.600255989752;9998.500074996295;10001.949990250076;9835.45904975226;9988.700338989769;9996.050375214343;10007.449590272532;10011.249156313306;28654;29122.70877291221;39913.201735965114;40750.388744168864;40940.38589421161;2619.240420278117;2670.5593577059763;2904.564315352693;3118.7193152616146;3141.8586163622463;26532.46935061307;26542;26666.200013999613;26970.460590788076;27158.728412716016;3251.7561182911377;3312.3044160726276;3343.732501399882;3377.459606462954;3403.2002479417315;198747;198918;199163;199428;199591;50744;51088;51185.48814511807;51330;51415.22877156846;53723;54309.45690543123;54310;54336.45663543314;54475.72762136164;13641.386137623633;13641.590752277447;13711.657208569666;13814;13858.376373063236;10895.945520272347;10949.726256843642;10977.506012229469;10981.352797080503;10995.615153469751;17548.210330535156;17774.37789677381;17839.643207136043;17898.55253618644;18050;6858.622775747382;7284.6721897514735;7320.853582928418;7352.742654007084;7391.963040184764;769.9653515591812;828.867381219002;865.5585651317873;869.8129902071086;890.1943740914483;25713.614295785577;26123;26124.73875261261;26141.346466338113;26166.6075008875;810.440795850861;880.8414485392562;938.4041133879899;949.5821838391086;984.9950750246203;13624.727505449835;14277.516354872098;14483.565493035227;14485.493007744679;14643.48747793822;252892;256365;256813;257318;258225;44917.32624010643;44994.77502612466;45063.77468112704;45087.32369014467;45119.77440112778;1161.1349544589166;1198.3277291639517;1203.8916497515265;1210.5944508589546;1214.690253985228;25650;25941.870290648425;26758.59862102109;27499.86250068737;27505.31236719018;37406;37730;37773.62226377701;37795.433068503444;37799.244015118995;176460;177965;178164;178562;178648.10675946536;23326.533469330177;23664;25671.743282566935;27713.168604941882;28050.859745701142;33036.50445243371;33360.1659958503;35329.646703532635;36236;36536.26927461489;31337.37325253528;31541;31728.524072139397;32073.839630801696;32179.678203217667;24574.385640358418;28984.565231521967;31520.2119946994;31649.525257121622;31953.520697189095;29301.41397172087;29493.705062949095;29507.262318442212;29513.557296640138;29540.704592953796;24994.625080623442;26472.602910955964;26787.732122678524;26885.86557067202;27056;20915.37253882386;21664.37517186186;22784.886075569517;22855.428614284778;23078.653820192376 09:21:04 INFO - 2015-11-24 09:21:04,685 DEBUG : BROWSER_OUTPUT: |2;jquery.html;332.44979558830147;334.2679531825302;334.9480830471278;337.0142333674004;338.19172178493403;12416.130870839044;12805.423755930982;14817.110973341594;15266.160361180131;15917.76123358149;10142.290039697205;10465.58137674494;10917;15335.616609584766;15370.769438458432;4549.4768101668315;4665.370175026362;4665.83669571565;4668.159731248374;4669.463011753658;3401.1667141550356;3487.0584942065625;4888.608911287089;5049.242613607951;5227.79088836446;5093.770780314876;5140.151874940649;5147.150720131174;5208.635395522315;5214.765335559909;5070.08738427083;5158.40678321994;5574.163875418679;5598.944010559903;5603.7478313475995;5000.249962505617;5002.799888004475;5005.774740136702;5006.974965125188;5007.549320561167;12098.637040888787;16747.413840515645;18478.815211847977;19204;19229;1737.4787563730831;1740.103846519031;1751.5621094726318;1755.5052685095695;1782.269269599471;8931;9014.639414423415;9160.450372977642;9258.305627077929;9414.058594140599;1549.1170033081148;1648.546649671338;1656.1719140429784;1656.6355401811581;1664.650423411073;54440.18339724907;55536.72231638816;57259.71370143206;57735.711321443545;57908.420915790724;9765.218782497524;9810.607575696893;9825.459599722084;9843.655472058443;9877.654282100235;12651.114421990556;12657.746845063048;12676.429560669792;12684.23894566329;12689.428975696115;6846.554973926679;6846.828829279209;6963.61700106499;6981.685824137926;7102.1889418198025;6643.236027856762;6684.665766711742;6694.564853284618;6713.328667133345;6739.326067393222;4122.40225167355;4145.398917156996;4146.1914926589625;4173.9582604174175;4186.267403204427;1570.4267942201013;1634.3054201964117;1641.0645931818988;1663.7254852949127;1738.982610173882;831.7629475599546;850.0437008365589;881.8236352729351;889.1997202517786;917.3349321741684;15542.222888855513;15882.285297161425;16095;16134.193290335672;16196.676066478605;732.4177279063158;762.6491813765618;781.3280578702312;825.7398919340509;921.6543796076471;8205.179482051746;8375.664973400995;8513.702020429255;8630.827383452295;8867.024627290994;456059;463136;466631;472204;482043;67716.6614166926;68804;69052;69164.6541767298;70343.94484082743;1051.805415998043;1068.5672302717412;1079.4279032112993;1086.245059683528;1086.3590481615884;8820.514871681862;9542.85685714701;9696.466694331879;9784.853227201455;13787.172769633855;29625.111246662636;30577.694223058374;31913.202169945936;32590.348193035534;33077.50383744294;42898.78550607352;43101.56898430976;43784.78107609441;44020.71751389854;44118.11763764771;13666.11170273929;13957.511487097903;14005.719885602435;14104.29478526049;14187.432502699776;17022.74465882988;17055;17445.651086977934;17546.38587649426;17602.29590816353;14323.57029289123;14438.783418248944;14798.6300342488;14857.257137143315;14865.925670371578;8902.198802107841;9131.086891310815;9208.079192080739;9226.40028398152;9310.581023853807;7845.529268243924;8557.828843422973;9406.95296523513;9495.572699228413;9628;11084.113270938144;12397.380130993233;12761.61715148547;12928.224306541637;13417.262050587311;14048.438062477795;14113.788293175405;14310.85689143137;14529.85470145285;14567.198804065454 09:21:04 INFO - 2015-11-24 09:21:04,686 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1177.8527684039495;1542.6220575958891;1602.1588665950374;1602.7836242107317;1641.7619445180458;5837.532997360212;6236.812895613133;6304.180456540649;6475.320091390407;6547.8363040924005;6766.391024807766;6786.7285308587725;6834.692438840251;6841.863162736742;6848;2039.4595432210476;2061.8247448966854;2062.7730949595534;2064.3600483849978;2064.5354795171042;2033.6339458897392;2040.1941233212872;2044.1516770540209;2073.9896300518476;2077.750669919612;2008.14653772147;2031.7663468701066;2047;2049.385184444661;2050.589882023594;2031.8577699561038;2043.1214577731569;2045.795420457957;2048;2048.94877628059;2042.3974927396453;2055.640262953977;2075.439631299556;2077.241806740544;2078.023329035351;5797.36229014808;6782.355676210752;6838.863222735567;6848.897266541006;6851.828704282383;3360.1767566946255;3982.123932734794;4033.5361433434946;4042.353223484258;4047.352423612208;2615.4115324052127;2615.7253488383635;2662.254568720761;2666.4533770576986;2674.8395096294284;874.1477059866643;910.7950711089952;915.7619019055094;927.1423932862076;940.5767404667859;8903.599338029804;8958.86561701575;8963.68627098055;8973.371863969525;8981.506017169053;3703.500027496307;3745.6441638044344;3758.1356288053903;3806.2958352704286;3915.2169566086327;7800.180980996914;7888.921110788819;7891.684332626631;7896.289333959971;7943.364530837519;4047.291723948297;4070.2266569351727;4071.89820254496;4074.1851629674184;4076.164386300801;3674.9632503675157;3707.796071216109;3710.1466662667735;3714.201446688975;3715.238376132886;3063.7242648161773;3079.0916679579577;3085.1515833146063;3104.7050530200045;3107.4872646013605;1029.1406675426103;1033;1034.9379037257638;1035.1253191053547;1039.6735862278122;787.0751866556773;797.5812698333422;797.8484088023373;798.2017982017982;933.6965486217007;6414.909465390895;6438.25960014595;6441.64570948593;6443.838904027343;6447.677616119176;417.81616088920777;427.8652224549257;430.0302817147375;430.03886314087987;432.6949500602068;4827.686200396963;5092.9745351273;5139.383274007143;5146.1766117421785;5154.123798954187;7400.703971841173;7912.09010963735;8004.51972881629;8051.718189863327;8114.188581141957;8057.435979481497;8063.072746634095;8091.1504292048485;8101.756947291591;8103.554304513308;6281.7173227204885;6413.134226879311;6469.838254043592;6473.579217350857;6479.481641468671;6281.497480201481;6295.968520157553;6298.433141017331;6303.338149494421;6307.463865571294;7155.391791697764;7373.889391659022;7471.514351567131;7476;7487.812804679927;7351.338379545867;7453.962730186315;7571.46999710037;7572.053493313336;7697.422693297913;5922.2597175353085;5941.9405805943115;5994.430529099728;5998.310194327533;6080.48315893154;6241.625502469867;6567.9671601641685;6573.211214654272;6586.901196481961;6591.769288074895;6052.848678783065;6065.302490213682;6150.261968563622;6152.230971128609;6187.226596675416;6045.667488288186;6124.234470691164;6185.536084793748;6200.348963358782;6204.5036397089025;6002.699865006645;6040.063790112539;6040.214772079602;6043.305019922589;6047.727852246571;5646.209530665792;5671.773129074791;5688.089905615082;5692.857678558069;5694.345150307768;5811;5839.912401314069;5844.795432159854;5845.1232315153065;5964.075568286922 09:21:04 INFO - 2015-11-24 09:21:04,688 DEBUG : BROWSER_OUTPUT: |4;prototype.html;303.8754110814566;312.19609505523283;312.68731268731267;313.800736532302;314.53134829104613;5268.288781014567;5291.312129423174;5392.91910621341;5410.323709536308;5428.647137936031;5338.893222135564;5348.277982472365;5348.679079255247;5350.197470379445;5358.410574836765;3960.5049368828895;4041.818118184674;4223.345381465878;4225.936610950838;4230.492340919079;4059.9797001014954;4063.3904914262803;4195.328747400416;4205.243056249874;4217.6625869930485;4150;4157.563455837124;4157.5634558371385;4173.227952828721;4179.916401671965;3935.74417662851;4013.177298653769;4175.519815221242;4185.97907010466;4192.601702838226;3626.4016437287814;3691.7600355976774;3701.1487357907563;3703.3889408247605;3709.6104908984707;5114.514121158484;5128.025675121752;5128.435872054109;5130.640855140142;5133.512316329943;4798.976005119987;4805.567498925114;4814.542618451242;4822.397200349957;4832.420109586872;5426.077566813651;5595.944040559583;5638.295213098363;5642.153676948449;5649.802256920988;3903.882883513471;3908.8436462541463;3909.2376986487648;3913.549941756706;3918.294706952747;5864.560157988125;5954.49386802118;5966.134910438005;5970.164177015221;5972;4197.664186865043;4205.810738516774;4207.936880946788;4209.1792100540715;4215.325547912319;4181.623653871166;4248.383984322256;4275.3800698898485;4278.465191851019;4283.5502272260965;4810.927836082462;4819.397575303087;4823.589994850407;4826.276058591239;4826.61387089032;5652.378238393773;5653.886922261532;5661.603687741818;5665.886682266331;5671.149327600893;1498.2059508460534;1510.0260332085963;1512.138081293674;1514.8560886715745;1514.9015314004555;1029.5572903651353;1044.1385856668278;1045.231754660324;1049.296971029397;1080.303204433152;4948.876278093005;4957.479464656231;4969.105560998983;4974.353334066548;4974.651774375831;5729.512991395778;5741.88516229673;5752.913706294409;5758.856028599234;5761.107028410603;4932.161532539477;4944.678595891256;4947.678400904002;4954.504549545017;4968.279599458058;3079.5996520452645;3089.6137982752157;3135.1378370948173;3164.2722173900133;3187.282861356223;5638.887222255532;5646;5652.66084034951;5654.85862853432;5655.717214139277;6087.208662873887;6102.938970610237;6111.8472038198515;6118.20463339763;6130.233720784902;5526.392096869422;5643.181738647873;5651.124075768263;5651.547876169897;5653.095504719307;5920.555958303231;5923.703814809156;5931.406859314034;5935.881282374415;5941.881162376641;5802.535797136304;5805.129230615442;5806.622569532967;5808.041673123887;5808.970955145197;5607.467290607386;5615.045442274742;5618.101103823368;5627.155926611041;5636.746346414503;3931.5478719947573;3975.204959008152;4013.15723698015;4045.2920738869993;4056.269871423172;5797.884042319214;5836.978528757366;5851.561132914963;5867;5868.09044598088;5632.887342253214;5645.9153112702525;5651.773929042956;5653.575981801299;5656.943430565641;5427.457254274541;5512.310961129859;5520.834374968757;5531.806386776604;5559.694216818114;5456.781728730806;5458.61789674719;5513.3108361454815;5540.501354877919;5548.056830338772;5436.510714035756;5611.298587676541;5682.460166284196;5690.3456102548735;5691.715414229189;5351.491608297206;5485.067538518381;5503.972480137573;5540.63985840919;5545.140503222007 09:21:04 INFO - 2015-11-24 09:21:04,689 DEBUG : BROWSER_OUTPUT: |5;yui.html;669.7856685860527;687.9380855722981;755.3579457461159;774.6514068669101;785.1167436633789;10696.893031069687;10729.141668666507;10778.892211077888;10794.622188223404;10797.190210734207;9515.096065873748;9649.614015439374;10078;10287.0741633253;10396.48017599119;727.1891840597722;748.9176190619028;751.7744676596999;751.8609057324412;751.9172890981988;728.9671964761571;743.2010588617231;743.7322563877;746.828229507211;747.1855677311729;760.6843160088584;774.3263360876045;776.8368642585064;777.0093131257635;777.0791611939841;753.773867839646;761.6572542355907;762.0284137724391;762.6034462079688;770.6339488742858;556.7272036702027;560.1653536231028;566.5665765689251;570.6804189653807;570.974306156224;7937.603119843985;7999;8030.277275045216;8050.355971522265;8069.193080691943;8365.24712775847;9263.25893928484;9427.292953028551;9755.219582433388;10102.494875256209;8122.634481448349;8128.105908350077;8144.389170812213;8190.140035296267;8261.17388261175;2295.1966811615966;2372.383180373098;2380.809535237177;2406.651035599828;2413.143334116381;33425.49861752051;37793.24413511742;39207.803960980295;39342.60657393447;39778.403323950166;9260.259179265642;9515.666951656658;9547.331686781998;9632.181264592447;9729.221662267002;15251.542453726406;15283.770743438858;15290.694186116438;15296.235188240544;15302.311395986984;6078.179445774764;6169.629822210682;6290.716917738621;6376.872462550723;6515.641639709766;3468.739844511672;3504.842282097312;3539.823008849547;3565.073080998959;3572.8749493767596;2678.4776968490955;2695.3396417877743;2697.9730202698115;2702.0542810016336;2703.2160673404887;465.206822367862;467.7778055423715;470.11618157863;470.4448750474473;477.45093142885264;432.4614512809764;445.94871589766944;448.0344856833464;455.3920516111029;511.54216975806446;6832.0776695146515;6892.379685828199;6915.377616014583;6987.89518157228;7012.228654847962;386.947762052125;475.995240047602;480.97595120243847;489.92651102334935;499.8825276060123;3194.2493514024186;3225.2904361040532;3249.2526718854797;3313.8343082846245;3360.3951288767767;46532.302015469795;47626.76186619045;47632.7618361906;47974.28038579424;48652;43489.78255108704;43915;43987.4810015198;44015.11969760587;44056.11887762227;34668;38460.23079538393;38725.80637096853;39481.60518394837;39639;7403.407727381904;7506.962465187639;7517.962410187914;7592.316691497792;7682.807929801576;31875.84062079675;32351.514727278638;32567.674323256466;32578.83710581432;32719;38578;39860.00349991273;40254.798726006185;40261;41102.79448602738;8925.107489251282;9010.86483702758;9224.861627075734;9401.81196376055;9567.473788941397;9530.714078577654;9719.562619682272;9772.12050915421;9903.45530995802;9974.60101595928;10102.747431314276;10179.643712470028;10181.236407269336;10191.286609937233;10204;10042.69871903844;10060.49697515136;10164.491775411348;10231.48842557884;10351.63769268072;9830.705078847646;9890.406575605486;9929;9967.800643987224;9980.650677226262;8416.242538171595;8511.574421278787;8512.106228845882;8594.527300998505;8655.69705060345;7568.697252109854;7673.386129109769;7926.269121699801;7996.20037996219;8645.308375330083 09:21:04 INFO - 2015-11-24 09:21:04,689 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:21:04 INFO - 2015-11-24 09:21:04,690 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:21:04 INFO - 2015-11-24 09:21:04,690 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1036 09:21:04 INFO - 2015-11-24 09:21:04,690 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:21:04 INFO - 2015-11-24 09:21:04,690 DEBUG : BROWSER_OUTPUT: __startTimestamp1448385664676__endTimestamp 09:21:04 INFO - 2015-11-24 09:21:04,690 DEBUG : BROWSER_OUTPUT: 09:21:04 INFO - 2015-11-24 09:21:04,690 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:21:04 INFO - 2015-11-24 09:21:04,690 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:21:04 INFO - 2015-11-24 09:21:04,690 DEBUG : BROWSER_OUTPUT: 09:21:04 INFO - 2015-11-24 09:21:04,690 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4596.94 Median:4751.60 stddev:491.15 (10.3%) stddev-sans-first:466.39 09:21:04 INFO - 2015-11-24 09:21:04,692 DEBUG : BROWSER_OUTPUT: Values: 2576.8 2617.1 2626.6 2633.4 2646.5 4516.0 4523.4 4555.7 4643.7 4653.0 4575.6 4597.0 4646.7 4653.3 4672.0 4279.1 4352.2 4367.8 4369.3 4403.7 4188.5 4405.3 4421.1 4452.8 4470.2 4264.4 4288.8 4306.1 4340.0 4369.2 4329.2 4330.2 4335.2 4336.5 4367.8 4307.1 4307.4 4313.8 4346.2 4356.8 4490.2 4566.7 4657.8 4658.6 4666.6 4995.7 5010.4 5018.9 5019.5 5059.3 5032.2 5035.1 5037.7 5041.2 5044.2 4437.6 4527.2 4538.9 4634.4 4751.6 5128.1 5153.5 5153.9 5173.8 5195.8 4962.3 4967.0 4972.6 5012.7 5021.3 4817.9 4922.2 4942.6 4944.1 4975.6 4921.6 4933.2 4936.1 4942.7 4991.4 4909.4 4911.0 4914.7 4915.6 4958.3 4003.3 4071.6 4107.5 4110.8 4113.4 3529.5 3593.6 3626.3 3628.0 3628.0 4197.8 4249.6 4254.0 4303.1 4306.5 4934.7 4936.7 4937.9 4946.4 4989.7 4245.5 4248.2 4248.9 4249.0 4284.3 4244.4 4294.3 4345.1 4352.0 4396.7 4760.0 4766.0 4768.1 4769.1 4815.1 4957.6 5036.7 5043.4 5043.5 5046.5 4552.3 4658.5 4659.9 4662.6 4805.1 4815.2 4883.3 4893.1 4929.4 4931.2 4970.6 4973.9 4980.4 4982.2 5024.4 4686.3 4800.5 4825.5 4827.8 4882.6 4768.8 4797.6 4886.0 4889.2 4929.5 4798.5 4808.0 4820.0 4834.2 4862.4 4766.2 4869.9 4963.9 4972.7 4999.0 4700.6 4722.5 4751.5 4778.7 4802.1 09:21:04 INFO - 2015-11-24 09:21:04,692 DEBUG : BROWSER_OUTPUT: 09:21:04 INFO - 2015-11-24 09:21:04,692 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:36637.17 Median:29510.41 stddev:55531.91 (188.2%) stddev-sans-first:55621.62 09:21:04 INFO - 2015-11-24 09:21:04,692 DEBUG : BROWSER_OUTPUT: Values: 561.6 567.9 568.4 575.4 576.6 27674.9 28205.6 28342.0 28579.6 28582.6 28438.7 36961.6 37860.8 37879.0 37922.4 7876.4 8018.2 8023.1 8023.3 8029.9 7051.4 7245.9 7750.3 7862.1 7863.4 7054.8 7157.6 7158.5 10024.9 10302.5 9853.3 9983.8 9993.6 9998.5 10001.9 9835.5 9988.7 9996.1 10007.4 10011.2 28654.0 29122.7 39913.2 40750.4 40940.4 2619.2 2670.6 2904.6 3118.7 3141.9 26532.5 26542.0 26666.2 26970.5 27158.7 3251.8 3312.3 3343.7 3377.5 3403.2 198747.0 198918.0 199163.0 199428.0 199591.0 50744.0 51088.0 51185.5 51330.0 51415.2 53723.0 54309.5 54310.0 54336.5 54475.7 13641.4 13641.6 13711.7 13814.0 13858.4 10895.9 10949.7 10977.5 10981.4 10995.6 17548.2 17774.4 17839.6 17898.6 18050.0 6858.6 7284.7 7320.9 7352.7 7392.0 770.0 828.9 865.6 869.8 890.2 25713.6 26123.0 26124.7 26141.3 26166.6 810.4 880.8 938.4 949.6 985.0 13624.7 14277.5 14483.6 14485.5 14643.5 252892.0 256365.0 256813.0 257318.0 258225.0 44917.3 44994.8 45063.8 45087.3 45119.8 1161.1 1198.3 1203.9 1210.6 1214.7 25650.0 25941.9 26758.6 27499.9 27505.3 37406.0 37730.0 37773.6 37795.4 37799.2 176460.0 177965.0 178164.0 178562.0 178648.1 23326.5 23664.0 25671.7 27713.2 28050.9 33036.5 33360.2 35329.6 36236.0 36536.3 31337.4 31541.0 31728.5 32073.8 32179.7 24574.4 28984.6 31520.2 31649.5 31953.5 29301.4 29493.7 29507.3 29513.6 29540.7 24994.6 26472.6 26787.7 26885.9 27056.0 20915.4 21664.4 22784.9 22855.4 23078.7 09:21:04 INFO - 2015-11-24 09:21:04,693 DEBUG : BROWSER_OUTPUT: 09:21:04 INFO - 2015-11-24 09:21:04,693 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25570.93 Median:43902.75 stddev:76473.70 (174.2%) stddev-sans-first:76664.75 09:21:04 INFO - 2015-11-24 09:21:04,693 DEBUG : BROWSER_OUTPUT: Values: 332.4 334.3 334.9 337.0 338.2 12416.1 12805.4 14817.1 15266.2 15917.8 10142.3 10465.6 10917.0 15335.6 15370.8 4549.5 4665.4 4665.8 4668.2 4669.5 3401.2 3487.1 4888.6 5049.2 5227.8 5093.8 5140.2 5147.2 5208.6 5214.8 5070.1 5158.4 5574.2 5598.9 5603.7 5000.2 5002.8 5005.8 5007.0 5007.5 12098.6 16747.4 18478.8 19204.0 19229.0 1737.5 1740.1 1751.6 1755.5 1782.3 8931.0 9014.6 9160.5 9258.3 9414.1 1549.1 1648.5 1656.2 1656.6 1664.7 54440.2 55536.7 57259.7 57735.7 57908.4 9765.2 9810.6 9825.5 9843.7 9877.7 12651.1 12657.7 12676.4 12684.2 12689.4 6846.6 6846.8 6963.6 6981.7 7102.2 6643.2 6684.7 6694.6 6713.3 6739.3 4122.4 4145.4 4146.2 4174.0 4186.3 1570.4 1634.3 1641.1 1663.7 1739.0 831.8 850.0 881.8 889.2 917.3 15542.2 15882.3 16095.0 16134.2 16196.7 732.4 762.6 781.3 825.7 921.7 8205.2 8375.7 8513.7 8630.8 8867.0 456059.0 463136.0 466631.0 472204.0 482043.0 67716.7 68804.0 69052.0 69164.7 70343.9 1051.8 1068.6 1079.4 1086.2 1086.4 8820.5 9542.9 9696.5 9784.9 13787.2 29625.1 30577.7 31913.2 32590.3 33077.5 42898.8 43101.6 43784.8 44020.7 44118.1 13666.1 13957.5 14005.7 14104.3 14187.4 17022.7 17055.0 17445.7 17546.4 17602.3 14323.6 14438.8 14798.6 14857.3 14865.9 8902.2 9131.1 9208.1 9226.4 9310.6 7845.5 8557.8 9407.0 9495.6 9628.0 11084.1 12397.4 12761.6 12928.2 13417.3 14048.4 14113.8 14310.9 14529.9 14567.2 09:21:04 INFO - 2015-11-24 09:21:04,694 DEBUG : BROWSER_OUTPUT: 09:21:04 INFO - 2015-11-24 09:21:04,694 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4727.72 Median:6000.51 stddev:2445.63 (40.8%) stddev-sans-first:2437.94 09:21:04 INFO - 2015-11-24 09:21:04,694 DEBUG : BROWSER_OUTPUT: Values: 1177.9 1542.6 1602.2 1602.8 1641.8 5837.5 6236.8 6304.2 6475.3 6547.8 6766.4 6786.7 6834.7 6841.9 6848.0 2039.5 2061.8 2062.8 2064.4 2064.5 2033.6 2040.2 2044.2 2074.0 2077.8 2008.1 2031.8 2047.0 2049.4 2050.6 2031.9 2043.1 2045.8 2048.0 2048.9 2042.4 2055.6 2075.4 2077.2 2078.0 5797.4 6782.4 6838.9 6848.9 6851.8 3360.2 3982.1 4033.5 4042.4 4047.4 2615.4 2615.7 2662.3 2666.5 2674.8 874.1 910.8 915.8 927.1 940.6 8903.6 8958.9 8963.7 8973.4 8981.5 3703.5 3745.6 3758.1 3806.3 3915.2 7800.2 7888.9 7891.7 7896.3 7943.4 4047.3 4070.2 4071.9 4074.2 4076.2 3675.0 3707.8 3710.1 3714.2 3715.2 3063.7 3079.1 3085.2 3104.7 3107.5 1029.1 1033.0 1034.9 1035.1 1039.7 787.1 797.6 797.8 798.2 933.7 6414.9 6438.3 6441.6 6443.8 6447.7 417.8 427.9 430.0 430.0 432.7 4827.7 5093.0 5139.4 5146.2 5154.1 7400.7 7912.1 8004.5 8051.7 8114.2 8057.4 8063.1 8091.2 8101.8 8103.6 6281.7 6413.1 6469.8 6473.6 6479.5 6281.5 6296.0 6298.4 6303.3 6307.5 7155.4 7373.9 7471.5 7476.0 7487.8 7351.3 7454.0 7571.5 7572.1 7697.4 5922.3 5941.9 5994.4 5998.3 6080.5 6241.6 6568.0 6573.2 6586.9 6591.8 6052.8 6065.3 6150.3 6152.2 6187.2 6045.7 6124.2 6185.5 6200.3 6204.5 6002.7 6040.1 6040.2 6043.3 6047.7 5646.2 5671.8 5688.1 5692.9 5694.3 5811.0 5839.9 5844.8 5845.1 5964.1 09:21:04 INFO - 2015-11-24 09:21:04,694 DEBUG : BROWSER_OUTPUT: 09:21:04 INFO - 2015-11-24 09:21:04,695 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4702.80 Median:5279.80 stddev:1368.17 (25.9%) stddev-sans-first:1331.57 09:21:04 INFO - 2015-11-24 09:21:04,695 DEBUG : BROWSER_OUTPUT: Values: 303.9 312.2 312.7 313.8 314.5 5268.3 5291.3 5392.9 5410.3 5428.6 5338.9 5348.3 5348.7 5350.2 5358.4 3960.5 4041.8 4223.3 4225.9 4230.5 4060.0 4063.4 4195.3 4205.2 4217.7 4150.0 4157.6 4157.6 4173.2 4179.9 3935.7 4013.2 4175.5 4186.0 4192.6 3626.4 3691.8 3701.1 3703.4 3709.6 5114.5 5128.0 5128.4 5130.6 5133.5 4799.0 4805.6 4814.5 4822.4 4832.4 5426.1 5595.9 5638.3 5642.2 5649.8 3903.9 3908.8 3909.2 3913.5 3918.3 5864.6 5954.5 5966.1 5970.2 5972.0 4197.7 4205.8 4207.9 4209.2 4215.3 4181.6 4248.4 4275.4 4278.5 4283.6 4810.9 4819.4 4823.6 4826.3 4826.6 5652.4 5653.9 5661.6 5665.9 5671.1 1498.2 1510.0 1512.1 1514.9 1514.9 1029.6 1044.1 1045.2 1049.3 1080.3 4948.9 4957.5 4969.1 4974.4 4974.7 5729.5 5741.9 5752.9 5758.9 5761.1 4932.2 4944.7 4947.7 4954.5 4968.3 3079.6 3089.6 3135.1 3164.3 3187.3 5638.9 5646.0 5652.7 5654.9 5655.7 6087.2 6102.9 6111.8 6118.2 6130.2 5526.4 5643.2 5651.1 5651.5 5653.1 5920.6 5923.7 5931.4 5935.9 5941.9 5802.5 5805.1 5806.6 5808.0 5809.0 5607.5 5615.0 5618.1 5627.2 5636.7 3931.5 3975.2 4013.2 4045.3 4056.3 5797.9 5837.0 5851.6 5867.0 5868.1 5632.9 5645.9 5651.8 5653.6 5656.9 5427.5 5512.3 5520.8 5531.8 5559.7 5456.8 5458.6 5513.3 5540.5 5548.1 5436.5 5611.3 5682.5 5690.3 5691.7 5351.5 5485.1 5504.0 5540.6 5545.1 09:21:04 INFO - 2015-11-24 09:21:04,695 DEBUG : BROWSER_OUTPUT: 09:21:04 INFO - 2015-11-24 09:21:04,695 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11537.66 Median:563.37 stddev:13508.15 (2397.8%) stddev-sans-first:13521.39 09:21:04 INFO - 2015-11-24 09:21:04,695 DEBUG : BROWSER_OUTPUT: Values: 669.8 687.9 755.4 774.7 785.1 10696.9 10729.1 10778.9 10794.6 10797.2 9515.1 9649.6 10078.0 10287.1 10396.5 727.2 748.9 751.8 751.9 751.9 729.0 743.2 743.7 746.8 747.2 760.7 774.3 776.8 777.0 777.1 753.8 761.7 762.0 762.6 770.6 556.7 560.2 566.6 570.7 571.0 7937.6 7999.0 8030.3 8050.4 8069.2 8365.2 9263.3 9427.3 9755.2 10102.5 8122.6 8128.1 8144.4 8190.1 8261.2 2295.2 2372.4 2380.8 2406.7 2413.1 33425.5 37793.2 39207.8 39342.6 39778.4 9260.3 9515.7 9547.3 9632.2 9729.2 15251.5 15283.8 15290.7 15296.2 15302.3 6078.2 6169.6 6290.7 6376.9 6515.6 3468.7 3504.8 3539.8 3565.1 3572.9 2678.5 2695.3 2698.0 2702.1 2703.2 465.2 467.8 470.1 470.4 477.5 432.5 445.9 448.0 455.4 511.5 6832.1 6892.4 6915.4 6987.9 7012.2 386.9 476.0 481.0 489.9 499.9 3194.2 3225.3 3249.3 3313.8 3360.4 46532.3 47626.8 47632.8 47974.3 48652.0 43489.8 43915.0 43987.5 44015.1 44056.1 34668.0 38460.2 38725.8 39481.6 39639.0 7403.4 7507.0 7518.0 7592.3 7682.8 31875.8 32351.5 32567.7 32578.8 32719.0 38578.0 39860.0 40254.8 40261.0 41102.8 8925.1 9010.9 9224.9 9401.8 9567.5 9530.7 9719.6 9772.1 9903.5 9974.6 10102.7 10179.6 10181.2 10191.3 10204.0 10042.7 10060.5 10164.5 10231.5 10351.6 9830.7 9890.4 9929.0 9967.8 9980.7 8416.2 8511.6 8512.1 8594.5 8655.7 7568.7 7673.4 7926.3 7996.2 8645.3 09:21:04 INFO - 2015-11-24 09:21:04,695 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:21:04 INFO - 2015-11-24 09:21:04,696 DEBUG : BROWSER_OUTPUT: 09:21:05 INFO - 2015-11-24 09:21:05,403 INFO : Browser exited with error code: 0 09:21:05 INFO - 2015-11-24 09:21:05,426 INFO : Completed test dromaeo_css (00:18:39) 09:21:05 INFO - 2015-11-24 09:21:05,426 INFO : Starting test kraken 09:21:05 INFO - 2015-11-24 09:21:05,426 DEBUG : operating with platform_type : linux_ 09:21:05 INFO - 2015-11-24 09:21:05,427 INFO : Initialising browser for kraken test... 09:21:05 INFO - 2015-11-24 09:21:05,433 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWDOB6B/profile http://localhost:44660/getInfo.html 09:21:09 INFO - 2015-11-24 09:21:09,681 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:21:09 INFO - 2015-11-24 09:21:09,681 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:21:09 INFO - 2015-11-24 09:21:09,681 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:21:09 INFO - 2015-11-24 09:21:09,681 DEBUG : BROWSER_OUTPUT: __metrics 09:21:09 INFO - 2015-11-24 09:21:09,838 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:21:11 INFO - 2015-11-24 09:21:11,254 INFO : Browser initialized. 09:21:11 INFO - 2015-11-24 09:21:11,254 INFO : Running cycle 1/1 for kraken test... 09:21:11 INFO - 2015-11-24 09:21:11,254 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWDOB6B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:21:23 INFO - 2015-11-24 09:21:23,201 DEBUG : BROWSER_OUTPUT: RSS: Main: 142000128 09:21:23 INFO - 2015-11-24 09:21:23,201 DEBUG : BROWSER_OUTPUT: 09:21:25 INFO - 2015-11-24 09:21:25,822 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44660/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44660/tests/kraken/driver.html?testName=audio-beat-detection) 09:21:26 INFO - 2015-11-24 09:21:26,412 DEBUG : BROWSER_OUTPUT: RSS: Main: 177070080 09:21:26 INFO - 2015-11-24 09:21:26,412 DEBUG : BROWSER_OUTPUT: 09:21:29 INFO - 2015-11-24 09:21:29,116 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44660/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44660/tests/kraken/driver.html?testName=audio-dft) 09:21:29 INFO - 2015-11-24 09:21:29,688 DEBUG : BROWSER_OUTPUT: RSS: Main: 168275968 09:21:29 INFO - 2015-11-24 09:21:29,689 DEBUG : BROWSER_OUTPUT: 09:21:32 INFO - 2015-11-24 09:21:32,713 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44660/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44660/tests/kraken/driver.html?testName=audio-fft) 09:21:33 INFO - 2015-11-24 09:21:33,282 DEBUG : BROWSER_OUTPUT: RSS: Main: 151236608 09:21:33 INFO - 2015-11-24 09:21:33,282 DEBUG : BROWSER_OUTPUT: 09:21:35 INFO - 2015-11-24 09:21:35,314 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44660/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44660/tests/kraken/driver.html?testName=audio-oscillator) 09:21:35 INFO - 2015-11-24 09:21:35,896 DEBUG : BROWSER_OUTPUT: RSS: Main: 154648576 09:21:35 INFO - 2015-11-24 09:21:35,896 DEBUG : BROWSER_OUTPUT: 09:21:38 INFO - 2015-11-24 09:21:38,142 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44660/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44660/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:21:38 INFO - 2015-11-24 09:21:38,703 DEBUG : BROWSER_OUTPUT: RSS: Main: 155770880 09:21:38 INFO - 2015-11-24 09:21:38,703 DEBUG : BROWSER_OUTPUT: 09:21:41 INFO - 2015-11-24 09:21:41,683 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44660/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44660/tests/kraken/driver.html?testName=imaging-darkroom) 09:21:42 INFO - 2015-11-24 09:21:42,254 DEBUG : BROWSER_OUTPUT: RSS: Main: 156487680 09:21:42 INFO - 2015-11-24 09:21:42,254 DEBUG : BROWSER_OUTPUT: 09:21:45 INFO - 2015-11-24 09:21:45,640 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44660/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44660/tests/kraken/driver.html?testName=imaging-desaturate) 09:21:46 INFO - 2015-11-24 09:21:46,214 DEBUG : BROWSER_OUTPUT: RSS: Main: 157630464 09:21:46 INFO - 2015-11-24 09:21:46,214 DEBUG : BROWSER_OUTPUT: 09:21:49 INFO - 2015-11-24 09:21:49,012 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44660/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44660/tests/kraken/driver.html?testName=json-parse-financial) 09:21:49 INFO - 2015-11-24 09:21:49,581 DEBUG : BROWSER_OUTPUT: RSS: Main: 156844032 09:21:49 INFO - 2015-11-24 09:21:49,581 DEBUG : BROWSER_OUTPUT: 09:21:51 INFO - 2015-11-24 09:21:51,336 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44660/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44660/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:21:51 INFO - 2015-11-24 09:21:51,905 DEBUG : BROWSER_OUTPUT: RSS: Main: 165548032 09:21:51 INFO - 2015-11-24 09:21:51,905 DEBUG : BROWSER_OUTPUT: 09:21:53 INFO - 2015-11-24 09:21:53,775 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44660/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44660/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:21:54 INFO - 2015-11-24 09:21:54,365 DEBUG : BROWSER_OUTPUT: RSS: Main: 165531648 09:21:54 INFO - 2015-11-24 09:21:54,365 DEBUG : BROWSER_OUTPUT: 09:21:56 INFO - 2015-11-24 09:21:56,765 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44660/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44660/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:21:57 INFO - 2015-11-24 09:21:57,346 DEBUG : BROWSER_OUTPUT: RSS: Main: 172544000 09:21:57 INFO - 2015-11-24 09:21:57,346 DEBUG : BROWSER_OUTPUT: 09:21:59 INFO - 2015-11-24 09:21:59,861 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44660/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44660/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:22:00 INFO - 2015-11-24 09:22:00,442 DEBUG : BROWSER_OUTPUT: RSS: Main: 181911552 09:22:00 INFO - 2015-11-24 09:22:00,443 DEBUG : BROWSER_OUTPUT: 09:22:03 INFO - 2015-11-24 09:22:03,045 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44660/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44660/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:22:03 INFO - 2015-11-24 09:22:03,626 DEBUG : BROWSER_OUTPUT: RSS: Main: 180555776 09:22:03 INFO - 2015-11-24 09:22:03,627 DEBUG : BROWSER_OUTPUT: 09:22:05 INFO - 2015-11-24 09:22:05,401 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44660/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44660/tests/kraken/driver.html?testName=ai-astar) 09:22:05 INFO - 2015-11-24 09:22:05,659 DEBUG : BROWSER_OUTPUT: RSS: Main: 240467968 09:22:05 INFO - 2015-11-24 09:22:05,659 DEBUG : BROWSER_OUTPUT: 09:22:05 INFO - 2015-11-24 09:22:05,659 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:22:05 INFO - 2015-11-24 09:22:05,659 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:22:05 INFO - 2015-11-24 09:22:05,659 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:22:05 INFO - 2015-11-24 09:22:05,659 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:22:05 INFO - 2015-11-24 09:22:05,660 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;112;106;112;113;114;103;113;112;106 09:22:05 INFO - 2015-11-24 09:22:05,660 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;129;156;170;142;161;151;130;166;131 09:22:05 INFO - 2015-11-24 09:22:05,660 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;161;160;160;160;164;163;163;162 09:22:05 INFO - 2015-11-24 09:22:05,660 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;72;87;100;72;71;72;100;89;71 09:22:05 INFO - 2015-11-24 09:22:05,660 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;130;94;94;94;138;94;95;134 09:22:05 INFO - 2015-11-24 09:22:05,660 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;109;110;110;110;109;110 09:22:05 INFO - 2015-11-24 09:22:05,660 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;146;147;146;146;146;146;147;146 09:22:05 INFO - 2015-11-24 09:22:05,660 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;96;95;95;96;95;95;95 09:22:05 INFO - 2015-11-24 09:22:05,660 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;72;72;72;71;71;72;72;69;68 09:22:05 INFO - 2015-11-24 09:22:05,660 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;67;68;68;69;68;68;69;69;69 09:22:05 INFO - 2015-11-24 09:22:05,661 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;84;83;87;83;84;82;82;82;83 09:22:05 INFO - 2015-11-24 09:22:05,661 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;120;120;119;130;122;121;121;120;129 09:22:05 INFO - 2015-11-24 09:22:05,661 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;147;147;144;153;151;136;148;152;144;136 09:22:05 INFO - 2015-11-24 09:22:05,661 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;70;68;69;73;69;68;69;69;68 09:22:05 INFO - 2015-11-24 09:22:05,661 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:22:05 INFO - 2015-11-24 09:22:05,661 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:22:05 INFO - 2015-11-24 09:22:05,661 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,966 09:22:05 INFO - 2015-11-24 09:22:05,661 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:22:05 INFO - 2015-11-24 09:22:05,661 DEBUG : BROWSER_OUTPUT: __startTimestamp1448385725653__endTimestamp 09:22:05 INFO - 2015-11-24 09:22:05,662 DEBUG : BROWSER_OUTPUT: 09:22:05 INFO - 2015-11-24 09:22:05,662 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:22:05 INFO - 2015-11-24 09:22:05,662 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:22:05 INFO - 2015-11-24 09:22:05,662 DEBUG : BROWSER_OUTPUT: 09:22:05 INFO - 2015-11-24 09:22:05,662 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.30 Median:112.00 stddev:3.80 (3.4%) stddev-sans-first:3.98 09:22:05 INFO - 2015-11-24 09:22:05,662 DEBUG : BROWSER_OUTPUT: Values: 112.0 112.0 106.0 112.0 113.0 114.0 103.0 113.0 112.0 106.0 09:22:05 INFO - 2015-11-24 09:22:05,663 DEBUG : BROWSER_OUTPUT: 09:22:05 INFO - 2015-11-24 09:22:05,663 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.90 Median:154.50 stddev:15.19 (9.8%) stddev-sans-first:16.04 09:22:05 INFO - 2015-11-24 09:22:05,663 DEBUG : BROWSER_OUTPUT: Values: 153.0 129.0 156.0 170.0 142.0 161.0 151.0 130.0 166.0 131.0 09:22:05 INFO - 2015-11-24 09:22:05,663 DEBUG : BROWSER_OUTPUT: 09:22:05 INFO - 2015-11-24 09:22:05,663 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.51 (0.9%) stddev-sans-first:1.59 09:22:05 INFO - 2015-11-24 09:22:05,663 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 161.0 160.0 160.0 160.0 164.0 163.0 163.0 162.0 09:22:05 INFO - 2015-11-24 09:22:05,664 DEBUG : BROWSER_OUTPUT: 09:22:05 INFO - 2015-11-24 09:22:05,665 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.50 Median:72.00 stddev:12.30 (17.1%) stddev-sans-first:12.56 09:22:05 INFO - 2015-11-24 09:22:05,665 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 87.0 100.0 72.0 71.0 72.0 100.0 89.0 71.0 09:22:05 INFO - 2015-11-24 09:22:05,665 DEBUG : BROWSER_OUTPUT: 09:22:05 INFO - 2015-11-24 09:22:05,665 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.10 Median:94.00 stddev:19.35 (20.6%) stddev-sans-first:20.02 09:22:05 INFO - 2015-11-24 09:22:05,665 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 130.0 94.0 94.0 94.0 138.0 94.0 95.0 134.0 09:22:05 INFO - 2015-11-24 09:22:05,665 DEBUG : BROWSER_OUTPUT: 09:22:05 INFO - 2015-11-24 09:22:05,666 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:22:05 INFO - 2015-11-24 09:22:05,666 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 109.0 110.0 110.0 110.0 109.0 110.0 09:22:05 INFO - 2015-11-24 09:22:05,666 DEBUG : BROWSER_OUTPUT: 09:22:05 INFO - 2015-11-24 09:22:05,666 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 09:22:05 INFO - 2015-11-24 09:22:05,666 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 147.0 146.0 09:22:05 INFO - 2015-11-24 09:22:05,666 DEBUG : BROWSER_OUTPUT: 09:22:05 INFO - 2015-11-24 09:22:05,667 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 09:22:05 INFO - 2015-11-24 09:22:05,667 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 96.0 95.0 95.0 96.0 95.0 95.0 95.0 09:22:05 INFO - 2015-11-24 09:22:05,667 DEBUG : BROWSER_OUTPUT: 09:22:05 INFO - 2015-11-24 09:22:05,667 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.00 Median:72.00 stddev:1.41 (2.0%) stddev-sans-first:1.50 09:22:05 INFO - 2015-11-24 09:22:05,667 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 72.0 72.0 71.0 71.0 72.0 72.0 69.0 68.0 09:22:05 INFO - 2015-11-24 09:22:05,667 DEBUG : BROWSER_OUTPUT: 09:22:05 INFO - 2015-11-24 09:22:05,667 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.50 stddev:0.67 (1.0%) stddev-sans-first:0.71 09:22:05 INFO - 2015-11-24 09:22:05,667 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 68.0 68.0 69.0 68.0 68.0 69.0 69.0 69.0 09:22:05 INFO - 2015-11-24 09:22:05,668 DEBUG : BROWSER_OUTPUT: 09:22:05 INFO - 2015-11-24 09:22:05,668 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:83.00 stddev:1.66 (2.0%) stddev-sans-first:1.58 09:22:05 INFO - 2015-11-24 09:22:05,668 DEBUG : BROWSER_OUTPUT: Values: 81.0 84.0 83.0 87.0 83.0 84.0 82.0 82.0 82.0 83.0 09:22:05 INFO - 2015-11-24 09:22:05,668 DEBUG : BROWSER_OUTPUT: 09:22:05 INFO - 2015-11-24 09:22:05,668 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.00 Median:121.50 stddev:4.24 (3.5%) stddev-sans-first:4.10 09:22:05 INFO - 2015-11-24 09:22:05,668 DEBUG : BROWSER_OUTPUT: Values: 128.0 120.0 120.0 119.0 130.0 122.0 121.0 121.0 120.0 129.0 09:22:05 INFO - 2015-11-24 09:22:05,668 DEBUG : BROWSER_OUTPUT: 09:22:05 INFO - 2015-11-24 09:22:05,669 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.80 Median:147.50 stddev:6.00 (4.1%) stddev-sans-first:6.34 09:22:05 INFO - 2015-11-24 09:22:05,669 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 144.0 153.0 151.0 136.0 148.0 152.0 144.0 136.0 09:22:05 INFO - 2015-11-24 09:22:05,669 DEBUG : BROWSER_OUTPUT: 09:22:05 INFO - 2015-11-24 09:22:05,669 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.00 stddev:1.52 (2.2%) stddev-sans-first:1.56 09:22:05 INFO - 2015-11-24 09:22:05,669 DEBUG : BROWSER_OUTPUT: Values: 68.0 70.0 68.0 69.0 73.0 69.0 68.0 69.0 69.0 68.0 09:22:05 INFO - 2015-11-24 09:22:05,669 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:22:05 INFO - 2015-11-24 09:22:05,669 DEBUG : BROWSER_OUTPUT: 09:22:06 INFO - 2015-11-24 09:22:06,607 INFO : Browser exited with error code: 0 09:22:06 INFO - 2015-11-24 09:22:06,656 INFO : Completed test kraken (00:01:01) 09:22:06 INFO - 2015-11-24 09:22:06,656 INFO : Starting test v8_7 09:22:06 INFO - 2015-11-24 09:22:06,656 DEBUG : operating with platform_type : linux_ 09:22:06 INFO - 2015-11-24 09:22:06,656 INFO : Initialising browser for v8_7 test... 09:22:06 INFO - 2015-11-24 09:22:06,662 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVUf_kH/profile http://localhost:44660/getInfo.html 09:22:11 INFO - 2015-11-24 09:22:11,083 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:22:11 INFO - 2015-11-24 09:22:11,083 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:22:11 INFO - 2015-11-24 09:22:11,084 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:22:11 INFO - 2015-11-24 09:22:11,084 DEBUG : BROWSER_OUTPUT: __metrics 09:22:11 INFO - 2015-11-24 09:22:11,180 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:22:12 INFO - 2015-11-24 09:22:12,674 INFO : Browser initialized. 09:22:12 INFO - 2015-11-24 09:22:12,675 INFO : Running cycle 1/1 for v8_7 test... 09:22:12 INFO - 2015-11-24 09:22:12,675 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVUf_kH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:22:24 INFO - 2015-11-24 09:22:24,615 DEBUG : BROWSER_OUTPUT: RSS: Main: 142348288 09:22:24 INFO - 2015-11-24 09:22:24,615 DEBUG : BROWSER_OUTPUT: 09:22:46 INFO - 2015-11-24 09:22:46,094 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44660/tests/v8_7/run.html (next: http://localhost:44660/tests/v8_7/run.html) 09:22:46 INFO - 2015-11-24 09:22:46,344 DEBUG : BROWSER_OUTPUT: RSS: Main: 439726080 09:22:46 INFO - 2015-11-24 09:22:46,344 DEBUG : BROWSER_OUTPUT: 09:22:46 INFO - 2015-11-24 09:22:46,346 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:22:46 INFO - 2015-11-24 09:22:46,346 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:22:46 INFO - 2015-11-24 09:22:46,346 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:22:46 INFO - 2015-11-24 09:22:46,346 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:22:46 INFO - 2015-11-24 09:22:46,346 DEBUG : BROWSER_OUTPUT: |0;Richards;189.82536066818528 09:22:46 INFO - 2015-11-24 09:22:46,346 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;184.84288354898337 09:22:46 INFO - 2015-11-24 09:22:46,346 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.3296089385475 09:22:46 INFO - 2015-11-24 09:22:46,347 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5000 09:22:46 INFO - 2015-11-24 09:22:46,347 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1980.1980198019803 09:22:46 INFO - 2015-11-24 09:22:46,347 DEBUG : BROWSER_OUTPUT: |5;Earley;779.423226812159 09:22:46 INFO - 2015-11-24 09:22:46,347 DEBUG : BROWSER_OUTPUT: |6;Boyer;11976.190476190477 09:22:46 INFO - 2015-11-24 09:22:46,347 DEBUG : BROWSER_OUTPUT: |7;RegExp;26368.42105263158 09:22:46 INFO - 2015-11-24 09:22:46,347 DEBUG : BROWSER_OUTPUT: |8;Splay;597.5103734439834 09:22:46 INFO - 2015-11-24 09:22:46,347 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 09:22:46 INFO - 2015-11-24 09:22:46,347 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:22:46 INFO - 2015-11-24 09:22:46,348 DEBUG : BROWSER_OUTPUT: __startTimestamp1448385766345__endTimestamp 09:22:46 INFO - 2015-11-24 09:22:46,348 DEBUG : BROWSER_OUTPUT: 09:22:46 INFO - 2015-11-24 09:22:46,348 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:22:46 INFO - 2015-11-24 09:22:46,348 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:22:46 INFO - 2015-11-24 09:22:46,348 DEBUG : BROWSER_OUTPUT: 09:22:46 INFO - 2015-11-24 09:22:46,349 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:189.83 Median:189.83 stddev:0.00 (0.0%) 09:22:46 INFO - 2015-11-24 09:22:46,350 DEBUG : BROWSER_OUTPUT: Values: 189.8 09:22:46 INFO - 2015-11-24 09:22:46,350 DEBUG : BROWSER_OUTPUT: 09:22:46 INFO - 2015-11-24 09:22:46,350 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:184.84 Median:184.84 stddev:0.00 (0.0%) 09:22:46 INFO - 2015-11-24 09:22:46,350 DEBUG : BROWSER_OUTPUT: Values: 184.8 09:22:46 INFO - 2015-11-24 09:22:46,351 DEBUG : BROWSER_OUTPUT: 09:22:46 INFO - 2015-11-24 09:22:46,351 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.33 Median:279.33 stddev:0.00 (0.0%) 09:22:46 INFO - 2015-11-24 09:22:46,351 DEBUG : BROWSER_OUTPUT: Values: 279.3 09:22:46 INFO - 2015-11-24 09:22:46,351 DEBUG : BROWSER_OUTPUT: 09:22:46 INFO - 2015-11-24 09:22:46,351 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5000.00 Median:5000.00 stddev:0.00 (0.0%) 09:22:46 INFO - 2015-11-24 09:22:46,351 DEBUG : BROWSER_OUTPUT: Values: 5000.0 09:22:46 INFO - 2015-11-24 09:22:46,351 DEBUG : BROWSER_OUTPUT: 09:22:46 INFO - 2015-11-24 09:22:46,351 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1980.20 Median:1980.20 stddev:0.00 (0.0%) 09:22:46 INFO - 2015-11-24 09:22:46,351 DEBUG : BROWSER_OUTPUT: Values: 1980.2 09:22:46 INFO - 2015-11-24 09:22:46,351 DEBUG : BROWSER_OUTPUT: 09:22:46 INFO - 2015-11-24 09:22:46,351 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:779.42 Median:779.42 stddev:0.00 (0.0%) 09:22:46 INFO - 2015-11-24 09:22:46,351 DEBUG : BROWSER_OUTPUT: Values: 779.4 09:22:46 INFO - 2015-11-24 09:22:46,351 DEBUG : BROWSER_OUTPUT: 09:22:46 INFO - 2015-11-24 09:22:46,351 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11976.19 Median:11976.19 stddev:0.00 (0.0%) 09:22:46 INFO - 2015-11-24 09:22:46,351 DEBUG : BROWSER_OUTPUT: Values: 11976.2 09:22:46 INFO - 2015-11-24 09:22:46,351 DEBUG : BROWSER_OUTPUT: 09:22:46 INFO - 2015-11-24 09:22:46,352 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26368.42 Median:26368.42 stddev:0.00 (0.0%) 09:22:46 INFO - 2015-11-24 09:22:46,352 DEBUG : BROWSER_OUTPUT: Values: 26368.4 09:22:46 INFO - 2015-11-24 09:22:46,352 DEBUG : BROWSER_OUTPUT: 09:22:46 INFO - 2015-11-24 09:22:46,352 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:597.51 Median:597.51 stddev:0.00 (0.0%) 09:22:46 INFO - 2015-11-24 09:22:46,352 DEBUG : BROWSER_OUTPUT: Values: 597.5 09:22:46 INFO - 2015-11-24 09:22:46,352 DEBUG : BROWSER_OUTPUT: 09:22:46 INFO - 2015-11-24 09:22:46,352 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 09:22:46 INFO - 2015-11-24 09:22:46,352 DEBUG : BROWSER_OUTPUT: Values: 4840.6 09:22:46 INFO - 2015-11-24 09:22:46,352 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:22:46 INFO - 2015-11-24 09:22:46,352 DEBUG : BROWSER_OUTPUT: 09:22:47 INFO - 2015-11-24 09:22:47,279 INFO : Browser exited with error code: 0 09:22:47 INFO - 2015-11-24 09:22:47,291 INFO : Completed test v8_7 (00:00:40) 09:22:47 INFO - 2015-11-24 09:22:47,310 INFO : Completed test suite (00:20:21) 09:22:47 INFO - 2015-11-24 09:22:47,311 DEBUG : Working with test: dromaeo_css 09:22:47 INFO - 2015-11-24 09:22:47,311 DEBUG : Generating results file: dromaeo_css 09:22:47 INFO - 2015-11-24 09:22:47,312 DEBUG : Working with test: kraken 09:22:47 INFO - 2015-11-24 09:22:47,312 DEBUG : Generating results file: kraken 09:22:47 INFO - 2015-11-24 09:22:47,312 INFO : javascript benchmark 09:22:47 INFO - 2015-11-24 09:22:47,312 DEBUG : Working with test: v8_7 09:22:47 INFO - 2015-11-24 09:22:47,312 DEBUG : Generating results file: v8_7 09:22:47 INFO - 2015-11-24 09:22:47,313 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:22:47 INFO - 2015-11-24 09:22:47,375 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 09:22:47 INFO - 2015-11-24 09:22:47,375 DEBUG : process_Request line: dromaeo_css 6085.83 graph.html#tests=[[72,132,35]] 09:22:47 INFO - 2015-11-24 09:22:47,375 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:22:47 INFO - 2015-11-24 09:22:47,433 DEBUG : process_Request line: kraken 1518.80 graph.html#tests=[[232,132,35]] 09:22:47 INFO - 2015-11-24 09:22:47,433 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:22:47 INFO - 2015-11-24 09:22:47,464 DEBUG : process_Request line: v8_7 19744.47 graph.html#tests=[[230,132,35]] 09:22:47 INFO - 2015-11-24 09:22:47,465 INFO : javascript benchmark 09:22:47 INFO - 2015-11-24 09:22:47,469 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2576.8136593045792, 2617.084020592793, 2626.606009098634, 2633.4469761350115, 2646.536856050192, 4516.0, 4523.38934243877, 4555.681102322838, 4643.721376717399, 4652.953470465294, 4575.565321294472, 4596.954030459694, 4646.674732768699, 4653.3252678361705, 4672.0, 4279.144171165756, 4352.238358287287, 4367.847125350613, 4369.279068953619, 4403.691741578091, 4188.5392606813375, 4405.31717583775, 4421.115776844628, 4452.755098469583, 4470.2177119004045, 4264.402983582301, 4288.807003684841, 4306.074194048263, 4340.045190058182, 4369.191699535596, 4329.1558146161515, 4330.198913201068, 4335.1979883721615, 4336.522982471925, 4367.781610919441, 4307.07397909451, 4307.396964424983, 4313.805878735465, 4346.217680817452, 4356.760378179199, 4490.2142125127975, 4566.657500687428, 4657.813687452498, 4658.557437043475, 4666.556677115668, 4995.650304478688, 5010.423801262865, 5018.874528136826, 5019.548240658358, 5059.342285502861, 5032.194848824171, 5035.118854200537, 5037.697738135724, 5041.1682072458, 5044.192929131358, 4437.556244375537, 4527.185106680763, 4538.8865278367975, 4634.351190833286, 4751.596114330251, 5128.076946149654, 5153.484651534816, 5153.922691159635, 5173.81891633791, 5195.792168313225, 4962.330085438492, 4967.0, 4972.627052971042, 5012.749362531858, 5021.271915572294, 4817.855464336076, 4922.212446008622, 4942.604591632661, 4944.1100601892, 4975.604898934567, 4921.630877684116, 4933.235348520985, 4936.062148191832, 4942.703437793743, 4991.351124353883, 4909.410870695539, 4911.0, 4914.680545764585, 4915.606751459874, 4958.330625365602, 4003.279409706281, 4071.633552980246, 4107.507099148122, 4110.794460277034, 4113.4035564843525, 3529.505869178317, 3593.640635936438, 3626.2747450510005, 3628.0, 3628.0385697790107, 4197.790110494463, 4249.638780703613, 4254.0, 4303.139372125587, 4306.4832220133785, 4934.6545741798445, 4936.7284799336385, 4937.925931111036, 4946.431160416526, 4989.675671081368, 4245.490541135084, 4248.235317642792, 4248.915021699549, 4248.9787551062045, 4284.250256205151, 4244.427002354704, 4294.26997410441, 4345.109252603209, 4352.0, 4396.736195828261, 4760.047990401864, 4765.9523404765505, 4768.117898188846, 4769.14155452015, 4815.109204797123, 4957.603391728581, 5036.6726162799305, 5043.445221025758, 5043.52086551777, 5046.53485517789, 4552.294394368878, 4658.464276608233, 4659.860204193879, 4662.626989840736, 4805.087033463631, 4815.181419158681, 4883.267509873547, 4893.1436998524405, 4929.383827021622, 4931.186354251508, 4970.627202959865, 4973.900521989613, 4980.352554167935, 4982.202847544376, 5024.371953505812, 4686.343911852412, 4800.543948324904, 4825.541573550507, 4827.831025914076, 4882.584980276574, 4768.76156192196, 4797.64017698681, 4886.047220791911, 4889.217725163957, 4929.507049295042, 4798.49615790337, 4807.975960120177, 4819.975900120477, 4834.226523756182, 4862.41651001882, 4766.237402015661, 4869.87825304356, 4963.932754457809, 4972.726500042532, 4998.975005124951, 4700.6239500839165, 4722.504137065696, 4751.50109238525, 4778.713277203379, 4802.063597598574], "unit": "ms", "name": "dojo.html", "value": 4565.338924327276}, {"lowerIsBetter": false, "replicates": [561.5647872898505, 567.8921005009046, 568.437247125346, 575.3843387575293, 576.6251936241442, 27674.86162569187, 28205.576916346246, 28342.0, 28579.571306430422, 28582.571261431043, 28438.715612843866, 36961.63038369615, 37860.81069594648, 37879.0, 37922.4311635325, 7876.409269304796, 8018.198180181994, 8023.077346105214, 8023.31801796848, 8029.879551806727, 7051.365377116059, 7245.927540724604, 7750.302472777449, 7862.135165131859, 7863.410244231705, 7054.753083642074, 7157.6063316517575, 7158.534695244818, 10024.94987525065, 10302.536385862617, 9853.261005424585, 9983.750406239866, 9993.600255989752, 9998.500074996295, 10001.949990250076, 9835.45904975226, 9988.700338989769, 9996.050375214343, 10007.449590272532, 10011.249156313306, 28654.0, 29122.70877291221, 39913.201735965114, 40750.388744168864, 40940.38589421161, 2619.240420278117, 2670.5593577059763, 2904.564315352693, 3118.7193152616146, 3141.8586163622463, 26532.46935061307, 26542.0, 26666.200013999613, 26970.460590788076, 27158.728412716016, 3251.7561182911377, 3312.3044160726276, 3343.732501399882, 3377.459606462954, 3403.2002479417315, 198747.0, 198918.0, 199163.0, 199428.0, 199591.0, 50744.0, 51088.0, 51185.48814511807, 51330.0, 51415.22877156846, 53723.0, 54309.45690543123, 54310.0, 54336.45663543314, 54475.72762136164, 13641.386137623633, 13641.590752277447, 13711.657208569666, 13814.0, 13858.376373063236, 10895.945520272347, 10949.726256843642, 10977.506012229469, 10981.352797080503, 10995.615153469751, 17548.210330535156, 17774.37789677381, 17839.643207136043, 17898.55253618644, 18050.0, 6858.622775747382, 7284.6721897514735, 7320.853582928418, 7352.742654007084, 7391.963040184764, 769.9653515591812, 828.867381219002, 865.5585651317873, 869.8129902071086, 890.1943740914483, 25713.614295785577, 26123.0, 26124.73875261261, 26141.346466338113, 26166.6075008875, 810.440795850861, 880.8414485392562, 938.4041133879899, 949.5821838391086, 984.9950750246203, 13624.727505449835, 14277.516354872098, 14483.565493035227, 14485.493007744679, 14643.48747793822, 252892.0, 256365.0, 256813.0, 257318.0, 258225.0, 44917.32624010643, 44994.77502612466, 45063.77468112704, 45087.32369014467, 45119.77440112778, 1161.1349544589166, 1198.3277291639517, 1203.8916497515265, 1210.5944508589546, 1214.690253985228, 25650.0, 25941.870290648425, 26758.59862102109, 27499.86250068737, 27505.31236719018, 37406.0, 37730.0, 37773.62226377701, 37795.433068503444, 37799.244015118995, 176460.0, 177965.0, 178164.0, 178562.0, 178648.10675946536, 23326.533469330177, 23664.0, 25671.743282566935, 27713.168604941882, 28050.859745701142, 33036.50445243371, 33360.1659958503, 35329.646703532635, 36236.0, 36536.26927461489, 31337.37325253528, 31541.0, 31728.524072139397, 32073.839630801696, 32179.678203217667, 24574.385640358418, 28984.565231521967, 31520.2119946994, 31649.525257121622, 31953.520697189095, 29301.41397172087, 29493.705062949095, 29507.262318442212, 29513.557296640138, 29540.704592953796, 24994.625080623442, 26472.602910955964, 26787.732122678524, 26885.86557067202, 27056.0, 20915.37253882386, 21664.37517186186, 22784.886075569517, 22855.428614284778, 23078.653820192376], "unit": "ms", "name": "ext.html", "value": 16134.673874442278}, {"lowerIsBetter": false, "replicates": [332.44979558830147, 334.2679531825302, 334.9480830471278, 337.0142333674004, 338.19172178493403, 12416.130870839044, 12805.423755930982, 14817.110973341594, 15266.160361180131, 15917.76123358149, 10142.290039697205, 10465.58137674494, 10917.0, 15335.616609584766, 15370.769438458432, 4549.4768101668315, 4665.370175026362, 4665.83669571565, 4668.159731248374, 4669.463011753658, 3401.1667141550356, 3487.0584942065625, 4888.608911287089, 5049.242613607951, 5227.79088836446, 5093.770780314876, 5140.151874940649, 5147.150720131174, 5208.635395522315, 5214.765335559909, 5070.08738427083, 5158.40678321994, 5574.163875418679, 5598.944010559903, 5603.7478313475995, 5000.249962505617, 5002.799888004475, 5005.774740136702, 5006.974965125188, 5007.549320561167, 12098.637040888787, 16747.413840515645, 18478.815211847977, 19204.0, 19229.0, 1737.4787563730831, 1740.103846519031, 1751.5621094726318, 1755.5052685095695, 1782.269269599471, 8931.0, 9014.639414423415, 9160.450372977642, 9258.305627077929, 9414.058594140599, 1549.1170033081148, 1648.546649671338, 1656.1719140429784, 1656.6355401811581, 1664.650423411073, 54440.18339724907, 55536.72231638816, 57259.71370143206, 57735.711321443545, 57908.420915790724, 9765.218782497524, 9810.607575696893, 9825.459599722084, 9843.655472058443, 9877.654282100235, 12651.114421990556, 12657.746845063048, 12676.429560669792, 12684.23894566329, 12689.428975696115, 6846.554973926679, 6846.828829279209, 6963.61700106499, 6981.685824137926, 7102.1889418198025, 6643.236027856762, 6684.665766711742, 6694.564853284618, 6713.328667133345, 6739.326067393222, 4122.40225167355, 4145.398917156996, 4146.1914926589625, 4173.9582604174175, 4186.267403204427, 1570.4267942201013, 1634.3054201964117, 1641.0645931818988, 1663.7254852949127, 1738.982610173882, 831.7629475599546, 850.0437008365589, 881.8236352729351, 889.1997202517786, 917.3349321741684, 15542.222888855513, 15882.285297161425, 16095.0, 16134.193290335672, 16196.676066478605, 732.4177279063158, 762.6491813765618, 781.3280578702312, 825.7398919340509, 921.6543796076471, 8205.179482051746, 8375.664973400995, 8513.702020429255, 8630.827383452295, 8867.024627290994, 456059.0, 463136.0, 466631.0, 472204.0, 482043.0, 67716.6614166926, 68804.0, 69052.0, 69164.6541767298, 70343.94484082743, 1051.805415998043, 1068.5672302717412, 1079.4279032112993, 1086.245059683528, 1086.3590481615884, 8820.514871681862, 9542.85685714701, 9696.466694331879, 9784.853227201455, 13787.172769633855, 29625.111246662636, 30577.694223058374, 31913.202169945936, 32590.348193035534, 33077.50383744294, 42898.78550607352, 43101.56898430976, 43784.78107609441, 44020.71751389854, 44118.11763764771, 13666.11170273929, 13957.511487097903, 14005.719885602435, 14104.29478526049, 14187.432502699776, 17022.74465882988, 17055.0, 17445.651086977934, 17546.38587649426, 17602.29590816353, 14323.57029289123, 14438.783418248944, 14798.6300342488, 14857.257137143315, 14865.925670371578, 8902.198802107841, 9131.086891310815, 9208.079192080739, 9226.40028398152, 9310.581023853807, 7845.529268243924, 8557.828843422973, 9406.95296523513, 9495.572699228413, 9628.0, 11084.113270938144, 12397.380130993233, 12761.61715148547, 12928.224306541637, 13417.262050587311, 14048.438062477795, 14113.788293175405, 14310.85689143137, 14529.85470145285, 14567.198804065454], "unit": "ms", "name": "jquery.html", "value": 8061.3170703725045}, {"lowerIsBetter": false, "replicates": [1177.8527684039495, 1542.6220575958891, 1602.1588665950374, 1602.7836242107317, 1641.7619445180458, 5837.532997360212, 6236.812895613133, 6304.180456540649, 6475.320091390407, 6547.8363040924005, 6766.391024807766, 6786.7285308587725, 6834.692438840251, 6841.863162736742, 6848.0, 2039.4595432210476, 2061.8247448966854, 2062.7730949595534, 2064.3600483849978, 2064.5354795171042, 2033.6339458897392, 2040.1941233212872, 2044.1516770540209, 2073.9896300518476, 2077.750669919612, 2008.14653772147, 2031.7663468701066, 2047.0, 2049.385184444661, 2050.589882023594, 2031.8577699561038, 2043.1214577731569, 2045.795420457957, 2048.0, 2048.94877628059, 2042.3974927396453, 2055.640262953977, 2075.439631299556, 2077.241806740544, 2078.023329035351, 5797.36229014808, 6782.355676210752, 6838.863222735567, 6848.897266541006, 6851.828704282383, 3360.1767566946255, 3982.123932734794, 4033.5361433434946, 4042.353223484258, 4047.352423612208, 2615.4115324052127, 2615.7253488383635, 2662.254568720761, 2666.4533770576986, 2674.8395096294284, 874.1477059866643, 910.7950711089952, 915.7619019055094, 927.1423932862076, 940.5767404667859, 8903.599338029804, 8958.86561701575, 8963.68627098055, 8973.371863969525, 8981.506017169053, 3703.500027496307, 3745.6441638044344, 3758.1356288053903, 3806.2958352704286, 3915.2169566086327, 7800.180980996914, 7888.921110788819, 7891.684332626631, 7896.289333959971, 7943.364530837519, 4047.291723948297, 4070.2266569351727, 4071.89820254496, 4074.1851629674184, 4076.164386300801, 3674.9632503675157, 3707.796071216109, 3710.1466662667735, 3714.201446688975, 3715.238376132886, 3063.7242648161773, 3079.0916679579577, 3085.1515833146063, 3104.7050530200045, 3107.4872646013605, 1029.1406675426103, 1033.0, 1034.9379037257638, 1035.1253191053547, 1039.6735862278122, 787.0751866556773, 797.5812698333422, 797.8484088023373, 798.2017982017982, 933.6965486217007, 6414.909465390895, 6438.25960014595, 6441.64570948593, 6443.838904027343, 6447.677616119176, 417.81616088920777, 427.8652224549257, 430.0302817147375, 430.03886314087987, 432.6949500602068, 4827.686200396963, 5092.9745351273, 5139.383274007143, 5146.1766117421785, 5154.123798954187, 7400.703971841173, 7912.09010963735, 8004.51972881629, 8051.718189863327, 8114.188581141957, 8057.435979481497, 8063.072746634095, 8091.1504292048485, 8101.756947291591, 8103.554304513308, 6281.7173227204885, 6413.134226879311, 6469.838254043592, 6473.579217350857, 6479.481641468671, 6281.497480201481, 6295.968520157553, 6298.433141017331, 6303.338149494421, 6307.463865571294, 7155.391791697764, 7373.889391659022, 7471.514351567131, 7476.0, 7487.812804679927, 7351.338379545867, 7453.962730186315, 7571.46999710037, 7572.053493313336, 7697.422693297913, 5922.2597175353085, 5941.9405805943115, 5994.430529099728, 5998.310194327533, 6080.48315893154, 6241.625502469867, 6567.9671601641685, 6573.211214654272, 6586.901196481961, 6591.769288074895, 6052.848678783065, 6065.302490213682, 6150.261968563622, 6152.230971128609, 6187.226596675416, 6045.667488288186, 6124.234470691164, 6185.536084793748, 6200.348963358782, 6204.5036397089025, 6002.699865006645, 6040.063790112539, 6040.214772079602, 6043.305019922589, 6047.727852246571, 5646.209530665792, 5671.773129074791, 5688.089905615082, 5692.857678558069, 5694.345150307768, 5811.0, 5839.912401314069, 5844.795432159854, 5845.1232315153065, 5964.075568286922], "unit": "ms", "name": "mootools.html", "value": 3822.8576686973643}, {"lowerIsBetter": false, "replicates": [303.8754110814566, 312.19609505523283, 312.68731268731267, 313.800736532302, 314.53134829104613, 5268.288781014567, 5291.312129423174, 5392.91910621341, 5410.323709536308, 5428.647137936031, 5338.893222135564, 5348.277982472365, 5348.679079255247, 5350.197470379445, 5358.410574836765, 3960.5049368828895, 4041.818118184674, 4223.345381465878, 4225.936610950838, 4230.492340919079, 4059.9797001014954, 4063.3904914262803, 4195.328747400416, 4205.243056249874, 4217.6625869930485, 4150.0, 4157.563455837124, 4157.5634558371385, 4173.227952828721, 4179.916401671965, 3935.74417662851, 4013.177298653769, 4175.519815221242, 4185.97907010466, 4192.601702838226, 3626.4016437287814, 3691.7600355976774, 3701.1487357907563, 3703.3889408247605, 3709.6104908984707, 5114.514121158484, 5128.025675121752, 5128.435872054109, 5130.640855140142, 5133.512316329943, 4798.976005119987, 4805.567498925114, 4814.542618451242, 4822.397200349957, 4832.420109586872, 5426.077566813651, 5595.944040559583, 5638.295213098363, 5642.153676948449, 5649.802256920988, 3903.882883513471, 3908.8436462541463, 3909.2376986487648, 3913.549941756706, 3918.294706952747, 5864.560157988125, 5954.49386802118, 5966.134910438005, 5970.164177015221, 5972.0, 4197.664186865043, 4205.810738516774, 4207.936880946788, 4209.1792100540715, 4215.325547912319, 4181.623653871166, 4248.383984322256, 4275.3800698898485, 4278.465191851019, 4283.5502272260965, 4810.927836082462, 4819.397575303087, 4823.589994850407, 4826.276058591239, 4826.61387089032, 5652.378238393773, 5653.886922261532, 5661.603687741818, 5665.886682266331, 5671.149327600893, 1498.2059508460534, 1510.0260332085963, 1512.138081293674, 1514.8560886715745, 1514.9015314004555, 1029.5572903651353, 1044.1385856668278, 1045.231754660324, 1049.296971029397, 1080.303204433152, 4948.876278093005, 4957.479464656231, 4969.105560998983, 4974.353334066548, 4974.651774375831, 5729.512991395778, 5741.88516229673, 5752.913706294409, 5758.856028599234, 5761.107028410603, 4932.161532539477, 4944.678595891256, 4947.678400904002, 4954.504549545017, 4968.279599458058, 3079.5996520452645, 3089.6137982752157, 3135.1378370948173, 3164.2722173900133, 3187.282861356223, 5638.887222255532, 5646.0, 5652.66084034951, 5654.85862853432, 5655.717214139277, 6087.208662873887, 6102.938970610237, 6111.8472038198515, 6118.20463339763, 6130.233720784902, 5526.392096869422, 5643.181738647873, 5651.124075768263, 5651.547876169897, 5653.095504719307, 5920.555958303231, 5923.703814809156, 5931.406859314034, 5935.881282374415, 5941.881162376641, 5802.535797136304, 5805.129230615442, 5806.622569532967, 5808.041673123887, 5808.970955145197, 5607.467290607386, 5615.045442274742, 5618.101103823368, 5627.155926611041, 5636.746346414503, 3931.5478719947573, 3975.204959008152, 4013.15723698015, 4045.2920738869993, 4056.269871423172, 5797.884042319214, 5836.978528757366, 5851.561132914963, 5867.0, 5868.09044598088, 5632.887342253214, 5645.9153112702525, 5651.773929042956, 5653.575981801299, 5656.943430565641, 5427.457254274541, 5512.310961129859, 5520.834374968757, 5531.806386776604, 5559.694216818114, 5456.781728730806, 5458.61789674719, 5513.3108361454815, 5540.501354877919, 5548.056830338772, 5436.510714035756, 5611.298587676541, 5682.460166284196, 5690.3456102548735, 5691.715414229189, 5351.491608297206, 5485.067538518381, 5503.972480137573, 5540.63985840919, 5545.140503222007], "unit": "ms", "name": "prototype.html", "value": 4269.474115668162}, {"lowerIsBetter": false, "replicates": [669.7856685860527, 687.9380855722981, 755.3579457461159, 774.6514068669101, 785.1167436633789, 10696.893031069687, 10729.141668666507, 10778.892211077888, 10794.622188223404, 10797.190210734207, 9515.096065873748, 9649.614015439374, 10078.0, 10287.0741633253, 10396.48017599119, 727.1891840597722, 748.9176190619028, 751.7744676596999, 751.8609057324412, 751.9172890981988, 728.9671964761571, 743.2010588617231, 743.7322563877, 746.828229507211, 747.1855677311729, 760.6843160088584, 774.3263360876045, 776.8368642585064, 777.0093131257635, 777.0791611939841, 753.773867839646, 761.6572542355907, 762.0284137724391, 762.6034462079688, 770.6339488742858, 556.7272036702027, 560.1653536231028, 566.5665765689251, 570.6804189653807, 570.974306156224, 7937.603119843985, 7999.0, 8030.277275045216, 8050.355971522265, 8069.193080691943, 8365.24712775847, 9263.25893928484, 9427.292953028551, 9755.219582433388, 10102.494875256209, 8122.634481448349, 8128.105908350077, 8144.389170812213, 8190.140035296267, 8261.17388261175, 2295.1966811615966, 2372.383180373098, 2380.809535237177, 2406.651035599828, 2413.143334116381, 33425.49861752051, 37793.24413511742, 39207.803960980295, 39342.60657393447, 39778.403323950166, 9260.259179265642, 9515.666951656658, 9547.331686781998, 9632.181264592447, 9729.221662267002, 15251.542453726406, 15283.770743438858, 15290.694186116438, 15296.235188240544, 15302.311395986984, 6078.179445774764, 6169.629822210682, 6290.716917738621, 6376.872462550723, 6515.641639709766, 3468.739844511672, 3504.842282097312, 3539.823008849547, 3565.073080998959, 3572.8749493767596, 2678.4776968490955, 2695.3396417877743, 2697.9730202698115, 2702.0542810016336, 2703.2160673404887, 465.206822367862, 467.7778055423715, 470.11618157863, 470.4448750474473, 477.45093142885264, 432.4614512809764, 445.94871589766944, 448.0344856833464, 455.3920516111029, 511.54216975806446, 6832.0776695146515, 6892.379685828199, 6915.377616014583, 6987.89518157228, 7012.228654847962, 386.947762052125, 475.995240047602, 480.97595120243847, 489.92651102334935, 499.8825276060123, 3194.2493514024186, 3225.2904361040532, 3249.2526718854797, 3313.8343082846245, 3360.3951288767767, 46532.302015469795, 47626.76186619045, 47632.7618361906, 47974.28038579424, 48652.0, 43489.78255108704, 43915.0, 43987.4810015198, 44015.11969760587, 44056.11887762227, 34668.0, 38460.23079538393, 38725.80637096853, 39481.60518394837, 39639.0, 7403.407727381904, 7506.962465187639, 7517.962410187914, 7592.316691497792, 7682.807929801576, 31875.84062079675, 32351.514727278638, 32567.674323256466, 32578.83710581432, 32719.0, 38578.0, 39860.00349991273, 40254.798726006185, 40261.0, 41102.79448602738, 8925.107489251282, 9010.86483702758, 9224.861627075734, 9401.81196376055, 9567.473788941397, 9530.714078577654, 9719.562619682272, 9772.12050915421, 9903.45530995802, 9974.60101595928, 10102.747431314276, 10179.643712470028, 10181.236407269336, 10191.286609937233, 10204.0, 10042.69871903844, 10060.49697515136, 10164.491775411348, 10231.48842557884, 10351.63769268072, 9830.705078847646, 9890.406575605486, 9929.0, 9967.800643987224, 9980.650677226262, 8416.242538171595, 8511.574421278787, 8512.106228845882, 8594.527300998505, 8655.69705060345, 7568.697252109854, 7673.386129109769, 7926.269121699801, 7996.20037996219, 8645.308375330083], "unit": "ms", "name": "yui.html", "value": 5241.701293897121}], "name": "dromaeo_css", "value": 6085.832373631768}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 112.0, 106.0, 112.0, 113.0, 114.0, 103.0, 113.0, 112.0, 106.0], "unit": "ms", "name": "ai-astar", "value": 110.3}, {"lowerIsBetter": true, "replicates": [153.0, 129.0, 156.0, 170.0, 142.0, 161.0, 151.0, 130.0, 166.0, 131.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.9}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 161.0, 160.0, 160.0, 160.0, 164.0, 163.0, 163.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 87.0, 100.0, 72.0, 71.0, 72.0, 100.0, 89.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 80.5}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 130.0, 94.0, 94.0, 94.0, 138.0, 94.0, 95.0, 134.0], "unit": "ms", "name": "audio-oscillator", "value": 106.1}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.2}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 72.0, 72.0, 71.0, 71.0, 72.0, 72.0, 69.0, 68.0], "unit": "ms", "name": "json-parse-financial", "value": 71.0}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 68.0, 68.0, 69.0, 68.0, 68.0, 69.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [81.0, 84.0, 83.0, 87.0, 83.0, 84.0, 82.0, 82.0, 82.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.1}, {"lowerIsBetter": true, "replicates": [128.0, 120.0, 120.0, 119.0, 130.0, 122.0, 121.0, 121.0, 120.0, 129.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 123.0}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 144.0, 153.0, 151.0, 136.0, 148.0, 152.0, 144.0, 136.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.8}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 68.0, 69.0, 73.0, 69.0, 68.0, 69.0, 69.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.1}], "name": "kraken", "value": 1518.7999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [189.82536066818528], "unit": "score", "name": "Richards", "value": 185.97093599999994}, {"lowerIsBetter": false, "replicates": [184.84288354898337], "unit": "score", "name": "DeltaBlue", "value": 357.6983799999999}, {"lowerIsBetter": false, "replicates": [279.3296089385475], "unit": "score", "name": "Encrypt", "value": 952.9279799999998}, {"lowerIsBetter": false, "replicates": [5000.0], "unit": "score", "name": "Decrypt", "value": 53.23619999999997}, {"lowerIsBetter": false, "replicates": [1980.1980198019803], "unit": "score", "name": "RayTrace", "value": 373.6944450000001}, {"lowerIsBetter": false, "replicates": [779.423226812159], "unit": "score", "name": "Earley", "value": 855.072029}, {"lowerIsBetter": false, "replicates": [11976.190476190477], "unit": "score", "name": "Boyer", "value": 55.648998011928406}, {"lowerIsBetter": false, "replicates": [26368.42105263158], "unit": "score", "name": "RegExp", "value": 34.54833333333334}, {"lowerIsBetter": false, "replicates": [597.5103734439834], "unit": "score", "name": "Splay", "value": 136.38424305555552}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19744.47045389207}]} 09:22:47 INFO - RETURN: dromaeo_css: 6085.83 09:22:47 INFO - RETURN: kraken: 1518.80 09:22:47 INFO - RETURN: v8_7: 19744.47 09:22:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19744.47"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1518.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6085.83"}}} 09:22:47 INFO - Return code: 0 09:22:47 INFO - # TBPL SUCCESS # 09:22:47 INFO - Running post-action listener: _resource_record_post_action 09:22:47 INFO - Running post-run listener: _resource_record_post_run 09:22:48 INFO - Total resource usage - Wall time: 1236s; CPU: 13.0%; Read bytes: 10248192; Write bytes: 464187392; Read time: 3028; Write time: 463584 09:22:48 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 4096; Write bytes: 65642496; Read time: 164; Write time: 48516 09:22:48 INFO - run-tests - Wall time: 1222s; CPU: 13.0%; Read bytes: 8052736; Write bytes: 371490816; Read time: 2576; Write time: 407308 09:22:48 INFO - Running post-run listener: _upload_blobber_files 09:22:48 INFO - Blob upload gear active. 09:22:48 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:22:48 INFO - Copying logs to upload dir... 09:22:48 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1269.865342 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-11-24 09:22:48.692555) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 09:22:48.698446) ========= 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=01deea79d00cc2c334834894000001d2-1448383093.687565-1158267869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/Y0MerU6WTcW46pJV-yH7Sg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009889 build_url: 'https://queue.taskcluster.net/v1/task/Y0MerU6WTcW46pJV-yH7Sg/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-24 09:22:48.750348) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 09:22:48.750704) ========= 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=01deea79d00cc2c334834894000001d2-1448383093.687565-1158267869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004436 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 09:22:48.800449) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 09:22:48.800788) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 09:22:48.801110) ========= ========= Total master_lag: 0.27 =========