builder: b2g-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-047 starttime: 1448418273.29 results: success (0) buildid: 20151124165836 builduid: 9079422952cf47039ae0ceeeb694bfd2 revision: dbf3d11d0f9ed1941ba5323b51fbdb2666b26f23 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 18:24:33.291118) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 18:24:33.291575) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 18:24:33.291878) ========= 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=f5f5a079460e1a9be8676904000001c1-1448417498.279178-775015110 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006667 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 18:24:33.340445) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 18:24:33.340842) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 18:24:33.358772) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 18:24:33.359101) ========= 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=f5f5a079460e1a9be8676904000001c1-1448417498.279178-775015110 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004692 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 18:24:33.408213) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 18:24:33.408518) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 18:24:33.408890) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 18:24:33.409164) ========= 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=f5f5a079460e1a9be8676904000001c1-1448417498.279178-775015110 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-24 18:24:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2015-11-24 18:24:33 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.156214 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 18:24:33.577031) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 18:24:33.577314) ========= 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=f5f5a079460e1a9be8676904000001c1-1448417498.279178-775015110 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022173 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 18:24:33.627287) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 18:24:33.627674) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev dbf3d11d0f9ed1941ba5323b51fbdb2666b26f23 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev dbf3d11d0f9ed1941ba5323b51fbdb2666b26f23 --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=f5f5a079460e1a9be8676904000001c1-1448417498.279178-775015110 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-24 18:24:33,707 truncating revision to first 12 chars 2015-11-24 18:24:33,707 Setting DEBUG logging. 2015-11-24 18:24:33,707 attempt 1/10 2015-11-24 18:24:33,707 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/dbf3d11d0f9e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-24 18:24:33,963 unpacking tar archive at: b2g-inbound-dbf3d11d0f9e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.539819 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 18:24:34.180170) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 18:24:34.180487) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 18:24:34.187565) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 18:24:34.187913) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 18:24:34.188349) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-11-24 18:24:34.188636) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=f5f5a079460e1a9be8676904000001c1-1448417498.279178-775015110 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:24:34 INFO - MultiFileLogger online at 20151124 18:24:34 in /builds/slave/test 18:24:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-Non-PGO 18:24:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:24:34 INFO - {'append_to_log': False, 18:24:34 INFO - 'base_work_dir': '/builds/slave/test', 18:24:34 INFO - 'blob_upload_branch': 'B2G-Inbound-Non-PGO', 18:24:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:24:34 INFO - 'branch': 'B2G-Inbound-Non-PGO', 18:24:34 INFO - 'buildbot_json_path': 'buildprops.json', 18:24:34 INFO - 'config_files': ('talos/linux_config.py',), 18:24:34 INFO - 'default_actions': ('clobber', 18:24:34 INFO - 'read-buildbot-config', 18:24:34 INFO - 'download-and-extract', 18:24:34 INFO - 'populate-webroot', 18:24:34 INFO - 'create-virtualenv', 18:24:34 INFO - 'install', 18:24:34 INFO - 'run-tests'), 18:24:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:24:34 INFO - 'download_minidump_stackwalk': True, 18:24:34 INFO - 'download_symbols': 'ondemand', 18:24:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:24:34 INFO - 'tooltool.py': '/tools/tooltool.py', 18:24:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:24:34 INFO - '/tools/misc-python/virtualenv.py')}, 18:24:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:24:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:24:34 INFO - 'installer_path': 'installer.exe', 18:24:34 INFO - 'log_level': 'info', 18:24:34 INFO - 'log_name': 'talos', 18:24:34 INFO - 'log_to_console': True, 18:24:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:24:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:24:34 INFO - 'opt_config_files': (), 18:24:34 INFO - 'pip_index': False, 18:24:34 INFO - 'sps_profile': False, 18:24:34 INFO - 'sps_profile_interval': 0, 18:24:34 INFO - 'suite': 'dromaeojs', 18:24:34 INFO - 'system_bits': '64', 18:24:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:24:34 INFO - 'title': 'talos-linux64-ix-047', 18:24:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:24:34 INFO - 'use_talos_json': True, 18:24:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:24:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:24:34 INFO - 'work_dir': 'build'} 18:24:34 INFO - ##### 18:24:34 INFO - ##### Running clobber step. 18:24:34 INFO - ##### 18:24:34 INFO - Running pre-action listener: _resource_record_pre_action 18:24:34 INFO - Running main action method: clobber 18:24:34 INFO - rmtree: /builds/slave/test/build 18:24:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:24:34 INFO - Running post-action listener: _resource_record_post_action 18:24:34 INFO - ##### 18:24:34 INFO - ##### Running read-buildbot-config step. 18:24:34 INFO - ##### 18:24:34 INFO - Running pre-action listener: _resource_record_pre_action 18:24:34 INFO - Running main action method: read_buildbot_config 18:24:34 INFO - Using buildbot properties: 18:24:34 INFO - { 18:24:34 INFO - "properties": { 18:24:34 INFO - "buildnumber": 286, 18:24:34 INFO - "product": "firefox", 18:24:34 INFO - "script_repo_revision": "production", 18:24:34 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 18:24:34 INFO - "repository": "", 18:24:34 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound talos dromaeojs", 18:24:34 INFO - "buildid": "20151124165836", 18:24:34 INFO - "slavename": "talos-linux64-ix-047", 18:24:34 INFO - "pgo_build": "False", 18:24:34 INFO - "basedir": "/builds/slave/test", 18:24:34 INFO - "project": "", 18:24:34 INFO - "platform": "ubuntu64_hw", 18:24:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:24:34 INFO - "slavebuilddir": "test", 18:24:34 INFO - "scheduler": "tests-b2g-inbound-linux64-talos", 18:24:34 INFO - "branch": "b2g-inbound", 18:24:34 INFO - "repo_path": "integration/b2g-inbound", 18:24:34 INFO - "stage_platform": "linux64", 18:24:34 INFO - "builduid": "9079422952cf47039ae0ceeeb694bfd2", 18:24:34 INFO - "revision": "dbf3d11d0f9ed1941ba5323b51fbdb2666b26f23" 18:24:34 INFO - }, 18:24:34 INFO - "sourcestamp": { 18:24:34 INFO - "repository": "", 18:24:34 INFO - "hasPatch": false, 18:24:34 INFO - "project": "", 18:24:34 INFO - "branch": "b2g-inbound-linux64-talos", 18:24:34 INFO - "changes": [ 18:24:34 INFO - { 18:24:34 INFO - "category": null, 18:24:34 INFO - "files": [ 18:24:34 INFO - { 18:24:34 INFO - "url": null, 18:24:34 INFO - "name": "https://queue.taskcluster.net/v1/task/HD0CMTTUTt2iGRyFjhG7TQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 18:24:34 INFO - } 18:24:34 INFO - ], 18:24:34 INFO - "repository": "", 18:24:34 INFO - "rev": "dbf3d11d0f9ed1941ba5323b51fbdb2666b26f23", 18:24:34 INFO - "who": "kwierso@gmail.com", 18:24:34 INFO - "when": 1448418263, 18:24:34 INFO - "number": 6703163, 18:24:34 INFO - "comments": "Merge m-c to b2ginbound, a=merge", 18:24:34 INFO - "project": "", 18:24:34 INFO - "at": "Tue 24 Nov 2015 18:24:23", 18:24:34 INFO - "branch": "b2g-inbound-linux64-talos", 18:24:34 INFO - "revlink": "", 18:24:34 INFO - "properties": [ 18:24:34 INFO - [ 18:24:34 INFO - "buildid", 18:24:34 INFO - "20151124165836", 18:24:34 INFO - "Change" 18:24:34 INFO - ], 18:24:34 INFO - [ 18:24:34 INFO - "builduid", 18:24:34 INFO - "9079422952cf47039ae0ceeeb694bfd2", 18:24:34 INFO - "Change" 18:24:34 INFO - ], 18:24:34 INFO - [ 18:24:34 INFO - "pgo_build", 18:24:34 INFO - "False", 18:24:34 INFO - "Change" 18:24:34 INFO - ] 18:24:34 INFO - ], 18:24:34 INFO - "revision": "dbf3d11d0f9ed1941ba5323b51fbdb2666b26f23" 18:24:34 INFO - } 18:24:34 INFO - ], 18:24:34 INFO - "revision": "dbf3d11d0f9ed1941ba5323b51fbdb2666b26f23" 18:24:34 INFO - } 18:24:34 INFO - } 18:24:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/HD0CMTTUTt2iGRyFjhG7TQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 18:24:34 INFO - Running post-action listener: _resource_record_post_action 18:24:34 INFO - ##### 18:24:34 INFO - ##### Running download-and-extract step. 18:24:34 INFO - ##### 18:24:34 INFO - Running pre-action listener: _resource_record_pre_action 18:24:34 INFO - Running main action method: download_and_extract 18:24:34 INFO - mkdir: /builds/slave/test/build/tests 18:24:34 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')]} 18:24:34 INFO - https://queue.taskcluster.net/v1/task/HD0CMTTUTt2iGRyFjhG7TQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:24:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HD0CMTTUTt2iGRyFjhG7TQ/artifacts/public/build/test_packages.json 18:24:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HD0CMTTUTt2iGRyFjhG7TQ/artifacts/public/build/test_packages.json 18:24:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HD0CMTTUTt2iGRyFjhG7TQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 18:24:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HD0CMTTUTt2iGRyFjhG7TQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 18:24:35 INFO - Downloaded 1302 bytes. 18:24:35 INFO - Reading from file /builds/slave/test/build/test_packages.json 18:24:35 INFO - Using the following test package requirements: 18:24:35 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:24:35 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:24:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:24:35 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:24:35 INFO - u'jsshell-linux-x86_64.zip'], 18:24:35 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:24:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:24:35 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:24:35 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:24:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:24:35 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:24:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:24:35 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:24:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:24:35 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:24:35 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:24:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:24:35 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:24:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:24:35 INFO - https://queue.taskcluster.net/v1/task/HD0CMTTUTt2iGRyFjhG7TQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:24:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HD0CMTTUTt2iGRyFjhG7TQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:24:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HD0CMTTUTt2iGRyFjhG7TQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:24:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HD0CMTTUTt2iGRyFjhG7TQ/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 18:24:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HD0CMTTUTt2iGRyFjhG7TQ/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 18:24:37 INFO - Downloaded 21345618 bytes. 18:24:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 18:24:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:24:37 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 18:24:38 INFO - Return code: 0 18:24:38 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:24:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:24:38 INFO - https://queue.taskcluster.net/v1/task/HD0CMTTUTt2iGRyFjhG7TQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:24:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HD0CMTTUTt2iGRyFjhG7TQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:24:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HD0CMTTUTt2iGRyFjhG7TQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:24:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HD0CMTTUTt2iGRyFjhG7TQ/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 18:24:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HD0CMTTUTt2iGRyFjhG7TQ/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 18:24:39 INFO - Downloaded 21345618 bytes. 18:24:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 18:24:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:24:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 18:24:40 INFO - Return code: 0 18:24:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:24:40 INFO - https://queue.taskcluster.net/v1/task/HD0CMTTUTt2iGRyFjhG7TQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:24:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HD0CMTTUTt2iGRyFjhG7TQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:24:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HD0CMTTUTt2iGRyFjhG7TQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:24:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HD0CMTTUTt2iGRyFjhG7TQ/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 18:24:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HD0CMTTUTt2iGRyFjhG7TQ/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 18:24:42 INFO - Downloaded 11131717 bytes. 18:24:42 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 18:24:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:24:42 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 18:24:42 INFO - Return code: 0 18:24:42 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')]} 18:24:42 INFO - https://queue.taskcluster.net/v1/task/HD0CMTTUTt2iGRyFjhG7TQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:24:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HD0CMTTUTt2iGRyFjhG7TQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:24:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HD0CMTTUTt2iGRyFjhG7TQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:24:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HD0CMTTUTt2iGRyFjhG7TQ/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 18:24:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HD0CMTTUTt2iGRyFjhG7TQ/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 18:24:45 INFO - Downloaded 56845639 bytes. 18:24:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HD0CMTTUTt2iGRyFjhG7TQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:24:45 INFO - mkdir: /builds/slave/test/properties 18:24:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:24:45 INFO - Writing to file /builds/slave/test/properties/build_url 18:24:45 INFO - Contents: 18:24:45 INFO - build_url:https://queue.taskcluster.net/v1/task/HD0CMTTUTt2iGRyFjhG7TQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:24:45 INFO - Running post-action listener: _resource_record_post_action 18:24:45 INFO - Running post-action listener: set_extra_try_arguments 18:24:45 INFO - ##### 18:24:45 INFO - ##### Running populate-webroot step. 18:24:45 INFO - ##### 18:24:45 INFO - Running pre-action listener: _resource_record_pre_action 18:24:45 INFO - Running main action method: populate_webroot 18:24:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:24:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:24:45 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 18:24:45 INFO - '../fennec_ids.txt'], 18:24:45 INFO - 'tests': ['tcheck2']}, 18:24:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:24:45 INFO - '--tppagecycles', 18:24:45 INFO - '7'], 18:24:45 INFO - 'tests': ['tsvgm']}}, 18:24:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:24:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:24:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:24:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:24:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:24:45 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:24:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:24:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:24:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:24:45 INFO - 'talos_options': ['--e10s'], 18:24:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:24:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:24:45 INFO - 'tests': ['damp', 'tps']}, 18:24:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:24:45 INFO - 'talos_options': ['--e10s'], 18:24:45 INFO - 'tests': ['damp', 'tps']}, 18:24:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:24:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:24:45 INFO - 'other': {'tests': ['a11yr', 18:24:45 INFO - 'ts_paint', 18:24:45 INFO - 'tpaint', 18:24:45 INFO - 'sessionrestore', 18:24:45 INFO - 'sessionrestore_no_auto_restore']}, 18:24:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:24:45 INFO - 'tests': ['a11yr', 18:24:45 INFO - 'ts_paint', 18:24:45 INFO - 'tpaint', 18:24:45 INFO - 'sessionrestore', 18:24:45 INFO - 'sessionrestore_no_auto_restore']}, 18:24:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:24:45 INFO - 'tests': ['a11yr', 18:24:45 INFO - 'ts_paint', 18:24:45 INFO - 'tpaint', 18:24:45 INFO - 'sessionrestore', 18:24:45 INFO - 'sessionrestore_no_auto_restore']}, 18:24:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:24:45 INFO - 'tests': ['a11yr', 18:24:45 INFO - 'ts_paint', 18:24:45 INFO - 'tpaint', 18:24:45 INFO - 'sessionrestore', 18:24:45 INFO - 'sessionrestore_no_auto_restore']}, 18:24:45 INFO - 'other_l64': {'tests': ['a11yr', 18:24:45 INFO - 'ts_paint', 18:24:45 INFO - 'tpaint', 18:24:45 INFO - 'sessionrestore', 18:24:45 INFO - 'sessionrestore_no_auto_restore']}, 18:24:45 INFO - 'other_nol64': {'tests': ['a11yr', 18:24:45 INFO - 'ts_paint', 18:24:45 INFO - 'tpaint', 18:24:45 INFO - 'sessionrestore', 18:24:45 INFO - 'sessionrestore_no_auto_restore']}, 18:24:45 INFO - 'svgr': {'tests': ['tsvgx', 18:24:45 INFO - 'tsvgr_opacity', 18:24:45 INFO - 'tart', 18:24:45 INFO - 'tscrollx', 18:24:45 INFO - 'cart']}, 18:24:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:24:45 INFO - 'tests': ['tsvgx', 18:24:45 INFO - 'tsvgr_opacity', 18:24:45 INFO - 'tart', 18:24:45 INFO - 'tscrollx', 18:24:45 INFO - 'cart']}, 18:24:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:24:45 INFO - 'tests': ['tp5o']}, 18:24:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:24:45 INFO - 'talos_options': ['--e10s'], 18:24:45 INFO - 'tests': ['tp5o']}, 18:24:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:24:45 INFO - 'talos_options': ['--xperf_path', 18:24:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:24:45 INFO - 'tests': ['tp5n']}, 18:24:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:24:45 INFO - 'talos_options': ['--e10s', 18:24:45 INFO - '--xperf_path', 18:24:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:24:45 INFO - 'tests': ['tp5n']}}, 18:24:45 INFO - 'talos.zip': {'path': '', 18:24:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:24:45 INFO - Running post-action listener: _resource_record_post_action 18:24:45 INFO - ##### 18:24:45 INFO - ##### Running create-virtualenv step. 18:24:45 INFO - ##### 18:24:45 INFO - Running pre-action listener: _resource_record_pre_action 18:24:45 INFO - Running main action method: create_virtualenv 18:24:45 INFO - Creating virtualenv /builds/slave/test/build/venv 18:24:45 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 18:24:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:24:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:24:45 INFO - Using real prefix '/usr' 18:24:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:24:46 INFO - Installing distribute.............................................................................................................................................................................................done. 18:24:48 INFO - Installing pip.................done. 18:24:48 INFO - Return code: 0 18:24:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:24: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')]} 18:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:24:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24: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')]} 18:24:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:24:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b17210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba9220>, '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 0x2b152b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b15740>, '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': 'f5f5a079460e1a9be8676904000001c1-1448417498.279178-775015110', '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 18:24:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:24:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:24:48 INFO - Using env: {'DISPLAY': ':0', 18:24:48 INFO - 'HOME': '/home/cltbld', 18:24:48 INFO - 'LANG': 'en_US.UTF-8', 18:24:48 INFO - 'LANGUAGE': 'en_US:en', 18:24:48 INFO - 'LOGNAME': 'cltbld', 18:24:48 INFO - 'MAIL': '/var/mail/cltbld', 18:24:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:48 INFO - 'MOZ_NO_REMOTE': '1', 18:24:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:24:48 INFO - 'NO_EM_RESTART': '1', 18:24:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:24:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:48 INFO - 'PWD': '/builds/slave/test', 18:24:48 INFO - 'SHELL': '/bin/bash', 18:24:48 INFO - 'SHLVL': '1', 18:24:48 INFO - 'TERM': 'linux', 18:24:48 INFO - 'TMOUT': '86400', 18:24:48 INFO - 'USER': 'cltbld', 18:24:48 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1448417498.279178-775015110', 18:24:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:48 INFO - '_': '/tools/buildbot/bin/python'} 18:24:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:24:48 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 18:24:48 INFO - Cleaning up... 18:24:48 INFO - Return code: 0 18:24:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:24: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')]} 18:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:24:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24: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')]} 18:24:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:24:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x28e6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b17210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba9220>, '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 0x2b152b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b15740>, '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': 'f5f5a079460e1a9be8676904000001c1-1448417498.279178-775015110', '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 18:24:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 18:24:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 18:24:48 INFO - Using env: {'DISPLAY': ':0', 18:24:48 INFO - 'HOME': '/home/cltbld', 18:24:48 INFO - 'LANG': 'en_US.UTF-8', 18:24:48 INFO - 'LANGUAGE': 'en_US:en', 18:24:48 INFO - 'LOGNAME': 'cltbld', 18:24:48 INFO - 'MAIL': '/var/mail/cltbld', 18:24:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:48 INFO - 'MOZ_NO_REMOTE': '1', 18:24:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:24:48 INFO - 'NO_EM_RESTART': '1', 18:24:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:24:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:48 INFO - 'PWD': '/builds/slave/test', 18:24:48 INFO - 'SHELL': '/bin/bash', 18:24:48 INFO - 'SHLVL': '1', 18:24:48 INFO - 'TERM': 'linux', 18:24:48 INFO - 'TMOUT': '86400', 18:24:48 INFO - 'USER': 'cltbld', 18:24:48 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1448417498.279178-775015110', 18:24:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:48 INFO - '_': '/tools/buildbot/bin/python'} 18:24:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:24:48 INFO - Downloading/unpacking psutil>=0.7.1 18:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:24:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:24:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:24:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:24:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:24:50 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 18:24:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:24:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:24:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:24:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:24:50 INFO - Installing collected packages: psutil 18:24:50 INFO - Running setup.py install for psutil 18:24:50 INFO - building 'psutil._psutil_linux' extension 18:24:50 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 18:24:50 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 18:24:50 INFO - building 'psutil._psutil_posix' extension 18:24:50 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 18:24:50 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 18:24:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:24:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:24:50 INFO - Successfully installed psutil 18:24:50 INFO - Cleaning up... 18:24:50 INFO - Return code: 0 18:24:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:24:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:24:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:24:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:24:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:24:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x28e6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b17210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba9220>, '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 0x2b152b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b15740>, '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': 'f5f5a079460e1a9be8676904000001c1-1448417498.279178-775015110', '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 18:24:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 18:24:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 18:24:50 INFO - Using env: {'DISPLAY': ':0', 18:24:50 INFO - 'HOME': '/home/cltbld', 18:24:50 INFO - 'LANG': 'en_US.UTF-8', 18:24:50 INFO - 'LANGUAGE': 'en_US:en', 18:24:50 INFO - 'LOGNAME': 'cltbld', 18:24:50 INFO - 'MAIL': '/var/mail/cltbld', 18:24:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:50 INFO - 'MOZ_NO_REMOTE': '1', 18:24:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:24:50 INFO - 'NO_EM_RESTART': '1', 18:24:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:24:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:50 INFO - 'PWD': '/builds/slave/test', 18:24:50 INFO - 'SHELL': '/bin/bash', 18:24:50 INFO - 'SHLVL': '1', 18:24:50 INFO - 'TERM': 'linux', 18:24:50 INFO - 'TMOUT': '86400', 18:24:50 INFO - 'USER': 'cltbld', 18:24:50 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1448417498.279178-775015110', 18:24:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:50 INFO - '_': '/tools/buildbot/bin/python'} 18:24:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:24:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:24:51 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 18:24:51 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 18:24:51 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 18:24:51 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 18:24:51 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 18:24:51 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 18:24:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:24:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:24:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:24:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:24:52 INFO - Installing collected packages: mozsystemmonitor 18:24:52 INFO - Running setup.py install for mozsystemmonitor 18:24:52 INFO - Successfully installed mozsystemmonitor 18:24:52 INFO - Cleaning up... 18:24:53 INFO - Return code: 0 18:24:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:24: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')]} 18:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:24:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24: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')]} 18:24:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:24:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x28e6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b17210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba9220>, '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 0x2b152b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b15740>, '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': 'f5f5a079460e1a9be8676904000001c1-1448417498.279178-775015110', '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 18:24:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:24:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:24:53 INFO - Using env: {'DISPLAY': ':0', 18:24:53 INFO - 'HOME': '/home/cltbld', 18:24:53 INFO - 'LANG': 'en_US.UTF-8', 18:24:53 INFO - 'LANGUAGE': 'en_US:en', 18:24:53 INFO - 'LOGNAME': 'cltbld', 18:24:53 INFO - 'MAIL': '/var/mail/cltbld', 18:24:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:53 INFO - 'MOZ_NO_REMOTE': '1', 18:24:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:24:53 INFO - 'NO_EM_RESTART': '1', 18:24:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:24:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:53 INFO - 'PWD': '/builds/slave/test', 18:24:53 INFO - 'SHELL': '/bin/bash', 18:24:53 INFO - 'SHLVL': '1', 18:24:53 INFO - 'TERM': 'linux', 18:24:53 INFO - 'TMOUT': '86400', 18:24:53 INFO - 'USER': 'cltbld', 18:24:53 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1448417498.279178-775015110', 18:24:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:53 INFO - '_': '/tools/buildbot/bin/python'} 18:24:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:24:53 INFO - Downloading/unpacking blobuploader==1.2.4 18:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:24:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:24:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:24:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:24:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:24:54 INFO - Downloading blobuploader-1.2.4.tar.gz 18:24:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:24:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:24:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:24:55 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 18:24:55 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 18:24:55 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 18:24:55 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 18:24:55 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 18:24:55 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 18:24:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:24:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:24:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:24:55 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 18:24:55 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 18:24:55 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 18:24:55 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 18:24:55 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 18:24:55 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 18:24:55 INFO - Downloading docopt-0.6.1.tar.gz 18:24:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:24:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:24:55 INFO - Installing collected packages: blobuploader, requests, docopt 18:24:55 INFO - Running setup.py install for blobuploader 18:24:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:24:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:24:55 INFO - Running setup.py install for requests 18:24:56 INFO - Running setup.py install for docopt 18:24:56 INFO - Successfully installed blobuploader requests docopt 18:24:56 INFO - Cleaning up... 18:24:56 INFO - Return code: 0 18:24:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:24:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:24:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:24:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:56 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 0x28e6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b17210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba9220>, '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 0x2b152b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b15740>, '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': 'f5f5a079460e1a9be8676904000001c1-1448417498.279178-775015110', '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 18:24:56 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 18:24:56 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 18:24:56 INFO - Using env: {'DISPLAY': ':0', 18:24:56 INFO - 'HOME': '/home/cltbld', 18:24:56 INFO - 'LANG': 'en_US.UTF-8', 18:24:56 INFO - 'LANGUAGE': 'en_US:en', 18:24:56 INFO - 'LOGNAME': 'cltbld', 18:24:56 INFO - 'MAIL': '/var/mail/cltbld', 18:24:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:56 INFO - 'MOZ_NO_REMOTE': '1', 18:24:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:24:56 INFO - 'NO_EM_RESTART': '1', 18:24:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:24:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:56 INFO - 'PWD': '/builds/slave/test', 18:24:56 INFO - 'SHELL': '/bin/bash', 18:24:56 INFO - 'SHLVL': '1', 18:24:56 INFO - 'TERM': 'linux', 18:24:56 INFO - 'TMOUT': '86400', 18:24:56 INFO - 'USER': 'cltbld', 18:24:56 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1448417498.279178-775015110', 18:24:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:56 INFO - '_': '/tools/buildbot/bin/python'} 18:24:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:24:56 INFO - Running setup.py (path:/tmp/pip-AYb0ZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:24:56 INFO - Running setup.py (path:/tmp/pip-oFyUgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:24:56 INFO - Running setup.py (path:/tmp/pip-AHg8EC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:24:56 INFO - Running setup.py (path:/tmp/pip-idHfk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:24:56 INFO - Running setup.py (path:/tmp/pip-TocLIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:24:56 INFO - Running setup.py (path:/tmp/pip-BoBuiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:24:56 INFO - Running setup.py (path:/tmp/pip-6IMWJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:24:56 INFO - Running setup.py (path:/tmp/pip-pwnJvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:24:57 INFO - Running setup.py (path:/tmp/pip-p3DQk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:24:57 INFO - Running setup.py (path:/tmp/pip-vaz0v3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:24:57 INFO - Running setup.py (path:/tmp/pip-aclqCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:24:57 INFO - Running setup.py (path:/tmp/pip-09dFgh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:24:57 INFO - Running setup.py (path:/tmp/pip-5I2Cv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:24:57 INFO - Running setup.py (path:/tmp/pip-TcQQTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:24:57 INFO - Running setup.py (path:/tmp/pip-pSRHca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:24:57 INFO - Running setup.py (path:/tmp/pip-qmxjVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:24:57 INFO - Running setup.py (path:/tmp/pip-5w_ZzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:24:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:24:57 INFO - Running setup.py install for manifestparser 18:24:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:24:57 INFO - Running setup.py install for mozcrash 18:24:57 INFO - Running setup.py install for mozdebug 18:24:58 INFO - Running setup.py install for mozdevice 18:24:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:24:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:24:58 INFO - Running setup.py install for mozfile 18:24:58 INFO - Running setup.py install for mozhttpd 18:24:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:24:58 INFO - Running setup.py install for mozinfo 18:24:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:24:58 INFO - Running setup.py install for mozInstall 18:24:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:24:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:24:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:24:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:24:58 INFO - Running setup.py install for mozleak 18:24:58 INFO - Running setup.py install for mozlog 18:24:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:24:58 INFO - Running setup.py install for moznetwork 18:24:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:24:58 INFO - Running setup.py install for mozprocess 18:24:58 INFO - Running setup.py install for mozprofile 18:24:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:24:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:24:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:24:59 INFO - Running setup.py install for mozrunner 18:24:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:24:59 INFO - Running setup.py install for mozscreenshot 18:24:59 INFO - Running setup.py install for moztest 18:24:59 INFO - Running setup.py install for mozversion 18:24:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:24:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:24:59 INFO - Cleaning up... 18:24:59 INFO - Return code: 0 18:24:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:24: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')]} 18:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:24:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24: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')]} 18:24:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:24:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24: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', '-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 0x28e6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b17210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba9220>, '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 0x2b152b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b15740>, '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': 'f5f5a079460e1a9be8676904000001c1-1448417498.279178-775015110', '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 18:24:59 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 18:24:59 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 18:24:59 INFO - Using env: {'DISPLAY': ':0', 18:24:59 INFO - 'HOME': '/home/cltbld', 18:24:59 INFO - 'LANG': 'en_US.UTF-8', 18:24:59 INFO - 'LANGUAGE': 'en_US:en', 18:24:59 INFO - 'LOGNAME': 'cltbld', 18:24:59 INFO - 'MAIL': '/var/mail/cltbld', 18:24:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:59 INFO - 'MOZ_NO_REMOTE': '1', 18:24:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:24:59 INFO - 'NO_EM_RESTART': '1', 18:24:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:24:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:59 INFO - 'PWD': '/builds/slave/test', 18:24:59 INFO - 'SHELL': '/bin/bash', 18:24:59 INFO - 'SHLVL': '1', 18:24:59 INFO - 'TERM': 'linux', 18:24:59 INFO - 'TMOUT': '86400', 18:24:59 INFO - 'USER': 'cltbld', 18:24:59 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1448417498.279178-775015110', 18:24:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:59 INFO - '_': '/tools/buildbot/bin/python'} 18:24:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:24:59 INFO - Running setup.py (path:/tmp/pip-SLHEuw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:24:59 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)) 18:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:24:59 INFO - Running setup.py (path:/tmp/pip-1PgTP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:24:59 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)) 18:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:24:59 INFO - Running setup.py (path:/tmp/pip-yaglgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:24:59 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)) 18:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:24:59 INFO - Running setup.py (path:/tmp/pip-BytNG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:24:59 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)) 18:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:24:59 INFO - Running setup.py (path:/tmp/pip-eBxR7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:25:00 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)) 18:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:25:00 INFO - Running setup.py (path:/tmp/pip-FwmQfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:25:00 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)) 18:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:25:00 INFO - Running setup.py (path:/tmp/pip-24Uw0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:25:00 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)) 18:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:25:00 INFO - Running setup.py (path:/tmp/pip-_dLDgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:25:00 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)) 18:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:25:00 INFO - Running setup.py (path:/tmp/pip-YJILkx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:25:00 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)) 18:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:25:00 INFO - Running setup.py (path:/tmp/pip-cojS5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:25:00 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)) 18:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:25:00 INFO - Running setup.py (path:/tmp/pip-GT5PHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:25:00 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)) 18:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:25:00 INFO - Running setup.py (path:/tmp/pip-l9x0u7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:25:00 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)) 18:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:25:00 INFO - Running setup.py (path:/tmp/pip-WjpAzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:25:00 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)) 18:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:25:00 INFO - Running setup.py (path:/tmp/pip-wTjvn2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:25:00 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)) 18:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:25:00 INFO - Running setup.py (path:/tmp/pip-E3kS_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:25:00 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)) 18:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:25:00 INFO - Running setup.py (path:/tmp/pip-dHeSnI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:25:00 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)) 18:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:25:00 INFO - Running setup.py (path:/tmp/pip-WLx99m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:25:00 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)) 18:25:00 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)) 18:25:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:25:00 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)) 18:25:00 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)) 18:25:00 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)) 18:25:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:25: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 18:25: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 18:25: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 18:25: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 18:25: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 18:25: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 18:25:02 INFO - Downloading blessings-1.5.1.tar.gz 18:25:02 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 18:25:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:25:02 INFO - Installing collected packages: blessings 18:25:02 INFO - Running setup.py install for blessings 18:25:02 INFO - Successfully installed blessings 18:25:02 INFO - Cleaning up... 18:25:02 INFO - Return code: 0 18:25:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:25:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:25:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:25:03 INFO - Reading from file tmpfile_stdout 18:25:03 INFO - Current package versions: 18:25:03 INFO - argparse == 1.2.1 18:25:03 INFO - blessings == 1.5.1 18:25:03 INFO - blobuploader == 1.2.4 18:25:03 INFO - docopt == 0.6.1 18:25:03 INFO - manifestparser == 1.1 18:25:03 INFO - mozInstall == 1.12 18:25:03 INFO - mozcrash == 0.16 18:25:03 INFO - mozdebug == 0.1 18:25:03 INFO - mozdevice == 0.47 18:25:03 INFO - mozfile == 1.2 18:25:03 INFO - mozhttpd == 0.7 18:25:03 INFO - mozinfo == 0.9 18:25:03 INFO - mozleak == 0.1 18:25:03 INFO - mozlog == 3.1 18:25:03 INFO - moznetwork == 0.27 18:25:03 INFO - mozprocess == 0.22 18:25:03 INFO - mozprofile == 0.27 18:25:03 INFO - mozrunner == 6.11 18:25:03 INFO - mozscreenshot == 0.1 18:25:03 INFO - mozsystemmonitor == 0.0 18:25:03 INFO - moztest == 0.7 18:25:03 INFO - mozversion == 1.4 18:25:03 INFO - psutil == 3.1.1 18:25:03 INFO - requests == 1.2.3 18:25:03 INFO - wsgiref == 0.1.2 18:25:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:25:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:25:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:03 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 0x28e6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b17210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba9220>, '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 0x2b152b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b15740>, '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': 'f5f5a079460e1a9be8676904000001c1-1448417498.279178-775015110', '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 18:25:03 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 18:25:03 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 18:25:03 INFO - Using env: {'DISPLAY': ':0', 18:25:03 INFO - 'HOME': '/home/cltbld', 18:25:03 INFO - 'LANG': 'en_US.UTF-8', 18:25:03 INFO - 'LANGUAGE': 'en_US:en', 18:25:03 INFO - 'LOGNAME': 'cltbld', 18:25:03 INFO - 'MAIL': '/var/mail/cltbld', 18:25:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:03 INFO - 'MOZ_NO_REMOTE': '1', 18:25:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:03 INFO - 'NO_EM_RESTART': '1', 18:25:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:03 INFO - 'PWD': '/builds/slave/test', 18:25:03 INFO - 'SHELL': '/bin/bash', 18:25:03 INFO - 'SHLVL': '1', 18:25:03 INFO - 'TERM': 'linux', 18:25:03 INFO - 'TMOUT': '86400', 18:25:03 INFO - 'USER': 'cltbld', 18:25:03 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1448417498.279178-775015110', 18:25:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:03 INFO - '_': '/tools/buildbot/bin/python'} 18:25:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:03 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)) 18:25:03 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)) 18:25:03 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)) 18:25:03 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)) 18:25:03 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)) 18:25:03 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)) 18:25:03 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)) 18:25:03 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)) 18:25:03 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)) 18:25:03 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)) 18:25:03 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)) 18:25:03 INFO - Cleaning up... 18:25:03 INFO - Return code: 0 18:25:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:25:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:25:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:03 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 0x28e6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b17210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba9220>, '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 0x2b152b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b15740>, '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': 'f5f5a079460e1a9be8676904000001c1-1448417498.279178-775015110', '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 18:25:03 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 18:25:03 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 18:25:03 INFO - Using env: {'DISPLAY': ':0', 18:25:03 INFO - 'HOME': '/home/cltbld', 18:25:03 INFO - 'LANG': 'en_US.UTF-8', 18:25:03 INFO - 'LANGUAGE': 'en_US:en', 18:25:03 INFO - 'LOGNAME': 'cltbld', 18:25:03 INFO - 'MAIL': '/var/mail/cltbld', 18:25:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:03 INFO - 'MOZ_NO_REMOTE': '1', 18:25:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:03 INFO - 'NO_EM_RESTART': '1', 18:25:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:03 INFO - 'PWD': '/builds/slave/test', 18:25:03 INFO - 'SHELL': '/bin/bash', 18:25:03 INFO - 'SHLVL': '1', 18:25:03 INFO - 'TERM': 'linux', 18:25:03 INFO - 'TMOUT': '86400', 18:25:03 INFO - 'USER': 'cltbld', 18:25:03 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1448417498.279178-775015110', 18:25:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:03 INFO - '_': '/tools/buildbot/bin/python'} 18:25:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:03 INFO - Downloading/unpacking jsonschema 18:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:25:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:25:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:25:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:25:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:25:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:25:05 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 18:25:05 INFO - Downloading/unpacking functools32 (from jsonschema) 18:25:05 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 18:25:05 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 18:25:05 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 18:25:05 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 18:25:05 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 18:25:05 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 18:25:05 INFO - Downloading functools32-3.2.3-2.tar.gz 18:25:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 18:25:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:25:05 INFO - warning: no files found matching '*.txt' 18:25:05 INFO - no previously-included directories found matching 'build' 18:25:05 INFO - no previously-included directories found matching 'dist' 18:25:05 INFO - no previously-included directories found matching '.git*' 18:25:05 INFO - Installing collected packages: jsonschema, functools32 18:25:05 INFO - Running setup.py install for functools32 18:25:05 INFO - warning: no files found matching '*.txt' 18:25:05 INFO - no previously-included directories found matching 'build' 18:25:05 INFO - no previously-included directories found matching 'dist' 18:25:05 INFO - no previously-included directories found matching '.git*' 18:25:05 INFO - Successfully installed jsonschema functools32 18:25:05 INFO - Cleaning up... 18:25:05 INFO - Return code: 0 18:25:05 INFO - Running post-action listener: _resource_record_post_action 18:25:05 INFO - Running post-action listener: _start_resource_monitoring 18:25:05 INFO - Starting resource monitoring. 18:25:05 INFO - ##### 18:25:05 INFO - ##### Running install step. 18:25:05 INFO - ##### 18:25:05 INFO - Running pre-action listener: _resource_record_pre_action 18:25:05 INFO - Running main action method: install 18:25:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:25:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:25:05 INFO - Reading from file tmpfile_stdout 18:25:05 INFO - Detecting whether we're running mozinstall >=1.0... 18:25:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:25:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:25:06 INFO - Reading from file tmpfile_stdout 18:25:06 INFO - Output received: 18:25:06 INFO - Usage: mozinstall [options] installer 18:25:06 INFO - Options: 18:25:06 INFO - -h, --help show this help message and exit 18:25:06 INFO - -d DEST, --destination=DEST 18:25:06 INFO - Directory to install application into. [default: 18:25:06 INFO - "/builds/slave/test"] 18:25:06 INFO - --app=APP Application being installed. [default: firefox] 18:25:06 INFO - mkdir: /builds/slave/test/build/application 18:25:06 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'] 18:25:06 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 18:25:20 INFO - Reading from file tmpfile_stdout 18:25:20 INFO - Output received: 18:25:20 INFO - /builds/slave/test/build/application/firefox/firefox 18:25:20 INFO - Running post-action listener: _resource_record_post_action 18:25:20 INFO - ##### 18:25:20 INFO - ##### Running run-tests step. 18:25:20 INFO - ##### 18:25:20 INFO - Running pre-action listener: _resource_record_pre_action 18:25:20 INFO - Running main action method: run_tests 18:25:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:25:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:25:20 INFO - Python 2.7.3 18:25:20 INFO - Return code: 0 18:25:20 INFO - grabbing minidump binary from tooltool 18:25:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:25:20 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 0x2ba9220>, '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 0x2b152b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b15740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:25:20 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 18:25:20 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 18:25:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:25:20 INFO - Return code: 0 18:25:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:25:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:25:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:25:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:25:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:25:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HD0CMTTUTt2iGRyFjhG7TQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost'] in /builds/slave/test/build 18:25:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName B2G-Inbound-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HD0CMTTUTt2iGRyFjhG7TQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost 18:25:20 INFO - Using env: {'DISPLAY': ':0', 18:25:20 INFO - 'HOME': '/home/cltbld', 18:25:20 INFO - 'LANG': 'en_US.UTF-8', 18:25:20 INFO - 'LANGUAGE': 'en_US:en', 18:25:20 INFO - 'LOGNAME': 'cltbld', 18:25:20 INFO - 'MAIL': '/var/mail/cltbld', 18:25:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:25:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:25:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:20 INFO - 'MOZ_NO_REMOTE': '1', 18:25:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:25:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:20 INFO - 'NO_EM_RESTART': '1', 18:25:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:20 INFO - 'PWD': '/builds/slave/test', 18:25:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:25:20 INFO - 'SHELL': '/bin/bash', 18:25:20 INFO - 'SHLVL': '1', 18:25:20 INFO - 'TERM': 'linux', 18:25:20 INFO - 'TMOUT': '86400', 18:25:20 INFO - 'USER': 'cltbld', 18:25:20 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1448417498.279178-775015110', 18:25:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:20 INFO - '_': '/tools/buildbot/bin/python'} 18:25:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HD0CMTTUTt2iGRyFjhG7TQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost'] with output_timeout 3600 18:25:20 INFO - mozversion INFO | application_buildid: 20151124165836 18:25:20 INFO - mozversion INFO | application_changeset: dbf3d11d0f9ed1941ba5323b51fbdb2666b26f23 18:25:20 INFO - mozversion INFO | application_display_name: Nightly 18:25:20 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:25:20 INFO - mozversion INFO | application_name: Firefox 18:25:20 INFO - mozversion INFO | application_remotingname: firefox 18:25:20 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 18:25:20 INFO - mozversion INFO | application_vendor: Mozilla 18:25:20 INFO - mozversion INFO | application_version: 45.0a1 18:25:20 INFO - mozversion INFO | platform_buildid: 20151124165836 18:25:20 INFO - mozversion INFO | platform_changeset: dbf3d11d0f9ed1941ba5323b51fbdb2666b26f23 18:25:20 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 18:25:20 INFO - mozversion INFO | platform_version: 45.0a1 18:25:20 INFO - 2015-11-24 18:25:20,583 DEBUG : using testdate: 1448418320 18:25:20 INFO - 2015-11-24 18:25:20,583 DEBUG : actual date: 1448418320 18:25:20 INFO - 2015-11-24 18:25:20,592 INFO : starting webserver on 'localhost:51815' 18:25:20 INFO - 2015-11-24 18:25:20,593 INFO : Starting test suite talos-linux64-ix-047 18:25:20 INFO - 2015-11-24 18:25:20,593 INFO : Starting test dromaeo_css 18:25:20 INFO - 2015-11-24 18:25:20,593 DEBUG : operating with platform_type : linux_ 18:25:20 INFO - 2015-11-24 18:25:20,594 INFO : Initialising browser for dromaeo_css test... 18:25:20 INFO - 2015-11-24 18:25:20,610 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYzfx4B/profile http://localhost:51815/getInfo.html 18:25:24 INFO - 2015-11-24 18:25:24,653 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:25:24 INFO - 2015-11-24 18:25:24,653 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:25:24 INFO - 2015-11-24 18:25:24,653 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:25:24 INFO - 2015-11-24 18:25:24,653 DEBUG : BROWSER_OUTPUT: __metrics 18:25:24 INFO - 2015-11-24 18:25:24,802 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] 18:25:25 INFO - 2015-11-24 18:25:25,979 INFO : Browser initialized. 18:25:25 INFO - 2015-11-24 18:25:25,980 INFO : Running cycle 1/1 for dromaeo_css test... 18:25:25 INFO - 2015-11-24 18:25:25,980 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYzfx4B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:25:37 INFO - 2015-11-24 18:25:37,833 DEBUG : BROWSER_OUTPUT: RSS: Main: 139116544 18:25:37 INFO - 2015-11-24 18:25:37,833 DEBUG : BROWSER_OUTPUT: 18:26:28 INFO - 2015-11-24 18:26:28,864 DEBUG : BROWSER_OUTPUT: 1448418388863 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] 18:28:40 INFO - 2015-11-24 18:28:40,678 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51815/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51815/tests/dromaeo/cssquery-ext.html) 18:28:41 INFO - 2015-11-24 18:28:41,810 DEBUG : BROWSER_OUTPUT: RSS: Main: 240627712 18:28:41 INFO - 2015-11-24 18:28:41,810 DEBUG : BROWSER_OUTPUT: 18:31:44 INFO - 2015-11-24 18:31:44,335 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51815/tests/dromaeo/cssquery-ext.html (next: http://localhost:51815/tests/dromaeo/cssquery-jquery.html) 18:31:44 INFO - 2015-11-24 18:31:44,905 DEBUG : BROWSER_OUTPUT: RSS: Main: 212508672 18:31:44 INFO - 2015-11-24 18:31:44,905 DEBUG : BROWSER_OUTPUT: 18:34:47 INFO - 2015-11-24 18:34:47,003 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51815/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51815/tests/dromaeo/cssquery-mootools.html) 18:34:47 INFO - 2015-11-24 18:34:47,570 DEBUG : BROWSER_OUTPUT: RSS: Main: 216817664 18:34:47 INFO - 2015-11-24 18:34:47,570 DEBUG : BROWSER_OUTPUT: 18:37:49 INFO - 2015-11-24 18:37:49,559 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51815/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51815/tests/dromaeo/cssquery-prototype.html) 18:37:50 INFO - 2015-11-24 18:37:50,141 DEBUG : BROWSER_OUTPUT: RSS: Main: 201666560 18:37:50 INFO - 2015-11-24 18:37:50,141 DEBUG : BROWSER_OUTPUT: 18:40:52 INFO - 2015-11-24 18:40:52,927 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51815/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51815/tests/dromaeo/cssquery-yui.html) 18:40:53 INFO - 2015-11-24 18:40:53,521 DEBUG : BROWSER_OUTPUT: RSS: Main: 204763136 18:40:53 INFO - 2015-11-24 18:40:53,521 DEBUG : BROWSER_OUTPUT: 18:43:56 INFO - 2015-11-24 18:43:56,075 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51815/tests/dromaeo/cssquery-yui.html (next: http://localhost:51815/tests/dromaeo/cssquery-dojo.html) 18:43:56 INFO - 2015-11-24 18:43:56,325 DEBUG : BROWSER_OUTPUT: RSS: Main: 246681600 18:43:56 INFO - 2015-11-24 18:43:56,325 DEBUG : BROWSER_OUTPUT: 18:43:56 INFO - 2015-11-24 18:43:56,325 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:43:56 INFO - 2015-11-24 18:43:56,326 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:43:56 INFO - 2015-11-24 18:43:56,326 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:43:56 INFO - 2015-11-24 18:43:56,326 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:43:56 INFO - 2015-11-24 18:43:56,326 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2591.5594348960676;2648.3379155211196;2649.0993062358816;2661.866906654667;2672.19834049785;4484.618807401366;4598.931016034758;4615.815367385309;4634.6292296616275;4636.582707556319;4512.842050528232;4559;4564.771761411933;4597.494275629678;4704.623630109591;4212.431321771567;4245.214635292466;4265.914681706364;4272.9359059614135;4291.678124140686;4261.105167914741;4325.718828276168;4334.154839806239;4334.501532323776;4364.061726728753;4087.9386809198036;4157.376393540962;4187.267228235077;4188.099558594886;4242.681798865066;4244;4262.957370426318;4273.615374616299;4275.123599662062;4290.76400797956;4203.432536607549;4210.305299625558;4215.957840421587;4217.7891105444605;4239.491261048663;4299.1831552005015;4421.513633500313;4428.2471979763195;4502.729836209838;4511.345854851061;4760.785764640599;4828.275758636198;4829.830955916526;4831.565159135695;4875.463698993108;4916.1888288432365;4942.406911170647;4976.800927962877;4987.526185012454;4993.650444468889;4442.955570444319;4550.0217453247715;4611.26219804833;4632.305154226826;4683.039976804746;4913.631477639191;4970.030843985388;4981.427135879348;4984.800607975641;5041.017001684636;4812.109759694467;4840.903181936342;4846.006568653417;4857.368542089505;4907.533784290486;4680.81276748933;4779.378680771547;4941.283513890466;4952.950470495249;4964.776585053682;4724.385829842167;4762;4844.176489996638;4863.3434486344595;4898.510148985073;4759.9524004759505;4770.689905156154;4773.188557945088;4776.259679749644;4821.132196204717;3833.3483307837732;3919.8236079376497;4014.036631208489;4019;4053.61490658387;3515.2793677296095;3549.4143466328283;3560.3769340365334;3584.301061293023;3587.7847329160336;4224.4508213931995;4313.374560688682;4314.352847072964;4316.892077698019;4361.280388735887;4709.788059537261;4797.040591881638;4957.975210123926;5011.473795251519;5058.974705126524;4174.290370636938;4219.662427005894;4224.324108142682;4233.80947857341;4275.978620106879;4326.307790753464;4340.435743353344;4341.15347507233;4355.477342718894;4373.387725718402;4492.550744925481;4603.148417542765;4658.114958158007;4659.65052621048;4704.694194877322;4771.856844294677;4807.903841923072;4854.927176092432;4869.099216644932;4911.312416261655;4645.140648979815;4646.512116227747;4650;4671.602913752233;4705.082508910729;4693.413323334583;4828.106800241966;4837.612990960785;4849.369581954324;4874.317595536699;4809.951900480951;4837.346958160603;4850.078485087822;4882.975585122052;4919.901601968012;4791.592714619157;4819.566239038503;4820.325154478306;4821.228603423436;4864.197407427735;4572.748498832596;4806.951930480651;4823.831165909176;4827.734474603931;4869.147899117569;4624.930626040545;4641;4655.487896331469;4742.2175341069715;4751.334813126096;4817.7350245736825;4833.419989601271;4833.927491087707;4834.081524510332;4878.80484780619;4542.591166795004;4736.668433209642;4744.1460537102275;4745.074710431571;4761.357216775691 18:43:56 INFO - 2015-11-24 18:43:56,326 DEBUG : BROWSER_OUTPUT: |1;ext.html;549.8213080748758;553.1989850084027;579.6377264209868;584.004272715021;586.4077281945235;27215;36290.45564316534;37025.62974370256;37070.629293707054;37082.40423170376;39739.403908941385;40367.39448908269;40373.59626403735;40378.798106009504;40426.55307916127;6910.5853648780985;7020.438364930793;7953.483023603476;8128.796780080486;9692.66075687351;10067.798644027114;10192.082712555868;10211.744706382326;10214.795704085915;10217.948910255476;10123.493825308742;10276.537555810006;10280.588776448933;10284.434356110449;10287.948560257188;7052.471064670171;7245.7826265212125;7250.456215783837;10127.240456965757;10505.4222017789;9893.258005649604;10065.949670251675;10067.647632332906;10073.194144468425;10075.798484030352;37267.62732372669;37644;37667.24665506702;37743.62256377456;37752.62247377518;2756.503829310723;2781.443711257736;2928.7071292870755;2953.158349870298;3428.5200071989943;27714.445711085664;27905.441891162063;27952.720472795216;28018.439631207464;28043;3395.9490607640905;3493.4410494320787;3494.336076145524;3550.130218096557;3620.746547741659;222060;224446;224706.99999999837;225220.99999999837;225743;51757.7412112937;56596.43403565994;56914;56927.14609280864;57026.144607830916;47291.5270847294;64624.35375646183;66070;66411.66794165998;66456;13643.181409115485;13856.445742170403;13863.376148073361;13871.930640346936;13882.167069975834;10158.339707919109;10228.744281393025;10229.181665466745;10229.948850255701;10240.948795255976;19248.742091366625;19553.511162220773;19598.314059007866;19626.705599416022;19649.31227407034;7520.360769334558;7917.683292668229;7919.673737030461;7928.722494712657;7962.920370796218;842.7219017724136;884.5930871798915;899.2131884600974;912.5072460871055;995.049727510226;26683.93782383403;26735.19794406171;27033.189004329903;27172.32069198286;27227.45545089087;922.9017469211617;923.6582464488182;968.7917097824002;971.9076687714655;1044.12815299226;13716.245606491539;13754.724905501835;13798.862011379959;13873.306334683226;13944.233067181402;561932;577436;577682;579129;579696;42535.361969570484;50024.74987625112;50551;50557.98884022373;50662.240066399034;1048.764028093688;1159.6289187459931;1166.2128063557234;1177.952881884732;1180.9291442513477;27274.727252727218;28717.85641071865;28907.132786016453;29274.56088158722;29371.853140734158;31835.522467162547;32642.673573263964;38381;39255.41116883192;39276.2144757109;172303;172968;173346;173982;174283;36060.45909311415;36544;36650.63349366579;36654.8167259162;36711.26577468382;42001.78999104985;42113.789431052646;42586.57413425826;42800;42808.78595607002;35375.29249415049;35917.82041089778;36582.8170859144;36819.44770828493;38007;35424.645753542136;35613.82193089018;36043.81978090093;36623;36642.45036324404;35446.822765886005;35968;36312.4553131698;36400;36464.453033205056;31088;32678.83660581777;33033.66966330402;33047.834760826045;33094.66905330916;25331;25671.486570268116;25699.229023129337;25713.87143064273;26092 18:43:56 INFO - 2015-11-24 18:43:56,326 DEBUG : BROWSER_OUTPUT: |2;jquery.html;328.2139276432945;333.614675050317;338.9457686770116;339.8834827591362;345.08208166277706;12268.693282667939;12532.749345013095;15064.924675376622;15112.697746045087;16863.49409517715;14337.569872903803;14764.335604897778;15226.467073652424;15788.921055394707;15797.447089351876;3799.563050249229;4943.406791185045;5007.474215207405;5070.492950704918;5072.26452164436;3635.909102272438;3753.8498460061564;5599.860003499904;5743.282089738783;5760.222369980041;5570.832875013736;5664.433556644344;5670.06443936752;5690.971545142268;5696.316442026962;5586.525145362649;5754.050581654043;5760.9711951440395;5766.50984666306;5781.710914454303;4965.106280869442;5081.237814327844;5091.66904151229;5094.235864620299;5096.184610462308;19364.612707745768;19406.70889936652;19649.919254441;19686.70469942952;19983.900080499505;1799.9280028798833;1800.6225237693175;1804.2422182683304;1840.7699037620298;1980.584077343745;8629.352798540134;8974.955125224333;12517.248965062125;12794.360281985957;13302.866971330259;1726.9740953885703;1729.1440736835348;1783.0638914569954;1783.8751287409887;1802.180008096313;54393;56048;56768;57401.425985740025;57563.424365756226;9892.307538472238;9893.307468477282;9960.750981225527;9967.352122112039;9967.40195588267;12585.622431327074;12595.433205505591;12600.684982875318;12601.18092323996;12603.49586016549;6938.548994315353;6986.580805151707;7024.929750702428;7032.824179395556;7069.681864316118;6549.574277671936;6552;6581.901271480931;6595.175603049619;6620.768273110418;4153.06556024892;4187.476565429321;4203.810828512663;4207.474065741782;4237.5762423758;1586.095925322578;1630.9755353669705;1646.4237516869;1649.381481944271;1658.6765580711888;565.8585353661584;828.4076885027114;863.9179277968583;898.7708134425679;908.6456282050005;11894.048476121889;14810.62973425673;15616.3753449863;16175.352985880432;16400;813.3615112137062;865.6796985115421;931.1433481197315;932.4545141092536;934.3646320501988;8885.777855553662;9015.098490151064;9230.261579073658;9291.349605527548;9425.717228483156;470958;472499;479273;480294;488425;64640.353596464374;73985.63007185038;76871.61564192144;77660.61169694115;78481.2151878474;1051.7002654243504;1068.273573969708;1073.4203530093662;1082.4912291223113;1082.7509672775147;13515.59453216405;14283.64290892736;14446.855531444551;14497.78253326222;14503.347349369515;28137.859310703316;28363;28958.42083158283;29288.41423171482;29869.5519567211;40842.79578602088;41761.79119104385;42742;42927;45822.31266530938;8949.686760963335;9209.355345125778;9222.123898229658;9243.445393276425;9271.582778775106;10657.946710266398;11608.419579021183;16145.67708645797;16158.67682646364;16590.50228493147;13477.326133693472;13888.375023123781;14133.717325653224;14218.289085545888;14296.642583935485;12611.87388126107;13081.149725267827;13470.259135747629;13649.522266720616;13754.93122534381;10914.945425273141;10968.725781855517;10997.670069897917;13262.53581124656;13298.335083245993;8859.734207973772;9015.504147271962;9354.53227338644;9391.624335026523;9438.433693978108;9750.80498390014;9854.063863932915;12020.278783273032;14055.367508461939;14510.709785804436 18:43:56 INFO - 2015-11-24 18:43:56,327 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1397.0290647999632;1585.389624994377;1644.4244514419954;1655.5364497940577;1665.9754251135555;5870.61840980336;6817.863642727142;6971.302869713026;6975;6979.581225126496;6861;7024.2273349931465;7047.0838790957105;7065.89401158983;7086.255943125975;1758.9824101759011;1785.232350089461;2021.6866385710202;2034.8372130229545;2055.0546748495635;2061.505238742706;2061.9587608247825;2070.4616799632054;2072;2072.1607748861734;2034.1354924157247;2035.3995571306425;2101.8528702990798;2102.9158833646634;2108.9894550527224;2029.9797002030086;2049.1086377425795;2067.1627990663806;2084.7289852319177;2086.2698055680617;2064.556120434099;2091.654876945302;2092.654711972523;2093.11042806808;2094.183268525276;6812.4550035997;6865.656717164122;6878.140232470942;6880.380765731058;6881.243063263037;4123.649489793371;4173.895652608679;4178.91642167155;4224.324108142682;4228.957710422918;2279.9544009119727;2690.6905705843883;2793.0782841662203;2815.662120545527;2835.8723857426257;780.1808101493409;797.8843067755143;819.3117781063876;856.884320616715;888.0497867282011;9180.678676246365;9201.631934722604;9216.354855160142;9230.169284764337;9245.491497967541;3883.9901625577554;3912.7456715313415;3970.82131304092;4013.0569316210667;4019.41718450823;8082.434229603989;8133.308668763103;8141.837163256701;8147.185281471924;8155.918440815634;4191.97904010478;4197.097624010852;4211.589117645623;4212.368144778307;4222.113356195234;3854.4411060396087;3871.1483473635753;3878.941815872764;3881.146147847469;3881.301365754135;2848.6154369160313;2967.718066783652;3372.79763214203;3406.6423025582453;3469.9132521686656;1084.322298563398;1103.7130346110068;1108.1688733449912;1118.4687273545;1120.78705046041;782.7886470652892;802.3941923847458;1026.5021464589668;1027.275770581738;1027.2809033676308;6080.391960803884;6117.357677443804;6352.14246076783;6352.65060421672;6370;933.4539294512786;945.1824172091092;1035.254616675992;1042.6924057403085;1046.1944302886734;4890.975545122252;5010.949890501049;5014.5737612303365;5015.924761128586;5085.0084233574835;8137.226963438464;8212.63043163059;8288.502689838508;8304.875426868603;8312.41813073079;8055;8177.1414001530175;8209.179082091743;8287.337013038943;8314.875276870851;6479.092926990225;6548.6725663716625;6555.410013098844;6567.44176744982;6568.86862262752;5965.522758179422;5980.551458640706;5986.431289027535;6005.789797357072;6184.752609895734;7200.171980222132;7326.157491888501;7340.2292759261645;7401.1488678802625;7493.70025198986;7600.733974310872;7644;7683.692652293846;7684.769456916301;7690.615469226628;5917.881642367042;6052.66710330936;6068.757249710139;6088.786892458743;6114;5468.097763868917;5589.524890384363;5598.300212473441;5600.915986260128;6485.416312531706;5511.448855114457;5968.970155149196;6112.083187521729;6194.659293738888;6219.129321894848;6028.457438830526;6053.061775424816;6103.206583144163;6117.694115294128;6174.38256174379;6175.752969881154;6203.069539569101;6242.250929888442;6261.060840873905;6269.467095296951;5772.826815195383;5799.565032622654;5804.361520232856;5808.6224395414165;5815.82552523425;5735.13972904051;5757.280339957505;5758.740856661377;5760.366359700346;5773.74018169175 18:43:56 INFO - 2015-11-24 18:43:56,329 DEBUG : BROWSER_OUTPUT: |4;prototype.html;299.55815172620385;305.73401141007326;311.20021544630293;311.2716243989068;312.2396963394136;5157.690538567688;5272.789088436462;5311.1502159654465;5339.305890234265;5406.270153529277;5158.613104017195;5289.153735402337;5305.442928492511;5308.973455132719;5312.1766126250395;3986.54154772202;4206.47419072616;4209.873703788876;4210.410542524034;4211.073563815963;4058.553559108496;4059.918801623966;4062.2890994076065;4063.674906007512;4090.1819636072755;4136.772477513736;4175.686823488235;4177.289860723684;4179.498460184782;4192.287311157111;4167.895802604929;4175.206710724968;4175.561566035583;4177.4778152730905;4186.0581369192;3704.6665800077853;3707.6292370762976;3709.091272638194;3710.9443358349645;3714.1271801126713;4949.158643030657;5104.668196567211;5109.20807274873;5111.693298402108;5116.565091967187;4714.010057887814;4724.480307166244;4726.243800991859;4732.337472753818;4738.19450693383;5312.442193569696;5544.86137846553;5548.91676624851;5555.944440555623;5557.3886872444;3817.503724515823;3902.570717221103;3997.360422332413;3998.900027499307;4002.3396139636925;5771.971140144315;5848.853778655525;5869.295684517842;5876.706164691748;5879.470847623735;4113.1568028554075;4122.525909520384;4123.463949686521;4127.071408932966;4128.876133715993;4114.177164567039;4169.770662613525;4175.749455032707;4201.285781417167;4202.495700515897;4699.577038066591;4730.716157030589;4738.1708201064675;4740.715557066587;4750;5568.303962004749;5570.108782594765;5581.6930068845795;5582.888342233214;5585.218069470277;1465.4944044304698;1481.5555333400152;1481.9110853348834;1482.7331080405415;1483.6735918098002;1012.3217444312328;1020.0666390252984;1020.3061917895902;1027.547878933282;1049.1030169205371;4894.143524883131;4904.117258893362;4915.729634870045;4921.483244259372;4922.704637721748;5791.189233507313;5792.681402522818;5799.5070419014855;5804.6807425592;5810.389909059572;4911.066897289504;4912.312276281324;4912.38595175603;4916.06594746997;4921.606271498272;3045.6040714706946;3110.486769682977;3128.702773236539;3144.3554071415306;3147.1502694272876;5490.313710786152;5538.6399884007415;5541.0580201365865;5544.972275138679;5549.361823390281;5992.910106348409;6006.909896351558;6010.849728756816;6015.729292181863;6022.759089636453;5460.945390546044;5520.972395138159;5538.75075621598;5540.556755459554;5541.501264886179;5682.687452190169;5838.416158384128;5839.8832023358445;5848.181254624271;5849.151872978309;5458.5087342139395;5597.160425936142;5600.915986260291;5605.383407825218;5614;5338.626296159232;5420.945790542044;5516.9448305518035;5518.751656175562;5543.944560554342;3969.345058065502;3995.48058752372;4002.9199416010933;4006.759594424344;4013.4983127109113;5674.517665998436;5814.622049566765;5823.621464604787;5823.679697616672;5835.533157347487;5605.775768969195;5617.634853734494;5619.80330688424;5621.10062390032;5627.52166065889;5620.100783874561;5625.409332020079;5626.915596265977;5629.46673996695;5634.549236061023;5463.535599474089;5503.669779813224;5507.201455788968;5507.834764957058;5513.531349835149;5495.368032676133;5667.263255776723;5669.489745922887;5670.631408958405;5674.4892959633835;5482.972585137049;5528.336599608073;5529.861753456195;5530.446955304598;5532.723363831873 18:43:56 INFO - 2015-11-24 18:43:56,330 DEBUG : BROWSER_OUTPUT: |5;yui.html;720.7225218290956;720.8522252938149;730.3828265115975;763.7097902796936;765.4259305520859;11451.885481145186;11564.306141631487;11578.189526733133;11583.826242606368;11696.941515292423;10541.78916421671;11382.772344553105;11488.483018264178;11501.942490287558;11540;575.2981362737464;755.2485277149244;757.8446418484198;761.0106861080601;762.828363618187;757.8522188173308;772.953622782632;775.5966897213445;775.7052320118347;775.728495026739;778.5056489129387;786.5909726941986;788.7988562916448;792.6789650191653;793.9761807145766;773.4122067228918;780.4029917113413;783.1502819440885;783.5494590610365;783.5690370296314;578.1760990588394;580.118220305138;584.1296468262301;585.5169485174705;585.5432762445299;10153.238507111922;10262.486875656188;10267.79464410715;10303.587856485732;10315.381077135396;9501;9533.237341012702;9945.602175912954;10221.437820919846;10330.380177189392;8814.603342849587;8928.642854285821;9165.816683666357;9390.295727820441;9579.233661307078;3181.793183443092;3196.856141473639;3220.1949512621845;3220.8872689455993;3360.1263671445354;34021.31957360839;34659.82670086633;34737.82631086828;35867;41855.581444185475;9032.187103160748;9039.502827344559;9070.773230669287;9174.17432431071;9176.44941303524;15920.283587238602;15953.282102305191;16141;16157.919210403872;16183.757243641356;6341.207349081365;6360.395762402564;6430.485561155097;6443.548951573439;6531.542792004514;3584.4981702561663;3602.405603075463;3621.855125794991;3631.255592603563;3638.799866007395;2709.282040259333;2725.250556097089;2740.2327348342496;2748.1343376836235;2750.614913912054;493.0607193296775;493.3339991012105;501.603733050893;502.87428142964256;505.5702652745211;410.64282546185143;423.3755211063718;427.73547729141035;434.32245696713227;464.16682055710083;7380.741674041383;7521.849563008709;7581.886271705929;7591.658375373121;7606.657700403495;514.8995945790535;544.4011587253989;549.7416214379235;553.9113741801292;555.1450765820591;3506.1059429845227;3582.0328511302323;3876.7286289959998;3936.193080418507;3981.5421226558738;47011.764941175075;47397;48087.519124809005;48227;48739.26891096636;44748.3287750684;45253;45350.546494535294;45440.3183952241;45450.545494545295;34325.313493729984;39516.407253891215;40074.198516029515;42675.35986960198;43196;7827.608619569112;7893.644785984759;8049.597520124087;8118.431709780259;8186.8771968421715;31815.840920795246;32159.432159431788;32170.19574510656;32264.35471290608;32306.546205421284;34798.82600586981;34925.65074349326;41808.79095604503;44529.10941781211;44883.55116448794;9208.447493150432;9227.21568666644;9314.115159059878;9416.952915235654;9784.952618355172;10777.360450713368;10854.511546980248;11074.335539867634;11126.61056863006;11249;9500.994440063188;9610.759731006781;9613.90846649981;9697.127258546765;10264.486775661337;10314.638987635397;10503.579856805642;10545.10366618846;10625.734356641145;10895;9850.261230407892;9959.601615935282;9977.151942084714;10002.8499572505;10067.546960386946;8949.284057275532;9231.907680923105;9246.398984066014;9298.535073246176;9327.813443731224;8482.57587120629;8609.268212202032;8905.263473622581;8920.509371984603;8966.730998070068 18:43:56 INFO - 2015-11-24 18:43:56,330 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:43:56 INFO - 2015-11-24 18:43:56,330 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:43:56 INFO - 2015-11-24 18:43:56,330 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,900 18:43:56 INFO - 2015-11-24 18:43:56,330 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:43:56 INFO - 2015-11-24 18:43:56,330 DEBUG : BROWSER_OUTPUT: __startTimestamp1448419436323__endTimestamp 18:43:56 INFO - 2015-11-24 18:43:56,330 DEBUG : BROWSER_OUTPUT: 18:43:56 INFO - 2015-11-24 18:43:56,331 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:43:56 INFO - 2015-11-24 18:43:56,331 DEBUG : BROWSER_OUTPUT: Number of tests: 6 18:43:56 INFO - 2015-11-24 18:43:56,331 DEBUG : BROWSER_OUTPUT: 18:43:56 INFO - 2015-11-24 18:43:56,331 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4518.74 Median:4655.49 stddev:465.90 (10.0%) stddev-sans-first:442.12 18:43:56 INFO - 2015-11-24 18:43:56,331 DEBUG : BROWSER_OUTPUT: Values: 2591.6 2648.3 2649.1 2661.9 2672.2 4484.6 4598.9 4615.8 4634.6 4636.6 4512.8 4559.0 4564.8 4597.5 4704.6 4212.4 4245.2 4265.9 4272.9 4291.7 4261.1 4325.7 4334.2 4334.5 4364.1 4087.9 4157.4 4187.3 4188.1 4242.7 4244.0 4263.0 4273.6 4275.1 4290.8 4203.4 4210.3 4216.0 4217.8 4239.5 4299.2 4421.5 4428.2 4502.7 4511.3 4760.8 4828.3 4829.8 4831.6 4875.5 4916.2 4942.4 4976.8 4987.5 4993.7 4443.0 4550.0 4611.3 4632.3 4683.0 4913.6 4970.0 4981.4 4984.8 5041.0 4812.1 4840.9 4846.0 4857.4 4907.5 4680.8 4779.4 4941.3 4953.0 4964.8 4724.4 4762.0 4844.2 4863.3 4898.5 4760.0 4770.7 4773.2 4776.3 4821.1 3833.3 3919.8 4014.0 4019.0 4053.6 3515.3 3549.4 3560.4 3584.3 3587.8 4224.5 4313.4 4314.4 4316.9 4361.3 4709.8 4797.0 4958.0 5011.5 5059.0 4174.3 4219.7 4224.3 4233.8 4276.0 4326.3 4340.4 4341.2 4355.5 4373.4 4492.6 4603.1 4658.1 4659.7 4704.7 4771.9 4807.9 4854.9 4869.1 4911.3 4645.1 4646.5 4650.0 4671.6 4705.1 4693.4 4828.1 4837.6 4849.4 4874.3 4810.0 4837.3 4850.1 4883.0 4919.9 4791.6 4819.6 4820.3 4821.2 4864.2 4572.7 4807.0 4823.8 4827.7 4869.1 4624.9 4641.0 4655.5 4742.2 4751.3 4817.7 4833.4 4833.9 4834.1 4878.8 4542.6 4736.7 4744.1 4745.1 4761.4 18:43:56 INFO - 2015-11-24 18:43:56,331 DEBUG : BROWSER_OUTPUT: 18:43:56 INFO - 2015-11-24 18:43:56,331 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:48353.48 Median:19498.48 stddev:99539.38 (510.5%) stddev-sans-first:99753.90 18:43:56 INFO - 2015-11-24 18:43:56,332 DEBUG : BROWSER_OUTPUT: Values: 549.8 553.2 579.6 584.0 586.4 27215.0 36290.5 37025.6 37070.6 37082.4 39739.4 40367.4 40373.6 40378.8 40426.6 6910.6 7020.4 7953.5 8128.8 9692.7 10067.8 10192.1 10211.7 10214.8 10217.9 10123.5 10276.5 10280.6 10284.4 10287.9 7052.5 7245.8 7250.5 10127.2 10505.4 9893.3 10065.9 10067.6 10073.2 10075.8 37267.6 37644.0 37667.2 37743.6 37752.6 2756.5 2781.4 2928.7 2953.2 3428.5 27714.4 27905.4 27952.7 28018.4 28043.0 3395.9 3493.4 3494.3 3550.1 3620.7 222060.0 224446.0 224707.0 225221.0 225743.0 51757.7 56596.4 56914.0 56927.1 57026.1 47291.5 64624.4 66070.0 66411.7 66456.0 13643.2 13856.4 13863.4 13871.9 13882.2 10158.3 10228.7 10229.2 10229.9 10240.9 19248.7 19553.5 19598.3 19626.7 19649.3 7520.4 7917.7 7919.7 7928.7 7962.9 842.7 884.6 899.2 912.5 995.0 26683.9 26735.2 27033.2 27172.3 27227.5 922.9 923.7 968.8 971.9 1044.1 13716.2 13754.7 13798.9 13873.3 13944.2 561932.0 577436.0 577682.0 579129.0 579696.0 42535.4 50024.7 50551.0 50558.0 50662.2 1048.8 1159.6 1166.2 1178.0 1180.9 27274.7 28717.9 28907.1 29274.6 29371.9 31835.5 32642.7 38381.0 39255.4 39276.2 172303.0 172968.0 173346.0 173982.0 174283.0 36060.5 36544.0 36650.6 36654.8 36711.3 42001.8 42113.8 42586.6 42800.0 42808.8 35375.3 35917.8 36582.8 36819.4 38007.0 35424.6 35613.8 36043.8 36623.0 36642.5 35446.8 35968.0 36312.5 36400.0 36464.5 31088.0 32678.8 33033.7 33047.8 33094.7 25331.0 25671.5 25699.2 25713.9 26092.0 18:43:56 INFO - 2015-11-24 18:43:56,333 DEBUG : BROWSER_OUTPUT: 18:43:56 INFO - 2015-11-24 18:43:56,333 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26063.58 Median:22957.43 stddev:78175.13 (340.5%) stddev-sans-first:78370.54 18:43:56 INFO - 2015-11-24 18:43:56,333 DEBUG : BROWSER_OUTPUT: Values: 328.2 333.6 338.9 339.9 345.1 12268.7 12532.7 15064.9 15112.7 16863.5 14337.6 14764.3 15226.5 15788.9 15797.4 3799.6 4943.4 5007.5 5070.5 5072.3 3635.9 3753.8 5599.9 5743.3 5760.2 5570.8 5664.4 5670.1 5691.0 5696.3 5586.5 5754.1 5761.0 5766.5 5781.7 4965.1 5081.2 5091.7 5094.2 5096.2 19364.6 19406.7 19649.9 19686.7 19983.9 1799.9 1800.6 1804.2 1840.8 1980.6 8629.4 8975.0 12517.2 12794.4 13302.9 1727.0 1729.1 1783.1 1783.9 1802.2 54393.0 56048.0 56768.0 57401.4 57563.4 9892.3 9893.3 9960.8 9967.4 9967.4 12585.6 12595.4 12600.7 12601.2 12603.5 6938.5 6986.6 7024.9 7032.8 7069.7 6549.6 6552.0 6581.9 6595.2 6620.8 4153.1 4187.5 4203.8 4207.5 4237.6 1586.1 1631.0 1646.4 1649.4 1658.7 565.9 828.4 863.9 898.8 908.6 11894.0 14810.6 15616.4 16175.4 16400.0 813.4 865.7 931.1 932.5 934.4 8885.8 9015.1 9230.3 9291.3 9425.7 470958.0 472499.0 479273.0 480294.0 488425.0 64640.4 73985.6 76871.6 77660.6 78481.2 1051.7 1068.3 1073.4 1082.5 1082.8 13515.6 14283.6 14446.9 14497.8 14503.3 28137.9 28363.0 28958.4 29288.4 29869.6 40842.8 41761.8 42742.0 42927.0 45822.3 8949.7 9209.4 9222.1 9243.4 9271.6 10657.9 11608.4 16145.7 16158.7 16590.5 13477.3 13888.4 14133.7 14218.3 14296.6 12611.9 13081.1 13470.3 13649.5 13754.9 10914.9 10968.7 10997.7 13262.5 13298.3 8859.7 9015.5 9354.5 9391.6 9438.4 9750.8 9854.1 12020.3 14055.4 14510.7 18:43:56 INFO - 2015-11-24 18:43:56,333 DEBUG : BROWSER_OUTPUT: 18:43:56 INFO - 2015-11-24 18:43:56,333 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4798.29 Median:5843.22 stddev:2450.10 (41.9%) stddev-sans-first:2443.64 18:43:56 INFO - 2015-11-24 18:43:56,333 DEBUG : BROWSER_OUTPUT: Values: 1397.0 1585.4 1644.4 1655.5 1666.0 5870.6 6817.9 6971.3 6975.0 6979.6 6861.0 7024.2 7047.1 7065.9 7086.3 1759.0 1785.2 2021.7 2034.8 2055.1 2061.5 2062.0 2070.5 2072.0 2072.2 2034.1 2035.4 2101.9 2102.9 2109.0 2030.0 2049.1 2067.2 2084.7 2086.3 2064.6 2091.7 2092.7 2093.1 2094.2 6812.5 6865.7 6878.1 6880.4 6881.2 4123.6 4173.9 4178.9 4224.3 4229.0 2280.0 2690.7 2793.1 2815.7 2835.9 780.2 797.9 819.3 856.9 888.0 9180.7 9201.6 9216.4 9230.2 9245.5 3884.0 3912.7 3970.8 4013.1 4019.4 8082.4 8133.3 8141.8 8147.2 8155.9 4192.0 4197.1 4211.6 4212.4 4222.1 3854.4 3871.1 3878.9 3881.1 3881.3 2848.6 2967.7 3372.8 3406.6 3469.9 1084.3 1103.7 1108.2 1118.5 1120.8 782.8 802.4 1026.5 1027.3 1027.3 6080.4 6117.4 6352.1 6352.7 6370.0 933.5 945.2 1035.3 1042.7 1046.2 4891.0 5010.9 5014.6 5015.9 5085.0 8137.2 8212.6 8288.5 8304.9 8312.4 8055.0 8177.1 8209.2 8287.3 8314.9 6479.1 6548.7 6555.4 6567.4 6568.9 5965.5 5980.6 5986.4 6005.8 6184.8 7200.2 7326.2 7340.2 7401.1 7493.7 7600.7 7644.0 7683.7 7684.8 7690.6 5917.9 6052.7 6068.8 6088.8 6114.0 5468.1 5589.5 5598.3 5600.9 6485.4 5511.4 5969.0 6112.1 6194.7 6219.1 6028.5 6053.1 6103.2 6117.7 6174.4 6175.8 6203.1 6242.3 6261.1 6269.5 5772.8 5799.6 5804.4 5808.6 5815.8 5735.1 5757.3 5758.7 5760.4 5773.7 18:43:56 INFO - 2015-11-24 18:43:56,333 DEBUG : BROWSER_OUTPUT: 18:43:56 INFO - 2015-11-24 18:43:56,333 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4659.30 Median:5158.15 stddev:1349.65 (26.2%) stddev-sans-first:1313.17 18:43:56 INFO - 2015-11-24 18:43:56,334 DEBUG : BROWSER_OUTPUT: Values: 299.6 305.7 311.2 311.3 312.2 5157.7 5272.8 5311.2 5339.3 5406.3 5158.6 5289.2 5305.4 5309.0 5312.2 3986.5 4206.5 4209.9 4210.4 4211.1 4058.6 4059.9 4062.3 4063.7 4090.2 4136.8 4175.7 4177.3 4179.5 4192.3 4167.9 4175.2 4175.6 4177.5 4186.1 3704.7 3707.6 3709.1 3710.9 3714.1 4949.2 5104.7 5109.2 5111.7 5116.6 4714.0 4724.5 4726.2 4732.3 4738.2 5312.4 5544.9 5548.9 5555.9 5557.4 3817.5 3902.6 3997.4 3998.9 4002.3 5772.0 5848.9 5869.3 5876.7 5879.5 4113.2 4122.5 4123.5 4127.1 4128.9 4114.2 4169.8 4175.7 4201.3 4202.5 4699.6 4730.7 4738.2 4740.7 4750.0 5568.3 5570.1 5581.7 5582.9 5585.2 1465.5 1481.6 1481.9 1482.7 1483.7 1012.3 1020.1 1020.3 1027.5 1049.1 4894.1 4904.1 4915.7 4921.5 4922.7 5791.2 5792.7 5799.5 5804.7 5810.4 4911.1 4912.3 4912.4 4916.1 4921.6 3045.6 3110.5 3128.7 3144.4 3147.2 5490.3 5538.6 5541.1 5545.0 5549.4 5992.9 6006.9 6010.8 6015.7 6022.8 5460.9 5521.0 5538.8 5540.6 5541.5 5682.7 5838.4 5839.9 5848.2 5849.2 5458.5 5597.2 5600.9 5605.4 5614.0 5338.6 5420.9 5516.9 5518.8 5543.9 3969.3 3995.5 4002.9 4006.8 4013.5 5674.5 5814.6 5823.6 5823.7 5835.5 5605.8 5617.6 5619.8 5621.1 5627.5 5620.1 5625.4 5626.9 5629.5 5634.5 5463.5 5503.7 5507.2 5507.8 5513.5 5495.4 5667.3 5669.5 5670.6 5674.5 5483.0 5528.3 5529.9 5530.4 5532.7 18:43:56 INFO - 2015-11-24 18:43:56,334 DEBUG : BROWSER_OUTPUT: 18:43:56 INFO - 2015-11-24 18:43:56,335 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11914.30 Median:493.20 stddev:13585.03 (2754.5%) stddev-sans-first:13597.14 18:43:56 INFO - 2015-11-24 18:43:56,335 DEBUG : BROWSER_OUTPUT: Values: 720.7 720.9 730.4 763.7 765.4 11451.9 11564.3 11578.2 11583.8 11696.9 10541.8 11382.8 11488.5 11501.9 11540.0 575.3 755.2 757.8 761.0 762.8 757.9 773.0 775.6 775.7 775.7 778.5 786.6 788.8 792.7 794.0 773.4 780.4 783.2 783.5 783.6 578.2 580.1 584.1 585.5 585.5 10153.2 10262.5 10267.8 10303.6 10315.4 9501.0 9533.2 9945.6 10221.4 10330.4 8814.6 8928.6 9165.8 9390.3 9579.2 3181.8 3196.9 3220.2 3220.9 3360.1 34021.3 34659.8 34737.8 35867.0 41855.6 9032.2 9039.5 9070.8 9174.2 9176.4 15920.3 15953.3 16141.0 16157.9 16183.8 6341.2 6360.4 6430.5 6443.5 6531.5 3584.5 3602.4 3621.9 3631.3 3638.8 2709.3 2725.3 2740.2 2748.1 2750.6 493.1 493.3 501.6 502.9 505.6 410.6 423.4 427.7 434.3 464.2 7380.7 7521.8 7581.9 7591.7 7606.7 514.9 544.4 549.7 553.9 555.1 3506.1 3582.0 3876.7 3936.2 3981.5 47011.8 47397.0 48087.5 48227.0 48739.3 44748.3 45253.0 45350.5 45440.3 45450.5 34325.3 39516.4 40074.2 42675.4 43196.0 7827.6 7893.6 8049.6 8118.4 8186.9 31815.8 32159.4 32170.2 32264.4 32306.5 34798.8 34925.7 41808.8 44529.1 44883.6 9208.4 9227.2 9314.1 9417.0 9785.0 10777.4 10854.5 11074.3 11126.6 11249.0 9501.0 9610.8 9613.9 9697.1 10264.5 10314.6 10503.6 10545.1 10625.7 10895.0 9850.3 9959.6 9977.2 10002.8 10067.5 8949.3 9231.9 9246.4 9298.5 9327.8 8482.6 8609.3 8905.3 8920.5 8966.7 18:43:56 INFO - 2015-11-24 18:43:56,335 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:43:56 INFO - 2015-11-24 18:43:56,335 DEBUG : BROWSER_OUTPUT: 18:43:57 INFO - 2015-11-24 18:43:57,065 INFO : Browser exited with error code: 0 18:43:57 INFO - 2015-11-24 18:43:57,081 INFO : Completed test dromaeo_css (00:18:36) 18:43:57 INFO - 2015-11-24 18:43:57,082 INFO : Starting test kraken 18:43:57 INFO - 2015-11-24 18:43:57,082 DEBUG : operating with platform_type : linux_ 18:43:57 INFO - 2015-11-24 18:43:57,082 INFO : Initialising browser for kraken test... 18:43:57 INFO - 2015-11-24 18:43:57,088 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGK5DFt/profile http://localhost:51815/getInfo.html 18:44:00 INFO - 2015-11-24 18:44:00,870 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:44:00 INFO - 2015-11-24 18:44:00,870 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:44:00 INFO - 2015-11-24 18:44:00,870 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:44:00 INFO - 2015-11-24 18:44:00,870 DEBUG : BROWSER_OUTPUT: __metrics 18:44:00 INFO - 2015-11-24 18:44:00,992 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] 18:44:02 INFO - 2015-11-24 18:44:02,108 INFO : Browser initialized. 18:44:02 INFO - 2015-11-24 18:44:02,108 INFO : Running cycle 1/1 for kraken test... 18:44:02 INFO - 2015-11-24 18:44:02,108 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGK5DFt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:44:14 INFO - 2015-11-24 18:44:14,041 DEBUG : BROWSER_OUTPUT: RSS: Main: 139001856 18:44:14 INFO - 2015-11-24 18:44:14,041 DEBUG : BROWSER_OUTPUT: 18:44:16 INFO - 2015-11-24 18:44:16,641 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51815/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51815/tests/kraken/driver.html?testName=audio-beat-detection) 18:44:17 INFO - 2015-11-24 18:44:17,223 DEBUG : BROWSER_OUTPUT: RSS: Main: 177545216 18:44:17 INFO - 2015-11-24 18:44:17,223 DEBUG : BROWSER_OUTPUT: 18:44:19 INFO - 2015-11-24 18:44:19,940 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51815/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51815/tests/kraken/driver.html?testName=audio-dft) 18:44:20 INFO - 2015-11-24 18:44:20,515 DEBUG : BROWSER_OUTPUT: RSS: Main: 167174144 18:44:20 INFO - 2015-11-24 18:44:20,515 DEBUG : BROWSER_OUTPUT: 18:44:23 INFO - 2015-11-24 18:44:23,501 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51815/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51815/tests/kraken/driver.html?testName=audio-fft) 18:44:24 INFO - 2015-11-24 18:44:24,068 DEBUG : BROWSER_OUTPUT: RSS: Main: 151760896 18:44:24 INFO - 2015-11-24 18:44:24,068 DEBUG : BROWSER_OUTPUT: 18:44:26 INFO - 2015-11-24 18:44:26,074 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51815/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51815/tests/kraken/driver.html?testName=audio-oscillator) 18:44:26 INFO - 2015-11-24 18:44:26,641 DEBUG : BROWSER_OUTPUT: RSS: Main: 153047040 18:44:26 INFO - 2015-11-24 18:44:26,641 DEBUG : BROWSER_OUTPUT: 18:44:28 INFO - 2015-11-24 18:44:28,880 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51815/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51815/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:44:29 INFO - 2015-11-24 18:44:29,446 DEBUG : BROWSER_OUTPUT: RSS: Main: 154914816 18:44:29 INFO - 2015-11-24 18:44:29,446 DEBUG : BROWSER_OUTPUT: 18:44:32 INFO - 2015-11-24 18:44:32,445 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51815/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51815/tests/kraken/driver.html?testName=imaging-darkroom) 18:44:33 INFO - 2015-11-24 18:44:33,019 DEBUG : BROWSER_OUTPUT: RSS: Main: 154468352 18:44:33 INFO - 2015-11-24 18:44:33,019 DEBUG : BROWSER_OUTPUT: 18:44:36 INFO - 2015-11-24 18:44:36,446 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51815/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51815/tests/kraken/driver.html?testName=imaging-desaturate) 18:44:37 INFO - 2015-11-24 18:44:37,027 DEBUG : BROWSER_OUTPUT: RSS: Main: 155459584 18:44:37 INFO - 2015-11-24 18:44:37,027 DEBUG : BROWSER_OUTPUT: 18:44:39 INFO - 2015-11-24 18:44:39,877 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51815/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51815/tests/kraken/driver.html?testName=json-parse-financial) 18:44:40 INFO - 2015-11-24 18:44:40,451 DEBUG : BROWSER_OUTPUT: RSS: Main: 156827648 18:44:40 INFO - 2015-11-24 18:44:40,451 DEBUG : BROWSER_OUTPUT: 18:44:42 INFO - 2015-11-24 18:44:42,208 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51815/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51815/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:44:42 INFO - 2015-11-24 18:44:42,774 DEBUG : BROWSER_OUTPUT: RSS: Main: 166961152 18:44:42 INFO - 2015-11-24 18:44:42,775 DEBUG : BROWSER_OUTPUT: 18:44:44 INFO - 2015-11-24 18:44:44,650 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51815/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51815/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:44:45 INFO - 2015-11-24 18:44:45,251 DEBUG : BROWSER_OUTPUT: RSS: Main: 166244352 18:44:45 INFO - 2015-11-24 18:44:45,252 DEBUG : BROWSER_OUTPUT: 18:44:47 INFO - 2015-11-24 18:44:47,343 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51815/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51815/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:44:47 INFO - 2015-11-24 18:44:47,925 DEBUG : BROWSER_OUTPUT: RSS: Main: 175931392 18:44:47 INFO - 2015-11-24 18:44:47,925 DEBUG : BROWSER_OUTPUT: 18:44:50 INFO - 2015-11-24 18:44:50,460 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51815/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51815/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:44:51 INFO - 2015-11-24 18:44:51,045 DEBUG : BROWSER_OUTPUT: RSS: Main: 181256192 18:44:51 INFO - 2015-11-24 18:44:51,045 DEBUG : BROWSER_OUTPUT: 18:44:53 INFO - 2015-11-24 18:44:53,648 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51815/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51815/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:44:54 INFO - 2015-11-24 18:44:54,229 DEBUG : BROWSER_OUTPUT: RSS: Main: 178577408 18:44:54 INFO - 2015-11-24 18:44:54,229 DEBUG : BROWSER_OUTPUT: 18:44:55 INFO - 2015-11-24 18:44:55,963 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51815/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51815/tests/kraken/driver.html?testName=ai-astar) 18:44:56 INFO - 2015-11-24 18:44:56,213 DEBUG : BROWSER_OUTPUT: RSS: Main: 235888640 18:44:56 INFO - 2015-11-24 18:44:56,213 DEBUG : BROWSER_OUTPUT: 18:44:56 INFO - 2015-11-24 18:44:56,215 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:44:56 INFO - 2015-11-24 18:44:56,215 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:44:56 INFO - 2015-11-24 18:44:56,215 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:44:56 INFO - 2015-11-24 18:44:56,215 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:44:56 INFO - 2015-11-24 18:44:56,215 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;113;108;111;112;112;100;112;112;106 18:44:56 INFO - 2015-11-24 18:44:56,216 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;157;136;152;165;134;155;155;140;180;133 18:44:56 INFO - 2015-11-24 18:44:56,216 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;162;163;160;160;161;163;161;163;160 18:44:56 INFO - 2015-11-24 18:44:56,216 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;72;80;91;75;71;72;114;90;72 18:44:56 INFO - 2015-11-24 18:44:56,216 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;128;94;95;94;131;93;95;134 18:44:56 INFO - 2015-11-24 18:44:56,216 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;111;109;109;110;110;109;110;109 18:44:56 INFO - 2015-11-24 18:44:56,216 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;148;146;146;146;146;146;147;146;146 18:44:56 INFO - 2015-11-24 18:44:56,216 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;95;96;95;95;95;95 18:44:56 INFO - 2015-11-24 18:44:56,217 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;69;70;71;71;69;70;70;70;69 18:44:56 INFO - 2015-11-24 18:44:56,217 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;68;69;69;68;68;68;68;71 18:44:56 INFO - 2015-11-24 18:44:56,217 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;82;82;82;82;84;83;83;83;81 18:44:56 INFO - 2015-11-24 18:44:56,217 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;129;127;129;119;126;128;126;124;128;127 18:44:56 INFO - 2015-11-24 18:44:56,217 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;147;146;160;149;150;137;150;146;146;135 18:44:56 INFO - 2015-11-24 18:44:56,217 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;70;72;70;69;70;69;69;67;68 18:44:56 INFO - 2015-11-24 18:44:56,218 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:44:56 INFO - 2015-11-24 18:44:56,218 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:44:56 INFO - 2015-11-24 18:44:56,218 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,964 18:44:56 INFO - 2015-11-24 18:44:56,219 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:44:56 INFO - 2015-11-24 18:44:56,219 DEBUG : BROWSER_OUTPUT: __startTimestamp1448419496214__endTimestamp 18:44:56 INFO - 2015-11-24 18:44:56,220 DEBUG : BROWSER_OUTPUT: 18:44:56 INFO - 2015-11-24 18:44:56,223 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:44:56 INFO - 2015-11-24 18:44:56,223 DEBUG : BROWSER_OUTPUT: Number of tests: 14 18:44:56 INFO - 2015-11-24 18:44:56,223 DEBUG : BROWSER_OUTPUT: 18:44:56 INFO - 2015-11-24 18:44:56,223 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.60 Median:112.00 stddev:4.01 (3.6%) stddev-sans-first:4.25 18:44:56 INFO - 2015-11-24 18:44:56,223 DEBUG : BROWSER_OUTPUT: Values: 110.0 113.0 108.0 111.0 112.0 112.0 100.0 112.0 112.0 106.0 18:44:56 INFO - 2015-11-24 18:44:56,223 DEBUG : BROWSER_OUTPUT: 18:44:56 INFO - 2015-11-24 18:44:56,223 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.70 Median:155.00 stddev:15.14 (9.8%) stddev-sans-first:15.89 18:44:56 INFO - 2015-11-24 18:44:56,223 DEBUG : BROWSER_OUTPUT: Values: 157.0 136.0 152.0 165.0 134.0 155.0 155.0 140.0 180.0 133.0 18:44:56 INFO - 2015-11-24 18:44:56,223 DEBUG : BROWSER_OUTPUT: 18:44:56 INFO - 2015-11-24 18:44:56,224 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:1.34 (0.8%) stddev-sans-first:1.33 18:44:56 INFO - 2015-11-24 18:44:56,224 DEBUG : BROWSER_OUTPUT: Values: 160.0 162.0 163.0 160.0 160.0 161.0 163.0 161.0 163.0 160.0 18:44:56 INFO - 2015-11-24 18:44:56,224 DEBUG : BROWSER_OUTPUT: 18:44:56 INFO - 2015-11-24 18:44:56,224 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.80 Median:73.50 stddev:13.94 (19.0%) stddev-sans-first:14.33 18:44:56 INFO - 2015-11-24 18:44:56,224 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 80.0 91.0 75.0 71.0 72.0 114.0 90.0 72.0 18:44:56 INFO - 2015-11-24 18:44:56,224 DEBUG : BROWSER_OUTPUT: 18:44:56 INFO - 2015-11-24 18:44:56,224 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.20 Median:94.00 stddev:17.87 (19.0%) stddev-sans-first:18.49 18:44:56 INFO - 2015-11-24 18:44:56,224 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 128.0 94.0 95.0 94.0 131.0 93.0 95.0 134.0 18:44:56 INFO - 2015-11-24 18:44:56,224 DEBUG : BROWSER_OUTPUT: 18:44:56 INFO - 2015-11-24 18:44:56,224 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:109.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 18:44:56 INFO - 2015-11-24 18:44:56,224 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 111.0 109.0 109.0 110.0 110.0 109.0 110.0 109.0 18:44:56 INFO - 2015-11-24 18:44:56,224 DEBUG : BROWSER_OUTPUT: 18:44:56 INFO - 2015-11-24 18:44:56,224 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 18:44:56 INFO - 2015-11-24 18:44:56,224 DEBUG : BROWSER_OUTPUT: Values: 147.0 148.0 146.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 18:44:56 INFO - 2015-11-24 18:44:56,224 DEBUG : BROWSER_OUTPUT: 18:44:56 INFO - 2015-11-24 18:44:56,224 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 18:44:56 INFO - 2015-11-24 18:44:56,225 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 18:44:56 INFO - 2015-11-24 18:44:56,225 DEBUG : BROWSER_OUTPUT: 18:44:56 INFO - 2015-11-24 18:44:56,225 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:70.00 Median:70.00 stddev:0.82 (1.2%) stddev-sans-first:0.78 18:44:56 INFO - 2015-11-24 18:44:56,225 DEBUG : BROWSER_OUTPUT: Values: 71.0 69.0 70.0 71.0 71.0 69.0 70.0 70.0 70.0 69.0 18:44:56 INFO - 2015-11-24 18:44:56,225 DEBUG : BROWSER_OUTPUT: 18:44:56 INFO - 2015-11-24 18:44:56,225 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:68.50 stddev:0.97 (1.4%) stddev-sans-first:1.00 18:44:56 INFO - 2015-11-24 18:44:56,225 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 69.0 69.0 68.0 68.0 68.0 68.0 71.0 18:44:56 INFO - 2015-11-24 18:44:56,225 DEBUG : BROWSER_OUTPUT: 18:44:56 INFO - 2015-11-24 18:44:56,225 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:82.50 stddev:0.95 (1.1%) stddev-sans-first:0.88 18:44:56 INFO - 2015-11-24 18:44:56,225 DEBUG : BROWSER_OUTPUT: Values: 81.0 82.0 82.0 82.0 82.0 84.0 83.0 83.0 83.0 81.0 18:44:56 INFO - 2015-11-24 18:44:56,225 DEBUG : BROWSER_OUTPUT: 18:44:56 INFO - 2015-11-24 18:44:56,225 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.30 Median:127.50 stddev:2.98 (2.3%) stddev-sans-first:3.00 18:44:56 INFO - 2015-11-24 18:44:56,225 DEBUG : BROWSER_OUTPUT: Values: 129.0 127.0 129.0 119.0 126.0 128.0 126.0 124.0 128.0 127.0 18:44:56 INFO - 2015-11-24 18:44:56,225 DEBUG : BROWSER_OUTPUT: 18:44:56 INFO - 2015-11-24 18:44:56,225 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.60 Median:148.00 stddev:6.96 (4.7%) stddev-sans-first:7.38 18:44:56 INFO - 2015-11-24 18:44:56,225 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 160.0 149.0 150.0 137.0 150.0 146.0 146.0 135.0 18:44:56 INFO - 2015-11-24 18:44:56,226 DEBUG : BROWSER_OUTPUT: 18:44:56 INFO - 2015-11-24 18:44:56,226 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.50 stddev:1.34 (1.9%) stddev-sans-first:1.41 18:44:56 INFO - 2015-11-24 18:44:56,226 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 72.0 70.0 69.0 70.0 69.0 69.0 67.0 68.0 18:44:56 INFO - 2015-11-24 18:44:56,226 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:44:56 INFO - 2015-11-24 18:44:56,226 DEBUG : BROWSER_OUTPUT: 18:44:57 INFO - 2015-11-24 18:44:57,117 INFO : Browser exited with error code: 0 18:44:57 INFO - 2015-11-24 18:44:57,171 INFO : Completed test kraken (00:01:00) 18:44:57 INFO - 2015-11-24 18:44:57,171 INFO : Starting test v8_7 18:44:57 INFO - 2015-11-24 18:44:57,171 DEBUG : operating with platform_type : linux_ 18:44:57 INFO - 2015-11-24 18:44:57,171 INFO : Initialising browser for v8_7 test... 18:44:57 INFO - 2015-11-24 18:44:57,177 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWDvy58/profile http://localhost:51815/getInfo.html 18:45:00 INFO - 2015-11-24 18:45:00,929 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:45:00 INFO - 2015-11-24 18:45:00,929 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:45:00 INFO - 2015-11-24 18:45:00,929 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:45:00 INFO - 2015-11-24 18:45:00,929 DEBUG : BROWSER_OUTPUT: __metrics 18:45:01 INFO - 2015-11-24 18:45:01,034 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] 18:45:02 INFO - 2015-11-24 18:45:02,296 INFO : Browser initialized. 18:45:02 INFO - 2015-11-24 18:45:02,296 INFO : Running cycle 1/1 for v8_7 test... 18:45:02 INFO - 2015-11-24 18:45:02,296 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWDvy58/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:45:14 INFO - 2015-11-24 18:45:14,189 DEBUG : BROWSER_OUTPUT: RSS: Main: 138723328 18:45:14 INFO - 2015-11-24 18:45:14,189 DEBUG : BROWSER_OUTPUT: 18:45:35 INFO - 2015-11-24 18:45:35,627 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51815/tests/v8_7/run.html (next: http://localhost:51815/tests/v8_7/run.html) 18:45:35 INFO - 2015-11-24 18:45:35,877 DEBUG : BROWSER_OUTPUT: RSS: Main: 439103488 18:45:35 INFO - 2015-11-24 18:45:35,877 DEBUG : BROWSER_OUTPUT: 18:45:35 INFO - 2015-11-24 18:45:35,877 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:45:35 INFO - 2015-11-24 18:45:35,877 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:45:35 INFO - 2015-11-24 18:45:35,878 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:45:35 INFO - 2015-11-24 18:45:35,878 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:45:35 INFO - 2015-11-24 18:45:35,878 DEBUG : BROWSER_OUTPUT: |0;Richards;164.90765171503958 18:45:35 INFO - 2015-11-24 18:45:35,878 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;184.50184501845018 18:45:35 INFO - 2015-11-24 18:45:35,878 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.0850651149903 18:45:35 INFO - 2015-11-24 18:45:35,878 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5191.709844559586 18:45:35 INFO - 2015-11-24 18:45:35,878 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1955.078125 18:45:35 INFO - 2015-11-24 18:45:35,879 DEBUG : BROWSER_OUTPUT: |5;Earley;813.0081300813008 18:45:35 INFO - 2015-11-24 18:45:35,879 DEBUG : BROWSER_OUTPUT: |6;Boyer;12317.073170731708 18:45:35 INFO - 2015-11-24 18:45:35,879 DEBUG : BROWSER_OUTPUT: |7;RegExp;26763.157894736843 18:45:35 INFO - 2015-11-24 18:45:35,879 DEBUG : BROWSER_OUTPUT: |8;Splay;611.2469437652812 18:45:35 INFO - 2015-11-24 18:45:35,879 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 18:45:35 INFO - 2015-11-24 18:45:35,880 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:45:35 INFO - 2015-11-24 18:45:35,880 DEBUG : BROWSER_OUTPUT: __startTimestamp1448419535875__endTimestamp 18:45:35 INFO - 2015-11-24 18:45:35,880 DEBUG : BROWSER_OUTPUT: 18:45:35 INFO - 2015-11-24 18:45:35,880 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:45:35 INFO - 2015-11-24 18:45:35,880 DEBUG : BROWSER_OUTPUT: Number of tests: 10 18:45:35 INFO - 2015-11-24 18:45:35,880 DEBUG : BROWSER_OUTPUT: 18:45:35 INFO - 2015-11-24 18:45:35,880 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.91 Median:164.91 stddev:0.00 (0.0%) 18:45:35 INFO - 2015-11-24 18:45:35,881 DEBUG : BROWSER_OUTPUT: Values: 164.9 18:45:35 INFO - 2015-11-24 18:45:35,881 DEBUG : BROWSER_OUTPUT: 18:45:35 INFO - 2015-11-24 18:45:35,881 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:184.50 Median:184.50 stddev:0.00 (0.0%) 18:45:35 INFO - 2015-11-24 18:45:35,881 DEBUG : BROWSER_OUTPUT: Values: 184.5 18:45:35 INFO - 2015-11-24 18:45:35,881 DEBUG : BROWSER_OUTPUT: 18:45:35 INFO - 2015-11-24 18:45:35,881 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.09 Median:277.09 stddev:0.00 (0.0%) 18:45:35 INFO - 2015-11-24 18:45:35,881 DEBUG : BROWSER_OUTPUT: Values: 277.1 18:45:35 INFO - 2015-11-24 18:45:35,881 DEBUG : BROWSER_OUTPUT: 18:45:35 INFO - 2015-11-24 18:45:35,882 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5191.71 Median:5191.71 stddev:0.00 (0.0%) 18:45:35 INFO - 2015-11-24 18:45:35,882 DEBUG : BROWSER_OUTPUT: Values: 5191.7 18:45:35 INFO - 2015-11-24 18:45:35,882 DEBUG : BROWSER_OUTPUT: 18:45:35 INFO - 2015-11-24 18:45:35,882 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1955.08 Median:1955.08 stddev:0.00 (0.0%) 18:45:35 INFO - 2015-11-24 18:45:35,882 DEBUG : BROWSER_OUTPUT: Values: 1955.1 18:45:35 INFO - 2015-11-24 18:45:35,882 DEBUG : BROWSER_OUTPUT: 18:45:35 INFO - 2015-11-24 18:45:35,882 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:813.01 Median:813.01 stddev:0.00 (0.0%) 18:45:35 INFO - 2015-11-24 18:45:35,882 DEBUG : BROWSER_OUTPUT: Values: 813.0 18:45:35 INFO - 2015-11-24 18:45:35,882 DEBUG : BROWSER_OUTPUT: 18:45:35 INFO - 2015-11-24 18:45:35,882 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12317.07 Median:12317.07 stddev:0.00 (0.0%) 18:45:35 INFO - 2015-11-24 18:45:35,882 DEBUG : BROWSER_OUTPUT: Values: 12317.1 18:45:35 INFO - 2015-11-24 18:45:35,882 DEBUG : BROWSER_OUTPUT: 18:45:35 INFO - 2015-11-24 18:45:35,882 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26763.16 Median:26763.16 stddev:0.00 (0.0%) 18:45:35 INFO - 2015-11-24 18:45:35,883 DEBUG : BROWSER_OUTPUT: Values: 26763.2 18:45:35 INFO - 2015-11-24 18:45:35,883 DEBUG : BROWSER_OUTPUT: 18:45:35 INFO - 2015-11-24 18:45:35,883 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:611.25 Median:611.25 stddev:0.00 (0.0%) 18:45:35 INFO - 2015-11-24 18:45:35,883 DEBUG : BROWSER_OUTPUT: Values: 611.2 18:45:35 INFO - 2015-11-24 18:45:35,883 DEBUG : BROWSER_OUTPUT: 18:45:35 INFO - 2015-11-24 18:45:35,883 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 18:45:35 INFO - 2015-11-24 18:45:35,883 DEBUG : BROWSER_OUTPUT: Values: 4830.9 18:45:35 INFO - 2015-11-24 18:45:35,883 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:45:35 INFO - 2015-11-24 18:45:35,883 DEBUG : BROWSER_OUTPUT: 18:45:36 INFO - 2015-11-24 18:45:36,757 INFO : Browser exited with error code: 0 18:45:36 INFO - 2015-11-24 18:45:36,772 INFO : Completed test v8_7 (00:00:39) 18:45:36 INFO - 2015-11-24 18:45:36,857 INFO : Completed test suite (00:20:16) 18:45:36 INFO - 2015-11-24 18:45:36,857 DEBUG : Working with test: dromaeo_css 18:45:36 INFO - 2015-11-24 18:45:36,858 DEBUG : Generating results file: dromaeo_css 18:45:36 INFO - 2015-11-24 18:45:36,859 DEBUG : Working with test: kraken 18:45:36 INFO - 2015-11-24 18:45:36,859 DEBUG : Generating results file: kraken 18:45:36 INFO - 2015-11-24 18:45:36,859 INFO : javascript benchmark 18:45:36 INFO - 2015-11-24 18:45:36,859 DEBUG : Working with test: v8_7 18:45:36 INFO - 2015-11-24 18:45:36,859 DEBUG : Generating results file: v8_7 18:45:36 INFO - 2015-11-24 18:45:36,860 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:45:37 INFO - 2015-11-24 18:45:37,008 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,203,35]] 18:45:37 INFO - 2015-11-24 18:45:37,008 DEBUG : process_Request line: dromaeo_css 6279.89 graph.html#tests=[[72,203,35]] 18:45:37 INFO - 2015-11-24 18:45:37,008 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:45:37 INFO - 2015-11-24 18:45:37,042 DEBUG : process_Request line: kraken 1521.70 graph.html#tests=[[232,203,35]] 18:45:37 INFO - 2015-11-24 18:45:37,042 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:45:37 INFO - 2015-11-24 18:45:37,171 DEBUG : process_Request line: v8_7 19786.23 graph.html#tests=[[230,203,35]] 18:45:37 INFO - 2015-11-24 18:45:37,175 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2591.5594348960676, 2648.3379155211196, 2649.0993062358816, 2661.866906654667, 2672.19834049785, 4484.618807401366, 4598.931016034758, 4615.815367385309, 4634.6292296616275, 4636.582707556319, 4512.842050528232, 4559.0, 4564.771761411933, 4597.494275629678, 4704.623630109591, 4212.431321771567, 4245.214635292466, 4265.914681706364, 4272.9359059614135, 4291.678124140686, 4261.105167914741, 4325.718828276168, 4334.154839806239, 4334.501532323776, 4364.061726728753, 4087.9386809198036, 4157.376393540962, 4187.267228235077, 4188.099558594886, 4242.681798865066, 4244.0, 4262.957370426318, 4273.615374616299, 4275.123599662062, 4290.76400797956, 4203.432536607549, 4210.305299625558, 4215.957840421587, 4217.7891105444605, 4239.491261048663, 4299.1831552005015, 4421.513633500313, 4428.2471979763195, 4502.729836209838, 4511.345854851061, 4760.785764640599, 4828.275758636198, 4829.830955916526, 4831.565159135695, 4875.463698993108, 4916.1888288432365, 4942.406911170647, 4976.800927962877, 4987.526185012454, 4993.650444468889, 4442.955570444319, 4550.0217453247715, 4611.26219804833, 4632.305154226826, 4683.039976804746, 4913.631477639191, 4970.030843985388, 4981.427135879348, 4984.800607975641, 5041.017001684636, 4812.109759694467, 4840.903181936342, 4846.006568653417, 4857.368542089505, 4907.533784290486, 4680.81276748933, 4779.378680771547, 4941.283513890466, 4952.950470495249, 4964.776585053682, 4724.385829842167, 4762.0, 4844.176489996638, 4863.3434486344595, 4898.510148985073, 4759.9524004759505, 4770.689905156154, 4773.188557945088, 4776.259679749644, 4821.132196204717, 3833.3483307837732, 3919.8236079376497, 4014.036631208489, 4019.0, 4053.61490658387, 3515.2793677296095, 3549.4143466328283, 3560.3769340365334, 3584.301061293023, 3587.7847329160336, 4224.4508213931995, 4313.374560688682, 4314.352847072964, 4316.892077698019, 4361.280388735887, 4709.788059537261, 4797.040591881638, 4957.975210123926, 5011.473795251519, 5058.974705126524, 4174.290370636938, 4219.662427005894, 4224.324108142682, 4233.80947857341, 4275.978620106879, 4326.307790753464, 4340.435743353344, 4341.15347507233, 4355.477342718894, 4373.387725718402, 4492.550744925481, 4603.148417542765, 4658.114958158007, 4659.65052621048, 4704.694194877322, 4771.856844294677, 4807.903841923072, 4854.927176092432, 4869.099216644932, 4911.312416261655, 4645.140648979815, 4646.512116227747, 4650.0, 4671.602913752233, 4705.082508910729, 4693.413323334583, 4828.106800241966, 4837.612990960785, 4849.369581954324, 4874.317595536699, 4809.951900480951, 4837.346958160603, 4850.078485087822, 4882.975585122052, 4919.901601968012, 4791.592714619157, 4819.566239038503, 4820.325154478306, 4821.228603423436, 4864.197407427735, 4572.748498832596, 4806.951930480651, 4823.831165909176, 4827.734474603931, 4869.147899117569, 4624.930626040545, 4641.0, 4655.487896331469, 4742.2175341069715, 4751.334813126096, 4817.7350245736825, 4833.419989601271, 4833.927491087707, 4834.081524510332, 4878.80484780619, 4542.591166795004, 4736.668433209642, 4744.1460537102275, 4745.074710431571, 4761.357216775691], "unit": "ms", "name": "dojo.html", "value": 4490.1379043425495}, {"lowerIsBetter": false, "replicates": [549.8213080748758, 553.1989850084027, 579.6377264209868, 584.004272715021, 586.4077281945235, 27215.0, 36290.45564316534, 37025.62974370256, 37070.629293707054, 37082.40423170376, 39739.403908941385, 40367.39448908269, 40373.59626403735, 40378.798106009504, 40426.55307916127, 6910.5853648780985, 7020.438364930793, 7953.483023603476, 8128.796780080486, 9692.66075687351, 10067.798644027114, 10192.082712555868, 10211.744706382326, 10214.795704085915, 10217.948910255476, 10123.493825308742, 10276.537555810006, 10280.588776448933, 10284.434356110449, 10287.948560257188, 7052.471064670171, 7245.7826265212125, 7250.456215783837, 10127.240456965757, 10505.4222017789, 9893.258005649604, 10065.949670251675, 10067.647632332906, 10073.194144468425, 10075.798484030352, 37267.62732372669, 37644.0, 37667.24665506702, 37743.62256377456, 37752.62247377518, 2756.503829310723, 2781.443711257736, 2928.7071292870755, 2953.158349870298, 3428.5200071989943, 27714.445711085664, 27905.441891162063, 27952.720472795216, 28018.439631207464, 28043.0, 3395.9490607640905, 3493.4410494320787, 3494.336076145524, 3550.130218096557, 3620.746547741659, 222060.0, 224446.0, 224706.99999999837, 225220.99999999837, 225743.0, 51757.7412112937, 56596.43403565994, 56914.0, 56927.14609280864, 57026.144607830916, 47291.5270847294, 64624.35375646183, 66070.0, 66411.66794165998, 66456.0, 13643.181409115485, 13856.445742170403, 13863.376148073361, 13871.930640346936, 13882.167069975834, 10158.339707919109, 10228.744281393025, 10229.181665466745, 10229.948850255701, 10240.948795255976, 19248.742091366625, 19553.511162220773, 19598.314059007866, 19626.705599416022, 19649.31227407034, 7520.360769334558, 7917.683292668229, 7919.673737030461, 7928.722494712657, 7962.920370796218, 842.7219017724136, 884.5930871798915, 899.2131884600974, 912.5072460871055, 995.049727510226, 26683.93782383403, 26735.19794406171, 27033.189004329903, 27172.32069198286, 27227.45545089087, 922.9017469211617, 923.6582464488182, 968.7917097824002, 971.9076687714655, 1044.12815299226, 13716.245606491539, 13754.724905501835, 13798.862011379959, 13873.306334683226, 13944.233067181402, 561932.0, 577436.0, 577682.0, 579129.0, 579696.0, 42535.361969570484, 50024.74987625112, 50551.0, 50557.98884022373, 50662.240066399034, 1048.764028093688, 1159.6289187459931, 1166.2128063557234, 1177.952881884732, 1180.9291442513477, 27274.727252727218, 28717.85641071865, 28907.132786016453, 29274.56088158722, 29371.853140734158, 31835.522467162547, 32642.673573263964, 38381.0, 39255.41116883192, 39276.2144757109, 172303.0, 172968.0, 173346.0, 173982.0, 174283.0, 36060.45909311415, 36544.0, 36650.63349366579, 36654.8167259162, 36711.26577468382, 42001.78999104985, 42113.789431052646, 42586.57413425826, 42800.0, 42808.78595607002, 35375.29249415049, 35917.82041089778, 36582.8170859144, 36819.44770828493, 38007.0, 35424.645753542136, 35613.82193089018, 36043.81978090093, 36623.0, 36642.45036324404, 35446.822765886005, 35968.0, 36312.4553131698, 36400.0, 36464.453033205056, 31088.0, 32678.83660581777, 33033.66966330402, 33047.834760826045, 33094.66905330916, 25331.0, 25671.486570268116, 25699.229023129337, 25713.87143064273, 26092.0], "unit": "ms", "name": "ext.html", "value": 17884.95907118785}, {"lowerIsBetter": false, "replicates": [328.2139276432945, 333.614675050317, 338.9457686770116, 339.8834827591362, 345.08208166277706, 12268.693282667939, 12532.749345013095, 15064.924675376622, 15112.697746045087, 16863.49409517715, 14337.569872903803, 14764.335604897778, 15226.467073652424, 15788.921055394707, 15797.447089351876, 3799.563050249229, 4943.406791185045, 5007.474215207405, 5070.492950704918, 5072.26452164436, 3635.909102272438, 3753.8498460061564, 5599.860003499904, 5743.282089738783, 5760.222369980041, 5570.832875013736, 5664.433556644344, 5670.06443936752, 5690.971545142268, 5696.316442026962, 5586.525145362649, 5754.050581654043, 5760.9711951440395, 5766.50984666306, 5781.710914454303, 4965.106280869442, 5081.237814327844, 5091.66904151229, 5094.235864620299, 5096.184610462308, 19364.612707745768, 19406.70889936652, 19649.919254441, 19686.70469942952, 19983.900080499505, 1799.9280028798833, 1800.6225237693175, 1804.2422182683304, 1840.7699037620298, 1980.584077343745, 8629.352798540134, 8974.955125224333, 12517.248965062125, 12794.360281985957, 13302.866971330259, 1726.9740953885703, 1729.1440736835348, 1783.0638914569954, 1783.8751287409887, 1802.180008096313, 54393.0, 56048.0, 56768.0, 57401.425985740025, 57563.424365756226, 9892.307538472238, 9893.307468477282, 9960.750981225527, 9967.352122112039, 9967.40195588267, 12585.622431327074, 12595.433205505591, 12600.684982875318, 12601.18092323996, 12603.49586016549, 6938.548994315353, 6986.580805151707, 7024.929750702428, 7032.824179395556, 7069.681864316118, 6549.574277671936, 6552.0, 6581.901271480931, 6595.175603049619, 6620.768273110418, 4153.06556024892, 4187.476565429321, 4203.810828512663, 4207.474065741782, 4237.5762423758, 1586.095925322578, 1630.9755353669705, 1646.4237516869, 1649.381481944271, 1658.6765580711888, 565.8585353661584, 828.4076885027114, 863.9179277968583, 898.7708134425679, 908.6456282050005, 11894.048476121889, 14810.62973425673, 15616.3753449863, 16175.352985880432, 16400.0, 813.3615112137062, 865.6796985115421, 931.1433481197315, 932.4545141092536, 934.3646320501988, 8885.777855553662, 9015.098490151064, 9230.261579073658, 9291.349605527548, 9425.717228483156, 470958.0, 472499.0, 479273.0, 480294.0, 488425.0, 64640.353596464374, 73985.63007185038, 76871.61564192144, 77660.61169694115, 78481.2151878474, 1051.7002654243504, 1068.273573969708, 1073.4203530093662, 1082.4912291223113, 1082.7509672775147, 13515.59453216405, 14283.64290892736, 14446.855531444551, 14497.78253326222, 14503.347349369515, 28137.859310703316, 28363.0, 28958.42083158283, 29288.41423171482, 29869.5519567211, 40842.79578602088, 41761.79119104385, 42742.0, 42927.0, 45822.31266530938, 8949.686760963335, 9209.355345125778, 9222.123898229658, 9243.445393276425, 9271.582778775106, 10657.946710266398, 11608.419579021183, 16145.67708645797, 16158.67682646364, 16590.50228493147, 13477.326133693472, 13888.375023123781, 14133.717325653224, 14218.289085545888, 14296.642583935485, 12611.87388126107, 13081.149725267827, 13470.259135747629, 13649.522266720616, 13754.93122534381, 10914.945425273141, 10968.725781855517, 10997.670069897917, 13262.53581124656, 13298.335083245993, 8859.734207973772, 9015.504147271962, 9354.53227338644, 9391.624335026523, 9438.433693978108, 9750.80498390014, 9854.063863932915, 12020.278783273032, 14055.367508461939, 14510.709785804436], "unit": "ms", "name": "jquery.html", "value": 8251.030711325275}, {"lowerIsBetter": false, "replicates": [1397.0290647999632, 1585.389624994377, 1644.4244514419954, 1655.5364497940577, 1665.9754251135555, 5870.61840980336, 6817.863642727142, 6971.302869713026, 6975.0, 6979.581225126496, 6861.0, 7024.2273349931465, 7047.0838790957105, 7065.89401158983, 7086.255943125975, 1758.9824101759011, 1785.232350089461, 2021.6866385710202, 2034.8372130229545, 2055.0546748495635, 2061.505238742706, 2061.9587608247825, 2070.4616799632054, 2072.0, 2072.1607748861734, 2034.1354924157247, 2035.3995571306425, 2101.8528702990798, 2102.9158833646634, 2108.9894550527224, 2029.9797002030086, 2049.1086377425795, 2067.1627990663806, 2084.7289852319177, 2086.2698055680617, 2064.556120434099, 2091.654876945302, 2092.654711972523, 2093.11042806808, 2094.183268525276, 6812.4550035997, 6865.656717164122, 6878.140232470942, 6880.380765731058, 6881.243063263037, 4123.649489793371, 4173.895652608679, 4178.91642167155, 4224.324108142682, 4228.957710422918, 2279.9544009119727, 2690.6905705843883, 2793.0782841662203, 2815.662120545527, 2835.8723857426257, 780.1808101493409, 797.8843067755143, 819.3117781063876, 856.884320616715, 888.0497867282011, 9180.678676246365, 9201.631934722604, 9216.354855160142, 9230.169284764337, 9245.491497967541, 3883.9901625577554, 3912.7456715313415, 3970.82131304092, 4013.0569316210667, 4019.41718450823, 8082.434229603989, 8133.308668763103, 8141.837163256701, 8147.185281471924, 8155.918440815634, 4191.97904010478, 4197.097624010852, 4211.589117645623, 4212.368144778307, 4222.113356195234, 3854.4411060396087, 3871.1483473635753, 3878.941815872764, 3881.146147847469, 3881.301365754135, 2848.6154369160313, 2967.718066783652, 3372.79763214203, 3406.6423025582453, 3469.9132521686656, 1084.322298563398, 1103.7130346110068, 1108.1688733449912, 1118.4687273545, 1120.78705046041, 782.7886470652892, 802.3941923847458, 1026.5021464589668, 1027.275770581738, 1027.2809033676308, 6080.391960803884, 6117.357677443804, 6352.14246076783, 6352.65060421672, 6370.0, 933.4539294512786, 945.1824172091092, 1035.254616675992, 1042.6924057403085, 1046.1944302886734, 4890.975545122252, 5010.949890501049, 5014.5737612303365, 5015.924761128586, 5085.0084233574835, 8137.226963438464, 8212.63043163059, 8288.502689838508, 8304.875426868603, 8312.41813073079, 8055.0, 8177.1414001530175, 8209.179082091743, 8287.337013038943, 8314.875276870851, 6479.092926990225, 6548.6725663716625, 6555.410013098844, 6567.44176744982, 6568.86862262752, 5965.522758179422, 5980.551458640706, 5986.431289027535, 6005.789797357072, 6184.752609895734, 7200.171980222132, 7326.157491888501, 7340.2292759261645, 7401.1488678802625, 7493.70025198986, 7600.733974310872, 7644.0, 7683.692652293846, 7684.769456916301, 7690.615469226628, 5917.881642367042, 6052.66710330936, 6068.757249710139, 6088.786892458743, 6114.0, 5468.097763868917, 5589.524890384363, 5598.300212473441, 5600.915986260128, 6485.416312531706, 5511.448855114457, 5968.970155149196, 6112.083187521729, 6194.659293738888, 6219.129321894848, 6028.457438830526, 6053.061775424816, 6103.206583144163, 6117.694115294128, 6174.38256174379, 6175.752969881154, 6203.069539569101, 6242.250929888442, 6261.060840873905, 6269.467095296951, 5772.826815195383, 5799.565032622654, 5804.361520232856, 5808.6224395414165, 5815.82552523425, 5735.13972904051, 5757.280339957505, 5758.740856661377, 5760.366359700346, 5773.74018169175], "unit": "ms", "name": "mootools.html", "value": 3964.665071286632}, {"lowerIsBetter": false, "replicates": [299.55815172620385, 305.73401141007326, 311.20021544630293, 311.2716243989068, 312.2396963394136, 5157.690538567688, 5272.789088436462, 5311.1502159654465, 5339.305890234265, 5406.270153529277, 5158.613104017195, 5289.153735402337, 5305.442928492511, 5308.973455132719, 5312.1766126250395, 3986.54154772202, 4206.47419072616, 4209.873703788876, 4210.410542524034, 4211.073563815963, 4058.553559108496, 4059.918801623966, 4062.2890994076065, 4063.674906007512, 4090.1819636072755, 4136.772477513736, 4175.686823488235, 4177.289860723684, 4179.498460184782, 4192.287311157111, 4167.895802604929, 4175.206710724968, 4175.561566035583, 4177.4778152730905, 4186.0581369192, 3704.6665800077853, 3707.6292370762976, 3709.091272638194, 3710.9443358349645, 3714.1271801126713, 4949.158643030657, 5104.668196567211, 5109.20807274873, 5111.693298402108, 5116.565091967187, 4714.010057887814, 4724.480307166244, 4726.243800991859, 4732.337472753818, 4738.19450693383, 5312.442193569696, 5544.86137846553, 5548.91676624851, 5555.944440555623, 5557.3886872444, 3817.503724515823, 3902.570717221103, 3997.360422332413, 3998.900027499307, 4002.3396139636925, 5771.971140144315, 5848.853778655525, 5869.295684517842, 5876.706164691748, 5879.470847623735, 4113.1568028554075, 4122.525909520384, 4123.463949686521, 4127.071408932966, 4128.876133715993, 4114.177164567039, 4169.770662613525, 4175.749455032707, 4201.285781417167, 4202.495700515897, 4699.577038066591, 4730.716157030589, 4738.1708201064675, 4740.715557066587, 4750.0, 5568.303962004749, 5570.108782594765, 5581.6930068845795, 5582.888342233214, 5585.218069470277, 1465.4944044304698, 1481.5555333400152, 1481.9110853348834, 1482.7331080405415, 1483.6735918098002, 1012.3217444312328, 1020.0666390252984, 1020.3061917895902, 1027.547878933282, 1049.1030169205371, 4894.143524883131, 4904.117258893362, 4915.729634870045, 4921.483244259372, 4922.704637721748, 5791.189233507313, 5792.681402522818, 5799.5070419014855, 5804.6807425592, 5810.389909059572, 4911.066897289504, 4912.312276281324, 4912.38595175603, 4916.06594746997, 4921.606271498272, 3045.6040714706946, 3110.486769682977, 3128.702773236539, 3144.3554071415306, 3147.1502694272876, 5490.313710786152, 5538.6399884007415, 5541.0580201365865, 5544.972275138679, 5549.361823390281, 5992.910106348409, 6006.909896351558, 6010.849728756816, 6015.729292181863, 6022.759089636453, 5460.945390546044, 5520.972395138159, 5538.75075621598, 5540.556755459554, 5541.501264886179, 5682.687452190169, 5838.416158384128, 5839.8832023358445, 5848.181254624271, 5849.151872978309, 5458.5087342139395, 5597.160425936142, 5600.915986260291, 5605.383407825218, 5614.0, 5338.626296159232, 5420.945790542044, 5516.9448305518035, 5518.751656175562, 5543.944560554342, 3969.345058065502, 3995.48058752372, 4002.9199416010933, 4006.759594424344, 4013.4983127109113, 5674.517665998436, 5814.622049566765, 5823.621464604787, 5823.679697616672, 5835.533157347487, 5605.775768969195, 5617.634853734494, 5619.80330688424, 5621.10062390032, 5627.52166065889, 5620.100783874561, 5625.409332020079, 5626.915596265977, 5629.46673996695, 5634.549236061023, 5463.535599474089, 5503.669779813224, 5507.201455788968, 5507.834764957058, 5513.531349835149, 5495.368032676133, 5667.263255776723, 5669.489745922887, 5670.631408958405, 5674.4892959633835, 5482.972585137049, 5528.336599608073, 5529.861753456195, 5530.446955304598, 5532.723363831873], "unit": "ms", "name": "prototype.html", "value": 4229.7868326102425}, {"lowerIsBetter": false, "replicates": [720.7225218290956, 720.8522252938149, 730.3828265115975, 763.7097902796936, 765.4259305520859, 11451.885481145186, 11564.306141631487, 11578.189526733133, 11583.826242606368, 11696.941515292423, 10541.78916421671, 11382.772344553105, 11488.483018264178, 11501.942490287558, 11540.0, 575.2981362737464, 755.2485277149244, 757.8446418484198, 761.0106861080601, 762.828363618187, 757.8522188173308, 772.953622782632, 775.5966897213445, 775.7052320118347, 775.728495026739, 778.5056489129387, 786.5909726941986, 788.7988562916448, 792.6789650191653, 793.9761807145766, 773.4122067228918, 780.4029917113413, 783.1502819440885, 783.5494590610365, 783.5690370296314, 578.1760990588394, 580.118220305138, 584.1296468262301, 585.5169485174705, 585.5432762445299, 10153.238507111922, 10262.486875656188, 10267.79464410715, 10303.587856485732, 10315.381077135396, 9501.0, 9533.237341012702, 9945.602175912954, 10221.437820919846, 10330.380177189392, 8814.603342849587, 8928.642854285821, 9165.816683666357, 9390.295727820441, 9579.233661307078, 3181.793183443092, 3196.856141473639, 3220.1949512621845, 3220.8872689455993, 3360.1263671445354, 34021.31957360839, 34659.82670086633, 34737.82631086828, 35867.0, 41855.581444185475, 9032.187103160748, 9039.502827344559, 9070.773230669287, 9174.17432431071, 9176.44941303524, 15920.283587238602, 15953.282102305191, 16141.0, 16157.919210403872, 16183.757243641356, 6341.207349081365, 6360.395762402564, 6430.485561155097, 6443.548951573439, 6531.542792004514, 3584.4981702561663, 3602.405603075463, 3621.855125794991, 3631.255592603563, 3638.799866007395, 2709.282040259333, 2725.250556097089, 2740.2327348342496, 2748.1343376836235, 2750.614913912054, 493.0607193296775, 493.3339991012105, 501.603733050893, 502.87428142964256, 505.5702652745211, 410.64282546185143, 423.3755211063718, 427.73547729141035, 434.32245696713227, 464.16682055710083, 7380.741674041383, 7521.849563008709, 7581.886271705929, 7591.658375373121, 7606.657700403495, 514.8995945790535, 544.4011587253989, 549.7416214379235, 553.9113741801292, 555.1450765820591, 3506.1059429845227, 3582.0328511302323, 3876.7286289959998, 3936.193080418507, 3981.5421226558738, 47011.764941175075, 47397.0, 48087.519124809005, 48227.0, 48739.26891096636, 44748.3287750684, 45253.0, 45350.546494535294, 45440.3183952241, 45450.545494545295, 34325.313493729984, 39516.407253891215, 40074.198516029515, 42675.35986960198, 43196.0, 7827.608619569112, 7893.644785984759, 8049.597520124087, 8118.431709780259, 8186.8771968421715, 31815.840920795246, 32159.432159431788, 32170.19574510656, 32264.35471290608, 32306.546205421284, 34798.82600586981, 34925.65074349326, 41808.79095604503, 44529.10941781211, 44883.55116448794, 9208.447493150432, 9227.21568666644, 9314.115159059878, 9416.952915235654, 9784.952618355172, 10777.360450713368, 10854.511546980248, 11074.335539867634, 11126.61056863006, 11249.0, 9500.994440063188, 9610.759731006781, 9613.90846649981, 9697.127258546765, 10264.486775661337, 10314.638987635397, 10503.579856805642, 10545.10366618846, 10625.734356641145, 10895.0, 9850.261230407892, 9959.601615935282, 9977.151942084714, 10002.8499572505, 10067.546960386946, 8949.284057275532, 9231.907680923105, 9246.398984066014, 9298.535073246176, 9327.813443731224, 8482.57587120629, 8609.268212202032, 8905.263473622581, 8920.509371984603, 8966.730998070068], "unit": "ms", "name": "yui.html", "value": 5519.244943983681}], "name": "dromaeo_css"}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 113.0, 108.0, 111.0, 112.0, 112.0, 100.0, 112.0, 112.0, 106.0], "unit": "ms", "name": "ai-astar", "value": 109.6}, {"lowerIsBetter": true, "replicates": [157.0, 136.0, 152.0, 165.0, 134.0, 155.0, 155.0, 140.0, 180.0, 133.0], "unit": "ms", "name": "audio-beat-detection", "value": 150.7}, {"lowerIsBetter": true, "replicates": [160.0, 162.0, 163.0, 160.0, 160.0, 161.0, 163.0, 161.0, 163.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 80.0, 91.0, 75.0, 71.0, 72.0, 114.0, 90.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 80.8}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 128.0, 94.0, 95.0, 94.0, 131.0, 93.0, 95.0, 134.0], "unit": "ms", "name": "audio-oscillator", "value": 105.2}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 111.0, 109.0, 109.0, 110.0, 110.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [71.0, 69.0, 70.0, 71.0, 71.0, 69.0, 70.0, 70.0, 70.0, 69.0], "unit": "ms", "name": "json-parse-financial", "value": 70.0}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 69.0, 69.0, 68.0, 68.0, 68.0, 68.0, 71.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 82.0, 82.0, 82.0, 84.0, 83.0, 83.0, 83.0, 81.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.3}, {"lowerIsBetter": true, "replicates": [129.0, 127.0, 129.0, 119.0, 126.0, 128.0, 126.0, 124.0, 128.0, 127.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 126.3}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 160.0, 149.0, 150.0, 137.0, 150.0, 146.0, 146.0, 135.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.6}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 72.0, 70.0, 69.0, 70.0, 69.0, 69.0, 67.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.3}], "name": "kraken"}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.90765171503958], "unit": "score", "name": "Richards", "value": 214.07132799999994}, {"lowerIsBetter": false, "replicates": [184.50184501845018], "unit": "score", "name": "DeltaBlue", "value": 358.3595599999999}, {"lowerIsBetter": false, "replicates": [277.0850651149903], "unit": "score", "name": "Encrypt", "value": 960.647229}, {"lowerIsBetter": false, "replicates": [5191.709844559586], "unit": "score", "name": "Decrypt", "value": 51.270392215568904}, {"lowerIsBetter": false, "replicates": [1955.078125], "unit": "score", "name": "RayTrace", "value": 378.49587212787225}, {"lowerIsBetter": false, "replicates": [813.0081300813008], "unit": "score", "name": "Earley", "value": 819.7494899999999}, {"lowerIsBetter": false, "replicates": [12317.073170731708], "unit": "score", "name": "Boyer", "value": 54.108877227722786}, {"lowerIsBetter": false, "replicates": [26763.157894736843], "unit": "score", "name": "RegExp", "value": 34.0387708947886}, {"lowerIsBetter": false, "replicates": [611.2469437652812], "unit": "score", "name": "Splay", "value": 133.31927600000003}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7"}]} 18:45:37 INFO - RETURN: dromaeo_css: 6279.89 18:45:37 INFO - RETURN: kraken: 1521.70 18:45:37 INFO - RETURN: v8_7: 19786.23 18:45:37 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,203,35]]", "result": "19786.23"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,203,35]]", "result": "1521.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,203,35]]", "result": "6279.89"}}} 18:45:37 INFO - Return code: 0 18:45:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:45:37 INFO - # TBPL SUCCESS # 18:45:37 INFO - Running post-action listener: _resource_record_post_action 18:45:37 INFO - Running post-run listener: _resource_record_post_run 18:45:38 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 8192; Write bytes: 513994752; Read time: 16; Write time: 468444 18:45:38 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 228208640; Read time: 0; Write time: 307732 18:45:38 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 4096; Write bytes: 273178624; Read time: 8; Write time: 156412 18:45:38 INFO - Running post-run listener: _upload_blobber_files 18:45:38 INFO - Blob upload gear active. 18:45:38 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 18:45:38 INFO - Copying logs to upload dir... 18:45:38 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1264.178603 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-11-24 18:45:38.393136) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 18:45:38.396967) ========= 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=f5f5a079460e1a9be8676904000001c1-1448417498.279178-775015110 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/HD0CMTTUTt2iGRyFjhG7TQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.008797 build_url: 'https://queue.taskcluster.net/v1/task/HD0CMTTUTt2iGRyFjhG7TQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 18:45:38.448580) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 18:45:38.448901) ========= 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=f5f5a079460e1a9be8676904000001c1-1448417498.279178-775015110 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004500 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 18:45:38.499243) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 18:45:38.499662) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 18:45:38.500125) ========= ========= Total master_lag: 0.25 =========