builder: b2g-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-009 starttime: 1447970647.23 results: success (0) buildid: 20151119115539 builduid: 75fe4db27dee488a8aab6e3b79722410 revision: 0e866e588827af7a1785d6777e3ef5ef15022bde ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 14:04:07.234191) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 14:04:07.234579) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 14:04:07.234968) ========= 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=a732b360c9c0c9a4a8cfc42c000001d9-1447970598.846722-1189925068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.003542 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 14:04:07.250312) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 14:04:07.250582) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 14:04:07.259223) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 14:04:07.259485) ========= 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=a732b360c9c0c9a4a8cfc42c000001d9-1447970598.846722-1189925068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.003747 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 14:04:07.306831) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 14:04:07.307186) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 14:04:07.307569) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 14:04:07.307880) ========= 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=a732b360c9c0c9a4a8cfc42c000001d9-1447970598.846722-1189925068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-19 14:04:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2015-11-19 14:04:07 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.183041 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 14:04:07.502814) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 14:04:07.503143) ========= 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=a732b360c9c0c9a4a8cfc42c000001d9-1447970598.846722-1189925068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018092 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 14:04:07.552875) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 14:04:07.553251) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 0e866e588827af7a1785d6777e3ef5ef15022bde --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 0e866e588827af7a1785d6777e3ef5ef15022bde --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=a732b360c9c0c9a4a8cfc42c000001d9-1447970598.846722-1189925068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-19 14:04:07,697 truncating revision to first 12 chars 2015-11-19 14:04:07,697 Setting DEBUG logging. 2015-11-19 14:04:07,698 attempt 1/10 2015-11-19 14:04:07,698 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/0e866e588827?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-19 14:04:07,932 unpacking tar archive at: b2g-inbound-0e866e588827/testing/mozharness/ program finished with exit code 0 elapsedTime=0.564403 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 14:04:08.130302) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 14:04:08.130622) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 14:04:08.140466) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 14:04:08.140729) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 14:04:08.141174) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-11-19 14:04:08.141454) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a732b360c9c0c9a4a8cfc42c000001d9-1447970598.846722-1189925068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:04:08 INFO - MultiFileLogger online at 20151119 14:04:08 in /builds/slave/test 14:04:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-Non-PGO 14:04:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:04:08 INFO - {'append_to_log': False, 14:04:08 INFO - 'base_work_dir': '/builds/slave/test', 14:04:08 INFO - 'blob_upload_branch': 'B2G-Inbound-Non-PGO', 14:04:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:04:08 INFO - 'branch': 'B2G-Inbound-Non-PGO', 14:04:08 INFO - 'buildbot_json_path': 'buildprops.json', 14:04:08 INFO - 'config_files': ('talos/linux_config.py',), 14:04:08 INFO - 'default_actions': ('clobber', 14:04:08 INFO - 'read-buildbot-config', 14:04:08 INFO - 'download-and-extract', 14:04:08 INFO - 'populate-webroot', 14:04:08 INFO - 'create-virtualenv', 14:04:08 INFO - 'install', 14:04:08 INFO - 'run-tests'), 14:04:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:04:08 INFO - 'download_minidump_stackwalk': True, 14:04:08 INFO - 'download_symbols': 'ondemand', 14:04:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:04:08 INFO - 'tooltool.py': '/tools/tooltool.py', 14:04:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:04:08 INFO - '/tools/misc-python/virtualenv.py')}, 14:04:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:04:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:04:08 INFO - 'installer_path': 'installer.exe', 14:04:08 INFO - 'log_level': 'info', 14:04:08 INFO - 'log_name': 'talos', 14:04:08 INFO - 'log_to_console': True, 14:04:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:04:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:04:08 INFO - 'opt_config_files': (), 14:04:08 INFO - 'pip_index': False, 14:04:08 INFO - 'sps_profile': False, 14:04:08 INFO - 'sps_profile_interval': 0, 14:04:08 INFO - 'suite': 'dromaeojs', 14:04:08 INFO - 'system_bits': '64', 14:04:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:04:08 INFO - 'title': 'talos-linux64-ix-009', 14:04:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:04:08 INFO - 'use_talos_json': True, 14:04:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:04:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:04:08 INFO - 'work_dir': 'build'} 14:04:08 INFO - ##### 14:04:08 INFO - ##### Running clobber step. 14:04:08 INFO - ##### 14:04:08 INFO - Running pre-action listener: _resource_record_pre_action 14:04:08 INFO - Running main action method: clobber 14:04:08 INFO - rmtree: /builds/slave/test/build 14:04:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:04:08 INFO - Running post-action listener: _resource_record_post_action 14:04:08 INFO - ##### 14:04:08 INFO - ##### Running read-buildbot-config step. 14:04:08 INFO - ##### 14:04:08 INFO - Running pre-action listener: _resource_record_pre_action 14:04:08 INFO - Running main action method: read_buildbot_config 14:04:08 INFO - Using buildbot properties: 14:04:08 INFO - { 14:04:08 INFO - "properties": { 14:04:08 INFO - "buildnumber": 764, 14:04:08 INFO - "product": "firefox", 14:04:08 INFO - "script_repo_revision": "production", 14:04:08 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 14:04:08 INFO - "repository": "", 14:04:08 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound talos dromaeojs", 14:04:08 INFO - "buildid": "20151119115539", 14:04:08 INFO - "slavename": "talos-linux64-ix-009", 14:04:08 INFO - "pgo_build": "False", 14:04:08 INFO - "basedir": "/builds/slave/test", 14:04:08 INFO - "project": "", 14:04:08 INFO - "platform": "ubuntu64_hw", 14:04:08 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:04:08 INFO - "slavebuilddir": "test", 14:04:08 INFO - "scheduler": "tests-b2g-inbound-linux64-talos", 14:04:08 INFO - "branch": "b2g-inbound", 14:04:08 INFO - "repo_path": "integration/b2g-inbound", 14:04:08 INFO - "stage_platform": "linux64", 14:04:08 INFO - "builduid": "75fe4db27dee488a8aab6e3b79722410", 14:04:08 INFO - "revision": "0e866e588827af7a1785d6777e3ef5ef15022bde" 14:04:08 INFO - }, 14:04:08 INFO - "sourcestamp": { 14:04:08 INFO - "repository": "", 14:04:08 INFO - "hasPatch": false, 14:04:08 INFO - "project": "", 14:04:08 INFO - "branch": "b2g-inbound-linux64-talos", 14:04:08 INFO - "changes": [ 14:04:08 INFO - { 14:04:08 INFO - "category": null, 14:04:08 INFO - "files": [ 14:04:08 INFO - { 14:04:08 INFO - "url": null, 14:04:08 INFO - "name": "https://queue.taskcluster.net/v1/task/WoKItLM1TZig9NxMwSfwDw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 14:04:08 INFO - } 14:04:08 INFO - ], 14:04:08 INFO - "repository": "", 14:04:08 INFO - "rev": "0e866e588827af7a1785d6777e3ef5ef15022bde", 14:04:08 INFO - "who": "wcosta@mozilla.com", 14:04:08 INFO - "when": 1447970031, 14:04:08 INFO - "number": 6685122, 14:04:08 INFO - "comments": "Bug 1224770: Remove dogfood configuration from nexus 4-kk and 5-l. r=gerard-majax", 14:04:08 INFO - "project": "", 14:04:08 INFO - "at": "Thu 19 Nov 2015 13:53:51", 14:04:08 INFO - "branch": "b2g-inbound-linux64-talos", 14:04:08 INFO - "revlink": "", 14:04:08 INFO - "properties": [ 14:04:08 INFO - [ 14:04:08 INFO - "buildid", 14:04:08 INFO - "20151119115539", 14:04:08 INFO - "Change" 14:04:08 INFO - ], 14:04:08 INFO - [ 14:04:08 INFO - "builduid", 14:04:08 INFO - "75fe4db27dee488a8aab6e3b79722410", 14:04:08 INFO - "Change" 14:04:08 INFO - ], 14:04:08 INFO - [ 14:04:08 INFO - "pgo_build", 14:04:08 INFO - "False", 14:04:08 INFO - "Change" 14:04:08 INFO - ] 14:04:08 INFO - ], 14:04:08 INFO - "revision": "0e866e588827af7a1785d6777e3ef5ef15022bde" 14:04:08 INFO - } 14:04:08 INFO - ], 14:04:08 INFO - "revision": "0e866e588827af7a1785d6777e3ef5ef15022bde" 14:04:08 INFO - } 14:04:08 INFO - } 14:04:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/WoKItLM1TZig9NxMwSfwDw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 14:04:08 INFO - Running post-action listener: _resource_record_post_action 14:04:08 INFO - ##### 14:04:08 INFO - ##### Running download-and-extract step. 14:04:08 INFO - ##### 14:04:08 INFO - Running pre-action listener: _resource_record_pre_action 14:04:08 INFO - Running main action method: download_and_extract 14:04:08 INFO - mkdir: /builds/slave/test/build/tests 14:04:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:08 INFO - https://queue.taskcluster.net/v1/task/WoKItLM1TZig9NxMwSfwDw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:04:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WoKItLM1TZig9NxMwSfwDw/artifacts/public/build/test_packages.json 14:04:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WoKItLM1TZig9NxMwSfwDw/artifacts/public/build/test_packages.json 14:04:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WoKItLM1TZig9NxMwSfwDw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 14:04:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WoKItLM1TZig9NxMwSfwDw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 14:04:10 INFO - Downloaded 1302 bytes. 14:04:10 INFO - Reading from file /builds/slave/test/build/test_packages.json 14:04:10 INFO - Using the following test package requirements: 14:04:10 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 14:04:10 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:10 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:04:10 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:10 INFO - u'jsshell-linux-x86_64.zip'], 14:04:10 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:10 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:04:10 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 14:04:10 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:10 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:04:10 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:10 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:04:10 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:10 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:04:10 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 14:04:10 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:10 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:04:10 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:04: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')]} 14:04:10 INFO - https://queue.taskcluster.net/v1/task/WoKItLM1TZig9NxMwSfwDw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:04:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WoKItLM1TZig9NxMwSfwDw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:04:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WoKItLM1TZig9NxMwSfwDw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:04:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WoKItLM1TZig9NxMwSfwDw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:04:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WoKItLM1TZig9NxMwSfwDw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:04:15 INFO - Downloaded 21336235 bytes. 14:04:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 14:04:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:04:15 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 14:04:16 INFO - Return code: 0 14:04:16 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:04:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:16 INFO - https://queue.taskcluster.net/v1/task/WoKItLM1TZig9NxMwSfwDw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:04:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WoKItLM1TZig9NxMwSfwDw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:04:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WoKItLM1TZig9NxMwSfwDw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:04:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WoKItLM1TZig9NxMwSfwDw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:04:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WoKItLM1TZig9NxMwSfwDw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:04:17 INFO - Downloaded 21336235 bytes. 14:04:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 14:04:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:04:17 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 14:04:18 INFO - Return code: 0 14:04:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:18 INFO - https://queue.taskcluster.net/v1/task/WoKItLM1TZig9NxMwSfwDw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:04:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WoKItLM1TZig9NxMwSfwDw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 14:04:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WoKItLM1TZig9NxMwSfwDw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 14:04:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WoKItLM1TZig9NxMwSfwDw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 14:04:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WoKItLM1TZig9NxMwSfwDw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:04:19 INFO - Downloaded 11130997 bytes. 14:04:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 14:04:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 14:04:19 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 14:04:20 INFO - Return code: 0 14:04:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:20 INFO - https://queue.taskcluster.net/v1/task/WoKItLM1TZig9NxMwSfwDw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:04:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WoKItLM1TZig9NxMwSfwDw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:04:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WoKItLM1TZig9NxMwSfwDw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:04:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WoKItLM1TZig9NxMwSfwDw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:04:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WoKItLM1TZig9NxMwSfwDw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:04:21 INFO - Downloaded 55783237 bytes. 14:04:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WoKItLM1TZig9NxMwSfwDw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:04:21 INFO - mkdir: /builds/slave/test/properties 14:04:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:04:21 INFO - Writing to file /builds/slave/test/properties/build_url 14:04:21 INFO - Contents: 14:04:21 INFO - build_url:https://queue.taskcluster.net/v1/task/WoKItLM1TZig9NxMwSfwDw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:04:21 INFO - Running post-action listener: _resource_record_post_action 14:04:21 INFO - Running post-action listener: set_extra_try_arguments 14:04:21 INFO - ##### 14:04:21 INFO - ##### Running populate-webroot step. 14:04:21 INFO - ##### 14:04:21 INFO - Running pre-action listener: _resource_record_pre_action 14:04:21 INFO - Running main action method: populate_webroot 14:04:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:04:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:04:21 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 14:04:21 INFO - '../fennec_ids.txt'], 14:04:21 INFO - 'tests': ['tcheck2']}, 14:04:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:04:21 INFO - '--tppagecycles', 14:04:21 INFO - '7'], 14:04:21 INFO - 'tests': ['tsvgm']}}, 14:04:21 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:04:21 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:04:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:04:21 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:04:21 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:04:21 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:04:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:04:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:21 INFO - 'talos_options': ['--e10s'], 14:04:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:04:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:21 INFO - 'tests': ['damp', 'tps']}, 14:04:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:21 INFO - 'talos_options': ['--e10s'], 14:04:21 INFO - 'tests': ['damp', 'tps']}, 14:04:21 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:04:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:04:21 INFO - 'other': {'tests': ['a11yr', 14:04:21 INFO - 'ts_paint', 14:04:21 INFO - 'tpaint', 14:04:21 INFO - 'sessionrestore', 14:04:21 INFO - 'sessionrestore_no_auto_restore']}, 14:04:21 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:04:21 INFO - 'tests': ['a11yr', 14:04:21 INFO - 'ts_paint', 14:04:21 INFO - 'tpaint', 14:04:21 INFO - 'sessionrestore', 14:04:21 INFO - 'sessionrestore_no_auto_restore']}, 14:04:21 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:04:21 INFO - 'tests': ['a11yr', 14:04:21 INFO - 'ts_paint', 14:04:21 INFO - 'tpaint', 14:04:21 INFO - 'sessionrestore', 14:04:21 INFO - 'sessionrestore_no_auto_restore']}, 14:04:21 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:04:21 INFO - 'tests': ['a11yr', 14:04:21 INFO - 'ts_paint', 14:04:21 INFO - 'tpaint', 14:04:21 INFO - 'sessionrestore', 14:04:21 INFO - 'sessionrestore_no_auto_restore']}, 14:04:21 INFO - 'other_l64': {'tests': ['a11yr', 14:04:21 INFO - 'ts_paint', 14:04:21 INFO - 'tpaint', 14:04:21 INFO - 'sessionrestore', 14:04:21 INFO - 'sessionrestore_no_auto_restore']}, 14:04:21 INFO - 'other_nol64': {'tests': ['a11yr', 14:04:21 INFO - 'ts_paint', 14:04:21 INFO - 'tpaint', 14:04:21 INFO - 'sessionrestore', 14:04:21 INFO - 'sessionrestore_no_auto_restore']}, 14:04:21 INFO - 'svgr': {'tests': ['tsvgx', 14:04:21 INFO - 'tsvgr_opacity', 14:04:21 INFO - 'tart', 14:04:21 INFO - 'tscrollx', 14:04:21 INFO - 'cart']}, 14:04:21 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:04:21 INFO - 'tests': ['tsvgx', 14:04:21 INFO - 'tsvgr_opacity', 14:04:21 INFO - 'tart', 14:04:21 INFO - 'tscrollx', 14:04:21 INFO - 'cart']}, 14:04:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:21 INFO - 'tests': ['tp5o']}, 14:04:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:21 INFO - 'talos_options': ['--e10s'], 14:04:21 INFO - 'tests': ['tp5o']}, 14:04:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:21 INFO - 'talos_options': ['--xperf_path', 14:04:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:04:21 INFO - 'tests': ['tp5n']}, 14:04:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:21 INFO - 'talos_options': ['--e10s', 14:04:21 INFO - '--xperf_path', 14:04:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:04:21 INFO - 'tests': ['tp5n']}}, 14:04:21 INFO - 'talos.zip': {'path': '', 14:04:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:04:21 INFO - Running post-action listener: _resource_record_post_action 14:04:21 INFO - ##### 14:04:21 INFO - ##### Running create-virtualenv step. 14:04:21 INFO - ##### 14:04:21 INFO - Running pre-action listener: _resource_record_pre_action 14:04:21 INFO - Running main action method: create_virtualenv 14:04:21 INFO - Creating virtualenv /builds/slave/test/build/venv 14:04:21 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:04:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:04:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:04:21 INFO - Using real prefix '/usr' 14:04:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:04:22 INFO - Installing distribute.............................................................................................................................................................................................done. 14:04:24 INFO - Installing pip.................done. 14:04:24 INFO - Return code: 0 14:04:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:04:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:24 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 0x7f920fd5ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x154c900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1592b70>, '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 0x15e3dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e4250>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1447970598.846722-1189925068', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:04:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:04:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:04:24 INFO - Using env: {'DISPLAY': ':0', 14:04:24 INFO - 'HOME': '/home/cltbld', 14:04:24 INFO - 'LANG': 'en_US.UTF-8', 14:04:24 INFO - 'LANGUAGE': 'en_US:en', 14:04:24 INFO - 'LOGNAME': 'cltbld', 14:04:24 INFO - 'MAIL': '/var/mail/cltbld', 14:04:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:24 INFO - 'MOZ_NO_REMOTE': '1', 14:04:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:04:24 INFO - 'NO_EM_RESTART': '1', 14:04:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:04:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:24 INFO - 'PWD': '/builds/slave/test', 14:04:24 INFO - 'SHELL': '/bin/bash', 14:04:24 INFO - 'SHLVL': '1', 14:04:24 INFO - 'TERM': 'linux', 14:04:24 INFO - 'TMOUT': '86400', 14:04:24 INFO - 'USER': 'cltbld', 14:04:24 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1447970598.846722-1189925068', 14:04:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:24 INFO - '_': '/tools/buildbot/bin/python'} 14:04:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:24 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:04:24 INFO - Cleaning up... 14:04:24 INFO - Return code: 0 14:04:24 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:04:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:24 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 0x7f920fd5ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x154c900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1592b70>, '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 0x15e3dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e4250>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1447970598.846722-1189925068', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:04:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 14:04:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:04:24 INFO - Using env: {'DISPLAY': ':0', 14:04:24 INFO - 'HOME': '/home/cltbld', 14:04:24 INFO - 'LANG': 'en_US.UTF-8', 14:04:24 INFO - 'LANGUAGE': 'en_US:en', 14:04:24 INFO - 'LOGNAME': 'cltbld', 14:04:24 INFO - 'MAIL': '/var/mail/cltbld', 14:04:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:24 INFO - 'MOZ_NO_REMOTE': '1', 14:04:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:04:24 INFO - 'NO_EM_RESTART': '1', 14:04:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:04:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:24 INFO - 'PWD': '/builds/slave/test', 14:04:24 INFO - 'SHELL': '/bin/bash', 14:04:24 INFO - 'SHLVL': '1', 14:04:24 INFO - 'TERM': 'linux', 14:04:24 INFO - 'TMOUT': '86400', 14:04:24 INFO - 'USER': 'cltbld', 14:04:24 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1447970598.846722-1189925068', 14:04:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:24 INFO - '_': '/tools/buildbot/bin/python'} 14:04:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:24 INFO - Downloading/unpacking psutil>=0.7.1 14:04:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:26 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 14:04:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 14:04:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:04:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:04:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:04:26 INFO - Installing collected packages: psutil 14:04:26 INFO - Running setup.py install for psutil 14:04:26 INFO - building 'psutil._psutil_linux' extension 14:04:26 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:04:26 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:04:26 INFO - building 'psutil._psutil_posix' extension 14:04:26 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:04:26 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:04:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:04:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:04:26 INFO - Successfully installed psutil 14:04:26 INFO - Cleaning up... 14:04:26 INFO - Return code: 0 14:04:26 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:04:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:26 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 0x7f920fd5ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x154c900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1592b70>, '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 0x15e3dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e4250>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1447970598.846722-1189925068', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:04:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 14:04:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:04:26 INFO - Using env: {'DISPLAY': ':0', 14:04:26 INFO - 'HOME': '/home/cltbld', 14:04:26 INFO - 'LANG': 'en_US.UTF-8', 14:04:26 INFO - 'LANGUAGE': 'en_US:en', 14:04:26 INFO - 'LOGNAME': 'cltbld', 14:04:26 INFO - 'MAIL': '/var/mail/cltbld', 14:04:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:26 INFO - 'MOZ_NO_REMOTE': '1', 14:04:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:04:26 INFO - 'NO_EM_RESTART': '1', 14:04:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:04:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:26 INFO - 'PWD': '/builds/slave/test', 14:04:26 INFO - 'SHELL': '/bin/bash', 14:04:26 INFO - 'SHLVL': '1', 14:04:26 INFO - 'TERM': 'linux', 14:04:26 INFO - 'TMOUT': '86400', 14:04:26 INFO - 'USER': 'cltbld', 14:04:26 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1447970598.846722-1189925068', 14:04:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:26 INFO - '_': '/tools/buildbot/bin/python'} 14:04:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:26 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:04:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:28 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:04:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 14:04:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:04:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:04:28 INFO - Installing collected packages: mozsystemmonitor 14:04:28 INFO - Running setup.py install for mozsystemmonitor 14:04:28 INFO - Successfully installed mozsystemmonitor 14:04:28 INFO - Cleaning up... 14:04:28 INFO - Return code: 0 14:04:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:04:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:28 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 0x7f920fd5ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x154c900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1592b70>, '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 0x15e3dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e4250>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1447970598.846722-1189925068', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:04:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:04:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:04:28 INFO - Using env: {'DISPLAY': ':0', 14:04:28 INFO - 'HOME': '/home/cltbld', 14:04:28 INFO - 'LANG': 'en_US.UTF-8', 14:04:28 INFO - 'LANGUAGE': 'en_US:en', 14:04:28 INFO - 'LOGNAME': 'cltbld', 14:04:28 INFO - 'MAIL': '/var/mail/cltbld', 14:04:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:28 INFO - 'MOZ_NO_REMOTE': '1', 14:04:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:04:28 INFO - 'NO_EM_RESTART': '1', 14:04:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:04:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:28 INFO - 'PWD': '/builds/slave/test', 14:04:28 INFO - 'SHELL': '/bin/bash', 14:04:28 INFO - 'SHLVL': '1', 14:04:28 INFO - 'TERM': 'linux', 14:04:28 INFO - 'TMOUT': '86400', 14:04:28 INFO - 'USER': 'cltbld', 14:04:28 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1447970598.846722-1189925068', 14:04:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:28 INFO - '_': '/tools/buildbot/bin/python'} 14:04:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:29 INFO - Downloading/unpacking blobuploader==1.2.4 14:04:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:30 INFO - Downloading blobuploader-1.2.4.tar.gz 14:04:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 14:04:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:04:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:04:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 14:04:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:04:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:04:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:31 INFO - Downloading docopt-0.6.1.tar.gz 14:04:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 14:04:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:04:31 INFO - Installing collected packages: blobuploader, requests, docopt 14:04:31 INFO - Running setup.py install for blobuploader 14:04:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:04:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:04:31 INFO - Running setup.py install for requests 14:04:31 INFO - Running setup.py install for docopt 14:04:31 INFO - Successfully installed blobuploader requests docopt 14:04:31 INFO - Cleaning up... 14:04:32 INFO - Return code: 0 14:04:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:04:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:32 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 0x7f920fd5ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x154c900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1592b70>, '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 0x15e3dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e4250>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1447970598.846722-1189925068', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:04:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:04:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:04:32 INFO - Using env: {'DISPLAY': ':0', 14:04:32 INFO - 'HOME': '/home/cltbld', 14:04:32 INFO - 'LANG': 'en_US.UTF-8', 14:04:32 INFO - 'LANGUAGE': 'en_US:en', 14:04:32 INFO - 'LOGNAME': 'cltbld', 14:04:32 INFO - 'MAIL': '/var/mail/cltbld', 14:04:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:32 INFO - 'MOZ_NO_REMOTE': '1', 14:04:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:04:32 INFO - 'NO_EM_RESTART': '1', 14:04:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:04:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:32 INFO - 'PWD': '/builds/slave/test', 14:04:32 INFO - 'SHELL': '/bin/bash', 14:04:32 INFO - 'SHLVL': '1', 14:04:32 INFO - 'TERM': 'linux', 14:04:32 INFO - 'TMOUT': '86400', 14:04:32 INFO - 'USER': 'cltbld', 14:04:32 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1447970598.846722-1189925068', 14:04:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:32 INFO - '_': '/tools/buildbot/bin/python'} 14:04:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:04:32 INFO - Running setup.py (path:/tmp/pip-sLKCF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:04:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:04:32 INFO - Running setup.py (path:/tmp/pip-50UpQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:04:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:04:32 INFO - Running setup.py (path:/tmp/pip-u6XAVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:04:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:04:32 INFO - Running setup.py (path:/tmp/pip-0QqgOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:04:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:04:32 INFO - Running setup.py (path:/tmp/pip-bZTteM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:04:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:04:32 INFO - Running setup.py (path:/tmp/pip-N5dd4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:04:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:04:32 INFO - Running setup.py (path:/tmp/pip-n0qf1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:04:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:04:32 INFO - Running setup.py (path:/tmp/pip-3HsM1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:04:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:04:32 INFO - Running setup.py (path:/tmp/pip-bzeQHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:04:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:04:32 INFO - Running setup.py (path:/tmp/pip-5uFmUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:04:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:04:32 INFO - Running setup.py (path:/tmp/pip-SfAn9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:04:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:04:33 INFO - Running setup.py (path:/tmp/pip-Tg75O8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:04:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:04:33 INFO - Running setup.py (path:/tmp/pip-K3KK96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:04:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:04:33 INFO - Running setup.py (path:/tmp/pip-sohuJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:04:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:04:33 INFO - Running setup.py (path:/tmp/pip-Tav01W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:04:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:04:33 INFO - Running setup.py (path:/tmp/pip-gT2VuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:04:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:04:33 INFO - Running setup.py (path:/tmp/pip-LZcCIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:04:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:04:33 INFO - Running setup.py install for manifestparser 14:04:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:04:33 INFO - Running setup.py install for mozcrash 14:04:33 INFO - Running setup.py install for mozdebug 14:04:33 INFO - Running setup.py install for mozdevice 14:04:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:04:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:04:33 INFO - Running setup.py install for mozfile 14:04:33 INFO - Running setup.py install for mozhttpd 14:04:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:04:34 INFO - Running setup.py install for mozinfo 14:04:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:04:34 INFO - Running setup.py install for mozInstall 14:04:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:04:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:04:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:04:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:04:34 INFO - Running setup.py install for mozleak 14:04:34 INFO - Running setup.py install for mozlog 14:04:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:04:34 INFO - Running setup.py install for moznetwork 14:04:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:04:34 INFO - Running setup.py install for mozprocess 14:04:34 INFO - Running setup.py install for mozprofile 14:04:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:04:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:04:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:04:34 INFO - Running setup.py install for mozrunner 14:04:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:04:34 INFO - Running setup.py install for mozscreenshot 14:04:34 INFO - Running setup.py install for moztest 14:04:35 INFO - Running setup.py install for mozversion 14:04:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:04:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:04:35 INFO - Cleaning up... 14:04:35 INFO - Return code: 0 14:04:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:04:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:35 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 0x7f920fd5ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x154c900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1592b70>, '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 0x15e3dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e4250>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1447970598.846722-1189925068', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:04:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:04:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:04:35 INFO - Using env: {'DISPLAY': ':0', 14:04:35 INFO - 'HOME': '/home/cltbld', 14:04:35 INFO - 'LANG': 'en_US.UTF-8', 14:04:35 INFO - 'LANGUAGE': 'en_US:en', 14:04:35 INFO - 'LOGNAME': 'cltbld', 14:04:35 INFO - 'MAIL': '/var/mail/cltbld', 14:04:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:35 INFO - 'MOZ_NO_REMOTE': '1', 14:04:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:04:35 INFO - 'NO_EM_RESTART': '1', 14:04:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:04:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:35 INFO - 'PWD': '/builds/slave/test', 14:04:35 INFO - 'SHELL': '/bin/bash', 14:04:35 INFO - 'SHLVL': '1', 14:04:35 INFO - 'TERM': 'linux', 14:04:35 INFO - 'TMOUT': '86400', 14:04:35 INFO - 'USER': 'cltbld', 14:04:35 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1447970598.846722-1189925068', 14:04:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:35 INFO - '_': '/tools/buildbot/bin/python'} 14:04:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:04:35 INFO - Running setup.py (path:/tmp/pip-ChTfUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:04:35 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:04:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:04:35 INFO - Running setup.py (path:/tmp/pip-L7TkIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:04:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:04:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:04:35 INFO - Running setup.py (path:/tmp/pip-BNl5NY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:04:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:04:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:04:35 INFO - Running setup.py (path:/tmp/pip-4wIgpm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:04:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:04:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:04:35 INFO - Running setup.py (path:/tmp/pip-uhf6HB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:04:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:04:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:04:35 INFO - Running setup.py (path:/tmp/pip-U1Cw3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:04:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:04:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:04:35 INFO - Running setup.py (path:/tmp/pip-LuUNAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:04:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:04:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:04:35 INFO - Running setup.py (path:/tmp/pip-7UbPH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:04:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:04:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:04:36 INFO - Running setup.py (path:/tmp/pip-TPgR5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:04:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:04:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:04:36 INFO - Running setup.py (path:/tmp/pip-ExcFvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:04:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:04:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:04:36 INFO - Running setup.py (path:/tmp/pip-gi2mJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:04:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:04:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:04:36 INFO - Running setup.py (path:/tmp/pip-IQCj6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:04:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:04:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:04:36 INFO - Running setup.py (path:/tmp/pip-v_NLtI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:04:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:04:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:04:36 INFO - Running setup.py (path:/tmp/pip-27J1QZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:04:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:04:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:04:36 INFO - Running setup.py (path:/tmp/pip-pIQ8W9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:04:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:04:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:04:36 INFO - Running setup.py (path:/tmp/pip-RPBOZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:04:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:04:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:04:36 INFO - Running setup.py (path:/tmp/pip-uUzIY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:04:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:04:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:04:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:04:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:04:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:04:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:04:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:04:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:38 INFO - Downloading blessings-1.5.1.tar.gz 14:04:38 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 14:04:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:04:38 INFO - Installing collected packages: blessings 14:04:38 INFO - Running setup.py install for blessings 14:04:38 INFO - Successfully installed blessings 14:04:38 INFO - Cleaning up... 14:04:38 INFO - Return code: 0 14:04:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:04:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:04:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:04:38 INFO - Reading from file tmpfile_stdout 14:04:38 INFO - Current package versions: 14:04:38 INFO - argparse == 1.2.1 14:04:38 INFO - blessings == 1.5.1 14:04:38 INFO - blobuploader == 1.2.4 14:04:38 INFO - docopt == 0.6.1 14:04:38 INFO - manifestparser == 1.1 14:04:38 INFO - mozInstall == 1.12 14:04:38 INFO - mozcrash == 0.16 14:04:38 INFO - mozdebug == 0.1 14:04:38 INFO - mozdevice == 0.47 14:04:38 INFO - mozfile == 1.2 14:04:38 INFO - mozhttpd == 0.7 14:04:38 INFO - mozinfo == 0.9 14:04:38 INFO - mozleak == 0.1 14:04:38 INFO - mozlog == 3.0 14:04:38 INFO - moznetwork == 0.27 14:04:38 INFO - mozprocess == 0.22 14:04:38 INFO - mozprofile == 0.27 14:04:38 INFO - mozrunner == 6.11 14:04:38 INFO - mozscreenshot == 0.1 14:04:38 INFO - mozsystemmonitor == 0.0 14:04:38 INFO - moztest == 0.7 14:04:38 INFO - mozversion == 1.4 14:04:38 INFO - psutil == 3.1.1 14:04:38 INFO - requests == 1.2.3 14:04:38 INFO - wsgiref == 0.1.2 14:04:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:04:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:38 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 0x7f920fd5ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x154c900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1592b70>, '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 0x15e3dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e4250>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1447970598.846722-1189925068', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:04:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:04:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:04:38 INFO - Using env: {'DISPLAY': ':0', 14:04:38 INFO - 'HOME': '/home/cltbld', 14:04:38 INFO - 'LANG': 'en_US.UTF-8', 14:04:38 INFO - 'LANGUAGE': 'en_US:en', 14:04:38 INFO - 'LOGNAME': 'cltbld', 14:04:38 INFO - 'MAIL': '/var/mail/cltbld', 14:04:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:38 INFO - 'MOZ_NO_REMOTE': '1', 14:04:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:04:38 INFO - 'NO_EM_RESTART': '1', 14:04:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:04:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:38 INFO - 'PWD': '/builds/slave/test', 14:04:38 INFO - 'SHELL': '/bin/bash', 14:04:38 INFO - 'SHLVL': '1', 14:04:38 INFO - 'TERM': 'linux', 14:04:38 INFO - 'TMOUT': '86400', 14:04:38 INFO - 'USER': 'cltbld', 14:04:38 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1447970598.846722-1189925068', 14:04:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:38 INFO - '_': '/tools/buildbot/bin/python'} 14:04:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:04:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:04:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:04:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:04:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:04:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:04:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:04:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:04:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:04:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:04:38 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:04:38 INFO - Cleaning up... 14:04:38 INFO - Return code: 0 14:04:38 INFO - Running post-action listener: _resource_record_post_action 14:04:38 INFO - Running post-action listener: _start_resource_monitoring 14:04:39 INFO - Starting resource monitoring. 14:04:39 INFO - ##### 14:04:39 INFO - ##### Running install step. 14:04:39 INFO - ##### 14:04:39 INFO - Running pre-action listener: _resource_record_pre_action 14:04:39 INFO - Running main action method: install 14:04:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:04:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:04:39 INFO - Reading from file tmpfile_stdout 14:04:39 INFO - Detecting whether we're running mozinstall >=1.0... 14:04:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:04:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:04:39 INFO - Reading from file tmpfile_stdout 14:04:39 INFO - Output received: 14:04:39 INFO - Usage: mozinstall [options] installer 14:04:39 INFO - Options: 14:04:39 INFO - -h, --help show this help message and exit 14:04:39 INFO - -d DEST, --destination=DEST 14:04:39 INFO - Directory to install application into. [default: 14:04:39 INFO - "/builds/slave/test"] 14:04:39 INFO - --app=APP Application being installed. [default: firefox] 14:04:39 INFO - mkdir: /builds/slave/test/build/application 14:04:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:04:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:04:53 INFO - Reading from file tmpfile_stdout 14:04:53 INFO - Output received: 14:04:53 INFO - /builds/slave/test/build/application/firefox/firefox 14:04:53 INFO - Running post-action listener: _resource_record_post_action 14:04:53 INFO - ##### 14:04:53 INFO - ##### Running run-tests step. 14:04:53 INFO - ##### 14:04:53 INFO - Running pre-action listener: _resource_record_pre_action 14:04:53 INFO - Running main action method: run_tests 14:04:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:04:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:04:53 INFO - Python 2.7.3 14:04:53 INFO - Return code: 0 14:04:53 INFO - grabbing minidump binary from tooltool 14:04:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:53 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 0x1592b70>, '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 0x15e3dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e4250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:04:53 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:04:53 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:04:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:04:53 INFO - Return code: 0 14:04:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:04:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:04:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:04:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:04:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:04:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WoKItLM1TZig9NxMwSfwDw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost'] in /builds/slave/test/build 14:04:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName B2G-Inbound-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WoKItLM1TZig9NxMwSfwDw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --webServer localhost 14:04:53 INFO - Using env: {'DISPLAY': ':0', 14:04:53 INFO - 'HOME': '/home/cltbld', 14:04:53 INFO - 'LANG': 'en_US.UTF-8', 14:04:53 INFO - 'LANGUAGE': 'en_US:en', 14:04:53 INFO - 'LOGNAME': 'cltbld', 14:04:53 INFO - 'MAIL': '/var/mail/cltbld', 14:04:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:04:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:04:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:53 INFO - 'MOZ_NO_REMOTE': '1', 14:04:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:04:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:04:53 INFO - 'NO_EM_RESTART': '1', 14:04:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:04:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:53 INFO - 'PWD': '/builds/slave/test', 14:04:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:04:53 INFO - 'SHELL': '/bin/bash', 14:04:53 INFO - 'SHLVL': '1', 14:04:53 INFO - 'TERM': 'linux', 14:04:53 INFO - 'TMOUT': '86400', 14:04:53 INFO - 'USER': 'cltbld', 14:04:53 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1447970598.846722-1189925068', 14:04:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:53 INFO - '_': '/tools/buildbot/bin/python'} 14:04:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WoKItLM1TZig9NxMwSfwDw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost'] with output_timeout 3600 14:04:53 INFO - mozversion INFO | application_buildid: 20151119115539 14:04:53 INFO - mozversion INFO | application_changeset: 0e866e588827af7a1785d6777e3ef5ef15022bde 14:04:53 INFO - mozversion INFO | application_display_name: Nightly 14:04:53 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:04:53 INFO - mozversion INFO | application_name: Firefox 14:04:53 INFO - mozversion INFO | application_remotingname: firefox 14:04:53 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 14:04:53 INFO - mozversion INFO | application_vendor: Mozilla 14:04:53 INFO - mozversion INFO | application_version: 45.0a1 14:04:53 INFO - mozversion INFO | platform_buildid: 20151119115539 14:04:53 INFO - mozversion INFO | platform_changeset: 0e866e588827af7a1785d6777e3ef5ef15022bde 14:04:53 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 14:04:53 INFO - mozversion INFO | platform_version: 45.0a1 14:04:53 INFO - 2015-11-19 14:04:53,651 DEBUG : using testdate: 1447970693 14:04:53 INFO - 2015-11-19 14:04:53,651 DEBUG : actual date: 1447970693 14:04:53 INFO - 2015-11-19 14:04:53,659 INFO : starting webserver on 'localhost:38296' 14:04:53 INFO - 2015-11-19 14:04:53,659 INFO : Starting test suite talos-linux64-ix-009 14:04:53 INFO - 2015-11-19 14:04:53,659 INFO : Starting test dromaeo_css 14:04:53 INFO - 2015-11-19 14:04:53,660 DEBUG : operating with platform_type : linux_ 14:04:53 INFO - 2015-11-19 14:04:53,660 INFO : Initialising browser for dromaeo_css test... 14:04:53 INFO - 2015-11-19 14:04:53,667 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpINF5RQ/profile http://localhost:38296/getInfo.html 14:04:58 INFO - 2015-11-19 14:04:58,611 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:04:58 INFO - 2015-11-19 14:04:58,611 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:04:58 INFO - 2015-11-19 14:04:58,611 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:04:58 INFO - 2015-11-19 14:04:58,611 DEBUG : BROWSER_OUTPUT: __metrics 14:04:58 INFO - 2015-11-19 14:04:58,760 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:05:00 INFO - 2015-11-19 14:05:00,136 INFO : Browser initialized. 14:05:00 INFO - 2015-11-19 14:05:00,137 INFO : Running cycle 1/1 for dromaeo_css test... 14:05:00 INFO - 2015-11-19 14:05:00,137 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpINF5RQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:05:12 INFO - 2015-11-19 14:05:12,039 DEBUG : BROWSER_OUTPUT: RSS: Main: 141664256 14:05:12 INFO - 2015-11-19 14:05:12,039 DEBUG : BROWSER_OUTPUT: 14:06:03 INFO - 2015-11-19 14:06:03,262 DEBUG : BROWSER_OUTPUT: 1447970763261 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:08:15 INFO - 2015-11-19 14:08:15,376 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38296/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38296/tests/dromaeo/cssquery-ext.html) 14:08:16 INFO - 2015-11-19 14:08:16,400 DEBUG : BROWSER_OUTPUT: RSS: Main: 229662720 14:08:16 INFO - 2015-11-19 14:08:16,400 DEBUG : BROWSER_OUTPUT: 14:11:18 INFO - 2015-11-19 14:11:18,694 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38296/tests/dromaeo/cssquery-ext.html (next: http://localhost:38296/tests/dromaeo/cssquery-jquery.html) 14:11:19 INFO - 2015-11-19 14:11:19,263 DEBUG : BROWSER_OUTPUT: RSS: Main: 220213248 14:11:19 INFO - 2015-11-19 14:11:19,264 DEBUG : BROWSER_OUTPUT: 14:14:21 INFO - 2015-11-19 14:14:21,342 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38296/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38296/tests/dromaeo/cssquery-mootools.html) 14:14:21 INFO - 2015-11-19 14:14:21,915 DEBUG : BROWSER_OUTPUT: RSS: Main: 213377024 14:14:21 INFO - 2015-11-19 14:14:21,916 DEBUG : BROWSER_OUTPUT: 14:17:23 INFO - 2015-11-19 14:17:23,951 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38296/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38296/tests/dromaeo/cssquery-prototype.html) 14:17:24 INFO - 2015-11-19 14:17:24,537 DEBUG : BROWSER_OUTPUT: RSS: Main: 198656000 14:17:24 INFO - 2015-11-19 14:17:24,538 DEBUG : BROWSER_OUTPUT: 14:20:27 INFO - 2015-11-19 14:20:27,329 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38296/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38296/tests/dromaeo/cssquery-yui.html) 14:20:27 INFO - 2015-11-19 14:20:27,910 DEBUG : BROWSER_OUTPUT: RSS: Main: 200962048 14:20:27 INFO - 2015-11-19 14:20:27,910 DEBUG : BROWSER_OUTPUT: 14:23:30 INFO - 2015-11-19 14:23:30,539 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38296/tests/dromaeo/cssquery-yui.html (next: http://localhost:38296/tests/dromaeo/cssquery-dojo.html) 14:23:30 INFO - 2015-11-19 14:23:30,797 DEBUG : BROWSER_OUTPUT: RSS: Main: 245207040 14:23:30 INFO - 2015-11-19 14:23:30,797 DEBUG : BROWSER_OUTPUT: 14:23:30 INFO - 2015-11-19 14:23:30,797 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:23:30 INFO - 2015-11-19 14:23:30,798 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:23:30 INFO - 2015-11-19 14:23:30,799 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:23:30 INFO - 2015-11-19 14:23:30,799 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:23:30 INFO - 2015-11-19 14:23:30,799 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2611.6865976082872;2735.0700761741004;2749.2164733051086;2759.3377589378542;2770;4651.302304654304;4774.856754297377;4831.806727730891;4880.194767863302;4906.460289368171;4753.976230118845;4798.808047678098;4833.468318484973;4879.634027447947;4893.4617192108835;4431.689781715281;4457.33140028995;4469.977650111745;4526.502084770673;4547.590716835484;4530.252508336121;4558.772061396917;4578.267477203648;4579.564941330568;4601.677882548223;4320.524742278331;4404.66964977628;4434.423524941769;4436.046250056221;4530.433695788027;4479.820807167709;4491.39366185564;4510.985028368624;4518.344839998182;4538.659600529973;4458.643308535309;4466.620337271336;4469.5753903379455;4470.642348612136;4507.729536227836;4567.817287308504;4718.834840780591;4743.193657078305;4783.7129772213775;4837.9032419351415;5059.797608095671;5121.487851214886;5150.459201783796;5152.562032227265;5202.817901373433;5192.71440070796;5237.528622423962;5267.5259226669405;5280.867978300574;5317.707526086064;4609.815607375667;4713.6936099153445;4715.127701375257;4858.902821943541;4863.416390033183;5200.219967004904;5286;5298.576113910955;5304.867378315573;5348.465153484621;5147.3051138096625;5157.355330583677;5159;5165.896682066337;5166.922496162485;4975.800967961313;5096.592272618182;5105.566026887682;5251.2123181523075;5313.07021271276;4965.851024469272;5048.242763585418;5052.797888084509;5061.696298222045;5102.387713474407;5102.260172275073;5136.357955255593;5149.944261426399;5153.458886816905;5186.792528298825;4115.409758126839;4259.701820872509;4264.061906380592;4387.166438376698;4424.557544245549;3696.5009723687494;3764.4541541476333;3796;3807.3717836556657;3816.2558301131567;4436.245838207513;4437.755923424243;4468.017036252019;4476.888077798081;4486.798094085774;4917.164082106051;5030.622703297267;5155.716435596079;5156.407013193456;5165.741712914414;4351.282038463618;4424.6239069678795;4452.8218871245435;4484.170428470743;4516.299973504112;4643.582077613031;4652.883677908012;4655.627549796008;4658.487566367697;4684.344191813149;4767.785449654843;4891.388576427947;4952.306677065142;4952.4304704959395;4992.700437973734;5125.154349532286;5128.230765385222;5184.377874655065;5279.234510995807;5307.708076055854;4977.726225057657;4978.327925730125;4985.775640096132;5007.173816320266;5025;5150.536451719363;5152.639315247897;5156.097682905552;5157.793688252428;5203.349581302337;4956.306117143531;5134.7946082156295;5138.997895410359;5230.372355317386;5242.318498595158;4903.362562866804;4993.076280888047;5000.1749711297225;5000.924986125138;5045.4450010498085;5017.297578338962;5020;5028.547430731252;5030.0694371541385;5072.5688316493515;4716.693414928019;4799.904001920012;4810.254410566367;4928.865815962658;4932.432770231326;4896.706197628154;5008.5492305691205;5008.599312055099;5013.774380152829;5034.597232221487;4917.606591472745;4959.82640607577;4961.677490963076;4966.428860681068;5007.24891266313 14:23:30 INFO - 2015-11-19 14:23:30,800 DEBUG : BROWSER_OUTPUT: |1;ext.html;560.2744445942504;569.4447913284548;578.756922092721;579.7941730685609;583.4777873802947;28626.85686571567;29169.124926252192;37720.43419348705;38283.80858095713;38299;40797.30830954441;41364.58635413645;41431.378529322006;41447.79276103623;41488;7053.753118640849;7956.403269754763;8124.431289809716;8125.634346454394;8127.837443251132;7091.680874360641;7174.139103307584;7175.4977151599405;7181.640917954108;9971.90028099717;10142.594296228142;10259.281850270447;10272.897271027268;10281.434521101337;10282.074613284803;10093.192544596452;10196.235282353853;10196.796064078677;10197.490125493696;10210.030047145508;10060.647877324333;10136.54385552652;10186.185105191567;10189.286749927509;10215.080642742114;38453.885036322994;38915.22169556593;38947.610523894684;39010;39030.80484597559;2888.3068063664778;2929.26768307923;2978.717021882918;2987.6862929392537;3569;28578.428431431465;28884.566731499046;29111.41777164445;29183.41633167346;29647.40705185884;3103.1001009707156;3120.329129237225;3137.262743255333;3173.079806856009;3212.1969507623094;227319;228634;228719;228822.99999999834;229327;44641.776791116485;45717.771411142734;56430.717846411324;56518.7174064127;57613.13580296215;51772.74113629408;51823;52045;52048.21927671088;52151.47848521542;13333.20000799955;13573.389197486136;13575.185488870698;13580.38888250031;13586.796198057036;10219.540120694586;10293.7426564335;10315.484225788681;10342.069213770797;10394.48027598617;18768.343107991153;18945.526361840788;19059.142338594796;19073.332433364765;19075.713864292047;7492.962535187289;7763.4953728007495;7860.318599597269;7907.169747176578;7938.206179382016;835.0939230934383;912.3203213605774;918.6095909238547;981.1954197558076;999.6458340607909;23520.882395587912;23867.283981480236;23981.760182398302;24001.7599824003;24022.87988560046;947.7583216279804;982.5087456271864;1010.4240582867695;1030.5826140413144;1063.2822844580032;12936.805947910789;13151.868481315256;13154.473821047242;13289.867101329057;13292.68837597246;269159;273579;273700;273836;273922;46424;46911;47067.529324707;47084.293735593994;47115.29327060097;1030.3251370352432;1115.4255558387438;1190.8035174196161;1207.4988879614862;1212.3998620682642;24126.51746965086;26659.20022399331;26984.73015269901;27147.499152761742;27213.86393068101;37503.624963750015;37915.43126853044;37922;37955.81022094872;37956.810215948746;244830;250900;251806;303111;309886;27550.44899102047;27897.860510697315;28079.507278835288;28114.578281325386;28143.43713125767;38379.808100959315;39087.6091239084;39515.2096958065;39677.80161099176;39717.40423893586;33430.49854252237;34126.658733413344;34462.310753785285;34639.653603463645;35077;32548.349033018734;34738.82630586831;35021;35094.29811403809;35183.64816351804;30040.360567626158;30747.53878691777;30771.846140769154;30936.53595196029;30951.69048309488;26519.204423867315;28035.859820701582;30659;30921.69078309278;31075;23023.53952920966;23240.18659346915;23517.41206469852;23767.762322376555;23774.286771396884 14:23:30 INFO - 2015-11-19 14:23:30,800 DEBUG : BROWSER_OUTPUT: |2;jquery.html;338.9474631432128;340.67805923402386;341.8478776944259;343.585978895431;345.25941854721606;12660;13044.93477532611;14988.92505537472;15206.239688015596;17385.47843564695;15720.606984825385;15893.682126357466;16507.58731031725;16515.91742041288;16528.504144875675;4894.828680996157;5135.512126347991;5135.563477104451;5136.64043516954;5136.820211292606;3543.4153364694794;3642.3625865473437;5060.165072762989;5676.914846277309;5919.644821310713;5793.594448388614;5834.6790926499025;5836.270466191726;5847.619904706202;5861.0915308127305;5697;5851.795187168429;5903.055511118222;5905.143754155645;5908.704564771744;5146.897062058738;5159.535641792219;5163;5178.559822415099;5186.7147306898105;18385.908070459696;18597.907010464998;18741.15664795074;19110.61778764417;19544.31594894172;1825.863060270485;1901.8288354048202;1918.3094086128983;1931.8357939575153;2002.769681486633;12801.55194568195;12859.035572332112;12909.612711618667;13037.413316400785;13153.60539183826;1743.1807050686157;1754.5525890897738;1755.2013833705632;1770.530809335527;1814.7640806695176;52763;53742.73128634332;53786.193207101926;53907.46092539103;54107.18839217375;8781.209691127702;8872.467651940904;9024.8646270306;9058.864117038249;9089.5000774958;11261.155413344031;11266.605668801552;11280.830787538194;11296.943515282535;11307.434628268718;4797.472278049412;4907.558319751168;4914.655974081851;6819.965900170567;6886.621235832077;4986.925196122061;5020.3724534433195;5052.621053420935;5058.140116180185;5060.418051924003;3053.328267781085;3100.472919603673;3128.1710346758127;3129.6713845046397;3131.091983324856;991.9950400248097;1046.7383154211448;1084.4848696868924;1087.2009073331096;1162.0122895538893;374.6833925333089;389.08758960238197;407.84705735349246;420.04649445757957;422.0819717115262;9711.320207585542;9943.80112397748;10311.381317120997;10370.637027703995;11358.488868000959;430.34587427110614;438.2615293230916;440.0670578373868;447.8208716513421;452.7283629822146;6000.759969601167;6057.18228039209;6081.604695694766;6218.22272215973;6231.3145553989025;475655;479669;490258;494928;501563;65783.67108164428;65856.67071664611;65953;66507.00239496412;67463;479.36244794423334;483.8596806925952;484.5517895946236;485.39325842696627;485.6794515619745;9883.654072107442;10359.637412690821;10409.271351005356;10418.68743937683;10492.580296788348;32920;32923;33997.15007124842;34395.4840677385;34550.13624659403;39156.947900098094;39346.6065339343;41118.79440602778;45606;45932.7703361481;6304.306526282014;6468.450181734605;6516.837079073061;6528.575642583217;6532.902006469812;11511.94244028808;11621.36082515436;12012.819807702717;12029.639110826689;12047.397630118283;10442;10478.947605261925;10504.42225677595;10656.680299591024;10695.411752353695;9736.95131524338;10014.449205293779;10032.347897386646;10047.497625118862;10102.79794404093;8429.536375499407;9568.330216884751;10261.692149235534;10327.380357178594;10402.791944160923;5581.609287350009;6234.410225392496;6244.219472565929;6317.96841015792;6368.4586810121655;9963;9992;9992.65025724096;10082.395056296646;10305.124064454605 14:23:30 INFO - 2015-11-19 14:23:30,801 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1431.1770731829201;1635.035329155798;1688.8395602417766;1706.4368758309759;1722.1561434896905;6511.869762604751;7023.578585284887;7092.751753688622;7109.182444018939;7112.359887610114;7357.117145942494;7432.219616940224;7464.066991626047;7485.401167906568;7488.475806693534;1703.752955821405;1718.6133120048014;1720.6472673101985;2140.1118535807623;2170.913163473459;1839.7700287464068;2090.2370634718295;2140.892955352234;2148.677698345245;2151.741790985084;2030.1734023352997;2068.48287928018;2074.9481262968397;2092.3722883135074;2111.1660893946882;1792.2920446423655;1826.6803309420932;2057.07431655754;2101.149034640973;2137;2007.518195633052;2013.7514740860613;2023.2918478532542;2023.7672667643262;2025.3215172917091;7351.081114860643;7520.962395188044;7538.8115297117465;7541.396688264926;7546.358559522447;4431.290993441034;4524.434445694288;4535.546445355471;4553.430821147356;4558.8632341029825;2742.3966727319957;2859.042220856016;2860.1419574127885;2875.7268059534313;2887.812292201;845.4927043773748;889.6041261638574;903.0382642485731;907.1065000974036;907.9727608171765;10184.89815101847;10219.642312519027;10221.79556408875;10224.846627300596;10231.437270950095;4005.7997100144876;4093.467849179647;4173.5409104998425;4199.160167966358;4200.369944508348;8343.16568343173;8400.915990840136;8402.41183117176;8413.200745929127;8419.284360829275;4470.329450582439;4479.529649386767;4483.574060464251;4490.326451032372;4496.797644106023;4118.938215926763;4119.9176016479505;4134.607212314825;4139.9793001035405;4167.6457501112745;3162.8418579070953;3239.2549713566013;3269.6594396297405;3271.8527666255077;3275.918102047468;961.6489981156827;964.5032808103692;969.2197780786394;970.3789574672215;971.0386717150112;873.724776695339;878.6441491196076;1169.479581586186;1174.8002839517133;1198.988010119905;7138.750143745048;7163.964180179066;7174.820629484305;7205.675744591401;7240.493165478366;395.53327074052896;399.6542990313358;400.39340399295094;400.96591789698203;403.0246802737383;5104.464031276737;5191.402988656353;5497.697626630494;5738.512226460798;5803.8549036274435;8945;8947.507887066144;9165.083491650781;9180.219681327162;9181.770455738526;9083.636654533744;9128.178463938144;9133.406328588753;9225.400348977295;9245.306602004877;7042.401395881305;7049.189343225595;7178.676959536833;7191.029211056545;7192.892106618405;6835.316468353324;7065.010898474115;7099.112610923635;7108.07595012645;7117.181524124792;7869.370450363843;8063.758087257157;8220.671173153247;8232.259096681328;8244.051934027664;8074.354051675734;8136.779483077586;8138.674453021813;8187.3040791531;8443.746687599381;6290.402411770874;6353.96823015882;6366.045093235866;6376.298607153302;6389.7124629390855;6830.487713421613;7001.929980700332;7010.68451919675;7011.509194356346;7027.964860175666;6526.347365263436;6553.639549824806;6661.4004739573675;6705.262421133574;6796.864062718619;6476.935230647633;6618.635975021228;6631.403173714389;6705.161854768154;6745.460363171032;6709.027191057172;6745.460363171032;6747.089142965637;6752.662366881735;6761.628110453776;6131.478824299806;6171;6179.536534760001;6186.938130618636;6310.652914089769;6458.418742313026;6547.247066587403;6551.868962620816;6553.639549824806;6567.179102612174 14:23:30 INFO - 2015-11-19 14:23:30,803 DEBUG : BROWSER_OUTPUT: |4;prototype.html;312.1400541508145;318.53175831527653;324.3367313843192;325.03788785195826;326.8741534509213;5422;5422.8915421691545;5534.391216966131;5548.528375088117;5550.306211723535;5189.766460509277;5340.599455040868;5341.332333458317;5347.946520534793;5452.700101494416;4133.132042271127;4187.099773548694;4187.33002719565;4232.640225580814;4291.678124140686;4265.616094551489;4266.274733295348;4281.379200015996;4286.57134286572;4288.056627541936;4015.7791321477307;4248.745075295492;4250.128723611668;4256.2338779019765;4257.233697934371;4085.3259212229946;4132.4421203137645;4193.245215861144;4234.9364759528635;4247.957520424818;3742.700583953277;3746.1009357754215;3746.83139258734;3752.868649597251;3754.0427191066105;5255.947440525584;5256.237845512417;5256.50063243995;5258.395284542288;5264.2893209416625;4893;4898;4898.265260210961;4900.044491324194;4902.852914412573;5588.077967135418;5735.082386818089;5738.569607279429;5745.770169193227;5748.338941021752;3997;3998.3202855514633;3998.9200215995515;3999.8600048998437;4000.6799456043736;5956.493698035629;6040.550267935708;6041.063635136561;6044.546659000593;6044.667543285118;4026.67786577079;4115.71190016696;4118.382242663564;4118.91762164761;4119.649829764504;4181.97909010453;4187.45563076798;4188.958110418917;4197.160567886435;4209.7895105245225;4808.08646357191;4809.206480930678;4809.422869255712;4811;4812.844917219842;5739.827805165852;5745.2818397700285;5749.223854779551;5750.971245143747;5751.971240143773;1456.0899437851342;1482.8072350594355;1483.5401025682072;1484.332050577223;1485.138619600629;962.100436092256;963.5760265483165;973.2068364283086;974.9373183230313;982.975425614351;4915.3855768029;4924.60603151747;4924.679895806761;4936.777844996984;4943;5818.854528636818;5894.440028197314;5897.233359663216;5897.49871260939;5900.586958912921;5000.849974500771;5006.299118123466;5007.173816320266;5010.64925455222;5012.699238045729;3089.4902341113466;3137;3159.526071089355;3208.0536241808254;3213.694699003591;5576.693281869455;5603.579731520153;5606.579506536945;5677.17680936262;5685.744141513642;6169.691515424301;6175.228096487939;6178.7219575119225;6178.845528861814;6182.474489668429;5459.754311056012;5660.603757737002;5668.659880407106;5673.659580425187;5676.9432305678065;6006.609570377911;6011.729472173675;6014.48876845473;6016.21789167423;6017.699115044143;5880.235569375954;5883.705814709162;5884.146798714248;5884.146798714248;5885.61743486672;5566.638168519034;5661.57538184646;5681.318241811009;5687.232223649919;5694.032014557452;4074.898127546835;4123.731957422758;4126.793660317032;4129.463169787909;4132.173565287015;5978.760849565969;5981.773736383944;5988.191594134736;5989.071693887455;5999;5721.914171287351;5723.170140329712;5741.282339707536;5743.684097374685;5766.106253530709;5554.055810512304;5701.458361455655;5704.743286552032;5710;5769.769209231752;5607.327120745536;5645.870825834932;5649.85875353103;5656.2929633795775;5657.377688454185;5795.94204057954;5801.071828507418;5803.3616302207565;5805.535557155333;5832.12518122285;5480.177973303877;5598.524125449382;5604.523615492729;5665.603407761417;5669.149627555899 14:23:30 INFO - 2015-11-19 14:23:30,804 DEBUG : BROWSER_OUTPUT: |5;yui.html;686.135469308671;692.1521136607656;755.1957165618616;768.3699366519454;787.5038725602872;11542.538298468062;11742.119341049412;11764.588239411602;11783.764324713511;11798.351090690008;11679.941600292008;12709.936450317735;12938.870611293883;12952.805707914365;12958.222506649608;607.3228350389306;615.9568830181889;773.2924374197617;785.0500893918365;786.9016372953381;773.2267732267733;781.6170076662452;786.2491320788662;786.3316181245924;787.873940169573;794.8092457810113;808.5310519898475;818.3289702443998;819.1767273889733;819.8606236939705;630.3444417805476;635.7997230872261;789.5026133535864;803.5138741061631;819.8483280593109;584.2521572387351;585.4028890531633;595.0716881664574;595.0716881664617;595.5087053181143;11978.520859165623;12037.759244815143;12050.69873253167;12119.454624541917;12119.697007574792;8965.641374345018;9009.324300677476;9339.206167475773;9693.757656058584;10137.341072830242;8786.956065219696;8877.689280875204;8889.955550222208;9175.587098580512;9288.21050210733;2855.914322570326;2943.1906225787866;2957.438086763508;3031.242189452637;3039.8784048638026;35202.47196292058;36015.81992090049;36076;39775.40336894949;40052.198956021006;6497.675116244169;6559.048937903977;6584.144061272004;6616.074131795346;6649.700763465656;10435.37387756737;10447.791044179074;10484.4233567153;10498.42258675765;10520.26358154937;5672.602917795797;5688.488036076773;5708.771649133988;5796.275465566804;5901.704914754245;3586.8027258501033;3600.963990360063;3625.873094441682;3682.834272457746;3698.6856117230336;2526.9620955685677;2558.846469211853;2563.102913980092;2563.4873025394995;2564.025670245295;390.9081365879016;393.3745344901563;396.6707632664939;396.76590811421397;397.1243408284725;563.9904570818271;591.0576455044861;611.6605284067297;625.2372106030635;626.7242413338116;7345.88981165283;7472.286575492635;7629.351505122016;7679.2704693054075;7755.961220193863;455.90426010537493;594.7204813737536;605.7607245138233;632.4908448698842;660.7423104989058;3480.7215422766117;3544.989887114297;3726.6087060858763;3742.345089609362;4122.91754164915;50635;50835.745821270655;51261.231081533806;51398.486015140115;53959;45628;51140;51183.23225151626;51261.231081533806;51427;44139.337909931375;44141.33787993182;45916;46361.07277854424;46804.76597617058;7635.656395462106;8147.185281471805;8469.110743371857;8504.362172836938;8648.956755216184;32308.83845580757;32435;32689.836550817094;33305.16737081592;33459.330813384084;37980.24039519249;38329.6167038326;38693.22613547769;40817;41119.588804111576;10820;10895.182861285277;10995.285306455055;11041.39272340029;11130.610428634958;11005.339679619248;11044.42374645729;11528;11671.474783634927;11786.941065294961;10619.134158181621;10621.522031508755;10772.730681733019;10782.622608208674;10805.945970270413;10880.564777408816;11059.391733454737;11101.722456938318;11558.884411155781;11581.88418115808;8669.349798764992;9644;10137.290389672653;10245.436500992517;10632.468376581295;8627.063595408019;9093.897228004811;9332.766680833034;9447.055294470772;9781.657641982496;8816.206541411304;9029.23251523628;9072.274218062406;9130;9238.676646317346 14:23:30 INFO - 2015-11-19 14:23:30,804 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:23:30 INFO - 2015-11-19 14:23:30,804 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:23:30 INFO - 2015-11-19 14:23:30,804 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,786 14:23:30 INFO - 2015-11-19 14:23:30,804 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:23:30 INFO - 2015-11-19 14:23:30,804 DEBUG : BROWSER_OUTPUT: __startTimestamp1447971810797__endTimestamp 14:23:30 INFO - 2015-11-19 14:23:30,804 DEBUG : BROWSER_OUTPUT: 14:23:30 INFO - 2015-11-19 14:23:30,804 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:23:30 INFO - 2015-11-19 14:23:30,805 DEBUG : BROWSER_OUTPUT: Number of tests: 6 14:23:30 INFO - 2015-11-19 14:23:30,805 DEBUG : BROWSER_OUTPUT: 14:23:30 INFO - 2015-11-19 14:23:30,805 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4771.04 Median:4917.16 stddev:498.64 (10.1%) stddev-sans-first:470.52 14:23:30 INFO - 2015-11-19 14:23:30,805 DEBUG : BROWSER_OUTPUT: Values: 2611.7 2735.1 2749.2 2759.3 2770.0 4651.3 4774.9 4831.8 4880.2 4906.5 4754.0 4798.8 4833.5 4879.6 4893.5 4431.7 4457.3 4470.0 4526.5 4547.6 4530.3 4558.8 4578.3 4579.6 4601.7 4320.5 4404.7 4434.4 4436.0 4530.4 4479.8 4491.4 4511.0 4518.3 4538.7 4458.6 4466.6 4469.6 4470.6 4507.7 4567.8 4718.8 4743.2 4783.7 4837.9 5059.8 5121.5 5150.5 5152.6 5202.8 5192.7 5237.5 5267.5 5280.9 5317.7 4609.8 4713.7 4715.1 4858.9 4863.4 5200.2 5286.0 5298.6 5304.9 5348.5 5147.3 5157.4 5159.0 5165.9 5166.9 4975.8 5096.6 5105.6 5251.2 5313.1 4965.9 5048.2 5052.8 5061.7 5102.4 5102.3 5136.4 5149.9 5153.5 5186.8 4115.4 4259.7 4264.1 4387.2 4424.6 3696.5 3764.5 3796.0 3807.4 3816.3 4436.2 4437.8 4468.0 4476.9 4486.8 4917.2 5030.6 5155.7 5156.4 5165.7 4351.3 4424.6 4452.8 4484.2 4516.3 4643.6 4652.9 4655.6 4658.5 4684.3 4767.8 4891.4 4952.3 4952.4 4992.7 5125.2 5128.2 5184.4 5279.2 5307.7 4977.7 4978.3 4985.8 5007.2 5025.0 5150.5 5152.6 5156.1 5157.8 5203.3 4956.3 5134.8 5139.0 5230.4 5242.3 4903.4 4993.1 5000.2 5000.9 5045.4 5017.3 5020.0 5028.5 5030.1 5072.6 4716.7 4799.9 4810.3 4928.9 4932.4 4896.7 5008.5 5008.6 5013.8 5034.6 4917.6 4959.8 4961.7 4966.4 5007.2 14:23:30 INFO - 2015-11-19 14:23:30,805 DEBUG : BROWSER_OUTPUT: 14:23:30 INFO - 2015-11-19 14:23:30,805 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41554.39 Median:166885.00 stddev:67558.17 (40.5%) stddev-sans-first:67677.57 14:23:30 INFO - 2015-11-19 14:23:30,805 DEBUG : BROWSER_OUTPUT: Values: 560.3 569.4 578.8 579.8 583.5 28626.9 29169.1 37720.4 38283.8 38299.0 40797.3 41364.6 41431.4 41447.8 41488.0 7053.8 7956.4 8124.4 8125.6 8127.8 7091.7 7174.1 7175.5 7181.6 9971.9 10142.6 10259.3 10272.9 10281.4 10282.1 10093.2 10196.2 10196.8 10197.5 10210.0 10060.6 10136.5 10186.2 10189.3 10215.1 38453.9 38915.2 38947.6 39010.0 39030.8 2888.3 2929.3 2978.7 2987.7 3569.0 28578.4 28884.6 29111.4 29183.4 29647.4 3103.1 3120.3 3137.3 3173.1 3212.2 227319.0 228634.0 228719.0 228823.0 229327.0 44641.8 45717.8 56430.7 56518.7 57613.1 51772.7 51823.0 52045.0 52048.2 52151.5 13333.2 13573.4 13575.2 13580.4 13586.8 10219.5 10293.7 10315.5 10342.1 10394.5 18768.3 18945.5 19059.1 19073.3 19075.7 7493.0 7763.5 7860.3 7907.2 7938.2 835.1 912.3 918.6 981.2 999.6 23520.9 23867.3 23981.8 24001.8 24022.9 947.8 982.5 1010.4 1030.6 1063.3 12936.8 13151.9 13154.5 13289.9 13292.7 269159.0 273579.0 273700.0 273836.0 273922.0 46424.0 46911.0 47067.5 47084.3 47115.3 1030.3 1115.4 1190.8 1207.5 1212.4 24126.5 26659.2 26984.7 27147.5 27213.9 37503.6 37915.4 37922.0 37955.8 37956.8 244830.0 250900.0 251806.0 303111.0 309886.0 27550.4 27897.9 28079.5 28114.6 28143.4 38379.8 39087.6 39515.2 39677.8 39717.4 33430.5 34126.7 34462.3 34639.7 35077.0 32548.3 34738.8 35021.0 35094.3 35183.6 30040.4 30747.5 30771.8 30936.5 30951.7 26519.2 28035.9 30659.0 30921.7 31075.0 23023.5 23240.2 23517.4 23767.8 23774.3 14:23:30 INFO - 2015-11-19 14:23:30,805 DEBUG : BROWSER_OUTPUT: 14:23:30 INFO - 2015-11-19 14:23:30,805 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25164.86 Median:434.30 stddev:79868.53 (18390.0%) stddev-sans-first:80070.83 14:23:30 INFO - 2015-11-19 14:23:30,806 DEBUG : BROWSER_OUTPUT: Values: 338.9 340.7 341.8 343.6 345.3 12660.0 13044.9 14988.9 15206.2 17385.5 15720.6 15893.7 16507.6 16515.9 16528.5 4894.8 5135.5 5135.6 5136.6 5136.8 3543.4 3642.4 5060.2 5676.9 5919.6 5793.6 5834.7 5836.3 5847.6 5861.1 5697.0 5851.8 5903.1 5905.1 5908.7 5146.9 5159.5 5163.0 5178.6 5186.7 18385.9 18597.9 18741.2 19110.6 19544.3 1825.9 1901.8 1918.3 1931.8 2002.8 12801.6 12859.0 12909.6 13037.4 13153.6 1743.2 1754.6 1755.2 1770.5 1814.8 52763.0 53742.7 53786.2 53907.5 54107.2 8781.2 8872.5 9024.9 9058.9 9089.5 11261.2 11266.6 11280.8 11296.9 11307.4 4797.5 4907.6 4914.7 6820.0 6886.6 4986.9 5020.4 5052.6 5058.1 5060.4 3053.3 3100.5 3128.2 3129.7 3131.1 992.0 1046.7 1084.5 1087.2 1162.0 374.7 389.1 407.8 420.0 422.1 9711.3 9943.8 10311.4 10370.6 11358.5 430.3 438.3 440.1 447.8 452.7 6000.8 6057.2 6081.6 6218.2 6231.3 475655.0 479669.0 490258.0 494928.0 501563.0 65783.7 65856.7 65953.0 66507.0 67463.0 479.4 483.9 484.6 485.4 485.7 9883.7 10359.6 10409.3 10418.7 10492.6 32920.0 32923.0 33997.2 34395.5 34550.1 39156.9 39346.6 41118.8 45606.0 45932.8 6304.3 6468.5 6516.8 6528.6 6532.9 11511.9 11621.4 12012.8 12029.6 12047.4 10442.0 10478.9 10504.4 10656.7 10695.4 9737.0 10014.4 10032.3 10047.5 10102.8 8429.5 9568.3 10261.7 10327.4 10402.8 5581.6 6234.4 6244.2 6318.0 6368.5 9963.0 9992.0 9992.7 10082.4 10305.1 14:23:30 INFO - 2015-11-19 14:23:30,807 DEBUG : BROWSER_OUTPUT: 14:23:30 INFO - 2015-11-19 14:23:30,807 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5177.10 Median:6519.11 stddev:2773.65 (42.5%) stddev-sans-first:2767.15 14:23:30 INFO - 2015-11-19 14:23:30,807 DEBUG : BROWSER_OUTPUT: Values: 1431.2 1635.0 1688.8 1706.4 1722.2 6511.9 7023.6 7092.8 7109.2 7112.4 7357.1 7432.2 7464.1 7485.4 7488.5 1703.8 1718.6 1720.6 2140.1 2170.9 1839.8 2090.2 2140.9 2148.7 2151.7 2030.2 2068.5 2074.9 2092.4 2111.2 1792.3 1826.7 2057.1 2101.1 2137.0 2007.5 2013.8 2023.3 2023.8 2025.3 7351.1 7521.0 7538.8 7541.4 7546.4 4431.3 4524.4 4535.5 4553.4 4558.9 2742.4 2859.0 2860.1 2875.7 2887.8 845.5 889.6 903.0 907.1 908.0 10184.9 10219.6 10221.8 10224.8 10231.4 4005.8 4093.5 4173.5 4199.2 4200.4 8343.2 8400.9 8402.4 8413.2 8419.3 4470.3 4479.5 4483.6 4490.3 4496.8 4118.9 4119.9 4134.6 4140.0 4167.6 3162.8 3239.3 3269.7 3271.9 3275.9 961.6 964.5 969.2 970.4 971.0 873.7 878.6 1169.5 1174.8 1199.0 7138.8 7164.0 7174.8 7205.7 7240.5 395.5 399.7 400.4 401.0 403.0 5104.5 5191.4 5497.7 5738.5 5803.9 8945.0 8947.5 9165.1 9180.2 9181.8 9083.6 9128.2 9133.4 9225.4 9245.3 7042.4 7049.2 7178.7 7191.0 7192.9 6835.3 7065.0 7099.1 7108.1 7117.2 7869.4 8063.8 8220.7 8232.3 8244.1 8074.4 8136.8 8138.7 8187.3 8443.7 6290.4 6354.0 6366.0 6376.3 6389.7 6830.5 7001.9 7010.7 7011.5 7028.0 6526.3 6553.6 6661.4 6705.3 6796.9 6476.9 6618.6 6631.4 6705.2 6745.5 6709.0 6745.5 6747.1 6752.7 6761.6 6131.5 6171.0 6179.5 6186.9 6310.7 6458.4 6547.2 6551.9 6553.6 6567.2 14:23:30 INFO - 2015-11-19 14:23:30,807 DEBUG : BROWSER_OUTPUT: 14:23:30 INFO - 2015-11-19 14:23:30,807 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4764.36 Median:5437.80 stddev:1402.69 (25.8%) stddev-sans-first:1366.24 14:23:30 INFO - 2015-11-19 14:23:30,807 DEBUG : BROWSER_OUTPUT: Values: 312.1 318.5 324.3 325.0 326.9 5422.0 5422.9 5534.4 5548.5 5550.3 5189.8 5340.6 5341.3 5347.9 5452.7 4133.1 4187.1 4187.3 4232.6 4291.7 4265.6 4266.3 4281.4 4286.6 4288.1 4015.8 4248.7 4250.1 4256.2 4257.2 4085.3 4132.4 4193.2 4234.9 4248.0 3742.7 3746.1 3746.8 3752.9 3754.0 5255.9 5256.2 5256.5 5258.4 5264.3 4893.0 4898.0 4898.3 4900.0 4902.9 5588.1 5735.1 5738.6 5745.8 5748.3 3997.0 3998.3 3998.9 3999.9 4000.7 5956.5 6040.6 6041.1 6044.5 6044.7 4026.7 4115.7 4118.4 4118.9 4119.6 4182.0 4187.5 4189.0 4197.2 4209.8 4808.1 4809.2 4809.4 4811.0 4812.8 5739.8 5745.3 5749.2 5751.0 5752.0 1456.1 1482.8 1483.5 1484.3 1485.1 962.1 963.6 973.2 974.9 983.0 4915.4 4924.6 4924.7 4936.8 4943.0 5818.9 5894.4 5897.2 5897.5 5900.6 5000.8 5006.3 5007.2 5010.6 5012.7 3089.5 3137.0 3159.5 3208.1 3213.7 5576.7 5603.6 5606.6 5677.2 5685.7 6169.7 6175.2 6178.7 6178.8 6182.5 5459.8 5660.6 5668.7 5673.7 5676.9 6006.6 6011.7 6014.5 6016.2 6017.7 5880.2 5883.7 5884.1 5884.1 5885.6 5566.6 5661.6 5681.3 5687.2 5694.0 4074.9 4123.7 4126.8 4129.5 4132.2 5978.8 5981.8 5988.2 5989.1 5999.0 5721.9 5723.2 5741.3 5743.7 5766.1 5554.1 5701.5 5704.7 5710.0 5769.8 5607.3 5645.9 5649.9 5656.3 5657.4 5795.9 5801.1 5803.4 5805.5 5832.1 5480.2 5598.5 5604.5 5665.6 5669.1 14:23:30 INFO - 2015-11-19 14:23:30,807 DEBUG : BROWSER_OUTPUT: 14:23:30 INFO - 2015-11-19 14:23:30,807 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12271.50 Median:48719.88 stddev:14568.40 (29.9%) stddev-sans-first:14583.29 14:23:30 INFO - 2015-11-19 14:23:30,808 DEBUG : BROWSER_OUTPUT: Values: 686.1 692.2 755.2 768.4 787.5 11542.5 11742.1 11764.6 11783.8 11798.4 11679.9 12709.9 12938.9 12952.8 12958.2 607.3 616.0 773.3 785.1 786.9 773.2 781.6 786.2 786.3 787.9 794.8 808.5 818.3 819.2 819.9 630.3 635.8 789.5 803.5 819.8 584.3 585.4 595.1 595.1 595.5 11978.5 12037.8 12050.7 12119.5 12119.7 8965.6 9009.3 9339.2 9693.8 10137.3 8787.0 8877.7 8890.0 9175.6 9288.2 2855.9 2943.2 2957.4 3031.2 3039.9 35202.5 36015.8 36076.0 39775.4 40052.2 6497.7 6559.0 6584.1 6616.1 6649.7 10435.4 10447.8 10484.4 10498.4 10520.3 5672.6 5688.5 5708.8 5796.3 5901.7 3586.8 3601.0 3625.9 3682.8 3698.7 2527.0 2558.8 2563.1 2563.5 2564.0 390.9 393.4 396.7 396.8 397.1 564.0 591.1 611.7 625.2 626.7 7345.9 7472.3 7629.4 7679.3 7756.0 455.9 594.7 605.8 632.5 660.7 3480.7 3545.0 3726.6 3742.3 4122.9 50635.0 50835.7 51261.2 51398.5 53959.0 45628.0 51140.0 51183.2 51261.2 51427.0 44139.3 44141.3 45916.0 46361.1 46804.8 7635.7 8147.2 8469.1 8504.4 8649.0 32308.8 32435.0 32689.8 33305.2 33459.3 37980.2 38329.6 38693.2 40817.0 41119.6 10820.0 10895.2 10995.3 11041.4 11130.6 11005.3 11044.4 11528.0 11671.5 11786.9 10619.1 10621.5 10772.7 10782.6 10805.9 10880.6 11059.4 11101.7 11558.9 11581.9 8669.3 9644.0 10137.3 10245.4 10632.5 8627.1 9093.9 9332.8 9447.1 9781.7 8816.2 9029.2 9072.3 9130.0 9238.7 14:23:30 INFO - 2015-11-19 14:23:30,808 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:23:30 INFO - 2015-11-19 14:23:30,808 DEBUG : BROWSER_OUTPUT: 14:23:31 INFO - 2015-11-19 14:23:31,529 INFO : Browser exited with error code: 0 14:23:31 INFO - 2015-11-19 14:23:31,548 INFO : Completed test dromaeo_css (00:18:37) 14:23:31 INFO - 2015-11-19 14:23:31,548 INFO : Starting test kraken 14:23:31 INFO - 2015-11-19 14:23:31,548 DEBUG : operating with platform_type : linux_ 14:23:31 INFO - 2015-11-19 14:23:31,548 INFO : Initialising browser for kraken test... 14:23:31 INFO - 2015-11-19 14:23:31,554 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvyN0HN/profile http://localhost:38296/getInfo.html 14:23:35 INFO - 2015-11-19 14:23:35,256 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:23:35 INFO - 2015-11-19 14:23:35,257 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:23:35 INFO - 2015-11-19 14:23:35,257 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:23:35 INFO - 2015-11-19 14:23:35,257 DEBUG : BROWSER_OUTPUT: __metrics 14:23:35 INFO - 2015-11-19 14:23:35,434 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:23:36 INFO - 2015-11-19 14:23:36,566 INFO : Browser initialized. 14:23:36 INFO - 2015-11-19 14:23:36,567 INFO : Running cycle 1/1 for kraken test... 14:23:36 INFO - 2015-11-19 14:23:36,567 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvyN0HN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:23:48 INFO - 2015-11-19 14:23:48,457 DEBUG : BROWSER_OUTPUT: RSS: Main: 141910016 14:23:48 INFO - 2015-11-19 14:23:48,458 DEBUG : BROWSER_OUTPUT: 14:23:51 INFO - 2015-11-19 14:23:51,061 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38296/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38296/tests/kraken/driver.html?testName=audio-beat-detection) 14:23:51 INFO - 2015-11-19 14:23:51,642 DEBUG : BROWSER_OUTPUT: RSS: Main: 179302400 14:23:51 INFO - 2015-11-19 14:23:51,643 DEBUG : BROWSER_OUTPUT: 14:23:54 INFO - 2015-11-19 14:23:54,344 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38296/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38296/tests/kraken/driver.html?testName=audio-dft) 14:23:54 INFO - 2015-11-19 14:23:54,924 DEBUG : BROWSER_OUTPUT: RSS: Main: 167821312 14:23:54 INFO - 2015-11-19 14:23:54,925 DEBUG : BROWSER_OUTPUT: 14:23:57 INFO - 2015-11-19 14:23:57,944 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38296/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38296/tests/kraken/driver.html?testName=audio-fft) 14:23:58 INFO - 2015-11-19 14:23:58,512 DEBUG : BROWSER_OUTPUT: RSS: Main: 151318528 14:23:58 INFO - 2015-11-19 14:23:58,512 DEBUG : BROWSER_OUTPUT: 14:24:00 INFO - 2015-11-19 14:24:00,533 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38296/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38296/tests/kraken/driver.html?testName=audio-oscillator) 14:24:01 INFO - 2015-11-19 14:24:01,114 DEBUG : BROWSER_OUTPUT: RSS: Main: 153399296 14:24:01 INFO - 2015-11-19 14:24:01,114 DEBUG : BROWSER_OUTPUT: 14:24:03 INFO - 2015-11-19 14:24:03,308 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38296/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38296/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:24:03 INFO - 2015-11-19 14:24:03,873 DEBUG : BROWSER_OUTPUT: RSS: Main: 155586560 14:24:03 INFO - 2015-11-19 14:24:03,874 DEBUG : BROWSER_OUTPUT: 14:24:06 INFO - 2015-11-19 14:24:06,873 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38296/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38296/tests/kraken/driver.html?testName=imaging-darkroom) 14:24:07 INFO - 2015-11-19 14:24:07,438 DEBUG : BROWSER_OUTPUT: RSS: Main: 157528064 14:24:07 INFO - 2015-11-19 14:24:07,439 DEBUG : BROWSER_OUTPUT: 14:24:10 INFO - 2015-11-19 14:24:10,902 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38296/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38296/tests/kraken/driver.html?testName=imaging-desaturate) 14:24:11 INFO - 2015-11-19 14:24:11,487 DEBUG : BROWSER_OUTPUT: RSS: Main: 156430336 14:24:11 INFO - 2015-11-19 14:24:11,488 DEBUG : BROWSER_OUTPUT: 14:24:14 INFO - 2015-11-19 14:24:14,305 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38296/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38296/tests/kraken/driver.html?testName=json-parse-financial) 14:24:14 INFO - 2015-11-19 14:24:14,886 DEBUG : BROWSER_OUTPUT: RSS: Main: 156876800 14:24:14 INFO - 2015-11-19 14:24:14,886 DEBUG : BROWSER_OUTPUT: 14:24:16 INFO - 2015-11-19 14:24:16,601 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38296/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38296/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:24:17 INFO - 2015-11-19 14:24:17,167 DEBUG : BROWSER_OUTPUT: RSS: Main: 164737024 14:24:17 INFO - 2015-11-19 14:24:17,167 DEBUG : BROWSER_OUTPUT: 14:24:19 INFO - 2015-11-19 14:24:19,042 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38296/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38296/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:24:19 INFO - 2015-11-19 14:24:19,643 DEBUG : BROWSER_OUTPUT: RSS: Main: 165154816 14:24:19 INFO - 2015-11-19 14:24:19,644 DEBUG : BROWSER_OUTPUT: 14:24:21 INFO - 2015-11-19 14:24:21,756 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38296/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38296/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:24:22 INFO - 2015-11-19 14:24:22,337 DEBUG : BROWSER_OUTPUT: RSS: Main: 174030848 14:24:22 INFO - 2015-11-19 14:24:22,337 DEBUG : BROWSER_OUTPUT: 14:24:24 INFO - 2015-11-19 14:24:24,884 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38296/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38296/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:24:25 INFO - 2015-11-19 14:24:25,471 DEBUG : BROWSER_OUTPUT: RSS: Main: 180006912 14:24:25 INFO - 2015-11-19 14:24:25,471 DEBUG : BROWSER_OUTPUT: 14:24:28 INFO - 2015-11-19 14:24:28,047 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38296/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38296/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:24:28 INFO - 2015-11-19 14:24:28,616 DEBUG : BROWSER_OUTPUT: RSS: Main: 179077120 14:24:28 INFO - 2015-11-19 14:24:28,616 DEBUG : BROWSER_OUTPUT: 14:24:30 INFO - 2015-11-19 14:24:30,371 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38296/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38296/tests/kraken/driver.html?testName=ai-astar) 14:24:30 INFO - 2015-11-19 14:24:30,629 DEBUG : BROWSER_OUTPUT: RSS: Main: 237207552 14:24:30 INFO - 2015-11-19 14:24:30,629 DEBUG : BROWSER_OUTPUT: 14:24:30 INFO - 2015-11-19 14:24:30,629 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:24:30 INFO - 2015-11-19 14:24:30,629 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:24:30 INFO - 2015-11-19 14:24:30,629 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:24:30 INFO - 2015-11-19 14:24:30,629 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:24:30 INFO - 2015-11-19 14:24:30,629 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;113;105;113;112;112;102;113;116;112 14:24:30 INFO - 2015-11-19 14:24:30,629 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;131;154;172;130;155;158;130;169;134 14:24:30 INFO - 2015-11-19 14:24:30,629 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;159;161;159;161;160;160;162;160 14:24:30 INFO - 2015-11-19 14:24:30,630 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;75;85;97;73;73;73;95;88;72 14:24:30 INFO - 2015-11-19 14:24:30,630 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;91;133;91;91;92;125;91;92;127 14:24:30 INFO - 2015-11-19 14:24:30,630 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;109;110;110;110;109;109 14:24:30 INFO - 2015-11-19 14:24:30,630 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;147;148;147;146;147;146;146;146 14:24:30 INFO - 2015-11-19 14:24:30,630 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;95;95;95;95;95;96;95 14:24:30 INFO - 2015-11-19 14:24:30,630 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;69;68;69;68;68;68;69;78;66;67 14:24:30 INFO - 2015-11-19 14:24:30,630 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;68;69;69;69;68;68;69;69 14:24:30 INFO - 2015-11-19 14:24:30,630 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;89;84;82;86;84;83;84;84;84 14:24:30 INFO - 2015-11-19 14:24:30,630 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;128;131;128;126;125;130;123;127;119 14:24:30 INFO - 2015-11-19 14:24:30,630 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;134;147;147;150;136;148;138;151;157;133 14:24:30 INFO - 2015-11-19 14:24:30,630 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;69;74;70;68;74;69;67;68;67 14:24:30 INFO - 2015-11-19 14:24:30,630 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:24:30 INFO - 2015-11-19 14:24:30,630 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:24:30 INFO - 2015-11-19 14:24:30,630 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,971 14:24:30 INFO - 2015-11-19 14:24:30,630 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:24:30 INFO - 2015-11-19 14:24:30,630 DEBUG : BROWSER_OUTPUT: __startTimestamp1447971870623__endTimestamp 14:24:30 INFO - 2015-11-19 14:24:30,631 DEBUG : BROWSER_OUTPUT: 14:24:30 INFO - 2015-11-19 14:24:30,632 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:24:30 INFO - 2015-11-19 14:24:30,632 DEBUG : BROWSER_OUTPUT: Number of tests: 14 14:24:30 INFO - 2015-11-19 14:24:30,632 DEBUG : BROWSER_OUTPUT: 14:24:30 INFO - 2015-11-19 14:24:30,632 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.90 Median:112.50 stddev:4.18 (3.7%) stddev-sans-first:4.43 14:24:30 INFO - 2015-11-19 14:24:30,632 DEBUG : BROWSER_OUTPUT: Values: 111.0 113.0 105.0 113.0 112.0 112.0 102.0 113.0 116.0 112.0 14:24:30 INFO - 2015-11-19 14:24:30,632 DEBUG : BROWSER_OUTPUT: 14:24:30 INFO - 2015-11-19 14:24:30,632 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.70 Median:154.50 stddev:16.21 (10.5%) stddev-sans-first:17.08 14:24:30 INFO - 2015-11-19 14:24:30,632 DEBUG : BROWSER_OUTPUT: Values: 154.0 131.0 154.0 172.0 130.0 155.0 158.0 130.0 169.0 134.0 14:24:30 INFO - 2015-11-19 14:24:30,632 DEBUG : BROWSER_OUTPUT: 14:24:30 INFO - 2015-11-19 14:24:30,632 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.40 Median:161.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 14:24:30 INFO - 2015-11-19 14:24:30,633 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 159.0 161.0 159.0 161.0 160.0 160.0 162.0 160.0 14:24:30 INFO - 2015-11-19 14:24:30,633 DEBUG : BROWSER_OUTPUT: 14:24:30 INFO - 2015-11-19 14:24:30,633 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.40 Median:80.00 stddev:9.92 (12.4%) stddev-sans-first:10.16 14:24:30 INFO - 2015-11-19 14:24:30,633 DEBUG : BROWSER_OUTPUT: Values: 73.0 75.0 85.0 97.0 73.0 73.0 73.0 95.0 88.0 72.0 14:24:30 INFO - 2015-11-19 14:24:30,633 DEBUG : BROWSER_OUTPUT: 14:24:30 INFO - 2015-11-19 14:24:30,633 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.40 Median:91.00 stddev:18.01 (19.8%) stddev-sans-first:18.62 14:24:30 INFO - 2015-11-19 14:24:30,633 DEBUG : BROWSER_OUTPUT: Values: 91.0 91.0 133.0 91.0 91.0 92.0 125.0 91.0 92.0 127.0 14:24:30 INFO - 2015-11-19 14:24:30,633 DEBUG : BROWSER_OUTPUT: 14:24:30 INFO - 2015-11-19 14:24:30,633 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 14:24:30 INFO - 2015-11-19 14:24:30,633 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 109.0 110.0 110.0 110.0 109.0 109.0 14:24:30 INFO - 2015-11-19 14:24:30,633 DEBUG : BROWSER_OUTPUT: 14:24:30 INFO - 2015-11-19 14:24:30,633 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 14:24:30 INFO - 2015-11-19 14:24:30,633 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 147.0 148.0 147.0 146.0 147.0 146.0 146.0 146.0 14:24:30 INFO - 2015-11-19 14:24:30,634 DEBUG : BROWSER_OUTPUT: 14:24:30 INFO - 2015-11-19 14:24:30,634 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 14:24:30 INFO - 2015-11-19 14:24:30,634 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 14:24:30 INFO - 2015-11-19 14:24:30,634 DEBUG : BROWSER_OUTPUT: 14:24:30 INFO - 2015-11-19 14:24:30,634 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:69.00 Median:68.50 stddev:3.30 (4.8%) stddev-sans-first:3.50 14:24:30 INFO - 2015-11-19 14:24:30,634 DEBUG : BROWSER_OUTPUT: Values: 69.0 68.0 69.0 68.0 68.0 68.0 69.0 78.0 66.0 67.0 14:24:30 INFO - 2015-11-19 14:24:30,634 DEBUG : BROWSER_OUTPUT: 14:24:30 INFO - 2015-11-19 14:24:30,634 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:0.52 (0.7%) stddev-sans-first:0.50 14:24:30 INFO - 2015-11-19 14:24:30,634 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 69.0 69.0 69.0 68.0 68.0 69.0 69.0 14:24:30 INFO - 2015-11-19 14:24:30,634 DEBUG : BROWSER_OUTPUT: 14:24:30 INFO - 2015-11-19 14:24:30,634 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:84.00 stddev:1.90 (2.3%) stddev-sans-first:2.01 14:24:30 INFO - 2015-11-19 14:24:30,634 DEBUG : BROWSER_OUTPUT: Values: 85.0 89.0 84.0 82.0 86.0 84.0 83.0 84.0 84.0 84.0 14:24:30 INFO - 2015-11-19 14:24:30,634 DEBUG : BROWSER_OUTPUT: 14:24:30 INFO - 2015-11-19 14:24:30,635 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.00 Median:127.50 stddev:3.62 (2.8%) stddev-sans-first:3.67 14:24:30 INFO - 2015-11-19 14:24:30,635 DEBUG : BROWSER_OUTPUT: Values: 123.0 128.0 131.0 128.0 126.0 125.0 130.0 123.0 127.0 119.0 14:24:30 INFO - 2015-11-19 14:24:30,635 DEBUG : BROWSER_OUTPUT: 14:24:30 INFO - 2015-11-19 14:24:30,635 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.10 Median:147.50 stddev:8.23 (5.6%) stddev-sans-first:7.87 14:24:30 INFO - 2015-11-19 14:24:30,635 DEBUG : BROWSER_OUTPUT: Values: 134.0 147.0 147.0 150.0 136.0 148.0 138.0 151.0 157.0 133.0 14:24:30 INFO - 2015-11-19 14:24:30,635 DEBUG : BROWSER_OUTPUT: 14:24:30 INFO - 2015-11-19 14:24:30,635 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:69.50 stddev:2.55 (3.7%) stddev-sans-first:2.70 14:24:30 INFO - 2015-11-19 14:24:30,635 DEBUG : BROWSER_OUTPUT: Values: 70.0 69.0 74.0 70.0 68.0 74.0 69.0 67.0 68.0 67.0 14:24:30 INFO - 2015-11-19 14:24:30,635 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:24:30 INFO - 2015-11-19 14:24:30,635 DEBUG : BROWSER_OUTPUT: 14:24:31 INFO - 2015-11-19 14:24:31,521 INFO : Browser exited with error code: 0 14:24:31 INFO - 2015-11-19 14:24:31,572 INFO : Completed test kraken (00:01:00) 14:24:31 INFO - 2015-11-19 14:24:31,572 INFO : Starting test v8_7 14:24:31 INFO - 2015-11-19 14:24:31,572 DEBUG : operating with platform_type : linux_ 14:24:31 INFO - 2015-11-19 14:24:31,572 INFO : Initialising browser for v8_7 test... 14:24:31 INFO - 2015-11-19 14:24:31,579 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPfIjDy/profile http://localhost:38296/getInfo.html 14:24:35 INFO - 2015-11-19 14:24:35,558 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:24:35 INFO - 2015-11-19 14:24:35,558 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:24:35 INFO - 2015-11-19 14:24:35,558 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:24:35 INFO - 2015-11-19 14:24:35,558 DEBUG : BROWSER_OUTPUT: __metrics 14:24:35 INFO - 2015-11-19 14:24:35,687 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:24:36 INFO - 2015-11-19 14:24:36,798 INFO : Browser initialized. 14:24:36 INFO - 2015-11-19 14:24:36,798 INFO : Running cycle 1/1 for v8_7 test... 14:24:36 INFO - 2015-11-19 14:24:36,798 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPfIjDy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:24:48 INFO - 2015-11-19 14:24:48,686 DEBUG : BROWSER_OUTPUT: RSS: Main: 142417920 14:24:48 INFO - 2015-11-19 14:24:48,687 DEBUG : BROWSER_OUTPUT: 14:25:10 INFO - 2015-11-19 14:25:10,118 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38296/tests/v8_7/run.html (next: http://localhost:38296/tests/v8_7/run.html) 14:25:10 INFO - 2015-11-19 14:25:10,377 DEBUG : BROWSER_OUTPUT: RSS: Main: 444358656 14:25:10 INFO - 2015-11-19 14:25:10,377 DEBUG : BROWSER_OUTPUT: 14:25:10 INFO - 2015-11-19 14:25:10,377 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:25:10 INFO - 2015-11-19 14:25:10,377 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:25:10 INFO - 2015-11-19 14:25:10,377 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:25:10 INFO - 2015-11-19 14:25:10,377 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:25:10 INFO - 2015-11-19 14:25:10,377 DEBUG : BROWSER_OUTPUT: |0;Richards;162.60162601626016 14:25:10 INFO - 2015-11-19 14:25:10,377 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.49434242255612 14:25:10 INFO - 2015-11-19 14:25:10,377 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.17364600781684 14:25:10 INFO - 2015-11-19 14:25:10,377 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5025.125628140703 14:25:10 INFO - 2015-11-19 14:25:10,377 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2002 14:25:10 INFO - 2015-11-19 14:25:10,377 DEBUG : BROWSER_OUTPUT: |5;Earley;784.9293563579278 14:25:10 INFO - 2015-11-19 14:25:10,377 DEBUG : BROWSER_OUTPUT: |6;Boyer;12280.487804878048 14:25:10 INFO - 2015-11-19 14:25:10,378 DEBUG : BROWSER_OUTPUT: |7;RegExp;26102.5641025641 14:25:10 INFO - 2015-11-19 14:25:10,378 DEBUG : BROWSER_OUTPUT: |8;Splay;621.5880893300248 14:25:10 INFO - 2015-11-19 14:25:10,378 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 14:25:10 INFO - 2015-11-19 14:25:10,378 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:25:10 INFO - 2015-11-19 14:25:10,378 DEBUG : BROWSER_OUTPUT: __startTimestamp1447971910370__endTimestamp 14:25:10 INFO - 2015-11-19 14:25:10,378 DEBUG : BROWSER_OUTPUT: 14:25:10 INFO - 2015-11-19 14:25:10,378 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:25:10 INFO - 2015-11-19 14:25:10,378 DEBUG : BROWSER_OUTPUT: Number of tests: 10 14:25:10 INFO - 2015-11-19 14:25:10,378 DEBUG : BROWSER_OUTPUT: 14:25:10 INFO - 2015-11-19 14:25:10,378 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.60 Median:162.60 stddev:0.00 (0.0%) 14:25:10 INFO - 2015-11-19 14:25:10,378 DEBUG : BROWSER_OUTPUT: Values: 162.6 14:25:10 INFO - 2015-11-19 14:25:10,378 DEBUG : BROWSER_OUTPUT: 14:25:10 INFO - 2015-11-19 14:25:10,378 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.49 Median:185.49 stddev:0.00 (0.0%) 14:25:10 INFO - 2015-11-19 14:25:10,378 DEBUG : BROWSER_OUTPUT: Values: 185.5 14:25:10 INFO - 2015-11-19 14:25:10,378 DEBUG : BROWSER_OUTPUT: 14:25:10 INFO - 2015-11-19 14:25:10,379 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.17 Median:279.17 stddev:0.00 (0.0%) 14:25:10 INFO - 2015-11-19 14:25:10,379 DEBUG : BROWSER_OUTPUT: Values: 279.2 14:25:10 INFO - 2015-11-19 14:25:10,379 DEBUG : BROWSER_OUTPUT: 14:25:10 INFO - 2015-11-19 14:25:10,379 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5025.13 Median:5025.13 stddev:0.00 (0.0%) 14:25:10 INFO - 2015-11-19 14:25:10,379 DEBUG : BROWSER_OUTPUT: Values: 5025.1 14:25:10 INFO - 2015-11-19 14:25:10,379 DEBUG : BROWSER_OUTPUT: 14:25:10 INFO - 2015-11-19 14:25:10,379 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2002.00 Median:2002.00 stddev:0.00 (0.0%) 14:25:10 INFO - 2015-11-19 14:25:10,379 DEBUG : BROWSER_OUTPUT: Values: 2002.0 14:25:10 INFO - 2015-11-19 14:25:10,379 DEBUG : BROWSER_OUTPUT: 14:25:10 INFO - 2015-11-19 14:25:10,379 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:784.93 Median:784.93 stddev:0.00 (0.0%) 14:25:10 INFO - 2015-11-19 14:25:10,379 DEBUG : BROWSER_OUTPUT: Values: 784.9 14:25:10 INFO - 2015-11-19 14:25:10,379 DEBUG : BROWSER_OUTPUT: 14:25:10 INFO - 2015-11-19 14:25:10,379 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12280.49 Median:12280.49 stddev:0.00 (0.0%) 14:25:10 INFO - 2015-11-19 14:25:10,379 DEBUG : BROWSER_OUTPUT: Values: 12280.5 14:25:10 INFO - 2015-11-19 14:25:10,379 DEBUG : BROWSER_OUTPUT: 14:25:10 INFO - 2015-11-19 14:25:10,380 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26102.56 Median:26102.56 stddev:0.00 (0.0%) 14:25:10 INFO - 2015-11-19 14:25:10,380 DEBUG : BROWSER_OUTPUT: Values: 26102.6 14:25:10 INFO - 2015-11-19 14:25:10,380 DEBUG : BROWSER_OUTPUT: 14:25:10 INFO - 2015-11-19 14:25:10,380 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:621.59 Median:621.59 stddev:0.00 (0.0%) 14:25:10 INFO - 2015-11-19 14:25:10,380 DEBUG : BROWSER_OUTPUT: Values: 621.6 14:25:10 INFO - 2015-11-19 14:25:10,380 DEBUG : BROWSER_OUTPUT: 14:25:10 INFO - 2015-11-19 14:25:10,380 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 14:25:10 INFO - 2015-11-19 14:25:10,380 DEBUG : BROWSER_OUTPUT: Values: 4835.7 14:25:10 INFO - 2015-11-19 14:25:10,380 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:25:10 INFO - 2015-11-19 14:25:10,380 DEBUG : BROWSER_OUTPUT: 14:25:11 INFO - 2015-11-19 14:25:11,337 INFO : Browser exited with error code: 0 14:25:11 INFO - 2015-11-19 14:25:11,352 INFO : Completed test v8_7 (00:00:39) 14:25:11 INFO - 2015-11-19 14:25:11,380 INFO : Completed test suite (00:20:17) 14:25:11 INFO - 2015-11-19 14:25:11,380 DEBUG : Working with test: dromaeo_css 14:25:11 INFO - 2015-11-19 14:25:11,380 DEBUG : Generating results file: dromaeo_css 14:25:11 INFO - 2015-11-19 14:25:11,382 DEBUG : Working with test: kraken 14:25:11 INFO - 2015-11-19 14:25:11,382 DEBUG : Generating results file: kraken 14:25:11 INFO - 2015-11-19 14:25:11,382 INFO : javascript benchmark 14:25:11 INFO - 2015-11-19 14:25:11,382 DEBUG : Working with test: v8_7 14:25:11 INFO - 2015-11-19 14:25:11,382 DEBUG : Generating results file: v8_7 14:25:11 INFO - 2015-11-19 14:25:11,383 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:25:11 INFO - 2015-11-19 14:25:11,436 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,203,35]] 14:25:11 INFO - 2015-11-19 14:25:11,437 DEBUG : process_Request line: dromaeo_css 6169.42 graph.html#tests=[[72,203,35]] 14:25:11 INFO - 2015-11-19 14:25:11,437 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:25:11 INFO - 2015-11-19 14:25:11,469 DEBUG : process_Request line: kraken 1516.30 graph.html#tests=[[232,203,35]] 14:25:11 INFO - 2015-11-19 14:25:11,469 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:25:11 INFO - 2015-11-19 14:25:11,500 DEBUG : process_Request line: v8_7 19894.27 graph.html#tests=[[230,203,35]] 14:25:11 INFO - 2015-11-19 14:25:11,501 INFO : javascript benchmark 14:25:11 INFO - 2015-11-19 14:25:11,505 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2611.6865976082872, 2735.0700761741004, 2749.2164733051086, 2759.3377589378542, 2770.0, 4651.302304654304, 4774.856754297377, 4831.806727730891, 4880.194767863302, 4906.460289368171, 4753.976230118845, 4798.808047678098, 4833.468318484973, 4879.634027447947, 4893.4617192108835, 4431.689781715281, 4457.33140028995, 4469.977650111745, 4526.502084770673, 4547.590716835484, 4530.252508336121, 4558.772061396917, 4578.267477203648, 4579.564941330568, 4601.677882548223, 4320.524742278331, 4404.66964977628, 4434.423524941769, 4436.046250056221, 4530.433695788027, 4479.820807167709, 4491.39366185564, 4510.985028368624, 4518.344839998182, 4538.659600529973, 4458.643308535309, 4466.620337271336, 4469.5753903379455, 4470.642348612136, 4507.729536227836, 4567.817287308504, 4718.834840780591, 4743.193657078305, 4783.7129772213775, 4837.9032419351415, 5059.797608095671, 5121.487851214886, 5150.459201783796, 5152.562032227265, 5202.817901373433, 5192.71440070796, 5237.528622423962, 5267.5259226669405, 5280.867978300574, 5317.707526086064, 4609.815607375667, 4713.6936099153445, 4715.127701375257, 4858.902821943541, 4863.416390033183, 5200.219967004904, 5286.0, 5298.576113910955, 5304.867378315573, 5348.465153484621, 5147.3051138096625, 5157.355330583677, 5159.0, 5165.896682066337, 5166.922496162485, 4975.800967961313, 5096.592272618182, 5105.566026887682, 5251.2123181523075, 5313.07021271276, 4965.851024469272, 5048.242763585418, 5052.797888084509, 5061.696298222045, 5102.387713474407, 5102.260172275073, 5136.357955255593, 5149.944261426399, 5153.458886816905, 5186.792528298825, 4115.409758126839, 4259.701820872509, 4264.061906380592, 4387.166438376698, 4424.557544245549, 3696.5009723687494, 3764.4541541476333, 3796.0, 3807.3717836556657, 3816.2558301131567, 4436.245838207513, 4437.755923424243, 4468.017036252019, 4476.888077798081, 4486.798094085774, 4917.164082106051, 5030.622703297267, 5155.716435596079, 5156.407013193456, 5165.741712914414, 4351.282038463618, 4424.6239069678795, 4452.8218871245435, 4484.170428470743, 4516.299973504112, 4643.582077613031, 4652.883677908012, 4655.627549796008, 4658.487566367697, 4684.344191813149, 4767.785449654843, 4891.388576427947, 4952.306677065142, 4952.4304704959395, 4992.700437973734, 5125.154349532286, 5128.230765385222, 5184.377874655065, 5279.234510995807, 5307.708076055854, 4977.726225057657, 4978.327925730125, 4985.775640096132, 5007.173816320266, 5025.0, 5150.536451719363, 5152.639315247897, 5156.097682905552, 5157.793688252428, 5203.349581302337, 4956.306117143531, 5134.7946082156295, 5138.997895410359, 5230.372355317386, 5242.318498595158, 4903.362562866804, 4993.076280888047, 5000.1749711297225, 5000.924986125138, 5045.4450010498085, 5017.297578338962, 5020.0, 5028.547430731252, 5030.0694371541385, 5072.5688316493515, 4716.693414928019, 4799.904001920012, 4810.254410566367, 4928.865815962658, 4932.432770231326, 4896.706197628154, 5008.5492305691205, 5008.599312055099, 5013.774380152829, 5034.597232221487, 4917.606591472745, 4959.82640607577, 4961.677490963076, 4966.428860681068, 5007.24891266313], "unit": "ms", "name": "dojo.html", "value": 4739.639481495164}, {"lowerIsBetter": false, "replicates": [560.2744445942504, 569.4447913284548, 578.756922092721, 579.7941730685609, 583.4777873802947, 28626.85686571567, 29169.124926252192, 37720.43419348705, 38283.80858095713, 38299.0, 40797.30830954441, 41364.58635413645, 41431.378529322006, 41447.79276103623, 41488.0, 7053.753118640849, 7956.403269754763, 8124.431289809716, 8125.634346454394, 8127.837443251132, 7091.680874360641, 7174.139103307584, 7175.4977151599405, 7181.640917954108, 9971.90028099717, 10142.594296228142, 10259.281850270447, 10272.897271027268, 10281.434521101337, 10282.074613284803, 10093.192544596452, 10196.235282353853, 10196.796064078677, 10197.490125493696, 10210.030047145508, 10060.647877324333, 10136.54385552652, 10186.185105191567, 10189.286749927509, 10215.080642742114, 38453.885036322994, 38915.22169556593, 38947.610523894684, 39010.0, 39030.80484597559, 2888.3068063664778, 2929.26768307923, 2978.717021882918, 2987.6862929392537, 3569.0, 28578.428431431465, 28884.566731499046, 29111.41777164445, 29183.41633167346, 29647.40705185884, 3103.1001009707156, 3120.329129237225, 3137.262743255333, 3173.079806856009, 3212.1969507623094, 227319.0, 228634.0, 228719.0, 228822.99999999834, 229327.0, 44641.776791116485, 45717.771411142734, 56430.717846411324, 56518.7174064127, 57613.13580296215, 51772.74113629408, 51823.0, 52045.0, 52048.21927671088, 52151.47848521542, 13333.20000799955, 13573.389197486136, 13575.185488870698, 13580.38888250031, 13586.796198057036, 10219.540120694586, 10293.7426564335, 10315.484225788681, 10342.069213770797, 10394.48027598617, 18768.343107991153, 18945.526361840788, 19059.142338594796, 19073.332433364765, 19075.713864292047, 7492.962535187289, 7763.4953728007495, 7860.318599597269, 7907.169747176578, 7938.206179382016, 835.0939230934383, 912.3203213605774, 918.6095909238547, 981.1954197558076, 999.6458340607909, 23520.882395587912, 23867.283981480236, 23981.760182398302, 24001.7599824003, 24022.87988560046, 947.7583216279804, 982.5087456271864, 1010.4240582867695, 1030.5826140413144, 1063.2822844580032, 12936.805947910789, 13151.868481315256, 13154.473821047242, 13289.867101329057, 13292.68837597246, 269159.0, 273579.0, 273700.0, 273836.0, 273922.0, 46424.0, 46911.0, 47067.529324707, 47084.293735593994, 47115.29327060097, 1030.3251370352432, 1115.4255558387438, 1190.8035174196161, 1207.4988879614862, 1212.3998620682642, 24126.51746965086, 26659.20022399331, 26984.73015269901, 27147.499152761742, 27213.86393068101, 37503.624963750015, 37915.43126853044, 37922.0, 37955.81022094872, 37956.810215948746, 244830.0, 250900.0, 251806.0, 303111.0, 309886.0, 27550.44899102047, 27897.860510697315, 28079.507278835288, 28114.578281325386, 28143.43713125767, 38379.808100959315, 39087.6091239084, 39515.2096958065, 39677.80161099176, 39717.40423893586, 33430.49854252237, 34126.658733413344, 34462.310753785285, 34639.653603463645, 35077.0, 32548.349033018734, 34738.82630586831, 35021.0, 35094.29811403809, 35183.64816351804, 30040.360567626158, 30747.53878691777, 30771.846140769154, 30936.53595196029, 30951.69048309488, 26519.204423867315, 28035.859820701582, 30659.0, 30921.69078309278, 31075.0, 23023.53952920966, 23240.18659346915, 23517.41206469852, 23767.762322376555, 23774.286771396884], "unit": "ms", "name": "ext.html", "value": 17093.205086513128}, {"lowerIsBetter": false, "replicates": [338.9474631432128, 340.67805923402386, 341.8478776944259, 343.585978895431, 345.25941854721606, 12660.0, 13044.93477532611, 14988.92505537472, 15206.239688015596, 17385.47843564695, 15720.606984825385, 15893.682126357466, 16507.58731031725, 16515.91742041288, 16528.504144875675, 4894.828680996157, 5135.512126347991, 5135.563477104451, 5136.64043516954, 5136.820211292606, 3543.4153364694794, 3642.3625865473437, 5060.165072762989, 5676.914846277309, 5919.644821310713, 5793.594448388614, 5834.6790926499025, 5836.270466191726, 5847.619904706202, 5861.0915308127305, 5697.0, 5851.795187168429, 5903.055511118222, 5905.143754155645, 5908.704564771744, 5146.897062058738, 5159.535641792219, 5163.0, 5178.559822415099, 5186.7147306898105, 18385.908070459696, 18597.907010464998, 18741.15664795074, 19110.61778764417, 19544.31594894172, 1825.863060270485, 1901.8288354048202, 1918.3094086128983, 1931.8357939575153, 2002.769681486633, 12801.55194568195, 12859.035572332112, 12909.612711618667, 13037.413316400785, 13153.60539183826, 1743.1807050686157, 1754.5525890897738, 1755.2013833705632, 1770.530809335527, 1814.7640806695176, 52763.0, 53742.73128634332, 53786.193207101926, 53907.46092539103, 54107.18839217375, 8781.209691127702, 8872.467651940904, 9024.8646270306, 9058.864117038249, 9089.5000774958, 11261.155413344031, 11266.605668801552, 11280.830787538194, 11296.943515282535, 11307.434628268718, 4797.472278049412, 4907.558319751168, 4914.655974081851, 6819.965900170567, 6886.621235832077, 4986.925196122061, 5020.3724534433195, 5052.621053420935, 5058.140116180185, 5060.418051924003, 3053.328267781085, 3100.472919603673, 3128.1710346758127, 3129.6713845046397, 3131.091983324856, 991.9950400248097, 1046.7383154211448, 1084.4848696868924, 1087.2009073331096, 1162.0122895538893, 374.6833925333089, 389.08758960238197, 407.84705735349246, 420.04649445757957, 422.0819717115262, 9711.320207585542, 9943.80112397748, 10311.381317120997, 10370.637027703995, 11358.488868000959, 430.34587427110614, 438.2615293230916, 440.0670578373868, 447.8208716513421, 452.7283629822146, 6000.759969601167, 6057.18228039209, 6081.604695694766, 6218.22272215973, 6231.3145553989025, 475655.0, 479669.0, 490258.0, 494928.0, 501563.0, 65783.67108164428, 65856.67071664611, 65953.0, 66507.00239496412, 67463.0, 479.36244794423334, 483.8596806925952, 484.5517895946236, 485.39325842696627, 485.6794515619745, 9883.654072107442, 10359.637412690821, 10409.271351005356, 10418.68743937683, 10492.580296788348, 32920.0, 32923.0, 33997.15007124842, 34395.4840677385, 34550.13624659403, 39156.947900098094, 39346.6065339343, 41118.79440602778, 45606.0, 45932.7703361481, 6304.306526282014, 6468.450181734605, 6516.837079073061, 6528.575642583217, 6532.902006469812, 11511.94244028808, 11621.36082515436, 12012.819807702717, 12029.639110826689, 12047.397630118283, 10442.0, 10478.947605261925, 10504.42225677595, 10656.680299591024, 10695.411752353695, 9736.95131524338, 10014.449205293779, 10032.347897386646, 10047.497625118862, 10102.79794404093, 8429.536375499407, 9568.330216884751, 10261.692149235534, 10327.380357178594, 10402.791944160923, 5581.609287350009, 6234.410225392496, 6244.219472565929, 6317.96841015792, 6368.4586810121655, 9963.0, 9992.0, 9992.65025724096, 10082.395056296646, 10305.124064454605], "unit": "ms", "name": "jquery.html", "value": 6936.99369744923}, {"lowerIsBetter": false, "replicates": [1431.1770731829201, 1635.035329155798, 1688.8395602417766, 1706.4368758309759, 1722.1561434896905, 6511.869762604751, 7023.578585284887, 7092.751753688622, 7109.182444018939, 7112.359887610114, 7357.117145942494, 7432.219616940224, 7464.066991626047, 7485.401167906568, 7488.475806693534, 1703.752955821405, 1718.6133120048014, 1720.6472673101985, 2140.1118535807623, 2170.913163473459, 1839.7700287464068, 2090.2370634718295, 2140.892955352234, 2148.677698345245, 2151.741790985084, 2030.1734023352997, 2068.48287928018, 2074.9481262968397, 2092.3722883135074, 2111.1660893946882, 1792.2920446423655, 1826.6803309420932, 2057.07431655754, 2101.149034640973, 2137.0, 2007.518195633052, 2013.7514740860613, 2023.2918478532542, 2023.7672667643262, 2025.3215172917091, 7351.081114860643, 7520.962395188044, 7538.8115297117465, 7541.396688264926, 7546.358559522447, 4431.290993441034, 4524.434445694288, 4535.546445355471, 4553.430821147356, 4558.8632341029825, 2742.3966727319957, 2859.042220856016, 2860.1419574127885, 2875.7268059534313, 2887.812292201, 845.4927043773748, 889.6041261638574, 903.0382642485731, 907.1065000974036, 907.9727608171765, 10184.89815101847, 10219.642312519027, 10221.79556408875, 10224.846627300596, 10231.437270950095, 4005.7997100144876, 4093.467849179647, 4173.5409104998425, 4199.160167966358, 4200.369944508348, 8343.16568343173, 8400.915990840136, 8402.41183117176, 8413.200745929127, 8419.284360829275, 4470.329450582439, 4479.529649386767, 4483.574060464251, 4490.326451032372, 4496.797644106023, 4118.938215926763, 4119.9176016479505, 4134.607212314825, 4139.9793001035405, 4167.6457501112745, 3162.8418579070953, 3239.2549713566013, 3269.6594396297405, 3271.8527666255077, 3275.918102047468, 961.6489981156827, 964.5032808103692, 969.2197780786394, 970.3789574672215, 971.0386717150112, 873.724776695339, 878.6441491196076, 1169.479581586186, 1174.8002839517133, 1198.988010119905, 7138.750143745048, 7163.964180179066, 7174.820629484305, 7205.675744591401, 7240.493165478366, 395.53327074052896, 399.6542990313358, 400.39340399295094, 400.96591789698203, 403.0246802737383, 5104.464031276737, 5191.402988656353, 5497.697626630494, 5738.512226460798, 5803.8549036274435, 8945.0, 8947.507887066144, 9165.083491650781, 9180.219681327162, 9181.770455738526, 9083.636654533744, 9128.178463938144, 9133.406328588753, 9225.400348977295, 9245.306602004877, 7042.401395881305, 7049.189343225595, 7178.676959536833, 7191.029211056545, 7192.892106618405, 6835.316468353324, 7065.010898474115, 7099.112610923635, 7108.07595012645, 7117.181524124792, 7869.370450363843, 8063.758087257157, 8220.671173153247, 8232.259096681328, 8244.051934027664, 8074.354051675734, 8136.779483077586, 8138.674453021813, 8187.3040791531, 8443.746687599381, 6290.402411770874, 6353.96823015882, 6366.045093235866, 6376.298607153302, 6389.7124629390855, 6830.487713421613, 7001.929980700332, 7010.68451919675, 7011.509194356346, 7027.964860175666, 6526.347365263436, 6553.639549824806, 6661.4004739573675, 6705.262421133574, 6796.864062718619, 6476.935230647633, 6618.635975021228, 6631.403173714389, 6705.161854768154, 6745.460363171032, 6709.027191057172, 6745.460363171032, 6747.089142965637, 6752.662366881735, 6761.628110453776, 6131.478824299806, 6171.0, 6179.536534760001, 6186.938130618636, 6310.652914089769, 6458.418742313026, 6547.247066587403, 6551.868962620816, 6553.639549824806, 6567.179102612174], "unit": "ms", "name": "mootools.html", "value": 4106.836371745818}, {"lowerIsBetter": false, "replicates": [312.1400541508145, 318.53175831527653, 324.3367313843192, 325.03788785195826, 326.8741534509213, 5422.0, 5422.8915421691545, 5534.391216966131, 5548.528375088117, 5550.306211723535, 5189.766460509277, 5340.599455040868, 5341.332333458317, 5347.946520534793, 5452.700101494416, 4133.132042271127, 4187.099773548694, 4187.33002719565, 4232.640225580814, 4291.678124140686, 4265.616094551489, 4266.274733295348, 4281.379200015996, 4286.57134286572, 4288.056627541936, 4015.7791321477307, 4248.745075295492, 4250.128723611668, 4256.2338779019765, 4257.233697934371, 4085.3259212229946, 4132.4421203137645, 4193.245215861144, 4234.9364759528635, 4247.957520424818, 3742.700583953277, 3746.1009357754215, 3746.83139258734, 3752.868649597251, 3754.0427191066105, 5255.947440525584, 5256.237845512417, 5256.50063243995, 5258.395284542288, 5264.2893209416625, 4893.0, 4898.0, 4898.265260210961, 4900.044491324194, 4902.852914412573, 5588.077967135418, 5735.082386818089, 5738.569607279429, 5745.770169193227, 5748.338941021752, 3997.0, 3998.3202855514633, 3998.9200215995515, 3999.8600048998437, 4000.6799456043736, 5956.493698035629, 6040.550267935708, 6041.063635136561, 6044.546659000593, 6044.667543285118, 4026.67786577079, 4115.71190016696, 4118.382242663564, 4118.91762164761, 4119.649829764504, 4181.97909010453, 4187.45563076798, 4188.958110418917, 4197.160567886435, 4209.7895105245225, 4808.08646357191, 4809.206480930678, 4809.422869255712, 4811.0, 4812.844917219842, 5739.827805165852, 5745.2818397700285, 5749.223854779551, 5750.971245143747, 5751.971240143773, 1456.0899437851342, 1482.8072350594355, 1483.5401025682072, 1484.332050577223, 1485.138619600629, 962.100436092256, 963.5760265483165, 973.2068364283086, 974.9373183230313, 982.975425614351, 4915.3855768029, 4924.60603151747, 4924.679895806761, 4936.777844996984, 4943.0, 5818.854528636818, 5894.440028197314, 5897.233359663216, 5897.49871260939, 5900.586958912921, 5000.849974500771, 5006.299118123466, 5007.173816320266, 5010.64925455222, 5012.699238045729, 3089.4902341113466, 3137.0, 3159.526071089355, 3208.0536241808254, 3213.694699003591, 5576.693281869455, 5603.579731520153, 5606.579506536945, 5677.17680936262, 5685.744141513642, 6169.691515424301, 6175.228096487939, 6178.7219575119225, 6178.845528861814, 6182.474489668429, 5459.754311056012, 5660.603757737002, 5668.659880407106, 5673.659580425187, 5676.9432305678065, 6006.609570377911, 6011.729472173675, 6014.48876845473, 6016.21789167423, 6017.699115044143, 5880.235569375954, 5883.705814709162, 5884.146798714248, 5884.146798714248, 5885.61743486672, 5566.638168519034, 5661.57538184646, 5681.318241811009, 5687.232223649919, 5694.032014557452, 4074.898127546835, 4123.731957422758, 4126.793660317032, 4129.463169787909, 4132.173565287015, 5978.760849565969, 5981.773736383944, 5988.191594134736, 5989.071693887455, 5999.0, 5721.914171287351, 5723.170140329712, 5741.282339707536, 5743.684097374685, 5766.106253530709, 5554.055810512304, 5701.458361455655, 5704.743286552032, 5710.0, 5769.769209231752, 5607.327120745536, 5645.870825834932, 5649.85875353103, 5656.2929633795775, 5657.377688454185, 5795.94204057954, 5801.071828507418, 5803.3616302207565, 5805.535557155333, 5832.12518122285, 5480.177973303877, 5598.524125449382, 5604.523615492729, 5665.603407761417, 5669.149627555899], "unit": "ms", "name": "prototype.html", "value": 4314.501978344109}, {"lowerIsBetter": false, "replicates": [686.135469308671, 692.1521136607656, 755.1957165618616, 768.3699366519454, 787.5038725602872, 11542.538298468062, 11742.119341049412, 11764.588239411602, 11783.764324713511, 11798.351090690008, 11679.941600292008, 12709.936450317735, 12938.870611293883, 12952.805707914365, 12958.222506649608, 607.3228350389306, 615.9568830181889, 773.2924374197617, 785.0500893918365, 786.9016372953381, 773.2267732267733, 781.6170076662452, 786.2491320788662, 786.3316181245924, 787.873940169573, 794.8092457810113, 808.5310519898475, 818.3289702443998, 819.1767273889733, 819.8606236939705, 630.3444417805476, 635.7997230872261, 789.5026133535864, 803.5138741061631, 819.8483280593109, 584.2521572387351, 585.4028890531633, 595.0716881664574, 595.0716881664617, 595.5087053181143, 11978.520859165623, 12037.759244815143, 12050.69873253167, 12119.454624541917, 12119.697007574792, 8965.641374345018, 9009.324300677476, 9339.206167475773, 9693.757656058584, 10137.341072830242, 8786.956065219696, 8877.689280875204, 8889.955550222208, 9175.587098580512, 9288.21050210733, 2855.914322570326, 2943.1906225787866, 2957.438086763508, 3031.242189452637, 3039.8784048638026, 35202.47196292058, 36015.81992090049, 36076.0, 39775.40336894949, 40052.198956021006, 6497.675116244169, 6559.048937903977, 6584.144061272004, 6616.074131795346, 6649.700763465656, 10435.37387756737, 10447.791044179074, 10484.4233567153, 10498.42258675765, 10520.26358154937, 5672.602917795797, 5688.488036076773, 5708.771649133988, 5796.275465566804, 5901.704914754245, 3586.8027258501033, 3600.963990360063, 3625.873094441682, 3682.834272457746, 3698.6856117230336, 2526.9620955685677, 2558.846469211853, 2563.102913980092, 2563.4873025394995, 2564.025670245295, 390.9081365879016, 393.3745344901563, 396.6707632664939, 396.76590811421397, 397.1243408284725, 563.9904570818271, 591.0576455044861, 611.6605284067297, 625.2372106030635, 626.7242413338116, 7345.88981165283, 7472.286575492635, 7629.351505122016, 7679.2704693054075, 7755.961220193863, 455.90426010537493, 594.7204813737536, 605.7607245138233, 632.4908448698842, 660.7423104989058, 3480.7215422766117, 3544.989887114297, 3726.6087060858763, 3742.345089609362, 4122.91754164915, 50635.0, 50835.745821270655, 51261.231081533806, 51398.486015140115, 53959.0, 45628.0, 51140.0, 51183.23225151626, 51261.231081533806, 51427.0, 44139.337909931375, 44141.33787993182, 45916.0, 46361.07277854424, 46804.76597617058, 7635.656395462106, 8147.185281471805, 8469.110743371857, 8504.362172836938, 8648.956755216184, 32308.83845580757, 32435.0, 32689.836550817094, 33305.16737081592, 33459.330813384084, 37980.24039519249, 38329.6167038326, 38693.22613547769, 40817.0, 41119.588804111576, 10820.0, 10895.182861285277, 10995.285306455055, 11041.39272340029, 11130.610428634958, 11005.339679619248, 11044.42374645729, 11528.0, 11671.474783634927, 11786.941065294961, 10619.134158181621, 10621.522031508755, 10772.730681733019, 10782.622608208674, 10805.945970270413, 10880.564777408816, 11059.391733454737, 11101.722456938318, 11558.884411155781, 11581.88418115808, 8669.349798764992, 9644.0, 10137.290389672653, 10245.436500992517, 10632.468376581295, 8627.063595408019, 9093.897228004811, 9332.766680833034, 9447.055294470772, 9781.657641982496, 8816.206541411304, 9029.23251523628, 9072.274218062406, 9130.0, 9238.676646317346], "unit": "ms", "name": "yui.html", "value": 5536.639582808214}], "name": "dromaeo_css", "value": 6169.421246286988}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 105.0, 113.0, 112.0, 112.0, 102.0, 113.0, 116.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 110.9}, {"lowerIsBetter": true, "replicates": [154.0, 131.0, 154.0, 172.0, 130.0, 155.0, 158.0, 130.0, 169.0, 134.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.7}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 159.0, 161.0, 159.0, 161.0, 160.0, 160.0, 162.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 160.4}, {"lowerIsBetter": true, "replicates": [73.0, 75.0, 85.0, 97.0, 73.0, 73.0, 73.0, 95.0, 88.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 80.4}, {"lowerIsBetter": true, "replicates": [91.0, 91.0, 133.0, 91.0, 91.0, 92.0, 125.0, 91.0, 92.0, 127.0], "unit": "ms", "name": "audio-oscillator", "value": 102.4}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 148.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 69.0, 68.0, 68.0, 68.0, 69.0, 78.0, 66.0, 67.0], "unit": "ms", "name": "json-parse-financial", "value": 69.0}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 69.0, 69.0, 69.0, 68.0, 68.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [85.0, 89.0, 84.0, 82.0, 86.0, 84.0, 83.0, 84.0, 84.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.5}, {"lowerIsBetter": true, "replicates": [123.0, 128.0, 131.0, 128.0, 126.0, 125.0, 130.0, 123.0, 127.0, 119.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 126.0}, {"lowerIsBetter": true, "replicates": [134.0, 147.0, 147.0, 150.0, 136.0, 148.0, 138.0, 151.0, 157.0, 133.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.1}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 74.0, 70.0, 68.0, 74.0, 69.0, 67.0, 68.0, 67.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.6}], "name": "kraken", "value": 1516.2999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [162.60162601626016], "unit": "score", "name": "Richards", "value": 217.10729999999992}, {"lowerIsBetter": false, "replicates": [185.49434242255612], "unit": "score", "name": "DeltaBlue", "value": 356.44213800000017}, {"lowerIsBetter": false, "replicates": [279.17364600781684], "unit": "score", "name": "Encrypt", "value": 953.4603419999996}, {"lowerIsBetter": false, "replicates": [5025.125628140703], "unit": "score", "name": "Decrypt", "value": 52.970019}, {"lowerIsBetter": false, "replicates": [2002.0], "unit": "score", "name": "RayTrace", "value": 369.62487512487513}, {"lowerIsBetter": false, "replicates": [784.9293563579278], "unit": "score", "name": "Earley", "value": 849.0738620000004}, {"lowerIsBetter": false, "replicates": [12280.487804878048], "unit": "score", "name": "Boyer", "value": 54.27007547169812}, {"lowerIsBetter": false, "replicates": [26102.5641025641], "unit": "score", "name": "RegExp", "value": 34.90021119842827}, {"lowerIsBetter": false, "replicates": [621.5880893300248], "unit": "score", "name": "Splay", "value": 131.10128942115767}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19894.266713709592}]} 14:25:11 INFO - RETURN: dromaeo_css: 6169.42 14:25:11 INFO - RETURN: kraken: 1516.30 14:25:11 INFO - RETURN: v8_7: 19894.27 14:25:11 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,203,35]]", "result": "19894.27"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,203,35]]", "result": "1516.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,203,35]]", "result": "6169.42"}}} 14:25:11 INFO - Return code: 0 14:25:11 INFO - # TBPL SUCCESS # 14:25:11 INFO - Running post-action listener: _resource_record_post_action 14:25:11 INFO - Running post-run listener: _resource_record_post_run 14:25:12 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 73728; Write bytes: 516440064; Read time: 304; Write time: 537948 14:25:12 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 136945664; Read time: 0; Write time: 159776 14:25:12 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 69632; Write bytes: 325779456; Read time: 12; Write time: 346288 14:25:12 INFO - Running post-run listener: _upload_blobber_files 14:25:12 INFO - Blob upload gear active. 14:25:12 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 14:25:12 INFO - Copying logs to upload dir... 14:25:12 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1264.441151 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-11-19 14:25:12.613880) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 14:25:12.617777) ========= 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=a732b360c9c0c9a4a8cfc42c000001d9-1447970598.846722-1189925068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/WoKItLM1TZig9NxMwSfwDw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009960 build_url: 'https://queue.taskcluster.net/v1/task/WoKItLM1TZig9NxMwSfwDw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 14:25:12.675318) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 14:25:12.675848) ========= 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=a732b360c9c0c9a4a8cfc42c000001d9-1447970598.846722-1189925068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004670 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 14:25:12.726349) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 14:25:12.726807) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 14:25:12.727128) ========= ========= Total master_lag: 0.24 =========