builder: elm_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-033 starttime: 1448595643.15 results: success (0) buildid: 20151126181316 builduid: ad5a3616ca7749c4ac7f1c6aecd05029 revision: a8b2eec6909e922cdb7bb1db3d89fee3a0d0d757 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-26 19:40:43.152594) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-26 19:40:43.153126) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-26 19:40:43.153492) ========= 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=a194aa7faa1be204aaca7d660000020b-1448582686.191692-1031812117 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.007590 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-26 19:40:43.177165) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-26 19:40:43.177510) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-26 19:40:43.190672) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 19:40:43.190979) ========= 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=a194aa7faa1be204aaca7d660000020b-1448582686.191692-1031812117 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004599 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 19:40:43.241173) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-26 19:40:43.241546) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-26 19:40:43.242013) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 19:40:43.242347) ========= 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=a194aa7faa1be204aaca7d660000020b-1448582686.191692-1031812117 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-26 19:40:43-- 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% 43.3M=0s 2015-11-26 19:40:43 (43.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.385894 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 19:40:43.640948) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 19:40:43.641358) ========= 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=a194aa7faa1be204aaca7d660000020b-1448582686.191692-1031812117 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019214 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 19:40:43.690913) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-26 19:40:43.691296) ========= bash -c 'python archiver_client.py mozharness --repo projects/elm --rev a8b2eec6909e922cdb7bb1db3d89fee3a0d0d757 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/elm --rev a8b2eec6909e922cdb7bb1db3d89fee3a0d0d757 --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=a194aa7faa1be204aaca7d660000020b-1448582686.191692-1031812117 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-26 19:40:43,973 truncating revision to first 12 chars 2015-11-26 19:40:43,973 Setting DEBUG logging. 2015-11-26 19:40:43,973 attempt 1/10 2015-11-26 19:40:43,973 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/elm/a8b2eec6909e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-26 19:40:44,882 unpacking tar archive at: elm-a8b2eec6909e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.189438 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-26 19:40:44.893781) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-26 19:40:44.894135) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-26 19:40:44.904183) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-26 19:40:44.904494) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-26 19:40:44.904953) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-11-26 19:40:44.905323) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Elm --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Elm 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', 'Elm', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Elm'] 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=a194aa7faa1be204aaca7d660000020b-1448582686.191692-1031812117 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:40:45 INFO - MultiFileLogger online at 20151126 19:40:45 in /builds/slave/test 19:40:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Elm --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Elm 19:40:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:40:45 INFO - {'append_to_log': False, 19:40:45 INFO - 'base_work_dir': '/builds/slave/test', 19:40:45 INFO - 'blob_upload_branch': 'Elm', 19:40:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:40:45 INFO - 'branch': 'Elm', 19:40:45 INFO - 'buildbot_json_path': 'buildprops.json', 19:40:45 INFO - 'config_files': ('talos/linux_config.py',), 19:40:45 INFO - 'default_actions': ('clobber', 19:40:45 INFO - 'read-buildbot-config', 19:40:45 INFO - 'download-and-extract', 19:40:45 INFO - 'populate-webroot', 19:40:45 INFO - 'create-virtualenv', 19:40:45 INFO - 'install', 19:40:45 INFO - 'run-tests'), 19:40:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:40:45 INFO - 'download_minidump_stackwalk': True, 19:40:45 INFO - 'download_symbols': 'ondemand', 19:40:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:40:45 INFO - 'tooltool.py': '/tools/tooltool.py', 19:40:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:40:45 INFO - '/tools/misc-python/virtualenv.py')}, 19:40:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:40:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:40:45 INFO - 'installer_path': 'installer.exe', 19:40:45 INFO - 'log_level': 'info', 19:40:45 INFO - 'log_name': 'talos', 19:40:45 INFO - 'log_to_console': True, 19:40:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:40:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:40:45 INFO - 'opt_config_files': (), 19:40:45 INFO - 'pip_index': False, 19:40:45 INFO - 'sps_profile': False, 19:40:45 INFO - 'sps_profile_interval': 0, 19:40:45 INFO - 'suite': 'dromaeojs', 19:40:45 INFO - 'system_bits': '64', 19:40:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:40:45 INFO - 'title': 'talos-linux64-ix-033', 19:40:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:40:45 INFO - 'use_talos_json': True, 19:40:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:40:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:40:45 INFO - 'work_dir': 'build'} 19:40:45 INFO - ##### 19:40:45 INFO - ##### Running clobber step. 19:40:45 INFO - ##### 19:40:45 INFO - Running pre-action listener: _resource_record_pre_action 19:40:45 INFO - Running main action method: clobber 19:40:45 INFO - rmtree: /builds/slave/test/build 19:40:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:40:45 INFO - Running post-action listener: _resource_record_post_action 19:40:45 INFO - ##### 19:40:45 INFO - ##### Running read-buildbot-config step. 19:40:45 INFO - ##### 19:40:45 INFO - Running pre-action listener: _resource_record_pre_action 19:40:45 INFO - Running main action method: read_buildbot_config 19:40:45 INFO - Using buildbot properties: 19:40:45 INFO - { 19:40:45 INFO - "properties": { 19:40:45 INFO - "buildnumber": 43, 19:40:45 INFO - "product": "firefox", 19:40:45 INFO - "script_repo_revision": "production", 19:40:45 INFO - "builddir": "elm_ubuntu64_hw_test-dromaeojs", 19:40:45 INFO - "repository": "", 19:40:45 INFO - "buildername": "Ubuntu HW 12.04 x64 elm talos dromaeojs", 19:40:45 INFO - "buildid": "20151126181316", 19:40:45 INFO - "slavename": "talos-linux64-ix-033", 19:40:45 INFO - "pgo_build": "False", 19:40:45 INFO - "basedir": "/builds/slave/test", 19:40:45 INFO - "project": "", 19:40:45 INFO - "platform": "ubuntu64_hw", 19:40:45 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:40:45 INFO - "slavebuilddir": "test", 19:40:45 INFO - "scheduler": "tests-elm-linux64-talos", 19:40:45 INFO - "branch": "elm", 19:40:45 INFO - "repo_path": "projects/elm", 19:40:45 INFO - "stage_platform": "linux64", 19:40:45 INFO - "builduid": "ad5a3616ca7749c4ac7f1c6aecd05029", 19:40:45 INFO - "revision": "a8b2eec6909e922cdb7bb1db3d89fee3a0d0d757" 19:40:45 INFO - }, 19:40:45 INFO - "sourcestamp": { 19:40:45 INFO - "repository": "", 19:40:45 INFO - "hasPatch": false, 19:40:45 INFO - "project": "", 19:40:45 INFO - "branch": "elm-linux64-talos", 19:40:45 INFO - "changes": [ 19:40:45 INFO - { 19:40:45 INFO - "category": null, 19:40:45 INFO - "files": [ 19:40:45 INFO - { 19:40:45 INFO - "url": null, 19:40:45 INFO - "name": "https://queue.taskcluster.net/v1/task/CA6L_IFGR1eC7XXcLtfPuw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 19:40:45 INFO - } 19:40:45 INFO - ], 19:40:45 INFO - "repository": "", 19:40:45 INFO - "rev": "a8b2eec6909e922cdb7bb1db3d89fee3a0d0d757", 19:40:45 INFO - "who": "mh@glandium.org", 19:40:45 INFO - "when": 1448595593, 19:40:45 INFO - "number": 6713505, 19:40:45 INFO - "comments": "Merge m-c to elm. a=me", 19:40:45 INFO - "project": "", 19:40:45 INFO - "at": "Thu 26 Nov 2015 19:39:53", 19:40:45 INFO - "branch": "elm-linux64-talos", 19:40:45 INFO - "revlink": "", 19:40:45 INFO - "properties": [ 19:40:45 INFO - [ 19:40:45 INFO - "buildid", 19:40:45 INFO - "20151126181316", 19:40:45 INFO - "Change" 19:40:45 INFO - ], 19:40:45 INFO - [ 19:40:45 INFO - "builduid", 19:40:45 INFO - "ad5a3616ca7749c4ac7f1c6aecd05029", 19:40:45 INFO - "Change" 19:40:45 INFO - ], 19:40:45 INFO - [ 19:40:45 INFO - "pgo_build", 19:40:45 INFO - "False", 19:40:45 INFO - "Change" 19:40:45 INFO - ] 19:40:45 INFO - ], 19:40:45 INFO - "revision": "a8b2eec6909e922cdb7bb1db3d89fee3a0d0d757" 19:40:45 INFO - } 19:40:45 INFO - ], 19:40:45 INFO - "revision": "a8b2eec6909e922cdb7bb1db3d89fee3a0d0d757" 19:40:45 INFO - } 19:40:45 INFO - } 19:40:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/CA6L_IFGR1eC7XXcLtfPuw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 19:40:45 INFO - Running post-action listener: _resource_record_post_action 19:40:45 INFO - ##### 19:40:45 INFO - ##### Running download-and-extract step. 19:40:45 INFO - ##### 19:40:45 INFO - Running pre-action listener: _resource_record_pre_action 19:40:45 INFO - Running main action method: download_and_extract 19:40:45 INFO - mkdir: /builds/slave/test/build/tests 19:40:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:45 INFO - https://queue.taskcluster.net/v1/task/CA6L_IFGR1eC7XXcLtfPuw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:40:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CA6L_IFGR1eC7XXcLtfPuw/artifacts/public/build/test_packages.json 19:40:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CA6L_IFGR1eC7XXcLtfPuw/artifacts/public/build/test_packages.json 19:40:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CA6L_IFGR1eC7XXcLtfPuw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 19:40:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CA6L_IFGR1eC7XXcLtfPuw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 19:40:46 INFO - Downloaded 1302 bytes. 19:40:46 INFO - Reading from file /builds/slave/test/build/test_packages.json 19:40:46 INFO - Using the following test package requirements: 19:40:46 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 19:40:46 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:40:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:40:46 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:40:46 INFO - u'jsshell-linux-x86_64.zip'], 19:40:46 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:40:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:40:46 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 19:40:46 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:40:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:40:46 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:40:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:40:46 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:40:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:40:46 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 19:40:46 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:40:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:40:46 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:40:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:46 INFO - https://queue.taskcluster.net/v1/task/CA6L_IFGR1eC7XXcLtfPuw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:40:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CA6L_IFGR1eC7XXcLtfPuw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:40:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CA6L_IFGR1eC7XXcLtfPuw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:40:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CA6L_IFGR1eC7XXcLtfPuw/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 19:40:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CA6L_IFGR1eC7XXcLtfPuw/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 19:40:47 INFO - Downloaded 21508242 bytes. 19:40:47 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 19:40:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:40:47 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 19:40:48 INFO - Return code: 0 19:40:48 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 19:40:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:48 INFO - https://queue.taskcluster.net/v1/task/CA6L_IFGR1eC7XXcLtfPuw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:40:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CA6L_IFGR1eC7XXcLtfPuw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:40:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CA6L_IFGR1eC7XXcLtfPuw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:40:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CA6L_IFGR1eC7XXcLtfPuw/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 19:40:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CA6L_IFGR1eC7XXcLtfPuw/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 19:40:52 INFO - Downloaded 21508242 bytes. 19:40:52 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 19:40:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:40:52 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 19:40:53 INFO - Return code: 0 19:40: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')]} 19:40:53 INFO - https://queue.taskcluster.net/v1/task/CA6L_IFGR1eC7XXcLtfPuw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:40:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CA6L_IFGR1eC7XXcLtfPuw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 19:40:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CA6L_IFGR1eC7XXcLtfPuw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 19:40:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CA6L_IFGR1eC7XXcLtfPuw/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 19:40:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CA6L_IFGR1eC7XXcLtfPuw/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 19:40:55 INFO - Downloaded 11131717 bytes. 19:40:55 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 19:40:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 19:40:55 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 19:40:55 INFO - Return code: 0 19:40:55 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')]} 19:40:55 INFO - https://queue.taskcluster.net/v1/task/CA6L_IFGR1eC7XXcLtfPuw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:40:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CA6L_IFGR1eC7XXcLtfPuw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 19:40:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CA6L_IFGR1eC7XXcLtfPuw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 19:40:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CA6L_IFGR1eC7XXcLtfPuw/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 19:40:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CA6L_IFGR1eC7XXcLtfPuw/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 19:40:56 INFO - Downloaded 56839619 bytes. 19:40:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CA6L_IFGR1eC7XXcLtfPuw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 19:40:56 INFO - mkdir: /builds/slave/test/properties 19:40:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:40:56 INFO - Writing to file /builds/slave/test/properties/build_url 19:40:56 INFO - Contents: 19:40:56 INFO - build_url:https://queue.taskcluster.net/v1/task/CA6L_IFGR1eC7XXcLtfPuw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 19:40:56 INFO - Running post-action listener: _resource_record_post_action 19:40:56 INFO - Running post-action listener: set_extra_try_arguments 19:40:56 INFO - ##### 19:40:56 INFO - ##### Running populate-webroot step. 19:40:56 INFO - ##### 19:40:56 INFO - Running pre-action listener: _resource_record_pre_action 19:40:56 INFO - Running main action method: populate_webroot 19:40:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:40:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:40:56 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 19:40:56 INFO - '../fennec_ids.txt'], 19:40:56 INFO - 'tests': ['tcheck2']}, 19:40:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:40:56 INFO - '--tppagecycles', 19:40:56 INFO - '7'], 19:40:56 INFO - 'tests': ['tsvgm']}}, 19:40:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:40:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:40:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:40:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:40:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:40:56 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:40:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:40:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:40:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:40:56 INFO - 'talos_options': ['--e10s'], 19:40:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:40:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:40:56 INFO - 'tests': ['damp', 'tps']}, 19:40:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:40:56 INFO - 'talos_options': ['--e10s'], 19:40:56 INFO - 'tests': ['damp', 'tps']}, 19:40:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:40:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:40:56 INFO - 'other': {'tests': ['a11yr', 19:40:56 INFO - 'ts_paint', 19:40:56 INFO - 'tpaint', 19:40:56 INFO - 'sessionrestore', 19:40:56 INFO - 'sessionrestore_no_auto_restore']}, 19:40:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:40:56 INFO - 'tests': ['a11yr', 19:40:56 INFO - 'ts_paint', 19:40:56 INFO - 'tpaint', 19:40:56 INFO - 'sessionrestore', 19:40:56 INFO - 'sessionrestore_no_auto_restore']}, 19:40:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:40:56 INFO - 'tests': ['a11yr', 19:40:56 INFO - 'ts_paint', 19:40:56 INFO - 'tpaint', 19:40:56 INFO - 'sessionrestore', 19:40:56 INFO - 'sessionrestore_no_auto_restore']}, 19:40:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:40:56 INFO - 'tests': ['a11yr', 19:40:56 INFO - 'ts_paint', 19:40:56 INFO - 'tpaint', 19:40:56 INFO - 'sessionrestore', 19:40:56 INFO - 'sessionrestore_no_auto_restore']}, 19:40:56 INFO - 'other_l64': {'tests': ['a11yr', 19:40:56 INFO - 'ts_paint', 19:40:56 INFO - 'tpaint', 19:40:56 INFO - 'sessionrestore', 19:40:56 INFO - 'sessionrestore_no_auto_restore']}, 19:40:56 INFO - 'other_nol64': {'tests': ['a11yr', 19:40:56 INFO - 'ts_paint', 19:40:56 INFO - 'tpaint', 19:40:56 INFO - 'sessionrestore', 19:40:56 INFO - 'sessionrestore_no_auto_restore']}, 19:40:56 INFO - 'svgr': {'tests': ['tsvgx', 19:40:56 INFO - 'tsvgr_opacity', 19:40:56 INFO - 'tart', 19:40:56 INFO - 'tscrollx', 19:40:56 INFO - 'cart']}, 19:40:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:40:56 INFO - 'tests': ['tsvgx', 19:40:56 INFO - 'tsvgr_opacity', 19:40:56 INFO - 'tart', 19:40:56 INFO - 'tscrollx', 19:40:56 INFO - 'cart']}, 19:40:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:40:56 INFO - 'tests': ['tp5o']}, 19:40:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:40:56 INFO - 'talos_options': ['--e10s'], 19:40:56 INFO - 'tests': ['tp5o']}, 19:40:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:40:56 INFO - 'talos_options': ['--xperf_path', 19:40:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:40:56 INFO - 'tests': ['tp5n']}, 19:40:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:40:56 INFO - 'talos_options': ['--e10s', 19:40:56 INFO - '--xperf_path', 19:40:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:40:56 INFO - 'tests': ['tp5n']}}, 19:40:56 INFO - 'talos.zip': {'path': '', 19:40:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:40:56 INFO - Running post-action listener: _resource_record_post_action 19:40:56 INFO - ##### 19:40:56 INFO - ##### Running create-virtualenv step. 19:40:56 INFO - ##### 19:40:56 INFO - Running pre-action listener: _resource_record_pre_action 19:40:56 INFO - Running main action method: create_virtualenv 19:40:56 INFO - Creating virtualenv /builds/slave/test/build/venv 19:40:56 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 19:40:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:40:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:40:57 INFO - Using real prefix '/usr' 19:40:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:40:57 INFO - Installing distribute.............................................................................................................................................................................................done. 19:40:59 INFO - Installing pip.................done. 19:40:59 INFO - Return code: 0 19:40:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:40:59 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')]} 19:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:59 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')]} 19:40:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:59 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 0x1370030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a1210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1633220>, '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 0x159f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x159f740>, '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': 'a194aa7faa1be204aaca7d660000020b-1448582686.191692-1031812117', '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 19:40:59 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 19:40:59 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 19:40:59 INFO - Using env: {'DISPLAY': ':0', 19:40:59 INFO - 'HOME': '/home/cltbld', 19:40:59 INFO - 'LANG': 'en_US.UTF-8', 19:40:59 INFO - 'LANGUAGE': 'en_US:en', 19:40:59 INFO - 'LOGNAME': 'cltbld', 19:40:59 INFO - 'MAIL': '/var/mail/cltbld', 19:40:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:59 INFO - 'MOZ_NO_REMOTE': '1', 19:40:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:40:59 INFO - 'NO_EM_RESTART': '1', 19:40:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:40:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:59 INFO - 'PWD': '/builds/slave/test', 19:40:59 INFO - 'SHELL': '/bin/bash', 19:40:59 INFO - 'SHLVL': '1', 19:40:59 INFO - 'TERM': 'linux', 19:40:59 INFO - 'TMOUT': '86400', 19:40:59 INFO - 'USER': 'cltbld', 19:40:59 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448582686.191692-1031812117', 19:40:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:59 INFO - '_': '/tools/buildbot/bin/python'} 19:40:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:59 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 19:40:59 INFO - Cleaning up... 19:40:59 INFO - Return code: 0 19:40:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:40:59 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')]} 19:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:59 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')]} 19:40:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:59 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 0x1370030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a1210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1633220>, '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 0x159f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x159f740>, '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': 'a194aa7faa1be204aaca7d660000020b-1448582686.191692-1031812117', '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 19:40:59 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 19:40:59 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 19:40:59 INFO - Using env: {'DISPLAY': ':0', 19:40:59 INFO - 'HOME': '/home/cltbld', 19:40:59 INFO - 'LANG': 'en_US.UTF-8', 19:40:59 INFO - 'LANGUAGE': 'en_US:en', 19:40:59 INFO - 'LOGNAME': 'cltbld', 19:40:59 INFO - 'MAIL': '/var/mail/cltbld', 19:40:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:59 INFO - 'MOZ_NO_REMOTE': '1', 19:40:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:40:59 INFO - 'NO_EM_RESTART': '1', 19:40:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:40:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:59 INFO - 'PWD': '/builds/slave/test', 19:40:59 INFO - 'SHELL': '/bin/bash', 19:40:59 INFO - 'SHLVL': '1', 19:40:59 INFO - 'TERM': 'linux', 19:40:59 INFO - 'TMOUT': '86400', 19:40:59 INFO - 'USER': 'cltbld', 19:40:59 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448582686.191692-1031812117', 19:40:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:59 INFO - '_': '/tools/buildbot/bin/python'} 19:41:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:41:00 INFO - Downloading/unpacking psutil>=0.7.1 19:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:41:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:41:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:41:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:41:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:41:01 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 19:41:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:41:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:41:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:41:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:41:01 INFO - Installing collected packages: psutil 19:41:01 INFO - Running setup.py install for psutil 19:41:01 INFO - building 'psutil._psutil_linux' extension 19:41:01 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 19:41:02 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 19:41:02 INFO - building 'psutil._psutil_posix' extension 19:41:02 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 19:41:02 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 19:41:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:41:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:41:02 INFO - Successfully installed psutil 19:41:02 INFO - Cleaning up... 19:41:02 INFO - Return code: 0 19:41:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:41:02 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')]} 19:41:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:41:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41:02 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')]} 19:41:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:41:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41:02 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 0x1370030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a1210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1633220>, '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 0x159f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x159f740>, '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': 'a194aa7faa1be204aaca7d660000020b-1448582686.191692-1031812117', '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 19:41:02 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 19:41:02 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 19:41:02 INFO - Using env: {'DISPLAY': ':0', 19:41:02 INFO - 'HOME': '/home/cltbld', 19:41:02 INFO - 'LANG': 'en_US.UTF-8', 19:41:02 INFO - 'LANGUAGE': 'en_US:en', 19:41:02 INFO - 'LOGNAME': 'cltbld', 19:41:02 INFO - 'MAIL': '/var/mail/cltbld', 19:41:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:41:02 INFO - 'MOZ_NO_REMOTE': '1', 19:41:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:41:02 INFO - 'NO_EM_RESTART': '1', 19:41:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:41:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:41:02 INFO - 'PWD': '/builds/slave/test', 19:41:02 INFO - 'SHELL': '/bin/bash', 19:41:02 INFO - 'SHLVL': '1', 19:41:02 INFO - 'TERM': 'linux', 19:41:02 INFO - 'TMOUT': '86400', 19:41:02 INFO - 'USER': 'cltbld', 19:41:02 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448582686.191692-1031812117', 19:41:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:41:02 INFO - '_': '/tools/buildbot/bin/python'} 19:41:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:41:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:41:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:41:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:41:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:41:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:41:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:41:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:41:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:41:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:41:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:41:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:41:04 INFO - Installing collected packages: mozsystemmonitor 19:41:04 INFO - Running setup.py install for mozsystemmonitor 19:41:04 INFO - Successfully installed mozsystemmonitor 19:41:04 INFO - Cleaning up... 19:41:04 INFO - Return code: 0 19:41:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:41:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:41:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:41:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:41:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:41:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x1370030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a1210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1633220>, '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 0x159f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x159f740>, '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': 'a194aa7faa1be204aaca7d660000020b-1448582686.191692-1031812117', '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 19:41:04 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 19:41:04 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 19:41:04 INFO - Using env: {'DISPLAY': ':0', 19:41:04 INFO - 'HOME': '/home/cltbld', 19:41:04 INFO - 'LANG': 'en_US.UTF-8', 19:41:04 INFO - 'LANGUAGE': 'en_US:en', 19:41:04 INFO - 'LOGNAME': 'cltbld', 19:41:04 INFO - 'MAIL': '/var/mail/cltbld', 19:41:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:41:04 INFO - 'MOZ_NO_REMOTE': '1', 19:41:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:41:04 INFO - 'NO_EM_RESTART': '1', 19:41:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:41:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:41:04 INFO - 'PWD': '/builds/slave/test', 19:41:04 INFO - 'SHELL': '/bin/bash', 19:41:04 INFO - 'SHLVL': '1', 19:41:04 INFO - 'TERM': 'linux', 19:41:04 INFO - 'TMOUT': '86400', 19:41:04 INFO - 'USER': 'cltbld', 19:41:04 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448582686.191692-1031812117', 19:41:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:41:04 INFO - '_': '/tools/buildbot/bin/python'} 19:41:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:41:04 INFO - Downloading/unpacking blobuploader==1.2.4 19:41:04 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 19:41:04 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 19:41:04 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 19:41:04 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 19:41:04 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 19:41:04 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 19:41:06 INFO - Downloading blobuploader-1.2.4.tar.gz 19:41:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:41:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:41:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:41:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:41:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:41:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:41:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:41:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:41:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:41:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:41:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:41:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:41:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:41:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:41:07 INFO - Downloading docopt-0.6.1.tar.gz 19:41:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:41:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:41:07 INFO - Installing collected packages: blobuploader, requests, docopt 19:41:07 INFO - Running setup.py install for blobuploader 19:41:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:41:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:41:07 INFO - Running setup.py install for requests 19:41:07 INFO - Running setup.py install for docopt 19:41:07 INFO - Successfully installed blobuploader requests docopt 19:41:07 INFO - Cleaning up... 19:41:07 INFO - Return code: 0 19:41:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:41:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:41:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:41:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:41:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41:07 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 0x1370030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a1210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1633220>, '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 0x159f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x159f740>, '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': 'a194aa7faa1be204aaca7d660000020b-1448582686.191692-1031812117', '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 19:41:07 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 19:41:07 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 19:41:07 INFO - Using env: {'DISPLAY': ':0', 19:41:07 INFO - 'HOME': '/home/cltbld', 19:41:07 INFO - 'LANG': 'en_US.UTF-8', 19:41:07 INFO - 'LANGUAGE': 'en_US:en', 19:41:07 INFO - 'LOGNAME': 'cltbld', 19:41:07 INFO - 'MAIL': '/var/mail/cltbld', 19:41:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:41:07 INFO - 'MOZ_NO_REMOTE': '1', 19:41:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:41:07 INFO - 'NO_EM_RESTART': '1', 19:41:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:41:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:41:07 INFO - 'PWD': '/builds/slave/test', 19:41:07 INFO - 'SHELL': '/bin/bash', 19:41:07 INFO - 'SHLVL': '1', 19:41:07 INFO - 'TERM': 'linux', 19:41:07 INFO - 'TMOUT': '86400', 19:41:07 INFO - 'USER': 'cltbld', 19:41:07 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448582686.191692-1031812117', 19:41:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:41:07 INFO - '_': '/tools/buildbot/bin/python'} 19:41:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:41:07 INFO - Running setup.py (path:/tmp/pip-MRavpa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:41:07 INFO - Running setup.py (path:/tmp/pip-QaV80h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:41:08 INFO - Running setup.py (path:/tmp/pip-BgLIqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:41:08 INFO - Running setup.py (path:/tmp/pip-V4KnKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:41:08 INFO - Running setup.py (path:/tmp/pip-VQYi8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:41:08 INFO - Running setup.py (path:/tmp/pip-Ur5o7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:41:08 INFO - Running setup.py (path:/tmp/pip-adzR1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:41:08 INFO - Running setup.py (path:/tmp/pip-NLb5Bv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:41:08 INFO - Running setup.py (path:/tmp/pip-O8jgEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:41:08 INFO - Running setup.py (path:/tmp/pip-2PRwsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:41:08 INFO - Running setup.py (path:/tmp/pip-qRZ9uw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:41:08 INFO - Running setup.py (path:/tmp/pip-hnBW14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:41:08 INFO - Running setup.py (path:/tmp/pip-r6sivn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:41:08 INFO - Running setup.py (path:/tmp/pip-2mdC4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:41:08 INFO - Running setup.py (path:/tmp/pip-bqF8LJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:41:08 INFO - Running setup.py (path:/tmp/pip-V_tFR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:41:09 INFO - Running setup.py (path:/tmp/pip-UxdSX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:41:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:41:09 INFO - Running setup.py install for manifestparser 19:41:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:41:09 INFO - Running setup.py install for mozcrash 19:41:09 INFO - Running setup.py install for mozdebug 19:41:09 INFO - Running setup.py install for mozdevice 19:41:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:41:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:41:09 INFO - Running setup.py install for mozfile 19:41:09 INFO - Running setup.py install for mozhttpd 19:41:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:41:09 INFO - Running setup.py install for mozinfo 19:41:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:41:09 INFO - Running setup.py install for mozInstall 19:41:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:41:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:41:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:41:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:41:09 INFO - Running setup.py install for mozleak 19:41:10 INFO - Running setup.py install for mozlog 19:41:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:41:10 INFO - Running setup.py install for moznetwork 19:41:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:41:10 INFO - Running setup.py install for mozprocess 19:41:10 INFO - Running setup.py install for mozprofile 19:41:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:41:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:41:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:41:10 INFO - Running setup.py install for mozrunner 19:41:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:41:10 INFO - Running setup.py install for mozscreenshot 19:41:10 INFO - Running setup.py install for moztest 19:41:10 INFO - Running setup.py install for mozversion 19:41:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:41:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:41:10 INFO - Cleaning up... 19:41:10 INFO - Return code: 0 19:41:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:41: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')]} 19:41:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:41:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41: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')]} 19:41:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:41:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x1370030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a1210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1633220>, '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 0x159f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x159f740>, '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': 'a194aa7faa1be204aaca7d660000020b-1448582686.191692-1031812117', '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 19:41:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 19:41:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/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 19:41:10 INFO - Using env: {'DISPLAY': ':0', 19:41:10 INFO - 'HOME': '/home/cltbld', 19:41:10 INFO - 'LANG': 'en_US.UTF-8', 19:41:10 INFO - 'LANGUAGE': 'en_US:en', 19:41:10 INFO - 'LOGNAME': 'cltbld', 19:41:10 INFO - 'MAIL': '/var/mail/cltbld', 19:41:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:41:10 INFO - 'MOZ_NO_REMOTE': '1', 19:41:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:41:10 INFO - 'NO_EM_RESTART': '1', 19:41:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:41:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:41:10 INFO - 'PWD': '/builds/slave/test', 19:41:10 INFO - 'SHELL': '/bin/bash', 19:41:10 INFO - 'SHLVL': '1', 19:41:10 INFO - 'TERM': 'linux', 19:41:10 INFO - 'TMOUT': '86400', 19:41:10 INFO - 'USER': 'cltbld', 19:41:10 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448582686.191692-1031812117', 19:41:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:41:10 INFO - '_': '/tools/buildbot/bin/python'} 19:41:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:41:11 INFO - Running setup.py (path:/tmp/pip-If5r5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:41:11 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)) 19:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:41:11 INFO - Running setup.py (path:/tmp/pip-XNb0pF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:41:11 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)) 19:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:41:11 INFO - Running setup.py (path:/tmp/pip-nWbWFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:41:11 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)) 19:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:41:11 INFO - Running setup.py (path:/tmp/pip-IhBqgB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:41:11 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)) 19:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:41:11 INFO - Running setup.py (path:/tmp/pip-YqR4q1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:41:11 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)) 19:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:41:11 INFO - Running setup.py (path:/tmp/pip-2BCL2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:41:11 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)) 19:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:41:11 INFO - Running setup.py (path:/tmp/pip-27_BuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:41:11 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)) 19:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:41:11 INFO - Running setup.py (path:/tmp/pip-e3Zcgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:41:11 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)) 19:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:41:11 INFO - Running setup.py (path:/tmp/pip-fzwJhs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:41:11 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)) 19:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:41:11 INFO - Running setup.py (path:/tmp/pip-JOOD_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:41:11 INFO - Running setup.py (path:/tmp/pip-XJIX3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:41:11 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)) 19:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:41:11 INFO - Running setup.py (path:/tmp/pip-ddq9to-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:41:11 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)) 19:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:41:11 INFO - Running setup.py (path:/tmp/pip-hBCbjL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:41:12 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)) 19:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:41:12 INFO - Running setup.py (path:/tmp/pip-m7RGAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:41:12 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)) 19:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:41:12 INFO - Running setup.py (path:/tmp/pip-QaV6zM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:41:12 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)) 19:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:41:12 INFO - Running setup.py (path:/tmp/pip-j1IOfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:41:12 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)) 19:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:41:12 INFO - Running setup.py (path:/tmp/pip-MCzrjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:41:12 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)) 19:41:12 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)) 19:41:12 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)) 19:41:12 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)) 19:41:12 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)) 19:41:12 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)) 19:41:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:41:12 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 19:41:12 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 19:41:12 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 19:41:12 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 19:41:12 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 19:41:12 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 19:41:13 INFO - Downloading blessings-1.5.1.tar.gz 19:41:13 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 19:41:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:41:14 INFO - Installing collected packages: blessings 19:41:14 INFO - Running setup.py install for blessings 19:41:14 INFO - Successfully installed blessings 19:41:14 INFO - Cleaning up... 19:41:14 INFO - Return code: 0 19:41:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:41:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:41:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:41:14 INFO - Reading from file tmpfile_stdout 19:41:14 INFO - Current package versions: 19:41:14 INFO - argparse == 1.2.1 19:41:14 INFO - blessings == 1.5.1 19:41:14 INFO - blobuploader == 1.2.4 19:41:14 INFO - docopt == 0.6.1 19:41:14 INFO - manifestparser == 1.1 19:41:14 INFO - mozInstall == 1.12 19:41:14 INFO - mozcrash == 0.16 19:41:14 INFO - mozdebug == 0.1 19:41:14 INFO - mozdevice == 0.47 19:41:14 INFO - mozfile == 1.2 19:41:14 INFO - mozhttpd == 0.7 19:41:14 INFO - mozinfo == 0.9 19:41:14 INFO - mozleak == 0.1 19:41:14 INFO - mozlog == 3.1 19:41:14 INFO - moznetwork == 0.27 19:41:14 INFO - mozprocess == 0.22 19:41:14 INFO - mozprofile == 0.27 19:41:14 INFO - mozrunner == 6.11 19:41:14 INFO - mozscreenshot == 0.1 19:41:14 INFO - mozsystemmonitor == 0.0 19:41:14 INFO - moztest == 0.7 19:41:14 INFO - mozversion == 1.4 19:41:14 INFO - psutil == 3.1.1 19:41:14 INFO - requests == 1.2.3 19:41:14 INFO - wsgiref == 0.1.2 19:41:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:41:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:41:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:41:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:41:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:41:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41:14 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 0x1370030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a1210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1633220>, '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 0x159f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x159f740>, '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': 'a194aa7faa1be204aaca7d660000020b-1448582686.191692-1031812117', '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 19:41:14 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 19:41:14 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 19:41:14 INFO - Using env: {'DISPLAY': ':0', 19:41:14 INFO - 'HOME': '/home/cltbld', 19:41:14 INFO - 'LANG': 'en_US.UTF-8', 19:41:14 INFO - 'LANGUAGE': 'en_US:en', 19:41:14 INFO - 'LOGNAME': 'cltbld', 19:41:14 INFO - 'MAIL': '/var/mail/cltbld', 19:41:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:41:14 INFO - 'MOZ_NO_REMOTE': '1', 19:41:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:41:14 INFO - 'NO_EM_RESTART': '1', 19:41:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:41:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:41:14 INFO - 'PWD': '/builds/slave/test', 19:41:14 INFO - 'SHELL': '/bin/bash', 19:41:14 INFO - 'SHLVL': '1', 19:41:14 INFO - 'TERM': 'linux', 19:41:14 INFO - 'TMOUT': '86400', 19:41:14 INFO - 'USER': 'cltbld', 19:41:14 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448582686.191692-1031812117', 19:41:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:41:14 INFO - '_': '/tools/buildbot/bin/python'} 19:41:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:41:14 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)) 19:41:14 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)) 19:41:14 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)) 19:41:14 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)) 19:41:14 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)) 19:41:14 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)) 19:41:14 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)) 19:41:14 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)) 19:41:14 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)) 19:41:14 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)) 19:41:14 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)) 19:41:14 INFO - Cleaning up... 19:41:14 INFO - Return code: 0 19:41:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:41:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:41:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:41:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:41:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:41:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41:14 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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1370030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a1210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1633220>, '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 0x159f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x159f740>, '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': 'a194aa7faa1be204aaca7d660000020b-1448582686.191692-1031812117', '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 19:41:14 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', 'jsonschema'] in /builds/slave/test/build 19:41:14 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 jsonschema 19:41:14 INFO - Using env: {'DISPLAY': ':0', 19:41:14 INFO - 'HOME': '/home/cltbld', 19:41:14 INFO - 'LANG': 'en_US.UTF-8', 19:41:14 INFO - 'LANGUAGE': 'en_US:en', 19:41:14 INFO - 'LOGNAME': 'cltbld', 19:41:14 INFO - 'MAIL': '/var/mail/cltbld', 19:41:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:41:14 INFO - 'MOZ_NO_REMOTE': '1', 19:41:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:41:14 INFO - 'NO_EM_RESTART': '1', 19:41:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:41:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:41:14 INFO - 'PWD': '/builds/slave/test', 19:41:14 INFO - 'SHELL': '/bin/bash', 19:41:14 INFO - 'SHLVL': '1', 19:41:14 INFO - 'TERM': 'linux', 19:41:14 INFO - 'TMOUT': '86400', 19:41:14 INFO - 'USER': 'cltbld', 19:41:14 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448582686.191692-1031812117', 19:41:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:41:14 INFO - '_': '/tools/buildbot/bin/python'} 19:41:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:41:14 INFO - Downloading/unpacking jsonschema 19:41:14 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 19:41:14 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 19:41:14 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 19:41:14 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 19:41:14 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 19:41:14 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 19:41:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:41:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 19:41:16 INFO - Downloading/unpacking functools32 (from jsonschema) 19:41:16 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 19:41:16 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 19:41:16 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 19:41:16 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 19:41:16 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 19:41:16 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 19:41:16 INFO - Downloading functools32-3.2.3-2.tar.gz 19:41:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 19:41:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:41:17 INFO - warning: no files found matching '*.txt' 19:41:17 INFO - no previously-included directories found matching 'build' 19:41:17 INFO - no previously-included directories found matching 'dist' 19:41:17 INFO - no previously-included directories found matching '.git*' 19:41:17 INFO - Installing collected packages: jsonschema, functools32 19:41:17 INFO - Running setup.py install for functools32 19:41:17 INFO - warning: no files found matching '*.txt' 19:41:17 INFO - no previously-included directories found matching 'build' 19:41:17 INFO - no previously-included directories found matching 'dist' 19:41:17 INFO - no previously-included directories found matching '.git*' 19:41:17 INFO - Successfully installed jsonschema functools32 19:41:17 INFO - Cleaning up... 19:41:17 INFO - Return code: 0 19:41:17 INFO - Running post-action listener: _resource_record_post_action 19:41:17 INFO - Running post-action listener: _start_resource_monitoring 19:41:17 INFO - Starting resource monitoring. 19:41:17 INFO - ##### 19:41:17 INFO - ##### Running install step. 19:41:17 INFO - ##### 19:41:17 INFO - Running pre-action listener: _resource_record_pre_action 19:41:17 INFO - Running main action method: install 19:41:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:41:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:41:17 INFO - Reading from file tmpfile_stdout 19:41:17 INFO - Detecting whether we're running mozinstall >=1.0... 19:41:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:41:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:41:17 INFO - Reading from file tmpfile_stdout 19:41:17 INFO - Output received: 19:41:17 INFO - Usage: mozinstall [options] installer 19:41:17 INFO - Options: 19:41:17 INFO - -h, --help show this help message and exit 19:41:17 INFO - -d DEST, --destination=DEST 19:41:17 INFO - Directory to install application into. [default: 19:41:17 INFO - "/builds/slave/test"] 19:41:17 INFO - --app=APP Application being installed. [default: firefox] 19:41:17 INFO - mkdir: /builds/slave/test/build/application 19:41:17 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'] 19:41:17 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 19:41:32 INFO - Reading from file tmpfile_stdout 19:41:32 INFO - Output received: 19:41:32 INFO - /builds/slave/test/build/application/firefox/firefox 19:41:32 INFO - Running post-action listener: _resource_record_post_action 19:41:32 INFO - ##### 19:41:32 INFO - ##### Running run-tests step. 19:41:32 INFO - ##### 19:41:32 INFO - Running pre-action listener: _resource_record_pre_action 19:41:32 INFO - Running main action method: run_tests 19:41:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:41:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:41:32 INFO - Python 2.7.3 19:41:32 INFO - Return code: 0 19:41:32 INFO - grabbing minidump binary from tooltool 19:41: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')]} 19:41:32 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 0x1633220>, '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 0x159f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x159f740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:41:32 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 19:41:32 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 19:41:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:41:32 INFO - Return code: 0 19:41:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:41:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:41:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:41:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:41:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:41:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Elm', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CA6L_IFGR1eC7XXcLtfPuw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost'] in /builds/slave/test/build 19:41:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Elm --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CA6L_IFGR1eC7XXcLtfPuw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --webServer localhost 19:41:32 INFO - Using env: {'DISPLAY': ':0', 19:41:32 INFO - 'HOME': '/home/cltbld', 19:41:32 INFO - 'LANG': 'en_US.UTF-8', 19:41:32 INFO - 'LANGUAGE': 'en_US:en', 19:41:32 INFO - 'LOGNAME': 'cltbld', 19:41:32 INFO - 'MAIL': '/var/mail/cltbld', 19:41:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:41:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:41:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:41:32 INFO - 'MOZ_NO_REMOTE': '1', 19:41:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:41:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:41:32 INFO - 'NO_EM_RESTART': '1', 19:41:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:41:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:41:32 INFO - 'PWD': '/builds/slave/test', 19:41:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:41:32 INFO - 'SHELL': '/bin/bash', 19:41:32 INFO - 'SHLVL': '1', 19:41:32 INFO - 'TERM': 'linux', 19:41:32 INFO - 'TMOUT': '86400', 19:41:32 INFO - 'USER': 'cltbld', 19:41:32 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448582686.191692-1031812117', 19:41:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:41:32 INFO - '_': '/tools/buildbot/bin/python'} 19:41:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Elm', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CA6L_IFGR1eC7XXcLtfPuw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost'] with output_timeout 3600 19:41:33 INFO - mozversion INFO | application_buildid: 20151126181316 19:41:33 INFO - mozversion INFO | application_changeset: a8b2eec6909e922cdb7bb1db3d89fee3a0d0d757 19:41:33 INFO - mozversion INFO | application_display_name: Nightly 19:41:33 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:41:33 INFO - mozversion INFO | application_name: Firefox 19:41:33 INFO - mozversion INFO | application_remotingname: firefox 19:41:33 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/projects/elm 19:41:33 INFO - mozversion INFO | application_vendor: Mozilla 19:41:33 INFO - mozversion INFO | application_version: 45.0a1 19:41:33 INFO - mozversion INFO | platform_buildid: 20151126181316 19:41:33 INFO - mozversion INFO | platform_changeset: a8b2eec6909e922cdb7bb1db3d89fee3a0d0d757 19:41:33 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/projects/elm 19:41:33 INFO - mozversion INFO | platform_version: 45.0a1 19:41:33 INFO - 2015-11-26 19:41:33,015 DEBUG : using testdate: 1448595693 19:41:33 INFO - 2015-11-26 19:41:33,015 DEBUG : actual date: 1448595693 19:41:33 INFO - 2015-11-26 19:41:33,023 INFO : starting webserver on 'localhost:53214' 19:41:33 INFO - 2015-11-26 19:41:33,024 INFO : Starting test suite talos-linux64-ix-033 19:41:33 INFO - 2015-11-26 19:41:33,025 INFO : Starting test dromaeo_css 19:41:33 INFO - 2015-11-26 19:41:33,025 DEBUG : operating with platform_type : linux_ 19:41:33 INFO - 2015-11-26 19:41:33,026 INFO : Initialising browser for dromaeo_css test... 19:41:33 INFO - 2015-11-26 19:41:33,042 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp02PlmT/profile http://localhost:53214/getInfo.html 19:41:37 INFO - 2015-11-26 19:41:37,325 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:41:37 INFO - 2015-11-26 19:41:37,325 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:41:37 INFO - 2015-11-26 19:41:37,325 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 19:41:37 INFO - 2015-11-26 19:41:37,325 DEBUG : BROWSER_OUTPUT: __metrics 19:41:37 INFO - 2015-11-26 19:41:37,551 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:41:39 INFO - 2015-11-26 19:41:39,101 INFO : Browser initialized. 19:41:39 INFO - 2015-11-26 19:41:39,102 INFO : Running cycle 1/1 for dromaeo_css test... 19:41:39 INFO - 2015-11-26 19:41:39,102 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp02PlmT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:41:50 INFO - 2015-11-26 19:41:50,921 DEBUG : BROWSER_OUTPUT: RSS: Main: 137920512 19:41:50 INFO - 2015-11-26 19:41:50,921 DEBUG : BROWSER_OUTPUT: 19:42:42 INFO - 2015-11-26 19:42:42,083 DEBUG : BROWSER_OUTPUT: 1448595762080 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] 19:44:53 INFO - 2015-11-26 19:44:53,901 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53214/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53214/tests/dromaeo/cssquery-ext.html) 19:44:55 INFO - 2015-11-26 19:44:55,455 DEBUG : BROWSER_OUTPUT: RSS: Main: 276250624 19:44:55 INFO - 2015-11-26 19:44:55,455 DEBUG : BROWSER_OUTPUT: 19:47:58 INFO - 2015-11-26 19:47:58,180 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53214/tests/dromaeo/cssquery-ext.html (next: http://localhost:53214/tests/dromaeo/cssquery-jquery.html) 19:47:58 INFO - 2015-11-26 19:47:58,754 DEBUG : BROWSER_OUTPUT: RSS: Main: 217899008 19:47:58 INFO - 2015-11-26 19:47:58,754 DEBUG : BROWSER_OUTPUT: 19:51:00 INFO - 2015-11-26 19:51:00,778 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53214/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53214/tests/dromaeo/cssquery-mootools.html) 19:51:01 INFO - 2015-11-26 19:51:01,346 DEBUG : BROWSER_OUTPUT: RSS: Main: 224067584 19:51:01 INFO - 2015-11-26 19:51:01,346 DEBUG : BROWSER_OUTPUT: 19:54:03 INFO - 2015-11-26 19:54:03,298 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53214/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53214/tests/dromaeo/cssquery-prototype.html) 19:54:03 INFO - 2015-11-26 19:54:03,887 DEBUG : BROWSER_OUTPUT: RSS: Main: 204034048 19:54:03 INFO - 2015-11-26 19:54:03,887 DEBUG : BROWSER_OUTPUT: 19:57:06 INFO - 2015-11-26 19:57:06,592 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53214/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53214/tests/dromaeo/cssquery-yui.html) 19:57:07 INFO - 2015-11-26 19:57:07,186 DEBUG : BROWSER_OUTPUT: RSS: Main: 181411840 19:57:07 INFO - 2015-11-26 19:57:07,186 DEBUG : BROWSER_OUTPUT: 20:00:09 INFO - 2015-11-26 20:00:09,830 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53214/tests/dromaeo/cssquery-yui.html (next: http://localhost:53214/tests/dromaeo/cssquery-dojo.html) 20:00:10 INFO - 2015-11-26 20:00:10,080 DEBUG : BROWSER_OUTPUT: RSS: Main: 249278464 20:00:10 INFO - 2015-11-26 20:00:10,080 DEBUG : BROWSER_OUTPUT: 20:00:10 INFO - 2015-11-26 20:00:10,080 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:00:10 INFO - 2015-11-26 20:00:10,082 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:00:10 INFO - 2015-11-26 20:00:10,082 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:00:10 INFO - 2015-11-26 20:00:10,082 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:00:10 INFO - 2015-11-26 20:00:10,086 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2639.406133619935;2734.6171535984954;2735.193118030181;2750.3124218945263;2771.7505424511796;4475.104979004196;4597.678162528624;4643.512431194722;4696.694714843533;4705.764711764411;4538.341940418637;4568.200564901137;4584.839530616429;4612.031473390583;4643.837465688702;4230.619244268015;4312.460942382202;4315.633171180438;4336.761478118702;4355.564443555635;4033.2135233629456;4320.891977700567;4375.496817865938;4395.362672412498;4451.087527056961;4149.439825623533;4249.107687385622;4251.213525497762;4251.91496170078;4368.47578290604;4332.783360831977;4340.348947657845;4347.934780978257;4353.28170851809;4362.454693163355;4280.379344994958;4292.635126014293;4316.762578058206;4319.654427645813;4334.956650433487;4415.867523974286;4553.271476563734;4553.2942393929;4626.537346265381;4700.318453824177;4816.951830481686;4939.777710003059;4960.131976904027;4967.751612419401;4969.180085285923;5019.447860735316;5021.397432308147;5040.899182016376;5046.26829109777;5052.46949070346;4664.9503861630865;4669.509701481364;4670.229412147026;4675.251959686434;4705.952940470585;4832.9275060874115;4933.50664933511;4954.5540901319055;4967.205247160437;5035.521625445577;4930.038642464685;4972.303877457159;4974.0797952378925;4974.129527332775;5027.572656324181;5039.21892106724;5056.747162641853;5060.797568097235;5061.949380506221;5069.493050694901;4700.741459219707;4747.8575642730775;4797.352357431702;4797.472278049412;4856.2958371036;4960.50394960501;4973.403191617029;4979.775910084055;4980.12847751642;5023.34696489454;3897.434871943609;3897.9805100974313;3900.180961998012;3921.745086569364;3939.153082087365;3386.712129469023;3481.7388695847912;3493.7903725776537;3503.649635036476;3543.7519373644113;4247.384129301234;4250.404943307939;4308.267594508941;4313.698041137153;4346.521882592912;5034.244863270465;5035.496450354935;5044.319016932741;5046.44489106198;5061.139606266944;4143.37849322598;4233.640140588084;4306.633936115465;4306.676999225071;4342.066455712037;4277.850275240352;4309.870703878889;4321.092570560218;4324.610785029363;4369.453818272716;4738.810447582058;4746.240601503743;4746.38297021385;4753.809847606126;4808.855734327975;4792.688475249098;4904.681195722266;4997.550220480174;4998.950010499849;5054.115529782347;4662.813487460464;4688.367070445446;4689.507601701908;4716.716996980193;4738.668293219442;4817.084753896748;4856.514348565115;4861.9027619448125;4869.683470574401;4901.3138160658245;4712.787924543335;4769.523047695203;4931.950680493293;4954.380702412199;4980.825671101494;4621.029583787442;4621.976890115528;4628.421447319085;4636.814527419;4636.83771068011;4787.8563643090765;4817.229243321051;4817.494163112963;4818.084563932842;4831.371921650163;4640.419947506562;4693.765311734468;4729.976350118227;4737.549932756383;4742.7865746040825;4878.268259761065;4935.703857768545;4943.505649435027;4943.752812359439;4988.55103040728;4791.041791641616;4813.975930120327;4815.6147508199965;4820.25286080644;4867.29424233477 20:00:10 INFO - 2015-11-26 20:00:10,086 DEBUG : BROWSER_OUTPUT: |1;ext.html;524.7454984332601;538.9137737961922;562.5668235458696;580.2311936683893;583.4807021750643;25471.49057018861;25984.350391240205;26041;34698.47952280718;35355;39052.80473597635;39834.402483962695;39967.400488992615;40025;40034.79982600083;7796.5711885846395;8026.759197224063;8027.157148499411;8037.638306276232;8039.598020099001;6871.828204294908;7061.364477197051;10198.490075496233;10418.79162416755;10430.426326552037;10008.899911000906;10027;10098.990100989915;10106.74733131674;10113.69658910234;6885.862282754367;7078.752243671498;9866.210703143732;9951.950240248825;9968.507873031778;10107.241956853191;10288.43413612251;10364.067233948981;10368.015038571324;10408.947955260175;37163.25673486542;37711.62288377109;37720;37727.35908486407;37776.244475110616;2734.5898115282666;2823.6046953426535;3394.6096198937194;3589.6769290763696;3627.4014787560022;28348.71651283502;28503.57244641332;28706.282342941384;28867.133985980454;28892.42215155685;3419.8803041893416;3503.877364292263;3513.841877115536;3580.6419358064245;3636.781793092423;217501;218423;218733.9999999984;219268;219833;41171.38242926358;53752.46247537553;54269.72865135649;54334.728326358905;54343.18485222725;39667.40498892519;63343;64603;64619;64736.67631661812;13010.54463093806;13278.136921100098;13284.00369972256;13285.66785830362;13298.401571929286;9742.61029558824;9836.655717049869;9859.802803943881;9862.02759448099;9869.11177993984;18346.724799128024;18520.98134602583;18546.44360669182;18570.628587428175;18652.533686657942;7148.997421083158;7318.451116166309;7366.447516436288;7368.37368823656;7420.591867447234;785.1990969211372;813.3899575318511;821.5892053973014;896.1979028769346;941.708070498134;23505.882470587538;23746.406339841644;24110.638340424906;25093.498130037297;25145.622815657778;881.722257488889;909.5815924674723;912.2656261709255;940.2008292950937;940.3840484482674;12599.496020159275;12632.178908370926;12838.358082095858;13160.802587961189;13195.274259915604;260636;263560.04659930116;264102;264195;265945;43914.12171756547;43969.78015109904;44096.779516102855;44157.55842441534;44258.33612495815;1058.5448257249302;1074.1514203778927;1167.5679998400476;1193.0932491306496;1193.6419074277856;22058.779412206313;22906.198283060014;23394.64908026347;26959.326016849736;28482.57276140818;41492.377614336416;42218;42250.36624450697;42388.78805605952;42445.726628201206;212155;214246;214306;214619;214822;24746;25257;28681.569776453787;28916.42167156687;29121.271968200963;36578.634213657526;36628.402624952956;37564.81217594004;38081.238375231784;38148.618513815614;32050.679493205702;32429.351412971137;32619.18452038718;32897.83551082229;33420;24815.503689926463;30762.384752305275;32055;32443.513347300282;33080.172995675304;32814.5077823828;33002.339953201285;33386.83306583549;33773.83113084419;33889.83055084709;25292.74707252904;27516.17451476459;27614.5857812137;28983.5652465209;29604.555931660612;23304.883475583192;23377.532449351256;23421.531569368857;23543.88228058849;23641.40896477602 20:00:10 INFO - 2015-11-26 20:00:10,087 DEBUG : BROWSER_OUTPUT: |2;jquery.html;331.8589599420247;334.59681084293413;336.2333878756435;336.23506522660944;336.6448396941226;14740.189289589081;14947;15682.372705091797;16301.755473667874;16316.918415407907;9072.591733371997;10052.14556762676;10055.849162262572;10070.748231294221;10071.69784906454;3253.8210398428077;4491.191585514606;4539.251023581105;4555.63554915606;5034.5468907798295;3306.983465082671;3308.6360500345063;3315.0386387947465;3343.414902392072;4978.352814134176;5091.592672586203;5124.871878203056;5139.820106296281;5144.819931302405;5145.305383773199;4969.850904472872;5054.19132938728;5067.721275329855;5071.137906555876;5111.488851114896;3138.5606015157896;3223.2103134731906;3224.6130464344196;3225.79032362898;3233.434149023935;17649.647007059786;17755.46733597994;18144.274229030823;18155.909220453945;18168.1824317906;1783.4382169616529;1800.324878170686;1807.566184115816;1814.8638852086146;1820.336008645599;8853.468791872509;8926.776830579223;11836.230645008047;11905.464254108585;12185.268883866996;1707.6499317639855;1709.6495218480181;1717.083440920011;1743.9128043597768;1826.6894627913155;52688.73655631736;55900.72049639766;56722.716386418215;57038.429615703724;57696;9566.234701224024;9629.518524073768;9688.660896868716;9702.320837541305;9809;12356.938215308866;12357.93821030889;12361.505539778487;12375.876241237473;12390.3185324808;6741.561798483181;6787.830304242335;6797.66011699423;6815.250322464525;6878.140232470942;6356.364363563606;6377.4579160771855;6407.295197528269;6410.326915673787;6415.775447859396;4075.5109386873764;4083.7958102094776;4087.9795601021806;4133.0700592366475;4170.457840480718;1709.7691811605523;1722.7674263974454;1733.9479815605553;1762.726777349513;1796.2455768577229;782.6673663692908;808.7960308160216;829.8589239829244;833.1585099050003;902.801383695586;14688;15700.293486793122;15965.521034368987;16079.29406039427;16243.187840607923;817.4890693316677;826.0582935453588;826.1036775099085;847.1528471528471;863.589794847455;6559.508036897157;8543.700970466003;8637.827243455222;8856.424332418372;9229.054504562822;442838;461912;470655;471661;483081;69164.3083569168;69444;69580.6520967392;70179;70472;872.9563521823883;892.901780804111;1054.8997845204694;1098.214776434837;1142.0977427832086;13744.175349479063;14426.567202983928;14523.927380363031;14643.633909152357;15073;32285.35429291448;32364;32725.836370817993;33208.66791332152;33236.66763332432;42020;42547.11820577802;42918;43658.781706091264;43756;8837.734867953972;8987.41581797181;9072.138146876036;9088.363814532919;9104.317176211678;10454.924874791246;15287;15356.308966096776;15700.29348679335;15762.133082680104;13346.666333341356;13672.316384180553;14032;14084.507042253472;14380.712385752016;13048.217106973612;13744.587662370144;13779.517716879862;13841;14038.649033774238;13043.152195107288;13361.799573006218;13546.119502232323;13610.659733506742;14127;8938.86591701138;8981.730548083568;9010.0989901012;9024.774380640536;9068.047854975133;13292.800607990694;13789.931050344683;13840.792388113985;13900.860991390362;13996.090254133449 20:00:10 INFO - 2015-11-26 20:00:10,088 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1265.0385706862783;1578.7000469910715;1646.9835301646988;1649.7772800671905;1684.4188754879563;5687.260656114704;6903.758368457099;7123.7862864114095;7218.061651985247;7219.314165154302;6586.8682626347445;6726.495512836545;6732.427743641796;6746.865062698743;6752.797416077513;1665.8001039875232;1695.440504633468;1696.5080126763223;2037.8369730421568;2082.427332483564;2042.8672136311166;2108.188347486221;2109.325015994882;2110.6833974903734;2111.80993710566;2014.556797504554;2036.1142902837314;2039.1333683184662;2059.608674351876;2063.2159779283925;1992.1035534009754;2038.6432374334506;2042.05044654235;2063.494443861256;2066.2148383614203;2107.79975902289;2139.4758284220466;2139.743230812297;2140.2081229944865;2145.356393082069;6901.551399159089;6959.512834101615;6963.965180174117;6966.198887127995;6969;4049.190161967618;4162.521310049323;4162.771047592381;4165.708400411972;4170.541240463546;2685.5300322443495;2806.0599699100826;2821.7742580593504;2829.5048366535775;2838.503261929154;707.678006507038;826.1201820061615;841.146236569882;847.4449235750593;865.2861389353808;9378.577963991636;9422.387544809566;9453.763655908657;9457.007014263472;9459.24326053914;3962.980185099056;3967.861124860674;4025.215083058834;4033.69747268956;4049.3521036633997;8200.712975045844;8211.95894020526;8231.176882311722;8241.175882411711;8252.793680157924;4237.660987121023;4242.300020496646;4246.023414614594;4250.341197114452;4253.723507971972;3861.7876016819346;3864.1885204107452;3867.45855580219;3871.1289959759392;3874.49631547897;3259.6251431085257;3289.983550082234;3298.67013298673;3322.1362445764275;3325.7671962962845;1053.3100818963437;1059.2849826367171;1072.9570817167382;1079.3362082319475;1111.4942701070993;893.1291990309396;906.7053207707521;907.1744712311896;909.6088681866728;1181.1259667845732;6703.93296067033;6756.459483241329;6757.087793147961;6758.256591774901;6759.256481787;419.5028890764454;420.7938110325918;421.1534815021767;1086.1745073744012;1112.8831472695413;5246.527812496894;5272.130098533699;5315.973420132875;5322.520973112361;5322.760475778599;7552.546847189186;8624.223819856117;8739.781505462413;8821.779455513664;8844.425112367675;7538.698452061856;8411.537365444838;8569.228769410784;8594.44136131162;8606.612702428405;6395.20059992501;6542.607443553306;6544.9672751635935;6546.70539825709;6558.901616475757;6357.96821015892;6511.706973186123;6514.511411644051;6519.08732777402;6520.119783829123;7453.142888567667;7525.059367579052;7550.093988721389;7553.131389890013;7626.504277221963;7717.6527056281475;7743.225677432437;7762.262585054411;7779.7666070017995;7874.842503150019;5891.499222565958;5995.730192141277;6003;6009.038553831366;6010.368911264254;6209;6548.1814773153355;6551.050097735897;6591.044298576776;6611.504137189826;6285.748570057147;6297.086922396318;6436.645984470899;6468.773592924414;6535.640539770358;6177.84555386119;6242.719077641608;6247.781327653511;6350.428461438492;6392.744290228525;6376.458001069961;6391.360863913757;6400.103985442135;6483.546151769331;6527.445167160845;5707.6290041147195;5721.1990321354215;5722;5728.283964504437;5731.8567035824435;6001.669908155093;6036.6679832609625;6045.78839740607;6060.212172417558;6093.390660933871 20:00:10 INFO - 2015-11-26 20:00:10,090 DEBUG : BROWSER_OUTPUT: |4;prototype.html;294.6052289931491;301.9350839569492;303.0877060049251;311.07300245269096;312.5109204095589;5325;5341.65279256848;5374.48942350476;5382.4886635769535;5388.43421440749;5281.683099014062;5293.470652934705;5298.178782288752;5309.070912590291;5309.389420216677;3917.8236979335998;4138.151678905817;4140.192662430827;4149.605787450188;4150.771707556083;4013.036871150932;4053.675705943532;4115.259253334399;4142.937855932163;4181.874543763692;4098.364753463218;4119.8352065917325;4121.711480196387;4131.752094874302;4136.069384388518;3879.9030024249337;3992.7205095643317;4015.156817068419;4113.115680128772;4115.52671442785;3640.9817950910074;3653.3058718843336;3661.9267614647824;3669.4862719219063;3672.026912868092;5147.047796157685;5150.716710580917;5154.07226699194;5157;5159.2003239497935;4783.904321913577;4790.257510085942;4793.304970779218;4795.088933102699;4799.208130658437;5457.727113644302;5626.521745651625;5627.2684551008515;5628.971855140698;5638.859028524279;3965.0087478130467;3968.523777146761;3973.304671682444;3986.3223252047223;3989.940150897739;5898.469137777578;5911.852203694899;5914.733836977346;5919.230500034968;5922.58541902067;4113.341865301538;4115.115250221217;4117.114820313647;4118.258713431551;4124.1133156371525;3921.5490218624655;4051.736637118578;4188.5811418857875;4189.622933935961;4192.45498085247;4688.789004494738;4689.882752931136;4691.741954192484;4697.037107392976;4698.694584852042;5658.773649054074;5664.433556644385;5666.206731057655;5669.348024977098;5672.205891175238;1416.235232974203;1432.5057855039995;1433.1186320412871;1434.2613554019688;1434.5911415246605;938.6573900526258;940.9576569054409;966.1642679082543;972.5186032913612;974.3033730882453;4961.826336078292;4962.751862406865;4967.5777558907175;4969.180085285887;4977.303177555145;5833.095870140135;5856.355800861902;5863.70681465925;5864.70676466175;5865.73604187804;4947.5794557462295;4954.430240522314;4955.925661115086;4959.13215187348;4960.801567937242;3098.98450507746;3158.6683398243313;3187.8724851006164;3193.0420873737785;3209.6148462184688;5605.299337582802;5610.943890561124;5622.072358060956;5626.099824028136;5630.071038278638;6096.817095487142;6098.451139397475;6098.908516372258;6099.69501524922;6103.450689437883;5490.121580547093;5606.635568688022;5622.128570071645;5623.943760562423;5625.212470254086;5898.085796701518;5937;5940.1683764272175;5946.791862284799;5947.31605865331;5767.6446035182535;5793.884122317614;5805.158252053513;5805.3614102447855;5810.7094645266725;5590.496855283044;5593.804216852391;5599.580031497572;5602.635828671123;5603.075492543685;3950.683945284313;4019.1157945253167;4042.6563742081075;4059.512858457004;4084.1627466368727;5903.527717782481;5915.467607915309;5919.822405327847;5920.585559010828;5920.79277225295;5681.914771278517;5693.345265294379;5704.515116215002;5705.087186050212;5708.57185711065;5542.279503664659;5699.544036476989;5709.314882214161;5714.171445140514;5714.342850572071;5535.944640553543;5556.361018482926;5588.608797384144;5589.80435684749;5604.523615492729;5403.621746477709;5597.160425935979;5703.401142879938;5715.714214289185;5729.54163666914;5404.918926216032;5549.417311182267;5587.273654424899;5618.438156184349;5625.296837895263 20:00:10 INFO - 2015-11-26 20:00:10,091 DEBUG : BROWSER_OUTPUT: |5;yui.html;766.2337662337663;773.1495355109377;778.844231153769;782.2724421814738;793.9126696063432;11128.165387595933;11433.428328583559;11446.542138314479;11530.538778448852;11558.53765849366;11261.380624065694;11290.548378064868;11357.034652054565;11358.943205283982;11366.943165284161;473.9265413860857;481.7615280436189;756.255088737593;756.8334966307403;783.6512751825439;770.7302444144533;773.6441237030945;779.4115442840647;780.0522365326127;780.1418439716296;505.2219581843956;814.7189219719218;822;822.4037572759761;823.1439303124743;506.82261208576887;794.5788731972035;809.1221025187679;810.05628442864;810.2950433123161;595.3570144244206;595.8599729063667;596.2814808156162;596.7612954818064;597.0298265318856;11753.823692644532;11904.642860714192;11920.284782913053;11928.880711192864;11932.16474846761;11192.832107518394;11262;11492.942535287353;11685.94157029218;12145.757084858253;9146.314026447977;9209.723708288762;9257.583408746556;9257.814843703089;9260.166585007315;3165.6517783043846;3225.3905281428215;3261.8858339957987;3285.4578994465883;3322.883699070545;41837.790811046056;41842.79078604618;41906.79046604778;41917;41922.580774192174;9106.590203440861;9194.080591940752;9234.81530369389;9260.768480788034;9299.20956718673;14820.62948426298;14900;14904.552863414116;14909.179995100374;14948.626284342761;6160.907586386208;6165.84585385369;6249.531285153632;6448.903266451007;6630.53586248958;3544.9645503544634;3635.363811333059;3654.1230104774663;3697.870574529932;3707.258548290353;2507.072383218221;2541.911033113832;2544.8345857519203;2550.2859199424192;2553.310606136333;472.09829226177834;477.27930824455325;490.60996507776406;490.629574671121;501.4158505341309;544.9509544140967;550.9366422861342;572.4275724275724;576.07827476038;583.9766409343579;7291.1250649921285;7879.527228366316;8120.472169308976;8133.59332033396;8560.357973152039;357.8479146362785;446.9452093060375;531.455258360184;542.8317221661298;552.9668219906819;3358.748093892968;3565;3569.5716514017963;3611.656892595252;3685.5024571683016;42634.14731705349;53335.46664533305;53601.463985360424;53703.73148134312;53800.73099634477;35873.103172420895;42325.36511952323;44642.33036504455;47254;47280.290795638095;44018.33972490415;44116.55883441125;44696.55303446989;44916.77541612336;45129;7441.888371674538;7736.994190755391;8186.304164146114;8212.384071194565;8436.198561136682;33437.665623343455;34104.14739631529;34204.14489637779;34451.65548344485;34524.48213276752;38634.22731545297;41907;42654.14691706086;42827.143457130056;43019.35470968;9455.527223638654;9612.75968100775;9957.302988790716;9969;10040.799184016132;10904.945475272572;10966.670999870017;11004.339739615649;11028;11476.655700329004;10397.32417392867;10782;10911.399873006743;10916.454177290945;11068.889311106786;10658.520366583678;10891.618793342195;10998.835017474905;11077.058450031838;11359.375234362189;9334.299927505328;9907.702768916944;9928.702138935843;10167.898321016992;10179.541920613443;8818.206361427247;9212.170904618617;9299.581518831805;9495.287853410884;9724.805503889742;8799.604017819342;9022.5939832709;9083.772905677411;9260.380579902887;9263.814723705624 20:00:10 INFO - 2015-11-26 20:00:10,091 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:00:10 INFO - 2015-11-26 20:00:10,091 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:00:10 INFO - 2015-11-26 20:00:10,091 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1246 20:00:10 INFO - 2015-11-26 20:00:10,091 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:00:10 INFO - 2015-11-26 20:00:10,091 DEBUG : BROWSER_OUTPUT: __startTimestamp1448596810080__endTimestamp 20:00:10 INFO - 2015-11-26 20:00:10,091 DEBUG : BROWSER_OUTPUT: 20:00:10 INFO - 2015-11-26 20:00:10,092 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:00:10 INFO - 2015-11-26 20:00:10,092 DEBUG : BROWSER_OUTPUT: Number of tests: 6 20:00:10 INFO - 2015-11-26 20:00:10,092 DEBUG : BROWSER_OUTPUT: 20:00:10 INFO - 2015-11-26 20:00:10,093 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4569.67 Median:4700.32 stddev:484.26 (10.3%) stddev-sans-first:461.47 20:00:10 INFO - 2015-11-26 20:00:10,093 DEBUG : BROWSER_OUTPUT: Values: 2639.4 2734.6 2735.2 2750.3 2771.8 4475.1 4597.7 4643.5 4696.7 4705.8 4538.3 4568.2 4584.8 4612.0 4643.8 4230.6 4312.5 4315.6 4336.8 4355.6 4033.2 4320.9 4375.5 4395.4 4451.1 4149.4 4249.1 4251.2 4251.9 4368.5 4332.8 4340.3 4347.9 4353.3 4362.5 4280.4 4292.6 4316.8 4319.7 4335.0 4415.9 4553.3 4553.3 4626.5 4700.3 4817.0 4939.8 4960.1 4967.8 4969.2 5019.4 5021.4 5040.9 5046.3 5052.5 4665.0 4669.5 4670.2 4675.3 4706.0 4832.9 4933.5 4954.6 4967.2 5035.5 4930.0 4972.3 4974.1 4974.1 5027.6 5039.2 5056.7 5060.8 5061.9 5069.5 4700.7 4747.9 4797.4 4797.5 4856.3 4960.5 4973.4 4979.8 4980.1 5023.3 3897.4 3898.0 3900.2 3921.7 3939.2 3386.7 3481.7 3493.8 3503.6 3543.8 4247.4 4250.4 4308.3 4313.7 4346.5 5034.2 5035.5 5044.3 5046.4 5061.1 4143.4 4233.6 4306.6 4306.7 4342.1 4277.9 4309.9 4321.1 4324.6 4369.5 4738.8 4746.2 4746.4 4753.8 4808.9 4792.7 4904.7 4997.6 4999.0 5054.1 4662.8 4688.4 4689.5 4716.7 4738.7 4817.1 4856.5 4861.9 4869.7 4901.3 4712.8 4769.5 4932.0 4954.4 4980.8 4621.0 4622.0 4628.4 4636.8 4636.8 4787.9 4817.2 4817.5 4818.1 4831.4 4640.4 4693.8 4730.0 4737.5 4742.8 4878.3 4935.7 4943.5 4943.8 4988.6 4791.0 4814.0 4815.6 4820.3 4867.3 20:00:10 INFO - 2015-11-26 20:00:10,093 DEBUG : BROWSER_OUTPUT: 20:00:10 INFO - 2015-11-26 20:00:10,093 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39143.54 Median:32856.17 stddev:60697.19 (184.7%) stddev-sans-first:60798.20 20:00:10 INFO - 2015-11-26 20:00:10,094 DEBUG : BROWSER_OUTPUT: Values: 524.7 538.9 562.6 580.2 583.5 25471.5 25984.4 26041.0 34698.5 35355.0 39052.8 39834.4 39967.4 40025.0 40034.8 7796.6 8026.8 8027.2 8037.6 8039.6 6871.8 7061.4 10198.5 10418.8 10430.4 10008.9 10027.0 10099.0 10106.7 10113.7 6885.9 7078.8 9866.2 9952.0 9968.5 10107.2 10288.4 10364.1 10368.0 10408.9 37163.3 37711.6 37720.0 37727.4 37776.2 2734.6 2823.6 3394.6 3589.7 3627.4 28348.7 28503.6 28706.3 28867.1 28892.4 3419.9 3503.9 3513.8 3580.6 3636.8 217501.0 218423.0 218734.0 219268.0 219833.0 41171.4 53752.5 54269.7 54334.7 54343.2 39667.4 63343.0 64603.0 64619.0 64736.7 13010.5 13278.1 13284.0 13285.7 13298.4 9742.6 9836.7 9859.8 9862.0 9869.1 18346.7 18521.0 18546.4 18570.6 18652.5 7149.0 7318.5 7366.4 7368.4 7420.6 785.2 813.4 821.6 896.2 941.7 23505.9 23746.4 24110.6 25093.5 25145.6 881.7 909.6 912.3 940.2 940.4 12599.5 12632.2 12838.4 13160.8 13195.3 260636.0 263560.0 264102.0 264195.0 265945.0 43914.1 43969.8 44096.8 44157.6 44258.3 1058.5 1074.2 1167.6 1193.1 1193.6 22058.8 22906.2 23394.6 26959.3 28482.6 41492.4 42218.0 42250.4 42388.8 42445.7 212155.0 214246.0 214306.0 214619.0 214822.0 24746.0 25257.0 28681.6 28916.4 29121.3 36578.6 36628.4 37564.8 38081.2 38148.6 32050.7 32429.4 32619.2 32897.8 33420.0 24815.5 30762.4 32055.0 32443.5 33080.2 32814.5 33002.3 33386.8 33773.8 33889.8 25292.7 27516.2 27614.6 28983.6 29604.6 23304.9 23377.5 23421.5 23543.9 23641.4 20:00:10 INFO - 2015-11-26 20:00:10,094 DEBUG : BROWSER_OUTPUT: 20:00:10 INFO - 2015-11-26 20:00:10,094 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25467.29 Median:1839.01 stddev:76194.99 (4143.3%) stddev-sans-first:76385.36 20:00:10 INFO - 2015-11-26 20:00:10,095 DEBUG : BROWSER_OUTPUT: Values: 331.9 334.6 336.2 336.2 336.6 14740.2 14947.0 15682.4 16301.8 16316.9 9072.6 10052.1 10055.8 10070.7 10071.7 3253.8 4491.2 4539.3 4555.6 5034.5 3307.0 3308.6 3315.0 3343.4 4978.4 5091.6 5124.9 5139.8 5144.8 5145.3 4969.9 5054.2 5067.7 5071.1 5111.5 3138.6 3223.2 3224.6 3225.8 3233.4 17649.6 17755.5 18144.3 18155.9 18168.2 1783.4 1800.3 1807.6 1814.9 1820.3 8853.5 8926.8 11836.2 11905.5 12185.3 1707.6 1709.6 1717.1 1743.9 1826.7 52688.7 55900.7 56722.7 57038.4 57696.0 9566.2 9629.5 9688.7 9702.3 9809.0 12356.9 12357.9 12361.5 12375.9 12390.3 6741.6 6787.8 6797.7 6815.3 6878.1 6356.4 6377.5 6407.3 6410.3 6415.8 4075.5 4083.8 4088.0 4133.1 4170.5 1709.8 1722.8 1733.9 1762.7 1796.2 782.7 808.8 829.9 833.2 902.8 14688.0 15700.3 15965.5 16079.3 16243.2 817.5 826.1 826.1 847.2 863.6 6559.5 8543.7 8637.8 8856.4 9229.1 442838.0 461912.0 470655.0 471661.0 483081.0 69164.3 69444.0 69580.7 70179.0 70472.0 873.0 892.9 1054.9 1098.2 1142.1 13744.2 14426.6 14523.9 14643.6 15073.0 32285.4 32364.0 32725.8 33208.7 33236.7 42020.0 42547.1 42918.0 43658.8 43756.0 8837.7 8987.4 9072.1 9088.4 9104.3 10454.9 15287.0 15356.3 15700.3 15762.1 13346.7 13672.3 14032.0 14084.5 14380.7 13048.2 13744.6 13779.5 13841.0 14038.6 13043.2 13361.8 13546.1 13610.7 14127.0 8938.9 8981.7 9010.1 9024.8 9068.0 13292.8 13789.9 13840.8 13900.9 13996.1 20:00:10 INFO - 2015-11-26 20:00:10,095 DEBUG : BROWSER_OUTPUT: 20:00:10 INFO - 2015-11-26 20:00:10,095 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4899.21 Median:6076.80 stddev:2544.23 (41.9%) stddev-sans-first:2536.70 20:00:10 INFO - 2015-11-26 20:00:10,095 DEBUG : BROWSER_OUTPUT: Values: 1265.0 1578.7 1647.0 1649.8 1684.4 5687.3 6903.8 7123.8 7218.1 7219.3 6586.9 6726.5 6732.4 6746.9 6752.8 1665.8 1695.4 1696.5 2037.8 2082.4 2042.9 2108.2 2109.3 2110.7 2111.8 2014.6 2036.1 2039.1 2059.6 2063.2 1992.1 2038.6 2042.1 2063.5 2066.2 2107.8 2139.5 2139.7 2140.2 2145.4 6901.6 6959.5 6964.0 6966.2 6969.0 4049.2 4162.5 4162.8 4165.7 4170.5 2685.5 2806.1 2821.8 2829.5 2838.5 707.7 826.1 841.1 847.4 865.3 9378.6 9422.4 9453.8 9457.0 9459.2 3963.0 3967.9 4025.2 4033.7 4049.4 8200.7 8212.0 8231.2 8241.2 8252.8 4237.7 4242.3 4246.0 4250.3 4253.7 3861.8 3864.2 3867.5 3871.1 3874.5 3259.6 3290.0 3298.7 3322.1 3325.8 1053.3 1059.3 1073.0 1079.3 1111.5 893.1 906.7 907.2 909.6 1181.1 6703.9 6756.5 6757.1 6758.3 6759.3 419.5 420.8 421.2 1086.2 1112.9 5246.5 5272.1 5316.0 5322.5 5322.8 7552.5 8624.2 8739.8 8821.8 8844.4 7538.7 8411.5 8569.2 8594.4 8606.6 6395.2 6542.6 6545.0 6546.7 6558.9 6358.0 6511.7 6514.5 6519.1 6520.1 7453.1 7525.1 7550.1 7553.1 7626.5 7717.7 7743.2 7762.3 7779.8 7874.8 5891.5 5995.7 6003.0 6009.0 6010.4 6209.0 6548.2 6551.1 6591.0 6611.5 6285.7 6297.1 6436.6 6468.8 6535.6 6177.8 6242.7 6247.8 6350.4 6392.7 6376.5 6391.4 6400.1 6483.5 6527.4 5707.6 5721.2 5722.0 5728.3 5731.9 6001.7 6036.7 6045.8 6060.2 6093.4 20:00:10 INFO - 2015-11-26 20:00:10,095 DEBUG : BROWSER_OUTPUT: 20:00:10 INFO - 2015-11-26 20:00:10,096 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4695.85 Median:5333.33 stddev:1391.28 (26.1%) stddev-sans-first:1355.40 20:00:10 INFO - 2015-11-26 20:00:10,096 DEBUG : BROWSER_OUTPUT: Values: 294.6 301.9 303.1 311.1 312.5 5325.0 5341.7 5374.5 5382.5 5388.4 5281.7 5293.5 5298.2 5309.1 5309.4 3917.8 4138.2 4140.2 4149.6 4150.8 4013.0 4053.7 4115.3 4142.9 4181.9 4098.4 4119.8 4121.7 4131.8 4136.1 3879.9 3992.7 4015.2 4113.1 4115.5 3641.0 3653.3 3661.9 3669.5 3672.0 5147.0 5150.7 5154.1 5157.0 5159.2 4783.9 4790.3 4793.3 4795.1 4799.2 5457.7 5626.5 5627.3 5629.0 5638.9 3965.0 3968.5 3973.3 3986.3 3989.9 5898.5 5911.9 5914.7 5919.2 5922.6 4113.3 4115.1 4117.1 4118.3 4124.1 3921.5 4051.7 4188.6 4189.6 4192.5 4688.8 4689.9 4691.7 4697.0 4698.7 5658.8 5664.4 5666.2 5669.3 5672.2 1416.2 1432.5 1433.1 1434.3 1434.6 938.7 941.0 966.2 972.5 974.3 4961.8 4962.8 4967.6 4969.2 4977.3 5833.1 5856.4 5863.7 5864.7 5865.7 4947.6 4954.4 4955.9 4959.1 4960.8 3099.0 3158.7 3187.9 3193.0 3209.6 5605.3 5610.9 5622.1 5626.1 5630.1 6096.8 6098.5 6098.9 6099.7 6103.5 5490.1 5606.6 5622.1 5623.9 5625.2 5898.1 5937.0 5940.2 5946.8 5947.3 5767.6 5793.9 5805.2 5805.4 5810.7 5590.5 5593.8 5599.6 5602.6 5603.1 3950.7 4019.1 4042.7 4059.5 4084.2 5903.5 5915.5 5919.8 5920.6 5920.8 5681.9 5693.3 5704.5 5705.1 5708.6 5542.3 5699.5 5709.3 5714.2 5714.3 5535.9 5556.4 5588.6 5589.8 5604.5 5403.6 5597.2 5703.4 5715.7 5729.5 5404.9 5549.4 5587.3 5618.4 5625.3 20:00:10 INFO - 2015-11-26 20:00:10,096 DEBUG : BROWSER_OUTPUT: 20:00:10 INFO - 2015-11-26 20:00:10,097 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12472.35 Median:47267.15 stddev:14468.59 (30.6%) stddev-sans-first:14482.47 20:00:10 INFO - 2015-11-26 20:00:10,098 DEBUG : BROWSER_OUTPUT: Values: 766.2 773.1 778.8 782.3 793.9 11128.2 11433.4 11446.5 11530.5 11558.5 11261.4 11290.5 11357.0 11358.9 11366.9 473.9 481.8 756.3 756.8 783.7 770.7 773.6 779.4 780.1 780.1 505.2 814.7 822.0 822.4 823.1 506.8 794.6 809.1 810.1 810.3 595.4 595.9 596.3 596.8 597.0 11753.8 11904.6 11920.3 11928.9 11932.2 11192.8 11262.0 11492.9 11685.9 12145.8 9146.3 9209.7 9257.6 9257.8 9260.2 3165.7 3225.4 3261.9 3285.5 3322.9 41837.8 41842.8 41906.8 41917.0 41922.6 9106.6 9194.1 9234.8 9260.8 9299.2 14820.6 14900.0 14904.6 14909.2 14948.6 6160.9 6165.8 6249.5 6448.9 6630.5 3545.0 3635.4 3654.1 3697.9 3707.3 2507.1 2541.9 2544.8 2550.3 2553.3 472.1 477.3 490.6 490.6 501.4 545.0 550.9 572.4 576.1 584.0 7291.1 7879.5 8120.5 8133.6 8560.4 357.8 446.9 531.5 542.8 553.0 3358.7 3565.0 3569.6 3611.7 3685.5 42634.1 53335.5 53601.5 53703.7 53800.7 35873.1 42325.4 44642.3 47254.0 47280.3 44018.3 44116.6 44696.6 44916.8 45129.0 7441.9 7737.0 8186.3 8212.4 8436.2 33437.7 34104.1 34204.1 34451.7 34524.5 38634.2 41907.0 42654.1 42827.1 43019.4 9455.5 9612.8 9957.3 9969.0 10040.8 10904.9 10966.7 11004.3 11028.0 11476.7 10397.3 10782.0 10911.4 10916.5 11068.9 10658.5 10891.6 10998.8 11077.1 11359.4 9334.3 9907.7 9928.7 10167.9 10179.5 8818.2 9212.2 9299.6 9495.3 9724.8 8799.6 9022.6 9083.8 9260.4 9263.8 20:00:10 INFO - 2015-11-26 20:00:10,098 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:00:10 INFO - 2015-11-26 20:00:10,098 DEBUG : BROWSER_OUTPUT: 20:00:10 INFO - 2015-11-26 20:00:10,901 INFO : Browser exited with error code: 0 20:00:10 INFO - 2015-11-26 20:00:10,920 INFO : Completed test dromaeo_css (00:18:37) 20:00:10 INFO - 2015-11-26 20:00:10,920 INFO : Starting test kraken 20:00:10 INFO - 2015-11-26 20:00:10,920 DEBUG : operating with platform_type : linux_ 20:00:10 INFO - 2015-11-26 20:00:10,921 INFO : Initialising browser for kraken test... 20:00:10 INFO - 2015-11-26 20:00:10,927 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuw0nfE/profile http://localhost:53214/getInfo.html 20:00:15 INFO - 2015-11-26 20:00:15,453 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:00:15 INFO - 2015-11-26 20:00:15,453 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:00:15 INFO - 2015-11-26 20:00:15,453 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:00:15 INFO - 2015-11-26 20:00:15,453 DEBUG : BROWSER_OUTPUT: __metrics 20:00:15 INFO - 2015-11-26 20:00:15,570 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:00:17 INFO - 2015-11-26 20:00:17,113 INFO : Browser initialized. 20:00:17 INFO - 2015-11-26 20:00:17,114 INFO : Running cycle 1/1 for kraken test... 20:00:17 INFO - 2015-11-26 20:00:17,114 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuw0nfE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:00:29 INFO - 2015-11-26 20:00:29,005 DEBUG : BROWSER_OUTPUT: RSS: Main: 138113024 20:00:29 INFO - 2015-11-26 20:00:29,005 DEBUG : BROWSER_OUTPUT: 20:00:31 INFO - 2015-11-26 20:00:31,634 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53214/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53214/tests/kraken/driver.html?testName=audio-beat-detection) 20:00:32 INFO - 2015-11-26 20:00:32,220 DEBUG : BROWSER_OUTPUT: RSS: Main: 175988736 20:00:32 INFO - 2015-11-26 20:00:32,220 DEBUG : BROWSER_OUTPUT: 20:00:34 INFO - 2015-11-26 20:00:34,983 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53214/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53214/tests/kraken/driver.html?testName=audio-dft) 20:00:35 INFO - 2015-11-26 20:00:35,565 DEBUG : BROWSER_OUTPUT: RSS: Main: 165568512 20:00:35 INFO - 2015-11-26 20:00:35,565 DEBUG : BROWSER_OUTPUT: 20:00:38 INFO - 2015-11-26 20:00:38,598 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53214/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53214/tests/kraken/driver.html?testName=audio-fft) 20:00:39 INFO - 2015-11-26 20:00:39,164 DEBUG : BROWSER_OUTPUT: RSS: Main: 149319680 20:00:39 INFO - 2015-11-26 20:00:39,164 DEBUG : BROWSER_OUTPUT: 20:00:41 INFO - 2015-11-26 20:00:41,168 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53214/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53214/tests/kraken/driver.html?testName=audio-oscillator) 20:00:41 INFO - 2015-11-26 20:00:41,741 DEBUG : BROWSER_OUTPUT: RSS: Main: 152231936 20:00:41 INFO - 2015-11-26 20:00:41,741 DEBUG : BROWSER_OUTPUT: 20:00:44 INFO - 2015-11-26 20:00:44,014 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53214/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53214/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:00:44 INFO - 2015-11-26 20:00:44,580 DEBUG : BROWSER_OUTPUT: RSS: Main: 153128960 20:00:44 INFO - 2015-11-26 20:00:44,580 DEBUG : BROWSER_OUTPUT: 20:00:47 INFO - 2015-11-26 20:00:47,566 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53214/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53214/tests/kraken/driver.html?testName=imaging-darkroom) 20:00:48 INFO - 2015-11-26 20:00:48,147 DEBUG : BROWSER_OUTPUT: RSS: Main: 154902528 20:00:48 INFO - 2015-11-26 20:00:48,148 DEBUG : BROWSER_OUTPUT: 20:00:51 INFO - 2015-11-26 20:00:51,583 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53214/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53214/tests/kraken/driver.html?testName=imaging-desaturate) 20:00:52 INFO - 2015-11-26 20:00:52,164 DEBUG : BROWSER_OUTPUT: RSS: Main: 155623424 20:00:52 INFO - 2015-11-26 20:00:52,164 DEBUG : BROWSER_OUTPUT: 20:00:55 INFO - 2015-11-26 20:00:55,043 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53214/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53214/tests/kraken/driver.html?testName=json-parse-financial) 20:00:55 INFO - 2015-11-26 20:00:55,612 DEBUG : BROWSER_OUTPUT: RSS: Main: 156278784 20:00:55 INFO - 2015-11-26 20:00:55,612 DEBUG : BROWSER_OUTPUT: 20:00:57 INFO - 2015-11-26 20:00:57,411 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53214/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53214/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:00:57 INFO - 2015-11-26 20:00:57,977 DEBUG : BROWSER_OUTPUT: RSS: Main: 165134336 20:00:57 INFO - 2015-11-26 20:00:57,977 DEBUG : BROWSER_OUTPUT: 20:00:59 INFO - 2015-11-26 20:00:59,843 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53214/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53214/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:01:00 INFO - 2015-11-26 20:01:00,444 DEBUG : BROWSER_OUTPUT: RSS: Main: 165576704 20:01:00 INFO - 2015-11-26 20:01:00,444 DEBUG : BROWSER_OUTPUT: 20:01:02 INFO - 2015-11-26 20:01:02,582 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53214/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53214/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:01:03 INFO - 2015-11-26 20:01:03,156 DEBUG : BROWSER_OUTPUT: RSS: Main: 174510080 20:01:03 INFO - 2015-11-26 20:01:03,157 DEBUG : BROWSER_OUTPUT: 20:01:05 INFO - 2015-11-26 20:01:05,734 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53214/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53214/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:01:06 INFO - 2015-11-26 20:01:06,315 DEBUG : BROWSER_OUTPUT: RSS: Main: 178089984 20:01:06 INFO - 2015-11-26 20:01:06,315 DEBUG : BROWSER_OUTPUT: 20:01:08 INFO - 2015-11-26 20:01:08,952 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53214/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53214/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:01:09 INFO - 2015-11-26 20:01:09,526 DEBUG : BROWSER_OUTPUT: RSS: Main: 176885760 20:01:09 INFO - 2015-11-26 20:01:09,526 DEBUG : BROWSER_OUTPUT: 20:01:11 INFO - 2015-11-26 20:01:11,280 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53214/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53214/tests/kraken/driver.html?testName=ai-astar) 20:01:11 INFO - 2015-11-26 20:01:11,530 DEBUG : BROWSER_OUTPUT: RSS: Main: 235024384 20:01:11 INFO - 2015-11-26 20:01:11,531 DEBUG : BROWSER_OUTPUT: 20:01:11 INFO - 2015-11-26 20:01:11,532 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:01:11 INFO - 2015-11-26 20:01:11,532 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:01:11 INFO - 2015-11-26 20:01:11,532 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:01:11 INFO - 2015-11-26 20:01:11,532 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:01:11 INFO - 2015-11-26 20:01:11,533 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;115;107;113;113;112;103;113;113;109 20:01:11 INFO - 2015-11-26 20:01:11,533 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;165;129;161;169;137;157;154;130;165;131 20:01:11 INFO - 2015-11-26 20:01:11,533 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;161;161;162;160;163;163;162;161 20:01:11 INFO - 2015-11-26 20:01:11,533 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;73;79;94;71;73;72;102;89;72 20:01:11 INFO - 2015-11-26 20:01:11,534 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;96;95;133;94;94;95;133;96;95;133 20:01:11 INFO - 2015-11-26 20:01:11,534 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;110;110;110;110;109;109;109 20:01:11 INFO - 2015-11-26 20:01:11,534 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;146;146;147;147;148;147;146;146 20:01:11 INFO - 2015-11-26 20:01:11,534 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;94;96;95;95;95;95;95;95 20:01:11 INFO - 2015-11-26 20:01:11,534 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;73;72;71;72;72;71;74;71;71 20:01:11 INFO - 2015-11-26 20:01:11,535 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;70;68;69;69;68;69;68;70 20:01:11 INFO - 2015-11-26 20:01:11,535 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;82;85;87;84;83;84;86;84;84 20:01:11 INFO - 2015-11-26 20:01:11,535 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;132;130;128;138;119;126;129;120;129;119 20:01:11 INFO - 2015-11-26 20:01:11,535 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;151;138;150;149;151;142;149;152;138;141 20:01:11 INFO - 2015-11-26 20:01:11,535 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;70;71;70;70;68;68;69;68;69 20:01:11 INFO - 2015-11-26 20:01:11,535 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:01:11 INFO - 2015-11-26 20:01:11,536 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:01:11 INFO - 2015-11-26 20:01:11,536 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,967 20:01:11 INFO - 2015-11-26 20:01:11,536 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:01:11 INFO - 2015-11-26 20:01:11,536 DEBUG : BROWSER_OUTPUT: __startTimestamp1448596871531__endTimestamp 20:01:11 INFO - 2015-11-26 20:01:11,536 DEBUG : BROWSER_OUTPUT: 20:01:11 INFO - 2015-11-26 20:01:11,539 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:01:11 INFO - 2015-11-26 20:01:11,540 DEBUG : BROWSER_OUTPUT: Number of tests: 14 20:01:11 INFO - 2015-11-26 20:01:11,540 DEBUG : BROWSER_OUTPUT: 20:01:11 INFO - 2015-11-26 20:01:11,540 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.00 Median:113.00 stddev:3.62 (3.2%) stddev-sans-first:3.82 20:01:11 INFO - 2015-11-26 20:01:11,540 DEBUG : BROWSER_OUTPUT: Values: 112.0 115.0 107.0 113.0 113.0 112.0 103.0 113.0 113.0 109.0 20:01:11 INFO - 2015-11-26 20:01:11,540 DEBUG : BROWSER_OUTPUT: 20:01:11 INFO - 2015-11-26 20:01:11,540 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.80 Median:159.00 stddev:16.22 (10.2%) stddev-sans-first:16.24 20:01:11 INFO - 2015-11-26 20:01:11,540 DEBUG : BROWSER_OUTPUT: Values: 165.0 129.0 161.0 169.0 137.0 157.0 154.0 130.0 165.0 131.0 20:01:11 INFO - 2015-11-26 20:01:11,540 DEBUG : BROWSER_OUTPUT: 20:01:11 INFO - 2015-11-26 20:01:11,540 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.07 (0.7%) stddev-sans-first:1.13 20:01:11 INFO - 2015-11-26 20:01:11,540 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 161.0 161.0 162.0 160.0 163.0 163.0 162.0 161.0 20:01:11 INFO - 2015-11-26 20:01:11,540 DEBUG : BROWSER_OUTPUT: 20:01:11 INFO - 2015-11-26 20:01:11,540 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.60 Median:73.00 stddev:11.30 (15.5%) stddev-sans-first:11.54 20:01:11 INFO - 2015-11-26 20:01:11,540 DEBUG : BROWSER_OUTPUT: Values: 71.0 73.0 79.0 94.0 71.0 73.0 72.0 102.0 89.0 72.0 20:01:11 INFO - 2015-11-26 20:01:11,540 DEBUG : BROWSER_OUTPUT: 20:01:11 INFO - 2015-11-26 20:01:11,540 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.40 Median:95.00 stddev:18.37 (19.3%) stddev-sans-first:19.09 20:01:11 INFO - 2015-11-26 20:01:11,540 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 133.0 94.0 94.0 95.0 133.0 96.0 95.0 133.0 20:01:11 INFO - 2015-11-26 20:01:11,541 DEBUG : BROWSER_OUTPUT: 20:01:11 INFO - 2015-11-26 20:01:11,541 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 20:01:11 INFO - 2015-11-26 20:01:11,541 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 110.0 110.0 110.0 110.0 109.0 109.0 109.0 20:01:11 INFO - 2015-11-26 20:01:11,541 DEBUG : BROWSER_OUTPUT: 20:01:11 INFO - 2015-11-26 20:01:11,541 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 20:01:11 INFO - 2015-11-26 20:01:11,541 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 146.0 146.0 147.0 147.0 148.0 147.0 146.0 146.0 20:01:11 INFO - 2015-11-26 20:01:11,541 DEBUG : BROWSER_OUTPUT: 20:01:11 INFO - 2015-11-26 20:01:11,541 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 20:01:11 INFO - 2015-11-26 20:01:11,541 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 94.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 20:01:11 INFO - 2015-11-26 20:01:11,541 DEBUG : BROWSER_OUTPUT: 20:01:11 INFO - 2015-11-26 20:01:11,541 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.00 Median:72.00 stddev:1.05 (1.5%) stddev-sans-first:1.05 20:01:11 INFO - 2015-11-26 20:01:11,541 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 72.0 71.0 72.0 72.0 71.0 74.0 71.0 71.0 20:01:11 INFO - 2015-11-26 20:01:11,541 DEBUG : BROWSER_OUTPUT: 20:01:11 INFO - 2015-11-26 20:01:11,541 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.00 stddev:0.79 (1.1%) stddev-sans-first:0.78 20:01:11 INFO - 2015-11-26 20:01:11,541 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 70.0 68.0 69.0 69.0 68.0 69.0 68.0 70.0 20:01:11 INFO - 2015-11-26 20:01:11,542 DEBUG : BROWSER_OUTPUT: 20:01:11 INFO - 2015-11-26 20:01:11,542 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:84.50 stddev:1.43 (1.7%) stddev-sans-first:1.50 20:01:11 INFO - 2015-11-26 20:01:11,542 DEBUG : BROWSER_OUTPUT: Values: 85.0 82.0 85.0 87.0 84.0 83.0 84.0 86.0 84.0 84.0 20:01:11 INFO - 2015-11-26 20:01:11,542 DEBUG : BROWSER_OUTPUT: 20:01:11 INFO - 2015-11-26 20:01:11,542 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:127.00 Median:129.00 stddev:6.16 (4.8%) stddev-sans-first:6.27 20:01:11 INFO - 2015-11-26 20:01:11,542 DEBUG : BROWSER_OUTPUT: Values: 132.0 130.0 128.0 138.0 119.0 126.0 129.0 120.0 129.0 119.0 20:01:11 INFO - 2015-11-26 20:01:11,542 DEBUG : BROWSER_OUTPUT: 20:01:11 INFO - 2015-11-26 20:01:11,542 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.10 Median:149.50 stddev:5.67 (3.8%) stddev-sans-first:5.73 20:01:11 INFO - 2015-11-26 20:01:11,542 DEBUG : BROWSER_OUTPUT: Values: 151.0 138.0 150.0 149.0 151.0 142.0 149.0 152.0 138.0 141.0 20:01:11 INFO - 2015-11-26 20:01:11,542 DEBUG : BROWSER_OUTPUT: 20:01:11 INFO - 2015-11-26 20:01:11,542 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:70.00 stddev:1.06 (1.5%) stddev-sans-first:1.09 20:01:11 INFO - 2015-11-26 20:01:11,543 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 71.0 70.0 70.0 68.0 68.0 69.0 68.0 69.0 20:01:11 INFO - 2015-11-26 20:01:11,543 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:01:11 INFO - 2015-11-26 20:01:11,543 DEBUG : BROWSER_OUTPUT: 20:01:12 INFO - 2015-11-26 20:01:12,509 INFO : Browser exited with error code: 0 20:01:12 INFO - 2015-11-26 20:01:12,561 INFO : Completed test kraken (00:01:01) 20:01:12 INFO - 2015-11-26 20:01:12,561 INFO : Starting test v8_7 20:01:12 INFO - 2015-11-26 20:01:12,561 DEBUG : operating with platform_type : linux_ 20:01:12 INFO - 2015-11-26 20:01:12,561 INFO : Initialising browser for v8_7 test... 20:01:12 INFO - 2015-11-26 20:01:12,567 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9w2wu0/profile http://localhost:53214/getInfo.html 20:01:16 INFO - 2015-11-26 20:01:16,872 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:01:16 INFO - 2015-11-26 20:01:16,872 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:01:16 INFO - 2015-11-26 20:01:16,872 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:01:16 INFO - 2015-11-26 20:01:16,872 DEBUG : BROWSER_OUTPUT: __metrics 20:01:17 INFO - 2015-11-26 20:01:17,009 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:01:18 INFO - 2015-11-26 20:01:18,645 INFO : Browser initialized. 20:01:18 INFO - 2015-11-26 20:01:18,646 INFO : Running cycle 1/1 for v8_7 test... 20:01:18 INFO - 2015-11-26 20:01:18,646 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9w2wu0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:01:30 INFO - 2015-11-26 20:01:30,566 DEBUG : BROWSER_OUTPUT: RSS: Main: 138178560 20:01:30 INFO - 2015-11-26 20:01:30,566 DEBUG : BROWSER_OUTPUT: 20:01:51 INFO - 2015-11-26 20:01:51,939 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53214/tests/v8_7/run.html (next: http://localhost:53214/tests/v8_7/run.html) 20:01:52 INFO - 2015-11-26 20:01:52,185 DEBUG : BROWSER_OUTPUT: RSS: Main: 434139136 20:01:52 INFO - 2015-11-26 20:01:52,185 DEBUG : BROWSER_OUTPUT: 20:01:52 INFO - 2015-11-26 20:01:52,186 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:01:52 INFO - 2015-11-26 20:01:52,186 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:01:52 INFO - 2015-11-26 20:01:52,186 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:01:52 INFO - 2015-11-26 20:01:52,186 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:01:52 INFO - 2015-11-26 20:01:52,186 DEBUG : BROWSER_OUTPUT: |0;Richards;165.20733520568314 20:01:52 INFO - 2015-11-26 20:01:52,187 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;192.67822736030828 20:01:52 INFO - 2015-11-26 20:01:52,187 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.97780275358247 20:01:52 INFO - 2015-11-26 20:01:52,187 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5175.257731958763 20:01:52 INFO - 2015-11-26 20:01:52,187 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1992.03187250996 20:01:52 INFO - 2015-11-26 20:01:52,187 DEBUG : BROWSER_OUTPUT: |5;Earley;780.811232449298 20:01:52 INFO - 2015-11-26 20:01:52,188 DEBUG : BROWSER_OUTPUT: |6;Boyer;12048.192771084337 20:01:52 INFO - 2015-11-26 20:01:52,188 DEBUG : BROWSER_OUTPUT: |7;RegExp;26000 20:01:52 INFO - 2015-11-26 20:01:52,188 DEBUG : BROWSER_OUTPUT: |8;Splay;620.9876543209876 20:01:52 INFO - 2015-11-26 20:01:52,188 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 20:01:52 INFO - 2015-11-26 20:01:52,189 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:01:52 INFO - 2015-11-26 20:01:52,189 DEBUG : BROWSER_OUTPUT: __startTimestamp1448596912184__endTimestamp 20:01:52 INFO - 2015-11-26 20:01:52,189 DEBUG : BROWSER_OUTPUT: 20:01:52 INFO - 2015-11-26 20:01:52,190 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:01:52 INFO - 2015-11-26 20:01:52,190 DEBUG : BROWSER_OUTPUT: Number of tests: 10 20:01:52 INFO - 2015-11-26 20:01:52,190 DEBUG : BROWSER_OUTPUT: 20:01:52 INFO - 2015-11-26 20:01:52,190 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.21 Median:165.21 stddev:0.00 (0.0%) 20:01:52 INFO - 2015-11-26 20:01:52,191 DEBUG : BROWSER_OUTPUT: Values: 165.2 20:01:52 INFO - 2015-11-26 20:01:52,191 DEBUG : BROWSER_OUTPUT: 20:01:52 INFO - 2015-11-26 20:01:52,191 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:192.68 Median:192.68 stddev:0.00 (0.0%) 20:01:52 INFO - 2015-11-26 20:01:52,191 DEBUG : BROWSER_OUTPUT: Values: 192.7 20:01:52 INFO - 2015-11-26 20:01:52,191 DEBUG : BROWSER_OUTPUT: 20:01:52 INFO - 2015-11-26 20:01:52,192 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.98 Median:280.98 stddev:0.00 (0.0%) 20:01:52 INFO - 2015-11-26 20:01:52,192 DEBUG : BROWSER_OUTPUT: Values: 281.0 20:01:52 INFO - 2015-11-26 20:01:52,192 DEBUG : BROWSER_OUTPUT: 20:01:52 INFO - 2015-11-26 20:01:52,193 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5175.26 Median:5175.26 stddev:0.00 (0.0%) 20:01:52 INFO - 2015-11-26 20:01:52,193 DEBUG : BROWSER_OUTPUT: Values: 5175.3 20:01:52 INFO - 2015-11-26 20:01:52,193 DEBUG : BROWSER_OUTPUT: 20:01:52 INFO - 2015-11-26 20:01:52,193 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1992.03 Median:1992.03 stddev:0.00 (0.0%) 20:01:52 INFO - 2015-11-26 20:01:52,193 DEBUG : BROWSER_OUTPUT: Values: 1992.0 20:01:52 INFO - 2015-11-26 20:01:52,193 DEBUG : BROWSER_OUTPUT: 20:01:52 INFO - 2015-11-26 20:01:52,193 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:780.81 Median:780.81 stddev:0.00 (0.0%) 20:01:52 INFO - 2015-11-26 20:01:52,193 DEBUG : BROWSER_OUTPUT: Values: 780.8 20:01:52 INFO - 2015-11-26 20:01:52,194 DEBUG : BROWSER_OUTPUT: 20:01:52 INFO - 2015-11-26 20:01:52,194 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12048.19 Median:12048.19 stddev:0.00 (0.0%) 20:01:52 INFO - 2015-11-26 20:01:52,194 DEBUG : BROWSER_OUTPUT: Values: 12048.2 20:01:52 INFO - 2015-11-26 20:01:52,194 DEBUG : BROWSER_OUTPUT: 20:01:52 INFO - 2015-11-26 20:01:52,194 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26000.00 Median:26000.00 stddev:0.00 (0.0%) 20:01:52 INFO - 2015-11-26 20:01:52,194 DEBUG : BROWSER_OUTPUT: Values: 26000.0 20:01:52 INFO - 2015-11-26 20:01:52,194 DEBUG : BROWSER_OUTPUT: 20:01:52 INFO - 2015-11-26 20:01:52,194 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:620.99 Median:620.99 stddev:0.00 (0.0%) 20:01:52 INFO - 2015-11-26 20:01:52,194 DEBUG : BROWSER_OUTPUT: Values: 621.0 20:01:52 INFO - 2015-11-26 20:01:52,194 DEBUG : BROWSER_OUTPUT: 20:01:52 INFO - 2015-11-26 20:01:52,194 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 20:01:52 INFO - 2015-11-26 20:01:52,194 DEBUG : BROWSER_OUTPUT: Values: 4826.9 20:01:52 INFO - 2015-11-26 20:01:52,194 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:01:52 INFO - 2015-11-26 20:01:52,194 DEBUG : BROWSER_OUTPUT: 20:01:53 INFO - 2015-11-26 20:01:53,094 INFO : Browser exited with error code: 0 20:01:53 INFO - 2015-11-26 20:01:53,110 INFO : Completed test v8_7 (00:00:40) 20:01:53 INFO - 2015-11-26 20:01:53,240 INFO : Completed test suite (00:20:20) 20:01:53 INFO - 2015-11-26 20:01:53,241 DEBUG : Working with test: dromaeo_css 20:01:53 INFO - 2015-11-26 20:01:53,241 DEBUG : Generating results file: dromaeo_css 20:01:53 INFO - 2015-11-26 20:01:53,242 DEBUG : Working with test: kraken 20:01:53 INFO - 2015-11-26 20:01:53,242 DEBUG : Generating results file: kraken 20:01:53 INFO - 2015-11-26 20:01:53,242 INFO : javascript benchmark 20:01:53 INFO - 2015-11-26 20:01:53,242 DEBUG : Working with test: v8_7 20:01:53 INFO - 2015-11-26 20:01:53,243 DEBUG : Generating results file: v8_7 20:01:53 INFO - 2015-11-26 20:01:53,243 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:01:53 INFO - 2015-11-26 20:01:53,312 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,141,35]] 20:01:53 INFO - 2015-11-26 20:01:53,312 DEBUG : process_Request line: dromaeo_css 6209.49 graph.html#tests=[[72,141,35]] 20:01:53 INFO - 2015-11-26 20:01:53,312 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:01:53 INFO - 2015-11-26 20:01:53,358 DEBUG : process_Request line: kraken 1526.90 graph.html#tests=[[232,141,35]] 20:01:53 INFO - 2015-11-26 20:01:53,358 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:01:53 INFO - 2015-11-26 20:01:53,399 DEBUG : process_Request line: v8_7 19787.70 graph.html#tests=[[230,141,35]] 20:01:53 INFO - 2015-11-26 20:01:53,400 INFO : javascript benchmark 20:01:53 INFO - 2015-11-26 20:01:53,404 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2639.406133619935, 2734.6171535984954, 2735.193118030181, 2750.3124218945263, 2771.7505424511796, 4475.104979004196, 4597.678162528624, 4643.512431194722, 4696.694714843533, 4705.764711764411, 4538.341940418637, 4568.200564901137, 4584.839530616429, 4612.031473390583, 4643.837465688702, 4230.619244268015, 4312.460942382202, 4315.633171180438, 4336.761478118702, 4355.564443555635, 4033.2135233629456, 4320.891977700567, 4375.496817865938, 4395.362672412498, 4451.087527056961, 4149.439825623533, 4249.107687385622, 4251.213525497762, 4251.91496170078, 4368.47578290604, 4332.783360831977, 4340.348947657845, 4347.934780978257, 4353.28170851809, 4362.454693163355, 4280.379344994958, 4292.635126014293, 4316.762578058206, 4319.654427645813, 4334.956650433487, 4415.867523974286, 4553.271476563734, 4553.2942393929, 4626.537346265381, 4700.318453824177, 4816.951830481686, 4939.777710003059, 4960.131976904027, 4967.751612419401, 4969.180085285923, 5019.447860735316, 5021.397432308147, 5040.899182016376, 5046.26829109777, 5052.46949070346, 4664.9503861630865, 4669.509701481364, 4670.229412147026, 4675.251959686434, 4705.952940470585, 4832.9275060874115, 4933.50664933511, 4954.5540901319055, 4967.205247160437, 5035.521625445577, 4930.038642464685, 4972.303877457159, 4974.0797952378925, 4974.129527332775, 5027.572656324181, 5039.21892106724, 5056.747162641853, 5060.797568097235, 5061.949380506221, 5069.493050694901, 4700.741459219707, 4747.8575642730775, 4797.352357431702, 4797.472278049412, 4856.2958371036, 4960.50394960501, 4973.403191617029, 4979.775910084055, 4980.12847751642, 5023.34696489454, 3897.434871943609, 3897.9805100974313, 3900.180961998012, 3921.745086569364, 3939.153082087365, 3386.712129469023, 3481.7388695847912, 3493.7903725776537, 3503.649635036476, 3543.7519373644113, 4247.384129301234, 4250.404943307939, 4308.267594508941, 4313.698041137153, 4346.521882592912, 5034.244863270465, 5035.496450354935, 5044.319016932741, 5046.44489106198, 5061.139606266944, 4143.37849322598, 4233.640140588084, 4306.633936115465, 4306.676999225071, 4342.066455712037, 4277.850275240352, 4309.870703878889, 4321.092570560218, 4324.610785029363, 4369.453818272716, 4738.810447582058, 4746.240601503743, 4746.38297021385, 4753.809847606126, 4808.855734327975, 4792.688475249098, 4904.681195722266, 4997.550220480174, 4998.950010499849, 5054.115529782347, 4662.813487460464, 4688.367070445446, 4689.507601701908, 4716.716996980193, 4738.668293219442, 4817.084753896748, 4856.514348565115, 4861.9027619448125, 4869.683470574401, 4901.3138160658245, 4712.787924543335, 4769.523047695203, 4931.950680493293, 4954.380702412199, 4980.825671101494, 4621.029583787442, 4621.976890115528, 4628.421447319085, 4636.814527419, 4636.83771068011, 4787.8563643090765, 4817.229243321051, 4817.494163112963, 4818.084563932842, 4831.371921650163, 4640.419947506562, 4693.765311734468, 4729.976350118227, 4737.549932756383, 4742.7865746040825, 4878.268259761065, 4935.703857768545, 4943.505649435027, 4943.752812359439, 4988.55103040728, 4791.041791641616, 4813.975930120327, 4815.6147508199965, 4820.25286080644, 4867.29424233477], "unit": "ms", "name": "dojo.html", "value": 4539.5505508874785}, {"lowerIsBetter": false, "replicates": [524.7454984332601, 538.9137737961922, 562.5668235458696, 580.2311936683893, 583.4807021750643, 25471.49057018861, 25984.350391240205, 26041.0, 34698.47952280718, 35355.0, 39052.80473597635, 39834.402483962695, 39967.400488992615, 40025.0, 40034.79982600083, 7796.5711885846395, 8026.759197224063, 8027.157148499411, 8037.638306276232, 8039.598020099001, 6871.828204294908, 7061.364477197051, 10198.490075496233, 10418.79162416755, 10430.426326552037, 10008.899911000906, 10027.0, 10098.990100989915, 10106.74733131674, 10113.69658910234, 6885.862282754367, 7078.752243671498, 9866.210703143732, 9951.950240248825, 9968.507873031778, 10107.241956853191, 10288.43413612251, 10364.067233948981, 10368.015038571324, 10408.947955260175, 37163.25673486542, 37711.62288377109, 37720.0, 37727.35908486407, 37776.244475110616, 2734.5898115282666, 2823.6046953426535, 3394.6096198937194, 3589.6769290763696, 3627.4014787560022, 28348.71651283502, 28503.57244641332, 28706.282342941384, 28867.133985980454, 28892.42215155685, 3419.8803041893416, 3503.877364292263, 3513.841877115536, 3580.6419358064245, 3636.781793092423, 217501.0, 218423.0, 218733.9999999984, 219268.0, 219833.0, 41171.38242926358, 53752.46247537553, 54269.72865135649, 54334.728326358905, 54343.18485222725, 39667.40498892519, 63343.0, 64603.0, 64619.0, 64736.67631661812, 13010.54463093806, 13278.136921100098, 13284.00369972256, 13285.66785830362, 13298.401571929286, 9742.61029558824, 9836.655717049869, 9859.802803943881, 9862.02759448099, 9869.11177993984, 18346.724799128024, 18520.98134602583, 18546.44360669182, 18570.628587428175, 18652.533686657942, 7148.997421083158, 7318.451116166309, 7366.447516436288, 7368.37368823656, 7420.591867447234, 785.1990969211372, 813.3899575318511, 821.5892053973014, 896.1979028769346, 941.708070498134, 23505.882470587538, 23746.406339841644, 24110.638340424906, 25093.498130037297, 25145.622815657778, 881.722257488889, 909.5815924674723, 912.2656261709255, 940.2008292950937, 940.3840484482674, 12599.496020159275, 12632.178908370926, 12838.358082095858, 13160.802587961189, 13195.274259915604, 260636.0, 263560.04659930116, 264102.0, 264195.0, 265945.0, 43914.12171756547, 43969.78015109904, 44096.779516102855, 44157.55842441534, 44258.33612495815, 1058.5448257249302, 1074.1514203778927, 1167.5679998400476, 1193.0932491306496, 1193.6419074277856, 22058.779412206313, 22906.198283060014, 23394.64908026347, 26959.326016849736, 28482.57276140818, 41492.377614336416, 42218.0, 42250.36624450697, 42388.78805605952, 42445.726628201206, 212155.0, 214246.0, 214306.0, 214619.0, 214822.0, 24746.0, 25257.0, 28681.569776453787, 28916.42167156687, 29121.271968200963, 36578.634213657526, 36628.402624952956, 37564.81217594004, 38081.238375231784, 38148.618513815614, 32050.679493205702, 32429.351412971137, 32619.18452038718, 32897.83551082229, 33420.0, 24815.503689926463, 30762.384752305275, 32055.0, 32443.513347300282, 33080.172995675304, 32814.5077823828, 33002.339953201285, 33386.83306583549, 33773.83113084419, 33889.83055084709, 25292.74707252904, 27516.17451476459, 27614.5857812137, 28983.5652465209, 29604.555931660612, 23304.883475583192, 23377.532449351256, 23421.531569368857, 23543.88228058849, 23641.40896477602], "unit": "ms", "name": "ext.html", "value": 16684.661900656432}, {"lowerIsBetter": false, "replicates": [331.8589599420247, 334.59681084293413, 336.2333878756435, 336.23506522660944, 336.6448396941226, 14740.189289589081, 14947.0, 15682.372705091797, 16301.755473667874, 16316.918415407907, 9072.591733371997, 10052.14556762676, 10055.849162262572, 10070.748231294221, 10071.69784906454, 3253.8210398428077, 4491.191585514606, 4539.251023581105, 4555.63554915606, 5034.5468907798295, 3306.983465082671, 3308.6360500345063, 3315.0386387947465, 3343.414902392072, 4978.352814134176, 5091.592672586203, 5124.871878203056, 5139.820106296281, 5144.819931302405, 5145.305383773199, 4969.850904472872, 5054.19132938728, 5067.721275329855, 5071.137906555876, 5111.488851114896, 3138.5606015157896, 3223.2103134731906, 3224.6130464344196, 3225.79032362898, 3233.434149023935, 17649.647007059786, 17755.46733597994, 18144.274229030823, 18155.909220453945, 18168.1824317906, 1783.4382169616529, 1800.324878170686, 1807.566184115816, 1814.8638852086146, 1820.336008645599, 8853.468791872509, 8926.776830579223, 11836.230645008047, 11905.464254108585, 12185.268883866996, 1707.6499317639855, 1709.6495218480181, 1717.083440920011, 1743.9128043597768, 1826.6894627913155, 52688.73655631736, 55900.72049639766, 56722.716386418215, 57038.429615703724, 57696.0, 9566.234701224024, 9629.518524073768, 9688.660896868716, 9702.320837541305, 9809.0, 12356.938215308866, 12357.93821030889, 12361.505539778487, 12375.876241237473, 12390.3185324808, 6741.561798483181, 6787.830304242335, 6797.66011699423, 6815.250322464525, 6878.140232470942, 6356.364363563606, 6377.4579160771855, 6407.295197528269, 6410.326915673787, 6415.775447859396, 4075.5109386873764, 4083.7958102094776, 4087.9795601021806, 4133.0700592366475, 4170.457840480718, 1709.7691811605523, 1722.7674263974454, 1733.9479815605553, 1762.726777349513, 1796.2455768577229, 782.6673663692908, 808.7960308160216, 829.8589239829244, 833.1585099050003, 902.801383695586, 14688.0, 15700.293486793122, 15965.521034368987, 16079.29406039427, 16243.187840607923, 817.4890693316677, 826.0582935453588, 826.1036775099085, 847.1528471528471, 863.589794847455, 6559.508036897157, 8543.700970466003, 8637.827243455222, 8856.424332418372, 9229.054504562822, 442838.0, 461912.0, 470655.0, 471661.0, 483081.0, 69164.3083569168, 69444.0, 69580.6520967392, 70179.0, 70472.0, 872.9563521823883, 892.901780804111, 1054.8997845204694, 1098.214776434837, 1142.0977427832086, 13744.175349479063, 14426.567202983928, 14523.927380363031, 14643.633909152357, 15073.0, 32285.35429291448, 32364.0, 32725.836370817993, 33208.66791332152, 33236.66763332432, 42020.0, 42547.11820577802, 42918.0, 43658.781706091264, 43756.0, 8837.734867953972, 8987.41581797181, 9072.138146876036, 9088.363814532919, 9104.317176211678, 10454.924874791246, 15287.0, 15356.308966096776, 15700.29348679335, 15762.133082680104, 13346.666333341356, 13672.316384180553, 14032.0, 14084.507042253472, 14380.712385752016, 13048.217106973612, 13744.587662370144, 13779.517716879862, 13841.0, 14038.649033774238, 13043.152195107288, 13361.799573006218, 13546.119502232323, 13610.659733506742, 14127.0, 8938.86591701138, 8981.730548083568, 9010.0989901012, 9024.774380640536, 9068.047854975133, 13292.800607990694, 13789.931050344683, 13840.792388113985, 13900.860991390362, 13996.090254133449], "unit": "ms", "name": "jquery.html", "value": 7918.8321425275735}, {"lowerIsBetter": false, "replicates": [1265.0385706862783, 1578.7000469910715, 1646.9835301646988, 1649.7772800671905, 1684.4188754879563, 5687.260656114704, 6903.758368457099, 7123.7862864114095, 7218.061651985247, 7219.314165154302, 6586.8682626347445, 6726.495512836545, 6732.427743641796, 6746.865062698743, 6752.797416077513, 1665.8001039875232, 1695.440504633468, 1696.5080126763223, 2037.8369730421568, 2082.427332483564, 2042.8672136311166, 2108.188347486221, 2109.325015994882, 2110.6833974903734, 2111.80993710566, 2014.556797504554, 2036.1142902837314, 2039.1333683184662, 2059.608674351876, 2063.2159779283925, 1992.1035534009754, 2038.6432374334506, 2042.05044654235, 2063.494443861256, 2066.2148383614203, 2107.79975902289, 2139.4758284220466, 2139.743230812297, 2140.2081229944865, 2145.356393082069, 6901.551399159089, 6959.512834101615, 6963.965180174117, 6966.198887127995, 6969.0, 4049.190161967618, 4162.521310049323, 4162.771047592381, 4165.708400411972, 4170.541240463546, 2685.5300322443495, 2806.0599699100826, 2821.7742580593504, 2829.5048366535775, 2838.503261929154, 707.678006507038, 826.1201820061615, 841.146236569882, 847.4449235750593, 865.2861389353808, 9378.577963991636, 9422.387544809566, 9453.763655908657, 9457.007014263472, 9459.24326053914, 3962.980185099056, 3967.861124860674, 4025.215083058834, 4033.69747268956, 4049.3521036633997, 8200.712975045844, 8211.95894020526, 8231.176882311722, 8241.175882411711, 8252.793680157924, 4237.660987121023, 4242.300020496646, 4246.023414614594, 4250.341197114452, 4253.723507971972, 3861.7876016819346, 3864.1885204107452, 3867.45855580219, 3871.1289959759392, 3874.49631547897, 3259.6251431085257, 3289.983550082234, 3298.67013298673, 3322.1362445764275, 3325.7671962962845, 1053.3100818963437, 1059.2849826367171, 1072.9570817167382, 1079.3362082319475, 1111.4942701070993, 893.1291990309396, 906.7053207707521, 907.1744712311896, 909.6088681866728, 1181.1259667845732, 6703.93296067033, 6756.459483241329, 6757.087793147961, 6758.256591774901, 6759.256481787, 419.5028890764454, 420.7938110325918, 421.1534815021767, 1086.1745073744012, 1112.8831472695413, 5246.527812496894, 5272.130098533699, 5315.973420132875, 5322.520973112361, 5322.760475778599, 7552.546847189186, 8624.223819856117, 8739.781505462413, 8821.779455513664, 8844.425112367675, 7538.698452061856, 8411.537365444838, 8569.228769410784, 8594.44136131162, 8606.612702428405, 6395.20059992501, 6542.607443553306, 6544.9672751635935, 6546.70539825709, 6558.901616475757, 6357.96821015892, 6511.706973186123, 6514.511411644051, 6519.08732777402, 6520.119783829123, 7453.142888567667, 7525.059367579052, 7550.093988721389, 7553.131389890013, 7626.504277221963, 7717.6527056281475, 7743.225677432437, 7762.262585054411, 7779.7666070017995, 7874.842503150019, 5891.499222565958, 5995.730192141277, 6003.0, 6009.038553831366, 6010.368911264254, 6209.0, 6548.1814773153355, 6551.050097735897, 6591.044298576776, 6611.504137189826, 6285.748570057147, 6297.086922396318, 6436.645984470899, 6468.773592924414, 6535.640539770358, 6177.84555386119, 6242.719077641608, 6247.781327653511, 6350.428461438492, 6392.744290228525, 6376.458001069961, 6391.360863913757, 6400.103985442135, 6483.546151769331, 6527.445167160845, 5707.6290041147195, 5721.1990321354215, 5722.0, 5728.283964504437, 5731.8567035824435, 6001.669908155093, 6036.6679832609625, 6045.78839740607, 6060.212172417558, 6093.390660933871], "unit": "ms", "name": "mootools.html", "value": 3989.130833767211}, {"lowerIsBetter": false, "replicates": [294.6052289931491, 301.9350839569492, 303.0877060049251, 311.07300245269096, 312.5109204095589, 5325.0, 5341.65279256848, 5374.48942350476, 5382.4886635769535, 5388.43421440749, 5281.683099014062, 5293.470652934705, 5298.178782288752, 5309.070912590291, 5309.389420216677, 3917.8236979335998, 4138.151678905817, 4140.192662430827, 4149.605787450188, 4150.771707556083, 4013.036871150932, 4053.675705943532, 4115.259253334399, 4142.937855932163, 4181.874543763692, 4098.364753463218, 4119.8352065917325, 4121.711480196387, 4131.752094874302, 4136.069384388518, 3879.9030024249337, 3992.7205095643317, 4015.156817068419, 4113.115680128772, 4115.52671442785, 3640.9817950910074, 3653.3058718843336, 3661.9267614647824, 3669.4862719219063, 3672.026912868092, 5147.047796157685, 5150.716710580917, 5154.07226699194, 5157.0, 5159.2003239497935, 4783.904321913577, 4790.257510085942, 4793.304970779218, 4795.088933102699, 4799.208130658437, 5457.727113644302, 5626.521745651625, 5627.2684551008515, 5628.971855140698, 5638.859028524279, 3965.0087478130467, 3968.523777146761, 3973.304671682444, 3986.3223252047223, 3989.940150897739, 5898.469137777578, 5911.852203694899, 5914.733836977346, 5919.230500034968, 5922.58541902067, 4113.341865301538, 4115.115250221217, 4117.114820313647, 4118.258713431551, 4124.1133156371525, 3921.5490218624655, 4051.736637118578, 4188.5811418857875, 4189.622933935961, 4192.45498085247, 4688.789004494738, 4689.882752931136, 4691.741954192484, 4697.037107392976, 4698.694584852042, 5658.773649054074, 5664.433556644385, 5666.206731057655, 5669.348024977098, 5672.205891175238, 1416.235232974203, 1432.5057855039995, 1433.1186320412871, 1434.2613554019688, 1434.5911415246605, 938.6573900526258, 940.9576569054409, 966.1642679082543, 972.5186032913612, 974.3033730882453, 4961.826336078292, 4962.751862406865, 4967.5777558907175, 4969.180085285887, 4977.303177555145, 5833.095870140135, 5856.355800861902, 5863.70681465925, 5864.70676466175, 5865.73604187804, 4947.5794557462295, 4954.430240522314, 4955.925661115086, 4959.13215187348, 4960.801567937242, 3098.98450507746, 3158.6683398243313, 3187.8724851006164, 3193.0420873737785, 3209.6148462184688, 5605.299337582802, 5610.943890561124, 5622.072358060956, 5626.099824028136, 5630.071038278638, 6096.817095487142, 6098.451139397475, 6098.908516372258, 6099.69501524922, 6103.450689437883, 5490.121580547093, 5606.635568688022, 5622.128570071645, 5623.943760562423, 5625.212470254086, 5898.085796701518, 5937.0, 5940.1683764272175, 5946.791862284799, 5947.31605865331, 5767.6446035182535, 5793.884122317614, 5805.158252053513, 5805.3614102447855, 5810.7094645266725, 5590.496855283044, 5593.804216852391, 5599.580031497572, 5602.635828671123, 5603.075492543685, 3950.683945284313, 4019.1157945253167, 4042.6563742081075, 4059.512858457004, 4084.1627466368727, 5903.527717782481, 5915.467607915309, 5919.822405327847, 5920.585559010828, 5920.79277225295, 5681.914771278517, 5693.345265294379, 5704.515116215002, 5705.087186050212, 5708.57185711065, 5542.279503664659, 5699.544036476989, 5709.314882214161, 5714.171445140514, 5714.342850572071, 5535.944640553543, 5556.361018482926, 5588.608797384144, 5589.80435684749, 5604.523615492729, 5403.621746477709, 5597.160425935979, 5703.401142879938, 5715.714214289185, 5729.54163666914, 5404.918926216032, 5549.417311182267, 5587.273654424899, 5618.438156184349, 5625.296837895263], "unit": "ms", "name": "prototype.html", "value": 4245.4786572131725}, {"lowerIsBetter": false, "replicates": [766.2337662337663, 773.1495355109377, 778.844231153769, 782.2724421814738, 793.9126696063432, 11128.165387595933, 11433.428328583559, 11446.542138314479, 11530.538778448852, 11558.53765849366, 11261.380624065694, 11290.548378064868, 11357.034652054565, 11358.943205283982, 11366.943165284161, 473.9265413860857, 481.7615280436189, 756.255088737593, 756.8334966307403, 783.6512751825439, 770.7302444144533, 773.6441237030945, 779.4115442840647, 780.0522365326127, 780.1418439716296, 505.2219581843956, 814.7189219719218, 822.0, 822.4037572759761, 823.1439303124743, 506.82261208576887, 794.5788731972035, 809.1221025187679, 810.05628442864, 810.2950433123161, 595.3570144244206, 595.8599729063667, 596.2814808156162, 596.7612954818064, 597.0298265318856, 11753.823692644532, 11904.642860714192, 11920.284782913053, 11928.880711192864, 11932.16474846761, 11192.832107518394, 11262.0, 11492.942535287353, 11685.94157029218, 12145.757084858253, 9146.314026447977, 9209.723708288762, 9257.583408746556, 9257.814843703089, 9260.166585007315, 3165.6517783043846, 3225.3905281428215, 3261.8858339957987, 3285.4578994465883, 3322.883699070545, 41837.790811046056, 41842.79078604618, 41906.79046604778, 41917.0, 41922.580774192174, 9106.590203440861, 9194.080591940752, 9234.81530369389, 9260.768480788034, 9299.20956718673, 14820.62948426298, 14900.0, 14904.552863414116, 14909.179995100374, 14948.626284342761, 6160.907586386208, 6165.84585385369, 6249.531285153632, 6448.903266451007, 6630.53586248958, 3544.9645503544634, 3635.363811333059, 3654.1230104774663, 3697.870574529932, 3707.258548290353, 2507.072383218221, 2541.911033113832, 2544.8345857519203, 2550.2859199424192, 2553.310606136333, 472.09829226177834, 477.27930824455325, 490.60996507776406, 490.629574671121, 501.4158505341309, 544.9509544140967, 550.9366422861342, 572.4275724275724, 576.07827476038, 583.9766409343579, 7291.1250649921285, 7879.527228366316, 8120.472169308976, 8133.59332033396, 8560.357973152039, 357.8479146362785, 446.9452093060375, 531.455258360184, 542.8317221661298, 552.9668219906819, 3358.748093892968, 3565.0, 3569.5716514017963, 3611.656892595252, 3685.5024571683016, 42634.14731705349, 53335.46664533305, 53601.463985360424, 53703.73148134312, 53800.73099634477, 35873.103172420895, 42325.36511952323, 44642.33036504455, 47254.0, 47280.290795638095, 44018.33972490415, 44116.55883441125, 44696.55303446989, 44916.77541612336, 45129.0, 7441.888371674538, 7736.994190755391, 8186.304164146114, 8212.384071194565, 8436.198561136682, 33437.665623343455, 34104.14739631529, 34204.14489637779, 34451.65548344485, 34524.48213276752, 38634.22731545297, 41907.0, 42654.14691706086, 42827.143457130056, 43019.35470968, 9455.527223638654, 9612.75968100775, 9957.302988790716, 9969.0, 10040.799184016132, 10904.945475272572, 10966.670999870017, 11004.339739615649, 11028.0, 11476.655700329004, 10397.32417392867, 10782.0, 10911.399873006743, 10916.454177290945, 11068.889311106786, 10658.520366583678, 10891.618793342195, 10998.835017474905, 11077.058450031838, 11359.375234362189, 9334.299927505328, 9907.702768916944, 9928.702138935843, 10167.898321016992, 10179.541920613443, 8818.206361427247, 9212.170904618617, 9299.581518831805, 9495.287853410884, 9724.805503889742, 8799.604017819342, 9022.5939832709, 9083.772905677411, 9260.380579902887, 9263.814723705624], "unit": "ms", "name": "yui.html", "value": 5642.794240838892}], "name": "dromaeo_css", "value": 6209.489962593242}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 115.0, 107.0, 113.0, 113.0, 112.0, 103.0, 113.0, 113.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 111.0}, {"lowerIsBetter": true, "replicates": [165.0, 129.0, 161.0, 169.0, 137.0, 157.0, 154.0, 130.0, 165.0, 131.0], "unit": "ms", "name": "audio-beat-detection", "value": 149.8}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 161.0, 161.0, 162.0, 160.0, 163.0, 163.0, 162.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 79.0, 94.0, 71.0, 73.0, 72.0, 102.0, 89.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 79.6}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 133.0, 94.0, 94.0, 95.0, 133.0, 96.0, 95.0, 133.0], "unit": "ms", "name": "audio-oscillator", "value": 106.4}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 110.0, 110.0, 110.0, 110.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 148.0, 147.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 94.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.0}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 72.0, 71.0, 72.0, 72.0, 71.0, 74.0, 71.0, 71.0], "unit": "ms", "name": "json-parse-financial", "value": 72.0}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 70.0, 68.0, 69.0, 69.0, 68.0, 69.0, 68.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.8}, {"lowerIsBetter": true, "replicates": [85.0, 82.0, 85.0, 87.0, 84.0, 83.0, 84.0, 86.0, 84.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.4}, {"lowerIsBetter": true, "replicates": [132.0, 130.0, 128.0, 138.0, 119.0, 126.0, 129.0, 120.0, 129.0, 119.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 127.0}, {"lowerIsBetter": true, "replicates": [151.0, 138.0, 150.0, 149.0, 151.0, 142.0, 149.0, 152.0, 138.0, 141.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.1}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 71.0, 70.0, 70.0, 68.0, 68.0, 69.0, 68.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.3}], "name": "kraken", "value": 1526.8999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.20733520568314], "unit": "score", "name": "Richards", "value": 213.68300599999995}, {"lowerIsBetter": false, "replicates": [192.67822736030828], "unit": "score", "name": "DeltaBlue", "value": 343.1524200000001}, {"lowerIsBetter": false, "replicates": [280.97780275358247], "unit": "score", "name": "Encrypt", "value": 947.3381789999996}, {"lowerIsBetter": false, "replicates": [5175.257731958763], "unit": "score", "name": "Decrypt", "value": 51.433380478087685}, {"lowerIsBetter": false, "replicates": [1992.03187250996], "unit": "score", "name": "RayTrace", "value": 371.474478}, {"lowerIsBetter": false, "replicates": [780.811232449298], "unit": "score", "name": "Earley", "value": 853.5520139860142}, {"lowerIsBetter": false, "replicates": [12048.192771084337], "unit": "score", "name": "Boyer", "value": 55.31642899999996}, {"lowerIsBetter": false, "replicates": [26000.0], "unit": "score", "name": "RegExp", "value": 35.037884615384634}, {"lowerIsBetter": false, "replicates": [620.9876543209876], "unit": "score", "name": "Splay", "value": 131.22805168986085}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 19787.70386264862}]} 20:01:53 INFO - RETURN: dromaeo_css: 6209.49 20:01:53 INFO - RETURN: kraken: 1526.90 20:01:53 INFO - RETURN: v8_7: 19787.70 20:01:53 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,141,35]]", "result": "19787.70"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,141,35]]", "result": "1526.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,141,35]]", "result": "6209.49"}}} 20:01:53 INFO - Return code: 0 20:01:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:01:53 INFO - # TBPL SUCCESS # 20:01:53 INFO - Running post-action listener: _resource_record_post_action 20:01:53 INFO - Running post-run listener: _resource_record_post_run 20:01:54 INFO - Total resource usage - Wall time: 1236s; CPU: 13.0%; Read bytes: 319488; Write bytes: 507817984; Read time: 104; Write time: 959332 20:01:54 INFO - install - Wall time: 15s; CPU: 17.0%; Read bytes: 0; Write bytes: 236806144; Read time: 0; Write time: 638036 20:01:54 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 114688; Write bytes: 266362880; Read time: 60; Write time: 317340 20:01:54 INFO - Running post-run listener: _upload_blobber_files 20:01:54 INFO - Blob upload gear active. 20:01:54 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 20:01:54 INFO - Copying logs to upload dir... 20:01:54 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1269.504969 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-11-26 20:01:54.436535) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-26 20:01:54.440697) ========= 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=a194aa7faa1be204aaca7d660000020b-1448582686.191692-1031812117 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/CA6L_IFGR1eC7XXcLtfPuw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010064 build_url: 'https://queue.taskcluster.net/v1/task/CA6L_IFGR1eC7XXcLtfPuw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-26 20:01:54.492301) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 20:01:54.492681) ========= 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=a194aa7faa1be204aaca7d660000020b-1448582686.191692-1031812117 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004578 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 20:01:54.541971) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-26 20:01:54.542324) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-26 20:01:54.542630) ========= ========= Total master_lag: 0.23 =========