builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-030 starttime: 1448442153.33 results: success (0) buildid: 20151124234132 builduid: fe0c5590855448afbee31a733c873c87 revision: a725c681dee314117d30a184f61e7a17c0fb1a17 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-25 01:02:33.327951) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-25 01:02:33.328541) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 01:02:33.328967) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1448441783.99007-1808360845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006560 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 01:02:33.366184) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 01:02:33.366683) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 01:02:33.442958) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 01:02:33.443499) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1448441783.99007-1808360845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004599 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 01:02:33.494709) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-25 01:02:33.495204) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-25 01:02:33.495766) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 01:02:33.496200) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1448441783.99007-1808360845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-25 01:02: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.7M=0s 2015-11-25 01:02:33 (43.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110667 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 01:02:33.619877) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 01:02:33.620153) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1448441783.99007-1808360845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014297 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 01:02:33.671569) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-25 01:02:33.671917) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a725c681dee314117d30a184f61e7a17c0fb1a17 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev a725c681dee314117d30a184f61e7a17c0fb1a17 --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=23f5739b2d6aa5d9caf5c428000001ae-1448441783.99007-1808360845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-25 01:02:33,977 truncating revision to first 12 chars 2015-11-25 01:02:33,977 Setting DEBUG logging. 2015-11-25 01:02:33,977 attempt 1/10 2015-11-25 01:02:33,977 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a725c681dee3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-25 01:02:35,226 unpacking tar archive at: fx-team-a725c681dee3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.546111 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-25 01:02:35.231364) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 01:02:35.231748) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 01:02:35.240747) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-25 01:02:35.241078) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-25 01:02:35.241502) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2015-11-25 01:02:35.241797) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=23f5739b2d6aa5d9caf5c428000001ae-1448441783.99007-1808360845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:02:35 INFO - MultiFileLogger online at 20151125 01:02:35 in /builds/slave/test 01:02:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 01:02:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:02:35 INFO - {'append_to_log': False, 01:02:35 INFO - 'base_work_dir': '/builds/slave/test', 01:02:35 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 01:02:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:02:35 INFO - 'branch': 'Fx-Team-Non-PGO', 01:02:35 INFO - 'buildbot_json_path': 'buildprops.json', 01:02:35 INFO - 'config_files': ('talos/linux_config.py',), 01:02:35 INFO - 'default_actions': ('clobber', 01:02:35 INFO - 'read-buildbot-config', 01:02:35 INFO - 'download-and-extract', 01:02:35 INFO - 'populate-webroot', 01:02:35 INFO - 'create-virtualenv', 01:02:35 INFO - 'install', 01:02:35 INFO - 'run-tests'), 01:02:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:02:35 INFO - 'download_minidump_stackwalk': True, 01:02:35 INFO - 'download_symbols': 'ondemand', 01:02:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:02:35 INFO - 'tooltool.py': '/tools/tooltool.py', 01:02:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:02:35 INFO - '/tools/misc-python/virtualenv.py')}, 01:02:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:02:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:02:35 INFO - 'installer_path': 'installer.exe', 01:02:35 INFO - 'log_level': 'info', 01:02:35 INFO - 'log_name': 'talos', 01:02:35 INFO - 'log_to_console': True, 01:02:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:02:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:02:35 INFO - 'opt_config_files': (), 01:02:35 INFO - 'pip_index': False, 01:02:35 INFO - 'sps_profile': False, 01:02:35 INFO - 'sps_profile_interval': 0, 01:02:35 INFO - 'suite': 'dromaeojs', 01:02:35 INFO - 'system_bits': '64', 01:02:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:02:35 INFO - 'title': 'talos-linux64-ix-030', 01:02:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:02:35 INFO - 'use_talos_json': True, 01:02:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:02:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:02:35 INFO - 'work_dir': 'build'} 01:02:35 INFO - ##### 01:02:35 INFO - ##### Running clobber step. 01:02:35 INFO - ##### 01:02:35 INFO - Running pre-action listener: _resource_record_pre_action 01:02:35 INFO - Running main action method: clobber 01:02:35 INFO - rmtree: /builds/slave/test/build 01:02:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:02:36 INFO - Running post-action listener: _resource_record_post_action 01:02:36 INFO - ##### 01:02:36 INFO - ##### Running read-buildbot-config step. 01:02:36 INFO - ##### 01:02:36 INFO - Running pre-action listener: _resource_record_pre_action 01:02:36 INFO - Running main action method: read_buildbot_config 01:02:36 INFO - Using buildbot properties: 01:02:36 INFO - { 01:02:36 INFO - "properties": { 01:02:36 INFO - "buildnumber": 922, 01:02:36 INFO - "product": "firefox", 01:02:36 INFO - "script_repo_revision": "production", 01:02:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 01:02:36 INFO - "repository": "", 01:02:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 01:02:36 INFO - "buildid": "20151124234132", 01:02:36 INFO - "slavename": "talos-linux64-ix-030", 01:02:36 INFO - "pgo_build": "False", 01:02:36 INFO - "basedir": "/builds/slave/test", 01:02:36 INFO - "project": "", 01:02:36 INFO - "platform": "ubuntu64_hw", 01:02:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:02:36 INFO - "slavebuilddir": "test", 01:02:36 INFO - "scheduler": "tests-fx-team-linux64-talos", 01:02:36 INFO - "branch": "fx-team", 01:02:36 INFO - "repo_path": "integration/fx-team", 01:02:36 INFO - "stage_platform": "linux64", 01:02:36 INFO - "builduid": "fe0c5590855448afbee31a733c873c87", 01:02:36 INFO - "revision": "a725c681dee314117d30a184f61e7a17c0fb1a17" 01:02:36 INFO - }, 01:02:36 INFO - "sourcestamp": { 01:02:36 INFO - "repository": "", 01:02:36 INFO - "hasPatch": false, 01:02:36 INFO - "project": "", 01:02:36 INFO - "branch": "fx-team-linux64-talos", 01:02:36 INFO - "changes": [ 01:02:36 INFO - { 01:02:36 INFO - "category": null, 01:02:36 INFO - "files": [ 01:02:36 INFO - { 01:02:36 INFO - "url": null, 01:02:36 INFO - "name": "https://queue.taskcluster.net/v1/task/2HwmPeEVSQKLx5NQKDe_3A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 01:02:36 INFO - } 01:02:36 INFO - ], 01:02:36 INFO - "repository": "", 01:02:36 INFO - "rev": "a725c681dee314117d30a184f61e7a17c0fb1a17", 01:02:36 INFO - "who": "cbook@mozilla.com", 01:02:36 INFO - "when": 1448442102, 01:02:36 INFO - "number": 6704635, 01:02:36 INFO - "comments": "Bug 1226217 - Use less verbose cycle collection macros for mozilla::devtools::HeapSnapshot; r=bz", 01:02:36 INFO - "project": "", 01:02:36 INFO - "at": "Wed 25 Nov 2015 01:01:42", 01:02:36 INFO - "branch": "fx-team-linux64-talos", 01:02:36 INFO - "revlink": "", 01:02:36 INFO - "properties": [ 01:02:36 INFO - [ 01:02:36 INFO - "buildid", 01:02:36 INFO - "20151124234132", 01:02:36 INFO - "Change" 01:02:36 INFO - ], 01:02:36 INFO - [ 01:02:36 INFO - "builduid", 01:02:36 INFO - "fe0c5590855448afbee31a733c873c87", 01:02:36 INFO - "Change" 01:02:36 INFO - ], 01:02:36 INFO - [ 01:02:36 INFO - "pgo_build", 01:02:36 INFO - "False", 01:02:36 INFO - "Change" 01:02:36 INFO - ] 01:02:36 INFO - ], 01:02:36 INFO - "revision": "a725c681dee314117d30a184f61e7a17c0fb1a17" 01:02:36 INFO - } 01:02:36 INFO - ], 01:02:36 INFO - "revision": "a725c681dee314117d30a184f61e7a17c0fb1a17" 01:02:36 INFO - } 01:02:36 INFO - } 01:02:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/2HwmPeEVSQKLx5NQKDe_3A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 01:02:36 INFO - Running post-action listener: _resource_record_post_action 01:02:36 INFO - ##### 01:02:36 INFO - ##### Running download-and-extract step. 01:02:36 INFO - ##### 01:02:36 INFO - Running pre-action listener: _resource_record_pre_action 01:02:36 INFO - Running main action method: download_and_extract 01:02:36 INFO - mkdir: /builds/slave/test/build/tests 01:02:36 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')]} 01:02:36 INFO - https://queue.taskcluster.net/v1/task/2HwmPeEVSQKLx5NQKDe_3A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:02:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2HwmPeEVSQKLx5NQKDe_3A/artifacts/public/build/test_packages.json 01:02:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2HwmPeEVSQKLx5NQKDe_3A/artifacts/public/build/test_packages.json 01:02:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2HwmPeEVSQKLx5NQKDe_3A/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 01:02:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2HwmPeEVSQKLx5NQKDe_3A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 01:02:39 INFO - Downloaded 1302 bytes. 01:02:39 INFO - Reading from file /builds/slave/test/build/test_packages.json 01:02:39 INFO - Using the following test package requirements: 01:02:39 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 01:02:39 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:02:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:02:39 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:02:39 INFO - u'jsshell-linux-x86_64.zip'], 01:02:39 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:02:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:02:39 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 01:02:39 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:02:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:02:39 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:02:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:02:39 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:02:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:02:39 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 01:02:39 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:02:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:02:39 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:02:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:02:39 INFO - https://queue.taskcluster.net/v1/task/2HwmPeEVSQKLx5NQKDe_3A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:02:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2HwmPeEVSQKLx5NQKDe_3A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:02:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2HwmPeEVSQKLx5NQKDe_3A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:02:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2HwmPeEVSQKLx5NQKDe_3A/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 01:02:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2HwmPeEVSQKLx5NQKDe_3A/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 01:02:40 INFO - Downloaded 21346027 bytes. 01:02:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 01:02:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:02:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 01:02:41 INFO - Return code: 0 01:02:41 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:02:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:02:41 INFO - https://queue.taskcluster.net/v1/task/2HwmPeEVSQKLx5NQKDe_3A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:02:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2HwmPeEVSQKLx5NQKDe_3A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:02:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2HwmPeEVSQKLx5NQKDe_3A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:02:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2HwmPeEVSQKLx5NQKDe_3A/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 01:02:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2HwmPeEVSQKLx5NQKDe_3A/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 01:02:45 INFO - Downloaded 21346027 bytes. 01:02:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 01:02:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:02:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 01:02:46 INFO - Return code: 0 01:02:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:02:46 INFO - https://queue.taskcluster.net/v1/task/2HwmPeEVSQKLx5NQKDe_3A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:02:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2HwmPeEVSQKLx5NQKDe_3A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 01:02:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2HwmPeEVSQKLx5NQKDe_3A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 01:02:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2HwmPeEVSQKLx5NQKDe_3A/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 01:02:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2HwmPeEVSQKLx5NQKDe_3A/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 01:02:48 INFO - Downloaded 11131717 bytes. 01:02:48 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 01:02:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 01:02:48 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 01:02:48 INFO - Return code: 0 01:02: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')]} 01:02:48 INFO - https://queue.taskcluster.net/v1/task/2HwmPeEVSQKLx5NQKDe_3A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:02:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2HwmPeEVSQKLx5NQKDe_3A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:02:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2HwmPeEVSQKLx5NQKDe_3A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:02:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2HwmPeEVSQKLx5NQKDe_3A/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 01:02:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2HwmPeEVSQKLx5NQKDe_3A/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 01:02:49 INFO - Downloaded 56849162 bytes. 01:02:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/2HwmPeEVSQKLx5NQKDe_3A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:02:49 INFO - mkdir: /builds/slave/test/properties 01:02:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:02:49 INFO - Writing to file /builds/slave/test/properties/build_url 01:02:49 INFO - Contents: 01:02:49 INFO - build_url:https://queue.taskcluster.net/v1/task/2HwmPeEVSQKLx5NQKDe_3A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:02:49 INFO - Running post-action listener: _resource_record_post_action 01:02:49 INFO - Running post-action listener: set_extra_try_arguments 01:02:49 INFO - ##### 01:02:49 INFO - ##### Running populate-webroot step. 01:02:49 INFO - ##### 01:02:49 INFO - Running pre-action listener: _resource_record_pre_action 01:02:49 INFO - Running main action method: populate_webroot 01:02:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:02:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:02:49 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 01:02:49 INFO - '../fennec_ids.txt'], 01:02:49 INFO - 'tests': ['tcheck2']}, 01:02:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:02:49 INFO - '--tppagecycles', 01:02:49 INFO - '7'], 01:02:49 INFO - 'tests': ['tsvgm']}}, 01:02:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:02:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:02:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:02:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:02:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:02:49 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:02:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:02:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:02:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:02:49 INFO - 'talos_options': ['--e10s'], 01:02:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:02:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:02:49 INFO - 'tests': ['damp', 'tps']}, 01:02:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:02:49 INFO - 'talos_options': ['--e10s'], 01:02:49 INFO - 'tests': ['damp', 'tps']}, 01:02:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:02:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:02:49 INFO - 'other': {'tests': ['a11yr', 01:02:49 INFO - 'ts_paint', 01:02:49 INFO - 'tpaint', 01:02:49 INFO - 'sessionrestore', 01:02:49 INFO - 'sessionrestore_no_auto_restore']}, 01:02:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:02:49 INFO - 'tests': ['a11yr', 01:02:49 INFO - 'ts_paint', 01:02:49 INFO - 'tpaint', 01:02:49 INFO - 'sessionrestore', 01:02:49 INFO - 'sessionrestore_no_auto_restore']}, 01:02:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:02:49 INFO - 'tests': ['a11yr', 01:02:49 INFO - 'ts_paint', 01:02:49 INFO - 'tpaint', 01:02:49 INFO - 'sessionrestore', 01:02:49 INFO - 'sessionrestore_no_auto_restore']}, 01:02:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:02:49 INFO - 'tests': ['a11yr', 01:02:49 INFO - 'ts_paint', 01:02:49 INFO - 'tpaint', 01:02:49 INFO - 'sessionrestore', 01:02:49 INFO - 'sessionrestore_no_auto_restore']}, 01:02:49 INFO - 'other_l64': {'tests': ['a11yr', 01:02:49 INFO - 'ts_paint', 01:02:49 INFO - 'tpaint', 01:02:49 INFO - 'sessionrestore', 01:02:49 INFO - 'sessionrestore_no_auto_restore']}, 01:02:49 INFO - 'other_nol64': {'tests': ['a11yr', 01:02:49 INFO - 'ts_paint', 01:02:49 INFO - 'tpaint', 01:02:49 INFO - 'sessionrestore', 01:02:49 INFO - 'sessionrestore_no_auto_restore']}, 01:02:49 INFO - 'svgr': {'tests': ['tsvgx', 01:02:49 INFO - 'tsvgr_opacity', 01:02:49 INFO - 'tart', 01:02:49 INFO - 'tscrollx', 01:02:49 INFO - 'cart']}, 01:02:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:02:49 INFO - 'tests': ['tsvgx', 01:02:49 INFO - 'tsvgr_opacity', 01:02:49 INFO - 'tart', 01:02:49 INFO - 'tscrollx', 01:02:49 INFO - 'cart']}, 01:02:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:02:49 INFO - 'tests': ['tp5o']}, 01:02:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:02:49 INFO - 'talos_options': ['--e10s'], 01:02:49 INFO - 'tests': ['tp5o']}, 01:02:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:02:49 INFO - 'talos_options': ['--xperf_path', 01:02:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:02:49 INFO - 'tests': ['tp5n']}, 01:02:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:02:49 INFO - 'talos_options': ['--e10s', 01:02:49 INFO - '--xperf_path', 01:02:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:02:49 INFO - 'tests': ['tp5n']}}, 01:02:49 INFO - 'talos.zip': {'path': '', 01:02:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:02:49 INFO - Running post-action listener: _resource_record_post_action 01:02:49 INFO - ##### 01:02:49 INFO - ##### Running create-virtualenv step. 01:02:49 INFO - ##### 01:02:49 INFO - Running pre-action listener: _resource_record_pre_action 01:02:49 INFO - Running main action method: create_virtualenv 01:02:49 INFO - Creating virtualenv /builds/slave/test/build/venv 01:02:49 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 01:02:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:02:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:02:50 INFO - Using real prefix '/usr' 01:02:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:02:50 INFO - Installing distribute.............................................................................................................................................................................................done. 01:02:52 INFO - Installing pip.................done. 01:02:52 INFO - Return code: 0 01:02:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:02:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:02:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:02:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:02:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:02:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2406030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2637210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c9220>, '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 0x26352b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2635740>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1448441783.99007-1808360845', '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 01:02:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:02:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:02:52 INFO - Using env: {'DISPLAY': ':0', 01:02:52 INFO - 'HOME': '/home/cltbld', 01:02:52 INFO - 'LANG': 'en_US.UTF-8', 01:02:52 INFO - 'LANGUAGE': 'en_US:en', 01:02:52 INFO - 'LOGNAME': 'cltbld', 01:02:52 INFO - 'MAIL': '/var/mail/cltbld', 01:02:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:02:52 INFO - 'MOZ_NO_REMOTE': '1', 01:02:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:02:52 INFO - 'NO_EM_RESTART': '1', 01:02:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:02:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:02:52 INFO - 'PWD': '/builds/slave/test', 01:02:52 INFO - 'SHELL': '/bin/bash', 01:02:52 INFO - 'SHLVL': '1', 01:02:52 INFO - 'TERM': 'linux', 01:02:52 INFO - 'TMOUT': '86400', 01:02:52 INFO - 'USER': 'cltbld', 01:02:52 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1448441783.99007-1808360845', 01:02:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:02:52 INFO - '_': '/tools/buildbot/bin/python'} 01:02:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:02:52 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 01:02:52 INFO - Cleaning up... 01:02:52 INFO - Return code: 0 01:02:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:02:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:02:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:02:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:02:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:02:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2406030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2637210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c9220>, '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 0x26352b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2635740>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1448441783.99007-1808360845', '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 01:02:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 01:02:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 01:02:52 INFO - Using env: {'DISPLAY': ':0', 01:02:52 INFO - 'HOME': '/home/cltbld', 01:02:52 INFO - 'LANG': 'en_US.UTF-8', 01:02:52 INFO - 'LANGUAGE': 'en_US:en', 01:02:52 INFO - 'LOGNAME': 'cltbld', 01:02:52 INFO - 'MAIL': '/var/mail/cltbld', 01:02:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:02:52 INFO - 'MOZ_NO_REMOTE': '1', 01:02:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:02:52 INFO - 'NO_EM_RESTART': '1', 01:02:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:02:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:02:52 INFO - 'PWD': '/builds/slave/test', 01:02:52 INFO - 'SHELL': '/bin/bash', 01:02:52 INFO - 'SHLVL': '1', 01:02:52 INFO - 'TERM': 'linux', 01:02:52 INFO - 'TMOUT': '86400', 01:02:52 INFO - 'USER': 'cltbld', 01:02:52 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1448441783.99007-1808360845', 01:02:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:02:52 INFO - '_': '/tools/buildbot/bin/python'} 01:02:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:02:53 INFO - Downloading/unpacking psutil>=0.7.1 01:02: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 01:02: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 01:02: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 01:02: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 01:02: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 01:02: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 01:02:54 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 01:02:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 01:02:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:02:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:02:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:02:54 INFO - Installing collected packages: psutil 01:02:54 INFO - Running setup.py install for psutil 01:02:54 INFO - building 'psutil._psutil_linux' extension 01:02:54 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 01:02:55 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 01:02:55 INFO - building 'psutil._psutil_posix' extension 01:02:55 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 01:02:55 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 01:02:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:02:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:02:55 INFO - Successfully installed psutil 01:02:55 INFO - Cleaning up... 01:02:55 INFO - Return code: 0 01:02:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:02:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:02:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:02:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:02:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:02:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02:55 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 0x2406030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2637210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c9220>, '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 0x26352b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2635740>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1448441783.99007-1808360845', '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 01:02:55 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 01:02:55 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 01:02:55 INFO - Using env: {'DISPLAY': ':0', 01:02:55 INFO - 'HOME': '/home/cltbld', 01:02:55 INFO - 'LANG': 'en_US.UTF-8', 01:02:55 INFO - 'LANGUAGE': 'en_US:en', 01:02:55 INFO - 'LOGNAME': 'cltbld', 01:02:55 INFO - 'MAIL': '/var/mail/cltbld', 01:02:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:02:55 INFO - 'MOZ_NO_REMOTE': '1', 01:02:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:02:55 INFO - 'NO_EM_RESTART': '1', 01:02:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:02:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:02:55 INFO - 'PWD': '/builds/slave/test', 01:02:55 INFO - 'SHELL': '/bin/bash', 01:02:55 INFO - 'SHLVL': '1', 01:02:55 INFO - 'TERM': 'linux', 01:02:55 INFO - 'TMOUT': '86400', 01:02:55 INFO - 'USER': 'cltbld', 01:02:55 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1448441783.99007-1808360845', 01:02:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:02:55 INFO - '_': '/tools/buildbot/bin/python'} 01:02:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:02:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:02: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 01:02: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 01:02: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 01:02: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 01:02: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 01:02: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 01:02:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:02:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 01:02:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:02:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:02:57 INFO - Installing collected packages: mozsystemmonitor 01:02:57 INFO - Running setup.py install for mozsystemmonitor 01:02:57 INFO - Successfully installed mozsystemmonitor 01:02:57 INFO - Cleaning up... 01:02:57 INFO - Return code: 0 01:02:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:02:57 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')]} 01:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:02:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02:57 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')]} 01:02:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:02:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02:57 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 0x2406030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2637210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c9220>, '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 0x26352b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2635740>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1448441783.99007-1808360845', '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 01:02:57 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 01:02:57 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 01:02:57 INFO - Using env: {'DISPLAY': ':0', 01:02:57 INFO - 'HOME': '/home/cltbld', 01:02:57 INFO - 'LANG': 'en_US.UTF-8', 01:02:57 INFO - 'LANGUAGE': 'en_US:en', 01:02:57 INFO - 'LOGNAME': 'cltbld', 01:02:57 INFO - 'MAIL': '/var/mail/cltbld', 01:02:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:02:57 INFO - 'MOZ_NO_REMOTE': '1', 01:02:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:02:57 INFO - 'NO_EM_RESTART': '1', 01:02:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:02:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:02:57 INFO - 'PWD': '/builds/slave/test', 01:02:57 INFO - 'SHELL': '/bin/bash', 01:02:57 INFO - 'SHLVL': '1', 01:02:57 INFO - 'TERM': 'linux', 01:02:57 INFO - 'TMOUT': '86400', 01:02:57 INFO - 'USER': 'cltbld', 01:02:57 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1448441783.99007-1808360845', 01:02:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:02:57 INFO - '_': '/tools/buildbot/bin/python'} 01:02:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:02:57 INFO - Downloading/unpacking blobuploader==1.2.4 01:02:57 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 01:02:57 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 01:02:57 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 01:02:57 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 01:02:57 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 01:02:57 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 01:02:59 INFO - Downloading blobuploader-1.2.4.tar.gz 01:02:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 01:02:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:02:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:02:59 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 01:02:59 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 01:02:59 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 01:02:59 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 01:02:59 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 01:02:59 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 01:02:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 01:02:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:02:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:02:59 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 01:02:59 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 01:02:59 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 01:02:59 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 01:02:59 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 01:02:59 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 01:02:59 INFO - Downloading docopt-0.6.1.tar.gz 01:02:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 01:02:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:03:00 INFO - Installing collected packages: blobuploader, requests, docopt 01:03:00 INFO - Running setup.py install for blobuploader 01:03:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:03:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:03:00 INFO - Running setup.py install for requests 01:03:00 INFO - Running setup.py install for docopt 01:03:00 INFO - Successfully installed blobuploader requests docopt 01:03:00 INFO - Cleaning up... 01:03:00 INFO - Return code: 0 01:03:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:03:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:03:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:03:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:03:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:03:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:00 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 0x2406030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2637210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c9220>, '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 0x26352b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2635740>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1448441783.99007-1808360845', '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 01:03:00 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 01:03:00 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 01:03:00 INFO - Using env: {'DISPLAY': ':0', 01:03:00 INFO - 'HOME': '/home/cltbld', 01:03:00 INFO - 'LANG': 'en_US.UTF-8', 01:03:00 INFO - 'LANGUAGE': 'en_US:en', 01:03:00 INFO - 'LOGNAME': 'cltbld', 01:03:00 INFO - 'MAIL': '/var/mail/cltbld', 01:03:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:03:00 INFO - 'MOZ_NO_REMOTE': '1', 01:03:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:03:00 INFO - 'NO_EM_RESTART': '1', 01:03:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:03:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:03:00 INFO - 'PWD': '/builds/slave/test', 01:03:00 INFO - 'SHELL': '/bin/bash', 01:03:00 INFO - 'SHLVL': '1', 01:03:00 INFO - 'TERM': 'linux', 01:03:00 INFO - 'TMOUT': '86400', 01:03:00 INFO - 'USER': 'cltbld', 01:03:00 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1448441783.99007-1808360845', 01:03:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:03:00 INFO - '_': '/tools/buildbot/bin/python'} 01:03:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:03:00 INFO - Running setup.py (path:/tmp/pip-PFSrwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:03:00 INFO - Running setup.py (path:/tmp/pip-jcCdDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:03:01 INFO - Running setup.py (path:/tmp/pip-i2sE2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:03:01 INFO - Running setup.py (path:/tmp/pip-miICaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:03:01 INFO - Running setup.py (path:/tmp/pip-lVvCgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:03:01 INFO - Running setup.py (path:/tmp/pip-8Q27yW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:03:01 INFO - Running setup.py (path:/tmp/pip-coqJi5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:03:01 INFO - Running setup.py (path:/tmp/pip-wyX47v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:03:01 INFO - Running setup.py (path:/tmp/pip-CsGXru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:03:01 INFO - Running setup.py (path:/tmp/pip-YUi16Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:03:01 INFO - Running setup.py (path:/tmp/pip-WEW4BS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:03:01 INFO - Running setup.py (path:/tmp/pip-iLpLz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:03:01 INFO - Running setup.py (path:/tmp/pip-VaGfwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:03:01 INFO - Running setup.py (path:/tmp/pip-GZrUCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:03:01 INFO - Running setup.py (path:/tmp/pip-y4MliA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:03:01 INFO - Running setup.py (path:/tmp/pip-yRl0LS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:03:02 INFO - Running setup.py (path:/tmp/pip-ltRzs7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:03:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:03:02 INFO - Running setup.py install for manifestparser 01:03:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:03:02 INFO - Running setup.py install for mozcrash 01:03:02 INFO - Running setup.py install for mozdebug 01:03:02 INFO - Running setup.py install for mozdevice 01:03:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:03:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:03:02 INFO - Running setup.py install for mozfile 01:03:02 INFO - Running setup.py install for mozhttpd 01:03:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:03:02 INFO - Running setup.py install for mozinfo 01:03:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:03:02 INFO - Running setup.py install for mozInstall 01:03:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:03:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:03:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:03:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:03:02 INFO - Running setup.py install for mozleak 01:03:02 INFO - Running setup.py install for mozlog 01:03:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:03:03 INFO - Running setup.py install for moznetwork 01:03:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:03:03 INFO - Running setup.py install for mozprocess 01:03:03 INFO - Running setup.py install for mozprofile 01:03:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:03:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:03:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:03:03 INFO - Running setup.py install for mozrunner 01:03:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:03:03 INFO - Running setup.py install for mozscreenshot 01:03:03 INFO - Running setup.py install for moztest 01:03:03 INFO - Running setup.py install for mozversion 01:03:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:03:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:03:03 INFO - Cleaning up... 01:03:03 INFO - Return code: 0 01:03:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:03: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')]} 01:03:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:03:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03: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')]} 01:03:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:03:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03: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/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 0x2406030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2637210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c9220>, '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 0x26352b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2635740>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1448441783.99007-1808360845', '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 01:03: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/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 01:03: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/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 01:03:03 INFO - Using env: {'DISPLAY': ':0', 01:03:03 INFO - 'HOME': '/home/cltbld', 01:03:03 INFO - 'LANG': 'en_US.UTF-8', 01:03:03 INFO - 'LANGUAGE': 'en_US:en', 01:03:03 INFO - 'LOGNAME': 'cltbld', 01:03:03 INFO - 'MAIL': '/var/mail/cltbld', 01:03:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:03:03 INFO - 'MOZ_NO_REMOTE': '1', 01:03:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:03:03 INFO - 'NO_EM_RESTART': '1', 01:03:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:03:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:03:03 INFO - 'PWD': '/builds/slave/test', 01:03:03 INFO - 'SHELL': '/bin/bash', 01:03:03 INFO - 'SHLVL': '1', 01:03:03 INFO - 'TERM': 'linux', 01:03:03 INFO - 'TMOUT': '86400', 01:03:03 INFO - 'USER': 'cltbld', 01:03:03 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1448441783.99007-1808360845', 01:03:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:03:03 INFO - '_': '/tools/buildbot/bin/python'} 01:03:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:03:04 INFO - Running setup.py (path:/tmp/pip-efUCGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:03:04 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)) 01:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:03:04 INFO - Running setup.py (path:/tmp/pip-3sBwYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:03:04 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)) 01:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:03:04 INFO - Running setup.py (path:/tmp/pip-USh3Cz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:03:04 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)) 01:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:03:04 INFO - Running setup.py (path:/tmp/pip-3M2x6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:03:04 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)) 01:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:03:04 INFO - Running setup.py (path:/tmp/pip-dx_dHt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:03:04 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)) 01:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:03:04 INFO - Running setup.py (path:/tmp/pip-p7LKK_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:03:04 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)) 01:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:03:04 INFO - Running setup.py (path:/tmp/pip-QNKGDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:03:04 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)) 01:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:03:04 INFO - Running setup.py (path:/tmp/pip-Gdj705-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:03:04 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)) 01:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:03:04 INFO - Running setup.py (path:/tmp/pip-NL36Ck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:03:04 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)) 01:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:03:04 INFO - Running setup.py (path:/tmp/pip-f5JoXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:03:04 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)) 01:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:03:04 INFO - Running setup.py (path:/tmp/pip-2G2DB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:03:04 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)) 01:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:03:04 INFO - Running setup.py (path:/tmp/pip-lStUbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:03:04 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)) 01:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:03:04 INFO - Running setup.py (path:/tmp/pip-vqZTCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:03:05 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)) 01:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:03:05 INFO - Running setup.py (path:/tmp/pip-gz7EBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:03:05 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)) 01:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:03:05 INFO - Running setup.py (path:/tmp/pip-NrQfdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:03:05 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)) 01:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:03:05 INFO - Running setup.py (path:/tmp/pip-NXie4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:03:05 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)) 01:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:03:05 INFO - Running setup.py (path:/tmp/pip-ybKx2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:03:05 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)) 01:03:05 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)) 01:03:05 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)) 01:03:05 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)) 01:03:05 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)) 01:03:05 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)) 01:03:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:03: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 01:03: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 01:03: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 01:03: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 01:03: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 01:03: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 01:03:06 INFO - Downloading blessings-1.5.1.tar.gz 01:03:06 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 01:03:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:03:07 INFO - Installing collected packages: blessings 01:03:07 INFO - Running setup.py install for blessings 01:03:07 INFO - Successfully installed blessings 01:03:07 INFO - Cleaning up... 01:03:07 INFO - Return code: 0 01:03:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:03:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:03:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:03:07 INFO - Reading from file tmpfile_stdout 01:03:07 INFO - Current package versions: 01:03:07 INFO - argparse == 1.2.1 01:03:07 INFO - blessings == 1.5.1 01:03:07 INFO - blobuploader == 1.2.4 01:03:07 INFO - docopt == 0.6.1 01:03:07 INFO - manifestparser == 1.1 01:03:07 INFO - mozInstall == 1.12 01:03:07 INFO - mozcrash == 0.16 01:03:07 INFO - mozdebug == 0.1 01:03:07 INFO - mozdevice == 0.47 01:03:07 INFO - mozfile == 1.2 01:03:07 INFO - mozhttpd == 0.7 01:03:07 INFO - mozinfo == 0.9 01:03:07 INFO - mozleak == 0.1 01:03:07 INFO - mozlog == 3.1 01:03:07 INFO - moznetwork == 0.27 01:03:07 INFO - mozprocess == 0.22 01:03:07 INFO - mozprofile == 0.27 01:03:07 INFO - mozrunner == 6.11 01:03:07 INFO - mozscreenshot == 0.1 01:03:07 INFO - mozsystemmonitor == 0.0 01:03:07 INFO - moztest == 0.7 01:03:07 INFO - mozversion == 1.4 01:03:07 INFO - psutil == 3.1.1 01:03:07 INFO - requests == 1.2.3 01:03:07 INFO - wsgiref == 0.1.2 01:03:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:03:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:03:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:03:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:03:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:03:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x2406030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2637210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c9220>, '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 0x26352b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2635740>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1448441783.99007-1808360845', '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 01:03:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 01:03:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/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 01:03:07 INFO - Using env: {'DISPLAY': ':0', 01:03:07 INFO - 'HOME': '/home/cltbld', 01:03:07 INFO - 'LANG': 'en_US.UTF-8', 01:03:07 INFO - 'LANGUAGE': 'en_US:en', 01:03:07 INFO - 'LOGNAME': 'cltbld', 01:03:07 INFO - 'MAIL': '/var/mail/cltbld', 01:03:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:03:07 INFO - 'MOZ_NO_REMOTE': '1', 01:03:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:03:07 INFO - 'NO_EM_RESTART': '1', 01:03:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:03:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:03:07 INFO - 'PWD': '/builds/slave/test', 01:03:07 INFO - 'SHELL': '/bin/bash', 01:03:07 INFO - 'SHLVL': '1', 01:03:07 INFO - 'TERM': 'linux', 01:03:07 INFO - 'TMOUT': '86400', 01:03:07 INFO - 'USER': 'cltbld', 01:03:07 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1448441783.99007-1808360845', 01:03:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:03:07 INFO - '_': '/tools/buildbot/bin/python'} 01:03:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:03:07 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)) 01:03:07 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)) 01:03:07 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)) 01:03:07 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)) 01:03:07 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)) 01:03:07 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)) 01:03:07 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)) 01:03:07 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)) 01:03:07 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)) 01:03:07 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)) 01:03:07 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)) 01:03:07 INFO - Cleaning up... 01:03:07 INFO - Return code: 0 01:03:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:03:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:03:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:03:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:03:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:03:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x2406030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2637210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c9220>, '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 0x26352b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2635740>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1448441783.99007-1808360845', '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 01:03:07 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 01:03:07 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 01:03:07 INFO - Using env: {'DISPLAY': ':0', 01:03:07 INFO - 'HOME': '/home/cltbld', 01:03:07 INFO - 'LANG': 'en_US.UTF-8', 01:03:07 INFO - 'LANGUAGE': 'en_US:en', 01:03:07 INFO - 'LOGNAME': 'cltbld', 01:03:07 INFO - 'MAIL': '/var/mail/cltbld', 01:03:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:03:07 INFO - 'MOZ_NO_REMOTE': '1', 01:03:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:03:07 INFO - 'NO_EM_RESTART': '1', 01:03:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:03:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:03:07 INFO - 'PWD': '/builds/slave/test', 01:03:07 INFO - 'SHELL': '/bin/bash', 01:03:07 INFO - 'SHLVL': '1', 01:03:07 INFO - 'TERM': 'linux', 01:03:07 INFO - 'TMOUT': '86400', 01:03:07 INFO - 'USER': 'cltbld', 01:03:07 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1448441783.99007-1808360845', 01:03:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:03:07 INFO - '_': '/tools/buildbot/bin/python'} 01:03:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:03:07 INFO - Downloading/unpacking jsonschema 01:03:07 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 01:03:07 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 01:03:07 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 01:03:07 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 01:03:07 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 01:03:07 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 01:03:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:03:09 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 01:03:09 INFO - Downloading/unpacking functools32 (from jsonschema) 01:03:09 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 01:03:09 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 01:03:09 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 01:03:09 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 01:03:09 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 01:03:09 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 01:03:09 INFO - Downloading functools32-3.2.3-2.tar.gz 01:03:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 01:03:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:03:09 INFO - warning: no files found matching '*.txt' 01:03:09 INFO - no previously-included directories found matching 'build' 01:03:09 INFO - no previously-included directories found matching 'dist' 01:03:09 INFO - no previously-included directories found matching '.git*' 01:03:09 INFO - Installing collected packages: jsonschema, functools32 01:03:09 INFO - Running setup.py install for functools32 01:03:09 INFO - warning: no files found matching '*.txt' 01:03:09 INFO - no previously-included directories found matching 'build' 01:03:09 INFO - no previously-included directories found matching 'dist' 01:03:09 INFO - no previously-included directories found matching '.git*' 01:03:09 INFO - Successfully installed jsonschema functools32 01:03:09 INFO - Cleaning up... 01:03:10 INFO - Return code: 0 01:03:10 INFO - Running post-action listener: _resource_record_post_action 01:03:10 INFO - Running post-action listener: _start_resource_monitoring 01:03:10 INFO - Starting resource monitoring. 01:03:10 INFO - ##### 01:03:10 INFO - ##### Running install step. 01:03:10 INFO - ##### 01:03:10 INFO - Running pre-action listener: _resource_record_pre_action 01:03:10 INFO - Running main action method: install 01:03:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:03:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:03:10 INFO - Reading from file tmpfile_stdout 01:03:10 INFO - Detecting whether we're running mozinstall >=1.0... 01:03:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:03:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:03:10 INFO - Reading from file tmpfile_stdout 01:03:10 INFO - Output received: 01:03:10 INFO - Usage: mozinstall [options] installer 01:03:10 INFO - Options: 01:03:10 INFO - -h, --help show this help message and exit 01:03:10 INFO - -d DEST, --destination=DEST 01:03:10 INFO - Directory to install application into. [default: 01:03:10 INFO - "/builds/slave/test"] 01:03:10 INFO - --app=APP Application being installed. [default: firefox] 01:03:10 INFO - mkdir: /builds/slave/test/build/application 01:03:10 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'] 01:03:10 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 01:03:24 INFO - Reading from file tmpfile_stdout 01:03:24 INFO - Output received: 01:03:24 INFO - /builds/slave/test/build/application/firefox/firefox 01:03:24 INFO - Running post-action listener: _resource_record_post_action 01:03:24 INFO - ##### 01:03:24 INFO - ##### Running run-tests step. 01:03:24 INFO - ##### 01:03:24 INFO - Running pre-action listener: _resource_record_pre_action 01:03:24 INFO - Running main action method: run_tests 01:03:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:03:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:03:24 INFO - Python 2.7.3 01:03:24 INFO - Return code: 0 01:03:24 INFO - grabbing minidump binary from tooltool 01:03:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:03:24 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 0x26c9220>, '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 0x26352b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2635740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:03:24 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 01:03:24 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 01:03:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:03:24 INFO - Return code: 0 01:03:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:03:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:03:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:03:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:03:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:03:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/2HwmPeEVSQKLx5NQKDe_3A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost'] in /builds/slave/test/build 01:03:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/2HwmPeEVSQKLx5NQKDe_3A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --webServer localhost 01:03:24 INFO - Using env: {'DISPLAY': ':0', 01:03:24 INFO - 'HOME': '/home/cltbld', 01:03:24 INFO - 'LANG': 'en_US.UTF-8', 01:03:24 INFO - 'LANGUAGE': 'en_US:en', 01:03:24 INFO - 'LOGNAME': 'cltbld', 01:03:24 INFO - 'MAIL': '/var/mail/cltbld', 01:03:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:03:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:03:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:03:24 INFO - 'MOZ_NO_REMOTE': '1', 01:03:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:03:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:03:24 INFO - 'NO_EM_RESTART': '1', 01:03:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:03:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:03:24 INFO - 'PWD': '/builds/slave/test', 01:03:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:03:24 INFO - 'SHELL': '/bin/bash', 01:03:24 INFO - 'SHLVL': '1', 01:03:24 INFO - 'TERM': 'linux', 01:03:24 INFO - 'TMOUT': '86400', 01:03:24 INFO - 'USER': 'cltbld', 01:03:24 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1448441783.99007-1808360845', 01:03:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:03:24 INFO - '_': '/tools/buildbot/bin/python'} 01:03:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/2HwmPeEVSQKLx5NQKDe_3A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost'] with output_timeout 3600 01:03:24 INFO - mozversion INFO | application_buildid: 20151124234132 01:03:24 INFO - mozversion INFO | application_changeset: a725c681dee314117d30a184f61e7a17c0fb1a17 01:03:24 INFO - mozversion INFO | application_display_name: Nightly 01:03:24 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:03:24 INFO - mozversion INFO | application_name: Firefox 01:03:24 INFO - mozversion INFO | application_remotingname: firefox 01:03:24 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 01:03:24 INFO - mozversion INFO | application_vendor: Mozilla 01:03:24 INFO - mozversion INFO | application_version: 45.0a1 01:03:24 INFO - mozversion INFO | platform_buildid: 20151124234132 01:03:24 INFO - mozversion INFO | platform_changeset: a725c681dee314117d30a184f61e7a17c0fb1a17 01:03:24 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 01:03:24 INFO - mozversion INFO | platform_version: 45.0a1 01:03:24 INFO - 2015-11-25 01:03:24,924 DEBUG : using testdate: 1448442204 01:03:24 INFO - 2015-11-25 01:03:24,924 DEBUG : actual date: 1448442204 01:03:24 INFO - 2015-11-25 01:03:24,973 INFO : starting webserver on 'localhost:43059' 01:03:24 INFO - 2015-11-25 01:03:24,974 INFO : Starting test suite talos-linux64-ix-030 01:03:24 INFO - 2015-11-25 01:03:24,974 INFO : Starting test dromaeo_css 01:03:24 INFO - 2015-11-25 01:03:24,974 DEBUG : operating with platform_type : linux_ 01:03:24 INFO - 2015-11-25 01:03:24,975 INFO : Initialising browser for dromaeo_css test... 01:03:24 INFO - 2015-11-25 01:03:24,990 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVEl2U1/profile http://localhost:43059/getInfo.html 01:03:29 INFO - 2015-11-25 01:03:29,297 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:03:29 INFO - 2015-11-25 01:03:29,299 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:03:29 INFO - 2015-11-25 01:03:29,299 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:03:29 INFO - 2015-11-25 01:03:29,299 DEBUG : BROWSER_OUTPUT: __metrics 01:03:29 INFO - 2015-11-25 01:03:29,380 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] 01:03:30 INFO - 2015-11-25 01:03:30,610 INFO : Browser initialized. 01:03:30 INFO - 2015-11-25 01:03:30,610 INFO : Running cycle 1/1 for dromaeo_css test... 01:03:30 INFO - 2015-11-25 01:03:30,611 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVEl2U1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:03:42 INFO - 2015-11-25 01:03:42,435 DEBUG : BROWSER_OUTPUT: RSS: Main: 138674176 01:03:42 INFO - 2015-11-25 01:03:42,435 DEBUG : BROWSER_OUTPUT: 01:04:33 INFO - 2015-11-25 01:04:33,617 DEBUG : BROWSER_OUTPUT: 1448442273616 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] 01:06:45 INFO - 2015-11-25 01:06:45,476 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43059/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43059/tests/dromaeo/cssquery-ext.html) 01:06:46 INFO - 2015-11-25 01:06:46,600 DEBUG : BROWSER_OUTPUT: RSS: Main: 239562752 01:06:46 INFO - 2015-11-25 01:06:46,601 DEBUG : BROWSER_OUTPUT: 01:09:49 INFO - 2015-11-25 01:09:49,170 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43059/tests/dromaeo/cssquery-ext.html (next: http://localhost:43059/tests/dromaeo/cssquery-jquery.html) 01:09:49 INFO - 2015-11-25 01:09:49,744 DEBUG : BROWSER_OUTPUT: RSS: Main: 211460096 01:09:49 INFO - 2015-11-25 01:09:49,744 DEBUG : BROWSER_OUTPUT: 01:12:51 INFO - 2015-11-25 01:12:51,765 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43059/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43059/tests/dromaeo/cssquery-mootools.html) 01:12:52 INFO - 2015-11-25 01:12:52,340 DEBUG : BROWSER_OUTPUT: RSS: Main: 210436096 01:12:52 INFO - 2015-11-25 01:12:52,340 DEBUG : BROWSER_OUTPUT: 01:15:54 INFO - 2015-11-25 01:15:54,212 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43059/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43059/tests/dromaeo/cssquery-prototype.html) 01:15:54 INFO - 2015-11-25 01:15:54,802 DEBUG : BROWSER_OUTPUT: RSS: Main: 201404416 01:15:54 INFO - 2015-11-25 01:15:54,802 DEBUG : BROWSER_OUTPUT: 01:18:57 INFO - 2015-11-25 01:18:57,436 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43059/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43059/tests/dromaeo/cssquery-yui.html) 01:18:58 INFO - 2015-11-25 01:18:58,042 DEBUG : BROWSER_OUTPUT: RSS: Main: 206008320 01:18:58 INFO - 2015-11-25 01:18:58,042 DEBUG : BROWSER_OUTPUT: 01:22:00 INFO - 2015-11-25 01:22:00,547 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43059/tests/dromaeo/cssquery-yui.html (next: http://localhost:43059/tests/dromaeo/cssquery-dojo.html) 01:22:00 INFO - 2015-11-25 01:22:00,793 DEBUG : BROWSER_OUTPUT: RSS: Main: 251080704 01:22:00 INFO - 2015-11-25 01:22:00,793 DEBUG : BROWSER_OUTPUT: 01:22:00 INFO - 2015-11-25 01:22:00,794 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:22:00 INFO - 2015-11-25 01:22:00,795 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:22:00 INFO - 2015-11-25 01:22:00,795 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:22:00 INFO - 2015-11-25 01:22:00,795 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:22:00 INFO - 2015-11-25 01:22:00,796 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2590.857502837344;2693.0843513205505;2709.3091261728255;2721.496523143219;2729.2358139720877;4475.798589063492;4483.237849565574;4554.863354099374;4590.036092420592;4597.77011149442;4439.533848945863;4526.932096018554;4530.886727831806;4539.546045395458;4675.392199014123;4252.638525725317;4258.318669012959;4336.956630433687;4396.758178300192;4426.247537918545;4378.430803995476;4385.386045953569;4427.490838553559;4429.424174857264;4453.131639330332;4108.198901214249;4199.559046300155;4201.159768046403;4203.663706903471;4267.231898258312;4320.805563749639;4327.740335579875;4338.370936214263;4346.369776382407;4369.235383807821;4307.396964424983;4314.956850431487;4317.69776115672;4324.805383757738;4362.149380870732;4391.033972526039;4492.281235002384;4496.213162696515;4522.276435770261;4615.030843522864;5003.424606170301;5013.573846223076;5017.096922553938;5021.096202683516;5025.673331233458;5033.84898453047;5034.169362055293;5042.722650254234;5066.873328166826;5086.949130508685;4439.866803995853;4540.477845047796;4542.386777785023;4544.182047231464;4656.604188643969;5082.186850103965;5100.464451232641;5109.591232701375;5111.131107711698;5115;4895.461499235082;4902.558769710672;4909.435414927258;4914;4953.281774142729;4709.293605959134;4795.376601041912;4800.039992001613;4801.4718380978065;4979.626528010342;4834.299026641188;4911.484294149134;4912.975435122801;4942.110420124341;4954.702717836942;4930.531599498042;4964.578010869044;4973.925391119136;4974.104661161025;5018.774155163026;3915.9021024474614;4169.1661667666585;4173.332266837291;4178.435911151955;4218.156368726267;3563.768355056913;3622;3655.8354874030733;3656.5794933582447;3675.650813172744;4276.444062271885;4283.20760659279;4285.935710964338;4288;4329.826806927687;4779.450363208275;4994.700317980933;5007.24891266313;5009.273655319958;5050.595952323805;4151.169766046803;4206.053637931441;4234.618884300427;4238.237117318912;4244.830206791694;4434.7560884151035;4452.48796388413;4454.26504626733;4460.576245256695;4485.887852803706;4552.5447455255535;4754.952450475451;4759.714417134914;4760.738159401266;4794.808207671654;4916.188828843201;4920.778564964657;4932.21084626458;4996.7001979881325;5052.5705315048635;4654.837080702159;4738.194506933898;4749.050189961952;4758.643101767312;4782.904341913212;4581.908361832811;4908.533689299511;4916.8770780730765;4920.483349248278;4971.229459433794;4867.318575399376;4875.585575226146;4890.55984961341;4930.778114984762;4979.900401992012;4813;4845.53967373099;4851.733154676385;4854.90290194187;4895.53492418234;4631;4838.056578967067;4850.1269771441475;4851.9514804852915;4896.338994235875;4614.284785858197;4655.9301610475195;4669.41632295963;4727.763611819327;4790.065937142223;4821.132196204717;4837.588804951478;4843.467218606021;4848.587870031087;4887.266909963534;4568.497465278883;4752.952470475251;4758.1435341638835;4759.024399997923;4789.44921334051 01:22:00 INFO - 2015-11-25 01:22:00,800 DEBUG : BROWSER_OUTPUT: |1;ext.html;565.5786439102869;569.4419468920458;576.6799426318393;577.653407955227;584.8830233953211;28274;28987.130386088425;36952.07619809509;37001.25997480049;37121.814390928004;39693.60306396935;40079.599204008024;40142.19715605686;40190.7990460048;40193.39709904354;7074.1511018677575;7996.960015199945;8193.262606365426;8204.097549269576;8212.096669366365;7134.821629459279;10310.072093511582;10515.789684206311;10517.84223236652;10529.894701053006;9940;10003.649872254473;10013.549390277454;10017.098461138496;10017.449040302781;7221.602811845346;7424.96287518559;10219;10297.742556436075;10334.328268662588;10086.747831304203;10226.693199204035;10227.590896364136;10231.33496322744;10233.437160956144;37486.812565937;38034.04914877123;38048.619513804784;38074.80962595197;38103.80948095242;2860.427914417104;2899.4411193467736;3410.539577157077;3474.930501389958;3674.595794462607;28275.57586636202;28298.575521367195;28770.71229287701;28924.27689307784;29716.257093572618;3367.461206206995;3377.257003459235;3429.5713035870517;3469.757117001811;3470.3059388122224;235044;236242;236821.99999999828;236936;237408;50255;51980;55153;55287.723561381936;56344.154837677466;49828;49923.001539968995;50106;50118.49881501211;50163;13335.333233338295;13515.729685406237;13518.864811351958;13519.256440895846;13528.32358382077;9995.350302230332;10060.24548158891;10065.949670251603;10066.798664026825;10165.4917254137;18875.528111797314;18961.051947402575;19057.80942190588;19060.428187154408;19075.332363367215;6852.657367131624;7070.787876363717;7191.101112360955;7226.458015648847;7312;916.4180745226696;925.8657494663236;942.8915674697498;1043.1706793099352;1054.3989925742253;26195.345116371864;26587.335316616853;26854;27022.864885675444;27097;908.2733812949746;942;976.8485884687884;976.8583555384572;1001.5142655811925;12686.555970540987;13001.544945926848;13185.14296570739;13245.867541324656;13258.469661213636;266344;271808;272056;272660;272711;46289.305660414444;46481;46485.30272045922;46537;46552.67236638154;993.572763711611;1226.9141160118706;1242.465739731924;1244.775940330749;1250.5935570939298;20548.69176962317;25356.36609084714;25620.23139305824;26936.191914242605;28662.570061448678;41999.3700094505;42316;42354.78822605867;42366;42476.57523424726;220297;222067;229196;232108;236755;28554.42891142207;28556.85721571379;28889.855550722114;29087;29266.561001584567;38934.6106538931;39812.601873980886;40062.39906401348;40266.194676105726;40512.1897562053;33545;34106.31787364189;34772.304553908274;34959.475607866414;35348;33288.500672490416;35169;35687.64312356843;35846.82076589705;36637.63362366342;34211.631534738335;34319.31361372808;35078.298434030665;36149.27701445904;37697.2460550793;36004.639953600126;37239;37398.439023414125;37580.624193757714;37588.248235035695;28138.85930570334;28842;28850.567241491815;29274;29400.26499337534 01:22:00 INFO - 2015-11-25 01:22:00,801 DEBUG : BROWSER_OUTPUT: |2;jquery.html;341.4264036418816;341.7624750798195;342.5341535511704;344.626080702438;346.35059263880225;12624.24254544728;13002.349882505885;15011.39954401824;15094.320755566;15978.68042639148;11862.169648124634;15083.547493575183;15223.54329370118;15496;15504.612384690388;4839.588634966023;4961.355023846912;4969.080720066781;4973.651844370896;4977.900441991158;3585.964140358602;3711.1278849470355;4944.060628480595;4945.9258111128365;4973.129702302101;5616.5787565932515;5726.453857458484;5748.741306641211;5787.305523337205;5803.245578074844;5598.24423702799;5732.369439361667;5741.598088133832;5743.712814359265;5755.712214389264;4969.602431805447;4969.676970996874;4978.029284289565;4978.079055374767;4981.501849814989;18596.163172657263;18641.44075677732;18986.43040708781;18988.5252868678;19388.12753426099;1884.9340273090377;1910.9713354299697;1911.6176764647125;1934.41000494849;2219.622664147099;12480.50077996879;12768.63717238762;12915.741685166338;13010.21938683682;13412.530561430303;1790.6239689665185;1813.1115753280797;1815.7276408538694;1817.3366721146817;1819.372316550788;54302.72848635771;56536;56669.71665141689;56759.71620141873;56958.43041569573;9486.95256523713;9592.95203523978;9598.136167744937;9721.513924303756;9776.169025632758;12362.134650574373;12376.690582735504;12391.070669699808;12411.875881241253;12419.254844709347;6446.903296450557;6476.643784591893;6496.252930912911;6501.739930402731;6735.191776986793;5838.4453476919625;5851.853703657443;5890.558208134407;5917.881642367129;5926.051831706906;5665.773369065191;5735.2257445245195;5758.2514273144225;5812.157237200667;5868.530517558671;1578.1241411016995;1666.9166541672869;1684.2000049976164;1700.0734599643224;1706.0360896093666;815.2866242038217;851.8168593752373;853.7694822397917;961.4711908450324;990.7424069741775;15454.613634659;16524.917375413046;17631.382901598638;17762.200700968486;17857.642847142983;727.2291371146601;758.8140905478083;833.8790875323044;880.1550511508896;881.5504092912532;8376.246137847624;8800.075992020873;9022.233110185707;9052.728418147466;9184.357095003286;531648;535749;547916.3437645236;554726;556228;69899;70374.64812676006;71333;71718.2828171722;71747.64126179335;1033.560736686905;1049.511976930731;1057.3655806516183;1057.4184198690689;1058.6771034834296;14436.783448248074;14459.566213013626;14468.204248765998;14496.202708851115;14554.927225363805;31944.68055319417;32327;32399.838000809847;33619.49570756489;34435.82782086074;40607.593924060384;40938.38592421057;41087.38368924528;42118.36822447604;44951.775241123585;8863;9074.410163339362;9350.345475816628;9371.671991480265;9372.531373431437;16499.340026398808;16655.750163747794;16818.747718784474;16900.830991690418;16943.91528042352;13854.376553054935;13905.443782248596;14232;14302.71394572082;14400.495982640557;13362.532311369056;13546.86453135456;13711.314434278445;13713.245771482665;13913.721725565634;13222.4049917752;13927.442902283796;13952.930235348758;14036.78944815808;14368.712625747217;8612.48325100496;8689.17452841979;8775.903012123485;8777.42946708462;8892.244159246537;9515.904840951778;13784.379702913193;13905.652358691113;14039.578812635636;14254.429822806971 01:22:00 INFO - 2015-11-25 01:22:00,804 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1410.0623085648044;1592.6894255620152;1660.1782117851665;1661.9750703739442;1699.7280435130374;5530.834074977752;6582.835429114269;6741.157355330583;6746.9662651686795;6751.459883209343;6754.121964144667;6894.310568943103;6903.378695917367;6908.067410899527;6920.965395173017;1752.0626464841312;1780.172219917738;1781.0471397802178;2052.445839623297;2086.0821238654944;1797.3978717129712;1807.1325763633463;2054.291269512016;2084.8540602157855;2092.6337890869036;2027.8681885677383;2034.6846238833004;2035.2164416699604;2036.8472364572642;2038.1439795285942;2012.6276638821791;2050.8872012039405;2061.6598261286867;2067.865588736727;2070.3064473401428;2024.7367842180422;2038.4190505705803;2039.1333683184587;2065.483629092727;2091.926782562603;6800.285969973131;6800.931990680079;6808.183018037867;6819.556728812611;6821.897671534931;4089.8159582818844;4109.321961876287;4136.131412403399;4173.269677806402;4181.038361176916;2643.246674697721;2687.6506054212828;2730.57676060211;2786.860656967164;2787.3031742064486;847.9236868681786;865.9090795466449;889.2663552569092;890.0698769785589;915.7756349694301;8937.50843703596;8957.417767845069;8969.327300452427;8971.372003959725;8992.955035224848;3822.7132965027736;3855.5373355197557;3911.3546264866545;3927;3927.548331941863;7565.319121279002;7579.204183560647;7582.393408527305;7582.507137036075;7593.5823529706395;4069.104796944667;4101.91796164075;4102.651274641629;4108.424820525129;4113;3746.400575907842;3761.1161377076364;3767.453719210699;3780.981095094507;3786.6402691744242;3308.4044871923284;3373.089265898194;3389.5593572835865;3399.847006884696;3410.4202285611505;940.9811803763887;954.341504361988;1071.1430855315716;1098.1708809848512;1102.5424448853796;811.8051667599851;819.5656302159746;820.1142765813026;823.7199352220274;930.3441074042784;6208.50331973441;6211.65835879022;6214.689265536705;6220.315765265817;6260;1017.4404077757351;1023.4115383654429;1032.2928793776287;1036.2176556699794;1036.8859425463193;4751.881202969884;4793.736344501086;4802.423709154924;4809.038192361541;4809.110314591811;7696.538207707556;7999.080105787909;8209.055958564722;8251.669933202726;8261.421700481029;7678.347340476123;7754.844903102019;7785.961070194726;7793;7802.205492736703;6377.872442551123;6433.839154021093;6456;6468.450181734511;6523.967380163069;5959.910601340896;6065.939340606537;6087.8782424350375;6090.69546522681;6099.817005489843;7121.394681452135;7242.058532390755;7259;7276.963615182102;7382.6677799498075;7337.669804858688;7514.699412023458;7530.472866899265;7532.322091011835;7653.846923061396;6108.389161083856;6176.166217560572;6182.7217775201125;6183.072539119168;6194.5354098443695;6489.1888513935755;6500.837479063061;6563.540552161494;6565.310642382672;6592.967035164986;6057.515398768176;6059.33347331802;6081.772145583251;6189.721462534107;6200.844978875564;5996.730147143477;6020.608660437058;6027.819165425044;6070.423309785563;6130.570860039755;6055.788047418319;6068.908966365596;6105.114758359924;6122.142899993915;6123.9693801532485;5498.202760599771;5707.514861236841;5745.770169193185;5752.33848107473;5772.076467765138;5789.594728368974;5807.332156801853;5810.970945145247;5814.796482123105;5821.505172060422 01:22:00 INFO - 2015-11-25 01:22:00,806 DEBUG : BROWSER_OUTPUT: |4;prototype.html;304.58424250897525;311.08230719377826;311.56692197844984;311.7755216244303;313.89484522684893;5150.562202212812;5212.166053431447;5233.947660523394;5235.84292471226;5239.083160446926;5177.741112944356;5193.402758682752;5195.272661827347;5204.32343795307;5214.243934629486;3927.5483319418204;4026.879193624196;4162.458880345566;4175.54069052404;4178.937315940263;4059.9594004060023;4105.712600117993;4127.401526778615;4140.0270936329935;4143.4199212110325;4090.284200264957;4099.89750256243;4104.97947510262;4105;4112.342025275956;3911.3937339712247;3998.300297447935;4038.697097717683;4111.342185250361;4114.074333275019;3651.233241019389;3665.9083522911874;3667.504886840269;3668.596454390015;3675.117971686803;5026.145555255579;5027.824026159067;5038.672486288379;5045.823396181153;5048.091343558158;4753.191957367256;4760.928586071212;4765.499622539618;4766.356541866873;4767.69010014348;5437.6465529740835;5537.418571050062;5546.584006199551;5554.333479982388;5571.749271282802;3970.66249368804;3972.602739726033;3974.3839704845795;3978.5822488638855;3979.1643754811525;5856.472917437409;5865.413458654143;5870.97064514679;5871.2073870027425;5872.412758724136;4079.7144199906315;4083.34666453372;4089.5297040840683;4099.282625540519;4104.199681062164;4062.837486500566;4165.333546632524;4170.020045289354;4170.35359519275;4185.24665560196;4727.7163370197895;4733.786979585927;4734.029523947583;4735.12400205963;4746.644001699887;5585.916211256835;5595.188697638901;5597.356304025007;5598.888022239614;5600.159976003551;1457.2203870929213;1467.1783801071433;1473.351725240912;1473.6315921019745;1481.1557412275115;1015.4871789746279;1017.8778546574458;1023.518946095334;1029.902159294866;1043.5669197283194;4852.490488498727;4880.902381952341;4887.902241955141;4892.951070489249;4893.412790465167;5771.480566749013;5772.5670574707065;5772.913406298909;5779.075347944308;5779.393163717833;4886.755662216875;4889.3888263967;4890.804367825247;4894.143524883202;4896.387951506062;2916.4992086056177;2956.9556456652736;3007.3912153832944;3085.5834462347298;3124.937501249962;5367.973160134175;5473.863153421196;5495.780168793203;5498.8075417361;5502.257195278667;5958.165856780054;5960.433758792908;5967.6419414835245;5975.701214939236;5978.641281523122;5313.574914006793;5451.809186678447;5466.508014278734;5471.343438787371;5476.835694929238;5813.418658134153;5820.447057529528;5820.563457740602;5837.912431313449;5842.357340692605;5714.457126572969;5722.055860783091;5722.942770572407;5724.227229324155;5724.627899186539;5483.588730845282;5483.8080667176455;5487.560995120461;5494.890102197854;5496.708273555631;3864.4976153099915;3992.1017771001293;3993.660538854114;4103.733257338264;4111.732737372061;5774.566907481872;5774.797882074107;5776.480116789509;5777.480026797609;5780.826575202751;5579.163125531203;5584.274044374205;5584.86037849057;5586.636868603528;5590.972045139748;5457.7271136443815;5570.554355651457;5574.08027675429;5578.944210557843;5582.944170558242;5516.779328826802;5522.641028333145;5522.944770552243;5529.253550770755;5530.474604912527;5667.619599768025;5668.716564171693;5677.1768093627015;5679;5679.375268720355;5531.778728850801;5532.03189441838;5537;5540.501354877919;5542.63972841764 01:22:00 INFO - 2015-11-25 01:22:00,806 DEBUG : BROWSER_OUTPUT: |5;yui.html;591.4292707537226;613.7268915332679;671.0839703804305;733.6038539188837;752.7478294771253;11542.307461552302;11732.120090993189;11772.587959421433;11814.940925295372;11872.7625447491;10892.019718225358;10921.290116142445;11016.559337626486;11017.44912754361;11027.283226590285;599.4365296621183;600.9399060093978;750.2235186581876;758.4614923404389;762.4815125714512;748.5246868238653;753.4575105923726;754.4077898849405;754.7320701151067;757.685560492395;791.0230864881867;793.3018943329862;793.305857374797;793.3256731777972;794.737736546941;628.691940948934;630.4987534909735;778.634042000259;781.6248200863561;788.6372268756379;578.2482772395869;579.2556564814194;581.5870731780441;583.0554501707219;584.1471451680552;10847.02376786093;10948.835767463494;10957.890421095766;10959.342439453658;10982.06652434544;10584.153267738562;11390.487428065757;11408.71478213043;11687.41562921859;11738.06095512357;9497.857532137023;9522;9582.425054496753;9601.711948641552;9669.90330096704;3242.8054316740836;3289.4243507386113;3296.423125952949;3300.1254667513126;3306.2230375861654;43033.1393372134;43081;43469.78265108686;43712.34431483498;43810;9042.3542436528;9353.532323383804;9649;9662.903370966342;9728.464934428534;16414.507564773077;16420.01479911209;16435.5891102721;16436.260368283456;16475.752863707054;6041.909371359433;6103.298120716086;6121.418465245794;6155.538334624921;6360.681965901686;3548.8757893473603;3570.107473131717;3596.4065929121925;3598.784072955631;3630.7276954228537;2770.279727270924;2772.2514920971225;2798.3423895384567;2804.971950280512;2808;484.5808375754947;491.2851800630075;491.56005375189005;493.3586337760897;525.6845892464568;536.1769683535754;541.775163307231;559.9020171469977;570.1106274212242;574.5202755698955;7469.365103966224;7559.357454616309;7560.9621951889885;7690.846183076307;7720.073591169095;386.48597365503815;420.9410682504452;438.5439143291005;518.028696194635;556.1407625218966;3338.2822693121097;3388.423967925459;3502.1594817244186;3548.840302186408;3575.4994300797907;47450.28824567634;48467.5153248463;48977.75511122493;49368.25947610789;49790;43752.781236094255;44527.33209001867;44719.32921006188;44801.77599111984;45079.32381014287;41577.584224157974;41687;41909.371359429635;41939.580604193565;42221.788891055345;7148.883486179042;7353.338199561851;7421.443391745533;7421.517601355895;7425.9628701856145;30320.848395758763;30767.538486922265;31390.68609313969;31435.685643143275;31535.47716182654;41172.588274118076;41233.793831030656;41509.37735933903;41885.79057104695;41960.79019604882;9398.201152901807;9472.715818525456;9507.904920950701;9771.657991970247;9793.755156121155;10684.89315106839;10717.839232411365;10804.837927430937;10831.783364332827;11304.321740695585;9673.516324183622;9769.804603908024;9775.120239178508;9884.950575247078;10008.299419040888;10089.89910100919;10108.646197383056;10146.441945693057;10479.318844275098;10665.360078395011;9756.902430975599;9804.117629413387;9821.5089245536;9927;10119.696409107739;8799.868001979847;8868.600912958804;8882.689105881263;9156.771080723036;9187.67843125514;7894.9199375801645;8249.79375515593;8685.435446695945;8923.955380223057;8955.955220223857 01:22:00 INFO - 2015-11-25 01:22:00,806 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:22:00 INFO - 2015-11-25 01:22:00,806 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:22:00 INFO - 2015-11-25 01:22:00,806 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,925 01:22:00 INFO - 2015-11-25 01:22:00,806 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:22:00 INFO - 2015-11-25 01:22:00,806 DEBUG : BROWSER_OUTPUT: __startTimestamp1448443320793__endTimestamp 01:22:00 INFO - 2015-11-25 01:22:00,806 DEBUG : BROWSER_OUTPUT: 01:22:00 INFO - 2015-11-25 01:22:00,806 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:22:00 INFO - 2015-11-25 01:22:00,807 DEBUG : BROWSER_OUTPUT: Number of tests: 6 01:22:00 INFO - 2015-11-25 01:22:00,807 DEBUG : BROWSER_OUTPUT: 01:22:00 INFO - 2015-11-25 01:22:00,807 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4577.03 Median:4675.39 stddev:470.89 (10.1%) stddev-sans-first:445.81 01:22:00 INFO - 2015-11-25 01:22:00,808 DEBUG : BROWSER_OUTPUT: Values: 2590.9 2693.1 2709.3 2721.5 2729.2 4475.8 4483.2 4554.9 4590.0 4597.8 4439.5 4526.9 4530.9 4539.5 4675.4 4252.6 4258.3 4337.0 4396.8 4426.2 4378.4 4385.4 4427.5 4429.4 4453.1 4108.2 4199.6 4201.2 4203.7 4267.2 4320.8 4327.7 4338.4 4346.4 4369.2 4307.4 4315.0 4317.7 4324.8 4362.1 4391.0 4492.3 4496.2 4522.3 4615.0 5003.4 5013.6 5017.1 5021.1 5025.7 5033.8 5034.2 5042.7 5066.9 5086.9 4439.9 4540.5 4542.4 4544.2 4656.6 5082.2 5100.5 5109.6 5111.1 5115.0 4895.5 4902.6 4909.4 4914.0 4953.3 4709.3 4795.4 4800.0 4801.5 4979.6 4834.3 4911.5 4913.0 4942.1 4954.7 4930.5 4964.6 4973.9 4974.1 5018.8 3915.9 4169.2 4173.3 4178.4 4218.2 3563.8 3622.0 3655.8 3656.6 3675.7 4276.4 4283.2 4285.9 4288.0 4329.8 4779.5 4994.7 5007.2 5009.3 5050.6 4151.2 4206.1 4234.6 4238.2 4244.8 4434.8 4452.5 4454.3 4460.6 4485.9 4552.5 4755.0 4759.7 4760.7 4794.8 4916.2 4920.8 4932.2 4996.7 5052.6 4654.8 4738.2 4749.1 4758.6 4782.9 4581.9 4908.5 4916.9 4920.5 4971.2 4867.3 4875.6 4890.6 4930.8 4979.9 4813.0 4845.5 4851.7 4854.9 4895.5 4631.0 4838.1 4850.1 4852.0 4896.3 4614.3 4655.9 4669.4 4727.8 4790.1 4821.1 4837.6 4843.5 4848.6 4887.3 4568.5 4753.0 4758.1 4759.0 4789.4 01:22:00 INFO - 2015-11-25 01:22:00,808 DEBUG : BROWSER_OUTPUT: 01:22:00 INFO - 2015-11-25 01:22:00,808 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41148.71 Median:18758.43 stddev:63856.51 (340.4%) stddev-sans-first:63962.94 01:22:00 INFO - 2015-11-25 01:22:00,808 DEBUG : BROWSER_OUTPUT: Values: 565.6 569.4 576.7 577.7 584.9 28274.0 28987.1 36952.1 37001.3 37121.8 39693.6 40079.6 40142.2 40190.8 40193.4 7074.2 7997.0 8193.3 8204.1 8212.1 7134.8 10310.1 10515.8 10517.8 10529.9 9940.0 10003.6 10013.5 10017.1 10017.4 7221.6 7425.0 10219.0 10297.7 10334.3 10086.7 10226.7 10227.6 10231.3 10233.4 37486.8 38034.0 38048.6 38074.8 38103.8 2860.4 2899.4 3410.5 3474.9 3674.6 28275.6 28298.6 28770.7 28924.3 29716.3 3367.5 3377.3 3429.6 3469.8 3470.3 235044.0 236242.0 236822.0 236936.0 237408.0 50255.0 51980.0 55153.0 55287.7 56344.2 49828.0 49923.0 50106.0 50118.5 50163.0 13335.3 13515.7 13518.9 13519.3 13528.3 9995.4 10060.2 10065.9 10066.8 10165.5 18875.5 18961.1 19057.8 19060.4 19075.3 6852.7 7070.8 7191.1 7226.5 7312.0 916.4 925.9 942.9 1043.2 1054.4 26195.3 26587.3 26854.0 27022.9 27097.0 908.3 942.0 976.8 976.9 1001.5 12686.6 13001.5 13185.1 13245.9 13258.5 266344.0 271808.0 272056.0 272660.0 272711.0 46289.3 46481.0 46485.3 46537.0 46552.7 993.6 1226.9 1242.5 1244.8 1250.6 20548.7 25356.4 25620.2 26936.2 28662.6 41999.4 42316.0 42354.8 42366.0 42476.6 220297.0 222067.0 229196.0 232108.0 236755.0 28554.4 28556.9 28889.9 29087.0 29266.6 38934.6 39812.6 40062.4 40266.2 40512.2 33545.0 34106.3 34772.3 34959.5 35348.0 33288.5 35169.0 35687.6 35846.8 36637.6 34211.6 34319.3 35078.3 36149.3 37697.2 36004.6 37239.0 37398.4 37580.6 37588.2 28138.9 28842.0 28850.6 29274.0 29400.3 01:22:00 INFO - 2015-11-25 01:22:00,808 DEBUG : BROWSER_OUTPUT: 01:22:00 INFO - 2015-11-25 01:22:00,808 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28130.83 Median:22159.36 stddev:88941.27 (401.4%) stddev-sans-first:89166.29 01:22:00 INFO - 2015-11-25 01:22:00,808 DEBUG : BROWSER_OUTPUT: Values: 341.4 341.8 342.5 344.6 346.4 12624.2 13002.3 15011.4 15094.3 15978.7 11862.2 15083.5 15223.5 15496.0 15504.6 4839.6 4961.4 4969.1 4973.7 4977.9 3586.0 3711.1 4944.1 4945.9 4973.1 5616.6 5726.5 5748.7 5787.3 5803.2 5598.2 5732.4 5741.6 5743.7 5755.7 4969.6 4969.7 4978.0 4978.1 4981.5 18596.2 18641.4 18986.4 18988.5 19388.1 1884.9 1911.0 1911.6 1934.4 2219.6 12480.5 12768.6 12915.7 13010.2 13412.5 1790.6 1813.1 1815.7 1817.3 1819.4 54302.7 56536.0 56669.7 56759.7 56958.4 9487.0 9593.0 9598.1 9721.5 9776.2 12362.1 12376.7 12391.1 12411.9 12419.3 6446.9 6476.6 6496.3 6501.7 6735.2 5838.4 5851.9 5890.6 5917.9 5926.1 5665.8 5735.2 5758.3 5812.2 5868.5 1578.1 1666.9 1684.2 1700.1 1706.0 815.3 851.8 853.8 961.5 990.7 15454.6 16524.9 17631.4 17762.2 17857.6 727.2 758.8 833.9 880.2 881.6 8376.2 8800.1 9022.2 9052.7 9184.4 531648.0 535749.0 547916.3 554726.0 556228.0 69899.0 70374.6 71333.0 71718.3 71747.6 1033.6 1049.5 1057.4 1057.4 1058.7 14436.8 14459.6 14468.2 14496.2 14554.9 31944.7 32327.0 32399.8 33619.5 34435.8 40607.6 40938.4 41087.4 42118.4 44951.8 8863.0 9074.4 9350.3 9371.7 9372.5 16499.3 16655.8 16818.7 16900.8 16943.9 13854.4 13905.4 14232.0 14302.7 14400.5 13362.5 13546.9 13711.3 13713.2 13913.7 13222.4 13927.4 13952.9 14036.8 14368.7 8612.5 8689.2 8775.9 8777.4 8892.2 9515.9 13784.4 13905.7 14039.6 14254.4 01:22:00 INFO - 2015-11-25 01:22:00,809 DEBUG : BROWSER_OUTPUT: 01:22:00 INFO - 2015-11-25 01:22:00,809 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4741.99 Median:6062.64 stddev:2396.02 (39.5%) stddev-sans-first:2389.66 01:22:00 INFO - 2015-11-25 01:22:00,810 DEBUG : BROWSER_OUTPUT: Values: 1410.1 1592.7 1660.2 1662.0 1699.7 5530.8 6582.8 6741.2 6747.0 6751.5 6754.1 6894.3 6903.4 6908.1 6921.0 1752.1 1780.2 1781.0 2052.4 2086.1 1797.4 1807.1 2054.3 2084.9 2092.6 2027.9 2034.7 2035.2 2036.8 2038.1 2012.6 2050.9 2061.7 2067.9 2070.3 2024.7 2038.4 2039.1 2065.5 2091.9 6800.3 6800.9 6808.2 6819.6 6821.9 4089.8 4109.3 4136.1 4173.3 4181.0 2643.2 2687.7 2730.6 2786.9 2787.3 847.9 865.9 889.3 890.1 915.8 8937.5 8957.4 8969.3 8971.4 8993.0 3822.7 3855.5 3911.4 3927.0 3927.5 7565.3 7579.2 7582.4 7582.5 7593.6 4069.1 4101.9 4102.7 4108.4 4113.0 3746.4 3761.1 3767.5 3781.0 3786.6 3308.4 3373.1 3389.6 3399.8 3410.4 941.0 954.3 1071.1 1098.2 1102.5 811.8 819.6 820.1 823.7 930.3 6208.5 6211.7 6214.7 6220.3 6260.0 1017.4 1023.4 1032.3 1036.2 1036.9 4751.9 4793.7 4802.4 4809.0 4809.1 7696.5 7999.1 8209.1 8251.7 8261.4 7678.3 7754.8 7786.0 7793.0 7802.2 6377.9 6433.8 6456.0 6468.5 6524.0 5959.9 6065.9 6087.9 6090.7 6099.8 7121.4 7242.1 7259.0 7277.0 7382.7 7337.7 7514.7 7530.5 7532.3 7653.8 6108.4 6176.2 6182.7 6183.1 6194.5 6489.2 6500.8 6563.5 6565.3 6593.0 6057.5 6059.3 6081.8 6189.7 6200.8 5996.7 6020.6 6027.8 6070.4 6130.6 6055.8 6068.9 6105.1 6122.1 6124.0 5498.2 5707.5 5745.8 5752.3 5772.1 5789.6 5807.3 5811.0 5814.8 5821.5 01:22:00 INFO - 2015-11-25 01:22:00,810 DEBUG : BROWSER_OUTPUT: 01:22:00 INFO - 2015-11-25 01:22:00,810 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4642.10 Median:5164.15 stddev:1353.46 (26.2%) stddev-sans-first:1317.52 01:22:00 INFO - 2015-11-25 01:22:00,810 DEBUG : BROWSER_OUTPUT: Values: 304.6 311.1 311.6 311.8 313.9 5150.6 5212.2 5233.9 5235.8 5239.1 5177.7 5193.4 5195.3 5204.3 5214.2 3927.5 4026.9 4162.5 4175.5 4178.9 4060.0 4105.7 4127.4 4140.0 4143.4 4090.3 4099.9 4105.0 4105.0 4112.3 3911.4 3998.3 4038.7 4111.3 4114.1 3651.2 3665.9 3667.5 3668.6 3675.1 5026.1 5027.8 5038.7 5045.8 5048.1 4753.2 4760.9 4765.5 4766.4 4767.7 5437.6 5537.4 5546.6 5554.3 5571.7 3970.7 3972.6 3974.4 3978.6 3979.2 5856.5 5865.4 5871.0 5871.2 5872.4 4079.7 4083.3 4089.5 4099.3 4104.2 4062.8 4165.3 4170.0 4170.4 4185.2 4727.7 4733.8 4734.0 4735.1 4746.6 5585.9 5595.2 5597.4 5598.9 5600.2 1457.2 1467.2 1473.4 1473.6 1481.2 1015.5 1017.9 1023.5 1029.9 1043.6 4852.5 4880.9 4887.9 4893.0 4893.4 5771.5 5772.6 5772.9 5779.1 5779.4 4886.8 4889.4 4890.8 4894.1 4896.4 2916.5 2957.0 3007.4 3085.6 3124.9 5368.0 5473.9 5495.8 5498.8 5502.3 5958.2 5960.4 5967.6 5975.7 5978.6 5313.6 5451.8 5466.5 5471.3 5476.8 5813.4 5820.4 5820.6 5837.9 5842.4 5714.5 5722.1 5722.9 5724.2 5724.6 5483.6 5483.8 5487.6 5494.9 5496.7 3864.5 3992.1 3993.7 4103.7 4111.7 5774.6 5774.8 5776.5 5777.5 5780.8 5579.2 5584.3 5584.9 5586.6 5591.0 5457.7 5570.6 5574.1 5578.9 5582.9 5516.8 5522.6 5522.9 5529.3 5530.5 5667.6 5668.7 5677.2 5679.0 5679.4 5531.8 5532.0 5537.0 5540.5 5542.6 01:22:00 INFO - 2015-11-25 01:22:00,810 DEBUG : BROWSER_OUTPUT: 01:22:00 INFO - 2015-11-25 01:22:00,811 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12216.84 Median:492.46 stddev:14132.18 (2869.7%) stddev-sans-first:14144.86 01:22:00 INFO - 2015-11-25 01:22:00,812 DEBUG : BROWSER_OUTPUT: Values: 591.4 613.7 671.1 733.6 752.7 11542.3 11732.1 11772.6 11814.9 11872.8 10892.0 10921.3 11016.6 11017.4 11027.3 599.4 600.9 750.2 758.5 762.5 748.5 753.5 754.4 754.7 757.7 791.0 793.3 793.3 793.3 794.7 628.7 630.5 778.6 781.6 788.6 578.2 579.3 581.6 583.1 584.1 10847.0 10948.8 10957.9 10959.3 10982.1 10584.2 11390.5 11408.7 11687.4 11738.1 9497.9 9522.0 9582.4 9601.7 9669.9 3242.8 3289.4 3296.4 3300.1 3306.2 43033.1 43081.0 43469.8 43712.3 43810.0 9042.4 9353.5 9649.0 9662.9 9728.5 16414.5 16420.0 16435.6 16436.3 16475.8 6041.9 6103.3 6121.4 6155.5 6360.7 3548.9 3570.1 3596.4 3598.8 3630.7 2770.3 2772.3 2798.3 2805.0 2808.0 484.6 491.3 491.6 493.4 525.7 536.2 541.8 559.9 570.1 574.5 7469.4 7559.4 7561.0 7690.8 7720.1 386.5 420.9 438.5 518.0 556.1 3338.3 3388.4 3502.2 3548.8 3575.5 47450.3 48467.5 48977.8 49368.3 49790.0 43752.8 44527.3 44719.3 44801.8 45079.3 41577.6 41687.0 41909.4 41939.6 42221.8 7148.9 7353.3 7421.4 7421.5 7426.0 30320.8 30767.5 31390.7 31435.7 31535.5 41172.6 41233.8 41509.4 41885.8 41960.8 9398.2 9472.7 9507.9 9771.7 9793.8 10684.9 10717.8 10804.8 10831.8 11304.3 9673.5 9769.8 9775.1 9885.0 10008.3 10089.9 10108.6 10146.4 10479.3 10665.4 9756.9 9804.1 9821.5 9927.0 10119.7 8799.9 8868.6 8882.7 9156.8 9187.7 7894.9 8249.8 8685.4 8924.0 8956.0 01:22:00 INFO - 2015-11-25 01:22:00,812 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:22:00 INFO - 2015-11-25 01:22:00,812 DEBUG : BROWSER_OUTPUT: 01:22:01 INFO - 2015-11-25 01:22:01,549 INFO : Browser exited with error code: 0 01:22:01 INFO - 2015-11-25 01:22:01,568 INFO : Completed test dromaeo_css (00:18:36) 01:22:01 INFO - 2015-11-25 01:22:01,568 INFO : Starting test kraken 01:22:01 INFO - 2015-11-25 01:22:01,568 DEBUG : operating with platform_type : linux_ 01:22:01 INFO - 2015-11-25 01:22:01,568 INFO : Initialising browser for kraken test... 01:22:01 INFO - 2015-11-25 01:22:01,574 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0zkOt9/profile http://localhost:43059/getInfo.html 01:22:05 INFO - 2015-11-25 01:22:05,583 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:22:05 INFO - 2015-11-25 01:22:05,583 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:22:05 INFO - 2015-11-25 01:22:05,583 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:22:05 INFO - 2015-11-25 01:22:05,583 DEBUG : BROWSER_OUTPUT: __metrics 01:22:05 INFO - 2015-11-25 01:22:05,692 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] 01:22:06 INFO - 2015-11-25 01:22:06,994 INFO : Browser initialized. 01:22:06 INFO - 2015-11-25 01:22:06,995 INFO : Running cycle 1/1 for kraken test... 01:22:06 INFO - 2015-11-25 01:22:06,995 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0zkOt9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:22:18 INFO - 2015-11-25 01:22:18,858 DEBUG : BROWSER_OUTPUT: RSS: Main: 138833920 01:22:18 INFO - 2015-11-25 01:22:18,858 DEBUG : BROWSER_OUTPUT: 01:22:21 INFO - 2015-11-25 01:22:21,440 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43059/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43059/tests/kraken/driver.html?testName=audio-beat-detection) 01:22:22 INFO - 2015-11-25 01:22:22,021 DEBUG : BROWSER_OUTPUT: RSS: Main: 177889280 01:22:22 INFO - 2015-11-25 01:22:22,021 DEBUG : BROWSER_OUTPUT: 01:22:24 INFO - 2015-11-25 01:22:24,723 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43059/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43059/tests/kraken/driver.html?testName=audio-dft) 01:22:25 INFO - 2015-11-25 01:22:25,306 DEBUG : BROWSER_OUTPUT: RSS: Main: 166862848 01:22:25 INFO - 2015-11-25 01:22:25,307 DEBUG : BROWSER_OUTPUT: 01:22:28 INFO - 2015-11-25 01:22:28,252 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43059/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43059/tests/kraken/driver.html?testName=audio-fft) 01:22:28 INFO - 2015-11-25 01:22:28,818 DEBUG : BROWSER_OUTPUT: RSS: Main: 151719936 01:22:28 INFO - 2015-11-25 01:22:28,818 DEBUG : BROWSER_OUTPUT: 01:22:30 INFO - 2015-11-25 01:22:30,859 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43059/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43059/tests/kraken/driver.html?testName=audio-oscillator) 01:22:31 INFO - 2015-11-25 01:22:31,440 DEBUG : BROWSER_OUTPUT: RSS: Main: 152940544 01:22:31 INFO - 2015-11-25 01:22:31,440 DEBUG : BROWSER_OUTPUT: 01:22:33 INFO - 2015-11-25 01:22:33,660 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43059/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43059/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:22:34 INFO - 2015-11-25 01:22:34,229 DEBUG : BROWSER_OUTPUT: RSS: Main: 154640384 01:22:34 INFO - 2015-11-25 01:22:34,229 DEBUG : BROWSER_OUTPUT: 01:22:37 INFO - 2015-11-25 01:22:37,208 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43059/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43059/tests/kraken/driver.html?testName=imaging-darkroom) 01:22:37 INFO - 2015-11-25 01:22:37,781 DEBUG : BROWSER_OUTPUT: RSS: Main: 154877952 01:22:37 INFO - 2015-11-25 01:22:37,781 DEBUG : BROWSER_OUTPUT: 01:22:41 INFO - 2015-11-25 01:22:41,207 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43059/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43059/tests/kraken/driver.html?testName=imaging-desaturate) 01:22:41 INFO - 2015-11-25 01:22:41,789 DEBUG : BROWSER_OUTPUT: RSS: Main: 155947008 01:22:41 INFO - 2015-11-25 01:22:41,789 DEBUG : BROWSER_OUTPUT: 01:22:44 INFO - 2015-11-25 01:22:44,591 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43059/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43059/tests/kraken/driver.html?testName=json-parse-financial) 01:22:45 INFO - 2015-11-25 01:22:45,172 DEBUG : BROWSER_OUTPUT: RSS: Main: 155332608 01:22:45 INFO - 2015-11-25 01:22:45,172 DEBUG : BROWSER_OUTPUT: 01:22:46 INFO - 2015-11-25 01:22:46,942 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43059/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43059/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:22:47 INFO - 2015-11-25 01:22:47,503 DEBUG : BROWSER_OUTPUT: RSS: Main: 168722432 01:22:47 INFO - 2015-11-25 01:22:47,503 DEBUG : BROWSER_OUTPUT: 01:22:49 INFO - 2015-11-25 01:22:49,357 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43059/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43059/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:22:49 INFO - 2015-11-25 01:22:49,960 DEBUG : BROWSER_OUTPUT: RSS: Main: 167129088 01:22:49 INFO - 2015-11-25 01:22:49,960 DEBUG : BROWSER_OUTPUT: 01:22:52 INFO - 2015-11-25 01:22:52,084 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43059/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43059/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:22:52 INFO - 2015-11-25 01:22:52,665 DEBUG : BROWSER_OUTPUT: RSS: Main: 174571520 01:22:52 INFO - 2015-11-25 01:22:52,666 DEBUG : BROWSER_OUTPUT: 01:22:55 INFO - 2015-11-25 01:22:55,221 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43059/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43059/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:22:55 INFO - 2015-11-25 01:22:55,814 DEBUG : BROWSER_OUTPUT: RSS: Main: 181878784 01:22:55 INFO - 2015-11-25 01:22:55,815 DEBUG : BROWSER_OUTPUT: 01:22:58 INFO - 2015-11-25 01:22:58,429 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43059/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43059/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:22:59 INFO - 2015-11-25 01:22:59,002 DEBUG : BROWSER_OUTPUT: RSS: Main: 179200000 01:22:59 INFO - 2015-11-25 01:22:59,003 DEBUG : BROWSER_OUTPUT: 01:23:00 INFO - 2015-11-25 01:23:00,744 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43059/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43059/tests/kraken/driver.html?testName=ai-astar) 01:23:00 INFO - 2015-11-25 01:23:00,994 DEBUG : BROWSER_OUTPUT: RSS: Main: 239448064 01:23:00 INFO - 2015-11-25 01:23:00,994 DEBUG : BROWSER_OUTPUT: 01:23:00 INFO - 2015-11-25 01:23:00,997 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:23:00 INFO - 2015-11-25 01:23:00,997 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:23:00 INFO - 2015-11-25 01:23:00,997 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:23:00 INFO - 2015-11-25 01:23:00,997 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:23:00 INFO - 2015-11-25 01:23:00,997 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;113;107;114;112;114;103;112;112;105 01:23:00 INFO - 2015-11-25 01:23:00,998 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;129;161;166;131;153;157;131;164;139 01:23:00 INFO - 2015-11-25 01:23:00,998 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;160;160;161;160;160;162;162;162 01:23:00 INFO - 2015-11-25 01:23:00,998 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;80;105;72;72;71;92;91;75 01:23:00 INFO - 2015-11-25 01:23:00,998 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;94;132;94;95;94;130;94;95;133 01:23:00 INFO - 2015-11-25 01:23:00,998 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;110;109;110;109;110;110;110 01:23:00 INFO - 2015-11-25 01:23:00,998 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;148;146;146;147;146;146;146;147;146 01:23:00 INFO - 2015-11-25 01:23:00,998 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;95;95;95;95;95;95;95 01:23:01 INFO - 2015-11-25 01:23:00,998 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;72;71;72;72;71;72;71;72;73 01:23:01 INFO - 2015-11-25 01:23:00,998 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;70;68;69;69;69;69;69;69;71 01:23:01 INFO - 2015-11-25 01:23:00,998 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;83;84;83;84;84;84;83;84;83 01:23:01 INFO - 2015-11-25 01:23:00,998 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;126;128;127;130;123;122;127;120;133;123 01:23:01 INFO - 2015-11-25 01:23:00,998 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;139;151;146;160;137;138;148;146;135 01:23:01 INFO - 2015-11-25 01:23:00,998 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;67;68;71;69;67;69;68;70;67 01:23:01 INFO - 2015-11-25 01:23:00,998 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:23:01 INFO - 2015-11-25 01:23:00,998 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:23:01 INFO - 2015-11-25 01:23:00,998 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,987 01:23:01 INFO - 2015-11-25 01:23:00,999 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:23:01 INFO - 2015-11-25 01:23:00,999 DEBUG : BROWSER_OUTPUT: __startTimestamp1448443380996__endTimestamp 01:23:01 INFO - 2015-11-25 01:23:00,999 DEBUG : BROWSER_OUTPUT: 01:23:01 INFO - 2015-11-25 01:23:01,002 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:23:01 INFO - 2015-11-25 01:23:01,002 DEBUG : BROWSER_OUTPUT: Number of tests: 14 01:23:01 INFO - 2015-11-25 01:23:01,002 DEBUG : BROWSER_OUTPUT: 01:23:01 INFO - 2015-11-25 01:23:01,002 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.20 Median:112.00 stddev:3.88 (3.5%) stddev-sans-first:4.12 01:23:01 INFO - 2015-11-25 01:23:01,002 DEBUG : BROWSER_OUTPUT: Values: 110.0 113.0 107.0 114.0 112.0 114.0 103.0 112.0 112.0 105.0 01:23:01 INFO - 2015-11-25 01:23:01,002 DEBUG : BROWSER_OUTPUT: 01:23:01 INFO - 2015-11-25 01:23:01,002 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.10 Median:155.00 stddev:14.45 (9.3%) stddev-sans-first:15.31 01:23:01 INFO - 2015-11-25 01:23:01,002 DEBUG : BROWSER_OUTPUT: Values: 150.0 129.0 161.0 166.0 131.0 153.0 157.0 131.0 164.0 139.0 01:23:01 INFO - 2015-11-25 01:23:01,002 DEBUG : BROWSER_OUTPUT: 01:23:01 INFO - 2015-11-25 01:23:01,003 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.00 Median:161.50 stddev:0.94 (0.6%) stddev-sans-first:1.00 01:23:01 INFO - 2015-11-25 01:23:01,003 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 160.0 160.0 161.0 160.0 160.0 162.0 162.0 162.0 01:23:01 INFO - 2015-11-25 01:23:01,003 DEBUG : BROWSER_OUTPUT: 01:23:01 INFO - 2015-11-25 01:23:01,003 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.30 Median:74.00 stddev:11.72 (15.8%) stddev-sans-first:12.04 01:23:01 INFO - 2015-11-25 01:23:01,003 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 80.0 105.0 72.0 72.0 71.0 92.0 91.0 75.0 01:23:01 INFO - 2015-11-25 01:23:01,003 DEBUG : BROWSER_OUTPUT: 01:23:01 INFO - 2015-11-25 01:23:01,003 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.60 Median:94.00 stddev:18.01 (19.2%) stddev-sans-first:18.69 01:23:01 INFO - 2015-11-25 01:23:01,003 DEBUG : BROWSER_OUTPUT: Values: 95.0 94.0 132.0 94.0 95.0 94.0 130.0 94.0 95.0 133.0 01:23:01 INFO - 2015-11-25 01:23:01,003 DEBUG : BROWSER_OUTPUT: 01:23:01 INFO - 2015-11-25 01:23:01,003 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 01:23:01 INFO - 2015-11-25 01:23:01,003 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 110.0 109.0 110.0 109.0 110.0 110.0 110.0 01:23:01 INFO - 2015-11-25 01:23:01,003 DEBUG : BROWSER_OUTPUT: 01:23:01 INFO - 2015-11-25 01:23:01,003 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 01:23:01 INFO - 2015-11-25 01:23:01,004 DEBUG : BROWSER_OUTPUT: Values: 146.0 148.0 146.0 146.0 147.0 146.0 146.0 146.0 147.0 146.0 01:23:01 INFO - 2015-11-25 01:23:01,004 DEBUG : BROWSER_OUTPUT: 01:23:01 INFO - 2015-11-25 01:23:01,004 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 01:23:01 INFO - 2015-11-25 01:23:01,004 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 01:23:01 INFO - 2015-11-25 01:23:01,004 DEBUG : BROWSER_OUTPUT: 01:23:01 INFO - 2015-11-25 01:23:01,004 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.90 Median:72.00 stddev:0.74 (1.0%) stddev-sans-first:0.67 01:23:01 INFO - 2015-11-25 01:23:01,004 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 71.0 72.0 72.0 71.0 72.0 71.0 72.0 73.0 01:23:01 INFO - 2015-11-25 01:23:01,004 DEBUG : BROWSER_OUTPUT: 01:23:01 INFO - 2015-11-25 01:23:01,004 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:69.00 stddev:0.88 (1.3%) stddev-sans-first:0.83 01:23:01 INFO - 2015-11-25 01:23:01,004 DEBUG : BROWSER_OUTPUT: Values: 68.0 70.0 68.0 69.0 69.0 69.0 69.0 69.0 69.0 71.0 01:23:01 INFO - 2015-11-25 01:23:01,004 DEBUG : BROWSER_OUTPUT: 01:23:01 INFO - 2015-11-25 01:23:01,004 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:84.00 stddev:0.52 (0.6%) stddev-sans-first:0.53 01:23:01 INFO - 2015-11-25 01:23:01,005 DEBUG : BROWSER_OUTPUT: Values: 84.0 83.0 84.0 83.0 84.0 84.0 84.0 83.0 84.0 83.0 01:23:01 INFO - 2015-11-25 01:23:01,005 DEBUG : BROWSER_OUTPUT: 01:23:01 INFO - 2015-11-25 01:23:01,005 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.90 Median:127.00 stddev:3.96 (3.1%) stddev-sans-first:4.20 01:23:01 INFO - 2015-11-25 01:23:01,005 DEBUG : BROWSER_OUTPUT: Values: 126.0 128.0 127.0 130.0 123.0 122.0 127.0 120.0 133.0 123.0 01:23:01 INFO - 2015-11-25 01:23:01,005 DEBUG : BROWSER_OUTPUT: 01:23:01 INFO - 2015-11-25 01:23:01,005 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.00 Median:146.00 stddev:7.72 (5.3%) stddev-sans-first:8.05 01:23:01 INFO - 2015-11-25 01:23:01,005 DEBUG : BROWSER_OUTPUT: Values: 140.0 139.0 151.0 146.0 160.0 137.0 138.0 148.0 146.0 135.0 01:23:01 INFO - 2015-11-25 01:23:01,005 DEBUG : BROWSER_OUTPUT: 01:23:01 INFO - 2015-11-25 01:23:01,005 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.50 stddev:1.42 (2.1%) stddev-sans-first:1.42 01:23:01 INFO - 2015-11-25 01:23:01,005 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 68.0 71.0 69.0 67.0 69.0 68.0 70.0 67.0 01:23:01 INFO - 2015-11-25 01:23:01,005 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:23:01 INFO - 2015-11-25 01:23:01,005 DEBUG : BROWSER_OUTPUT: 01:23:01 INFO - 2015-11-25 01:23:01,849 INFO : Browser exited with error code: 0 01:23:01 INFO - 2015-11-25 01:23:01,901 INFO : Completed test kraken (00:01:00) 01:23:01 INFO - 2015-11-25 01:23:01,901 INFO : Starting test v8_7 01:23:01 INFO - 2015-11-25 01:23:01,901 DEBUG : operating with platform_type : linux_ 01:23:01 INFO - 2015-11-25 01:23:01,901 INFO : Initialising browser for v8_7 test... 01:23:01 INFO - 2015-11-25 01:23:01,907 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpypb3gh/profile http://localhost:43059/getInfo.html 01:23:05 INFO - 2015-11-25 01:23:05,963 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:23:05 INFO - 2015-11-25 01:23:05,963 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:23:05 INFO - 2015-11-25 01:23:05,963 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:23:05 INFO - 2015-11-25 01:23:05,963 DEBUG : BROWSER_OUTPUT: __metrics 01:23:06 INFO - 2015-11-25 01:23:06,044 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] 01:23:07 INFO - 2015-11-25 01:23:07,327 INFO : Browser initialized. 01:23:07 INFO - 2015-11-25 01:23:07,328 INFO : Running cycle 1/1 for v8_7 test... 01:23:07 INFO - 2015-11-25 01:23:07,328 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpypb3gh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:23:19 INFO - 2015-11-25 01:23:19,228 DEBUG : BROWSER_OUTPUT: RSS: Main: 139210752 01:23:19 INFO - 2015-11-25 01:23:19,228 DEBUG : BROWSER_OUTPUT: 01:23:40 INFO - 2015-11-25 01:23:40,696 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43059/tests/v8_7/run.html (next: http://localhost:43059/tests/v8_7/run.html) 01:23:40 INFO - 2015-11-25 01:23:40,955 DEBUG : BROWSER_OUTPUT: RSS: Main: 483659776 01:23:40 INFO - 2015-11-25 01:23:40,955 DEBUG : BROWSER_OUTPUT: 01:23:40 INFO - 2015-11-25 01:23:40,955 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:23:40 INFO - 2015-11-25 01:23:40,955 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:23:40 INFO - 2015-11-25 01:23:40,956 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:23:40 INFO - 2015-11-25 01:23:40,956 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:23:40 INFO - 2015-11-25 01:23:40,956 DEBUG : BROWSER_OUTPUT: |0;Richards;164.257555847569 01:23:40 INFO - 2015-11-25 01:23:40,956 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;192.04916458613405 01:23:40 INFO - 2015-11-25 01:23:40,956 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.0850651149903 01:23:40 INFO - 2015-11-25 01:23:40,957 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5133.333333333333 01:23:40 INFO - 2015-11-25 01:23:40,957 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1984.126984126984 01:23:40 INFO - 2015-11-25 01:23:40,957 DEBUG : BROWSER_OUTPUT: |5;Earley;804.5052292839904 01:23:40 INFO - 2015-11-25 01:23:40,957 DEBUG : BROWSER_OUTPUT: |6;Boyer;12207.317073170732 01:23:40 INFO - 2015-11-25 01:23:40,957 DEBUG : BROWSER_OUTPUT: |7;RegExp;26102.5641025641 01:23:40 INFO - 2015-11-25 01:23:40,957 DEBUG : BROWSER_OUTPUT: |8;Splay;612.369871402327 01:23:40 INFO - 2015-11-25 01:23:40,957 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 01:23:40 INFO - 2015-11-25 01:23:40,958 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:23:40 INFO - 2015-11-25 01:23:40,958 DEBUG : BROWSER_OUTPUT: __startTimestamp1448443420948__endTimestamp 01:23:40 INFO - 2015-11-25 01:23:40,958 DEBUG : BROWSER_OUTPUT: 01:23:40 INFO - 2015-11-25 01:23:40,958 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:23:40 INFO - 2015-11-25 01:23:40,958 DEBUG : BROWSER_OUTPUT: Number of tests: 10 01:23:40 INFO - 2015-11-25 01:23:40,958 DEBUG : BROWSER_OUTPUT: 01:23:40 INFO - 2015-11-25 01:23:40,958 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.26 Median:164.26 stddev:0.00 (0.0%) 01:23:40 INFO - 2015-11-25 01:23:40,958 DEBUG : BROWSER_OUTPUT: Values: 164.3 01:23:40 INFO - 2015-11-25 01:23:40,959 DEBUG : BROWSER_OUTPUT: 01:23:40 INFO - 2015-11-25 01:23:40,959 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:192.05 Median:192.05 stddev:0.00 (0.0%) 01:23:40 INFO - 2015-11-25 01:23:40,959 DEBUG : BROWSER_OUTPUT: Values: 192.0 01:23:40 INFO - 2015-11-25 01:23:40,959 DEBUG : BROWSER_OUTPUT: 01:23:40 INFO - 2015-11-25 01:23:40,959 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.09 Median:277.09 stddev:0.00 (0.0%) 01:23:40 INFO - 2015-11-25 01:23:40,959 DEBUG : BROWSER_OUTPUT: Values: 277.1 01:23:40 INFO - 2015-11-25 01:23:40,959 DEBUG : BROWSER_OUTPUT: 01:23:40 INFO - 2015-11-25 01:23:40,959 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5133.33 Median:5133.33 stddev:0.00 (0.0%) 01:23:40 INFO - 2015-11-25 01:23:40,960 DEBUG : BROWSER_OUTPUT: Values: 5133.3 01:23:40 INFO - 2015-11-25 01:23:40,960 DEBUG : BROWSER_OUTPUT: 01:23:40 INFO - 2015-11-25 01:23:40,960 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1984.13 Median:1984.13 stddev:0.00 (0.0%) 01:23:40 INFO - 2015-11-25 01:23:40,960 DEBUG : BROWSER_OUTPUT: Values: 1984.1 01:23:40 INFO - 2015-11-25 01:23:40,960 DEBUG : BROWSER_OUTPUT: 01:23:40 INFO - 2015-11-25 01:23:40,960 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:804.51 Median:804.51 stddev:0.00 (0.0%) 01:23:40 INFO - 2015-11-25 01:23:40,960 DEBUG : BROWSER_OUTPUT: Values: 804.5 01:23:40 INFO - 2015-11-25 01:23:40,961 DEBUG : BROWSER_OUTPUT: 01:23:40 INFO - 2015-11-25 01:23:40,961 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12207.32 Median:12207.32 stddev:0.00 (0.0%) 01:23:40 INFO - 2015-11-25 01:23:40,961 DEBUG : BROWSER_OUTPUT: Values: 12207.3 01:23:40 INFO - 2015-11-25 01:23:40,961 DEBUG : BROWSER_OUTPUT: 01:23:40 INFO - 2015-11-25 01:23:40,961 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26102.56 Median:26102.56 stddev:0.00 (0.0%) 01:23:40 INFO - 2015-11-25 01:23:40,961 DEBUG : BROWSER_OUTPUT: Values: 26102.6 01:23:40 INFO - 2015-11-25 01:23:40,961 DEBUG : BROWSER_OUTPUT: 01:23:40 INFO - 2015-11-25 01:23:40,961 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:612.37 Median:612.37 stddev:0.00 (0.0%) 01:23:40 INFO - 2015-11-25 01:23:40,962 DEBUG : BROWSER_OUTPUT: Values: 612.4 01:23:40 INFO - 2015-11-25 01:23:40,962 DEBUG : BROWSER_OUTPUT: 01:23:40 INFO - 2015-11-25 01:23:40,962 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 01:23:40 INFO - 2015-11-25 01:23:40,962 DEBUG : BROWSER_OUTPUT: Values: 4826.9 01:23:40 INFO - 2015-11-25 01:23:40,962 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:23:40 INFO - 2015-11-25 01:23:40,962 DEBUG : BROWSER_OUTPUT: 01:23:41 INFO - 2015-11-25 01:23:41,829 INFO : Browser exited with error code: 0 01:23:41 INFO - 2015-11-25 01:23:41,846 INFO : Completed test v8_7 (00:00:39) 01:23:41 INFO - 2015-11-25 01:23:41,909 INFO : Completed test suite (00:20:16) 01:23:41 INFO - 2015-11-25 01:23:41,909 DEBUG : Working with test: dromaeo_css 01:23:41 INFO - 2015-11-25 01:23:41,910 DEBUG : Generating results file: dromaeo_css 01:23:41 INFO - 2015-11-25 01:23:41,911 DEBUG : Working with test: kraken 01:23:41 INFO - 2015-11-25 01:23:41,911 DEBUG : Generating results file: kraken 01:23:41 INFO - 2015-11-25 01:23:41,911 INFO : javascript benchmark 01:23:41 INFO - 2015-11-25 01:23:41,911 DEBUG : Working with test: v8_7 01:23:41 INFO - 2015-11-25 01:23:41,911 DEBUG : Generating results file: v8_7 01:23:41 INFO - 2015-11-25 01:23:41,912 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:23:41 INFO - 2015-11-25 01:23:41,970 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 01:23:41 INFO - 2015-11-25 01:23:41,971 DEBUG : process_Request line: dromaeo_css 6282.38 graph.html#tests=[[72,132,35]] 01:23:41 INFO - 2015-11-25 01:23:41,971 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:23:42 INFO - 2015-11-25 01:23:42,002 DEBUG : process_Request line: kraken 1519.10 graph.html#tests=[[232,132,35]] 01:23:42 INFO - 2015-11-25 01:23:42,003 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:23:42 INFO - 2015-11-25 01:23:42,033 DEBUG : process_Request line: v8_7 19792.04 graph.html#tests=[[230,132,35]] 01:23:42 INFO - 2015-11-25 01:23:42,038 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2590.857502837344, 2693.0843513205505, 2709.3091261728255, 2721.496523143219, 2729.2358139720877, 4475.798589063492, 4483.237849565574, 4554.863354099374, 4590.036092420592, 4597.77011149442, 4439.533848945863, 4526.932096018554, 4530.886727831806, 4539.546045395458, 4675.392199014123, 4252.638525725317, 4258.318669012959, 4336.956630433687, 4396.758178300192, 4426.247537918545, 4378.430803995476, 4385.386045953569, 4427.490838553559, 4429.424174857264, 4453.131639330332, 4108.198901214249, 4199.559046300155, 4201.159768046403, 4203.663706903471, 4267.231898258312, 4320.805563749639, 4327.740335579875, 4338.370936214263, 4346.369776382407, 4369.235383807821, 4307.396964424983, 4314.956850431487, 4317.69776115672, 4324.805383757738, 4362.149380870732, 4391.033972526039, 4492.281235002384, 4496.213162696515, 4522.276435770261, 4615.030843522864, 5003.424606170301, 5013.573846223076, 5017.096922553938, 5021.096202683516, 5025.673331233458, 5033.84898453047, 5034.169362055293, 5042.722650254234, 5066.873328166826, 5086.949130508685, 4439.866803995853, 4540.477845047796, 4542.386777785023, 4544.182047231464, 4656.604188643969, 5082.186850103965, 5100.464451232641, 5109.591232701375, 5111.131107711698, 5115.0, 4895.461499235082, 4902.558769710672, 4909.435414927258, 4914.0, 4953.281774142729, 4709.293605959134, 4795.376601041912, 4800.039992001613, 4801.4718380978065, 4979.626528010342, 4834.299026641188, 4911.484294149134, 4912.975435122801, 4942.110420124341, 4954.702717836942, 4930.531599498042, 4964.578010869044, 4973.925391119136, 4974.104661161025, 5018.774155163026, 3915.9021024474614, 4169.1661667666585, 4173.332266837291, 4178.435911151955, 4218.156368726267, 3563.768355056913, 3622.0, 3655.8354874030733, 3656.5794933582447, 3675.650813172744, 4276.444062271885, 4283.20760659279, 4285.935710964338, 4288.0, 4329.826806927687, 4779.450363208275, 4994.700317980933, 5007.24891266313, 5009.273655319958, 5050.595952323805, 4151.169766046803, 4206.053637931441, 4234.618884300427, 4238.237117318912, 4244.830206791694, 4434.7560884151035, 4452.48796388413, 4454.26504626733, 4460.576245256695, 4485.887852803706, 4552.5447455255535, 4754.952450475451, 4759.714417134914, 4760.738159401266, 4794.808207671654, 4916.188828843201, 4920.778564964657, 4932.21084626458, 4996.7001979881325, 5052.5705315048635, 4654.837080702159, 4738.194506933898, 4749.050189961952, 4758.643101767312, 4782.904341913212, 4581.908361832811, 4908.533689299511, 4916.8770780730765, 4920.483349248278, 4971.229459433794, 4867.318575399376, 4875.585575226146, 4890.55984961341, 4930.778114984762, 4979.900401992012, 4813.0, 4845.53967373099, 4851.733154676385, 4854.90290194187, 4895.53492418234, 4631.0, 4838.056578967067, 4850.1269771441475, 4851.9514804852915, 4896.338994235875, 4614.284785858197, 4655.9301610475195, 4669.41632295963, 4727.763611819327, 4790.065937142223, 4821.132196204717, 4837.588804951478, 4843.467218606021, 4848.587870031087, 4887.266909963534, 4568.497465278883, 4752.952470475251, 4758.1435341638835, 4759.024399997923, 4789.44921334051], "unit": "ms", "name": "dojo.html", "value": 4548.40854754621}, {"lowerIsBetter": false, "replicates": [565.5786439102869, 569.4419468920458, 576.6799426318393, 577.653407955227, 584.8830233953211, 28274.0, 28987.130386088425, 36952.07619809509, 37001.25997480049, 37121.814390928004, 39693.60306396935, 40079.599204008024, 40142.19715605686, 40190.7990460048, 40193.39709904354, 7074.1511018677575, 7996.960015199945, 8193.262606365426, 8204.097549269576, 8212.096669366365, 7134.821629459279, 10310.072093511582, 10515.789684206311, 10517.84223236652, 10529.894701053006, 9940.0, 10003.649872254473, 10013.549390277454, 10017.098461138496, 10017.449040302781, 7221.602811845346, 7424.96287518559, 10219.0, 10297.742556436075, 10334.328268662588, 10086.747831304203, 10226.693199204035, 10227.590896364136, 10231.33496322744, 10233.437160956144, 37486.812565937, 38034.04914877123, 38048.619513804784, 38074.80962595197, 38103.80948095242, 2860.427914417104, 2899.4411193467736, 3410.539577157077, 3474.930501389958, 3674.595794462607, 28275.57586636202, 28298.575521367195, 28770.71229287701, 28924.27689307784, 29716.257093572618, 3367.461206206995, 3377.257003459235, 3429.5713035870517, 3469.757117001811, 3470.3059388122224, 235044.0, 236242.0, 236821.99999999828, 236936.0, 237408.0, 50255.0, 51980.0, 55153.0, 55287.723561381936, 56344.154837677466, 49828.0, 49923.001539968995, 50106.0, 50118.49881501211, 50163.0, 13335.333233338295, 13515.729685406237, 13518.864811351958, 13519.256440895846, 13528.32358382077, 9995.350302230332, 10060.24548158891, 10065.949670251603, 10066.798664026825, 10165.4917254137, 18875.528111797314, 18961.051947402575, 19057.80942190588, 19060.428187154408, 19075.332363367215, 6852.657367131624, 7070.787876363717, 7191.101112360955, 7226.458015648847, 7312.0, 916.4180745226696, 925.8657494663236, 942.8915674697498, 1043.1706793099352, 1054.3989925742253, 26195.345116371864, 26587.335316616853, 26854.0, 27022.864885675444, 27097.0, 908.2733812949746, 942.0, 976.8485884687884, 976.8583555384572, 1001.5142655811925, 12686.555970540987, 13001.544945926848, 13185.14296570739, 13245.867541324656, 13258.469661213636, 266344.0, 271808.0, 272056.0, 272660.0, 272711.0, 46289.305660414444, 46481.0, 46485.30272045922, 46537.0, 46552.67236638154, 993.572763711611, 1226.9141160118706, 1242.465739731924, 1244.775940330749, 1250.5935570939298, 20548.69176962317, 25356.36609084714, 25620.23139305824, 26936.191914242605, 28662.570061448678, 41999.3700094505, 42316.0, 42354.78822605867, 42366.0, 42476.57523424726, 220297.0, 222067.0, 229196.0, 232108.0, 236755.0, 28554.42891142207, 28556.85721571379, 28889.855550722114, 29087.0, 29266.561001584567, 38934.6106538931, 39812.601873980886, 40062.39906401348, 40266.194676105726, 40512.1897562053, 33545.0, 34106.31787364189, 34772.304553908274, 34959.475607866414, 35348.0, 33288.500672490416, 35169.0, 35687.64312356843, 35846.82076589705, 36637.63362366342, 34211.631534738335, 34319.31361372808, 35078.298434030665, 36149.27701445904, 37697.2460550793, 36004.639953600126, 37239.0, 37398.439023414125, 37580.624193757714, 37588.248235035695, 28138.85930570334, 28842.0, 28850.567241491815, 29274.0, 29400.26499337534], "unit": "ms", "name": "ext.html", "value": 17463.94662248475}, {"lowerIsBetter": false, "replicates": [341.4264036418816, 341.7624750798195, 342.5341535511704, 344.626080702438, 346.35059263880225, 12624.24254544728, 13002.349882505885, 15011.39954401824, 15094.320755566, 15978.68042639148, 11862.169648124634, 15083.547493575183, 15223.54329370118, 15496.0, 15504.612384690388, 4839.588634966023, 4961.355023846912, 4969.080720066781, 4973.651844370896, 4977.900441991158, 3585.964140358602, 3711.1278849470355, 4944.060628480595, 4945.9258111128365, 4973.129702302101, 5616.5787565932515, 5726.453857458484, 5748.741306641211, 5787.305523337205, 5803.245578074844, 5598.24423702799, 5732.369439361667, 5741.598088133832, 5743.712814359265, 5755.712214389264, 4969.602431805447, 4969.676970996874, 4978.029284289565, 4978.079055374767, 4981.501849814989, 18596.163172657263, 18641.44075677732, 18986.43040708781, 18988.5252868678, 19388.12753426099, 1884.9340273090377, 1910.9713354299697, 1911.6176764647125, 1934.41000494849, 2219.622664147099, 12480.50077996879, 12768.63717238762, 12915.741685166338, 13010.21938683682, 13412.530561430303, 1790.6239689665185, 1813.1115753280797, 1815.7276408538694, 1817.3366721146817, 1819.372316550788, 54302.72848635771, 56536.0, 56669.71665141689, 56759.71620141873, 56958.43041569573, 9486.95256523713, 9592.95203523978, 9598.136167744937, 9721.513924303756, 9776.169025632758, 12362.134650574373, 12376.690582735504, 12391.070669699808, 12411.875881241253, 12419.254844709347, 6446.903296450557, 6476.643784591893, 6496.252930912911, 6501.739930402731, 6735.191776986793, 5838.4453476919625, 5851.853703657443, 5890.558208134407, 5917.881642367129, 5926.051831706906, 5665.773369065191, 5735.2257445245195, 5758.2514273144225, 5812.157237200667, 5868.530517558671, 1578.1241411016995, 1666.9166541672869, 1684.2000049976164, 1700.0734599643224, 1706.0360896093666, 815.2866242038217, 851.8168593752373, 853.7694822397917, 961.4711908450324, 990.7424069741775, 15454.613634659, 16524.917375413046, 17631.382901598638, 17762.200700968486, 17857.642847142983, 727.2291371146601, 758.8140905478083, 833.8790875323044, 880.1550511508896, 881.5504092912532, 8376.246137847624, 8800.075992020873, 9022.233110185707, 9052.728418147466, 9184.357095003286, 531648.0, 535749.0, 547916.3437645236, 554726.0, 556228.0, 69899.0, 70374.64812676006, 71333.0, 71718.2828171722, 71747.64126179335, 1033.560736686905, 1049.511976930731, 1057.3655806516183, 1057.4184198690689, 1058.6771034834296, 14436.783448248074, 14459.566213013626, 14468.204248765998, 14496.202708851115, 14554.927225363805, 31944.68055319417, 32327.0, 32399.838000809847, 33619.49570756489, 34435.82782086074, 40607.593924060384, 40938.38592421057, 41087.38368924528, 42118.36822447604, 44951.775241123585, 8863.0, 9074.410163339362, 9350.345475816628, 9371.671991480265, 9372.531373431437, 16499.340026398808, 16655.750163747794, 16818.747718784474, 16900.830991690418, 16943.91528042352, 13854.376553054935, 13905.443782248596, 14232.0, 14302.71394572082, 14400.495982640557, 13362.532311369056, 13546.86453135456, 13711.314434278445, 13713.245771482665, 13913.721725565634, 13222.4049917752, 13927.442902283796, 13952.930235348758, 14036.78944815808, 14368.712625747217, 8612.48325100496, 8689.17452841979, 8775.903012123485, 8777.42946708462, 8892.244159246537, 9515.904840951778, 13784.379702913193, 13905.652358691113, 14039.578812635636, 14254.429822806971], "unit": "ms", "name": "jquery.html", "value": 8457.484534998113}, {"lowerIsBetter": false, "replicates": [1410.0623085648044, 1592.6894255620152, 1660.1782117851665, 1661.9750703739442, 1699.7280435130374, 5530.834074977752, 6582.835429114269, 6741.157355330583, 6746.9662651686795, 6751.459883209343, 6754.121964144667, 6894.310568943103, 6903.378695917367, 6908.067410899527, 6920.965395173017, 1752.0626464841312, 1780.172219917738, 1781.0471397802178, 2052.445839623297, 2086.0821238654944, 1797.3978717129712, 1807.1325763633463, 2054.291269512016, 2084.8540602157855, 2092.6337890869036, 2027.8681885677383, 2034.6846238833004, 2035.2164416699604, 2036.8472364572642, 2038.1439795285942, 2012.6276638821791, 2050.8872012039405, 2061.6598261286867, 2067.865588736727, 2070.3064473401428, 2024.7367842180422, 2038.4190505705803, 2039.1333683184587, 2065.483629092727, 2091.926782562603, 6800.285969973131, 6800.931990680079, 6808.183018037867, 6819.556728812611, 6821.897671534931, 4089.8159582818844, 4109.321961876287, 4136.131412403399, 4173.269677806402, 4181.038361176916, 2643.246674697721, 2687.6506054212828, 2730.57676060211, 2786.860656967164, 2787.3031742064486, 847.9236868681786, 865.9090795466449, 889.2663552569092, 890.0698769785589, 915.7756349694301, 8937.50843703596, 8957.417767845069, 8969.327300452427, 8971.372003959725, 8992.955035224848, 3822.7132965027736, 3855.5373355197557, 3911.3546264866545, 3927.0, 3927.548331941863, 7565.319121279002, 7579.204183560647, 7582.393408527305, 7582.507137036075, 7593.5823529706395, 4069.104796944667, 4101.91796164075, 4102.651274641629, 4108.424820525129, 4113.0, 3746.400575907842, 3761.1161377076364, 3767.453719210699, 3780.981095094507, 3786.6402691744242, 3308.4044871923284, 3373.089265898194, 3389.5593572835865, 3399.847006884696, 3410.4202285611505, 940.9811803763887, 954.341504361988, 1071.1430855315716, 1098.1708809848512, 1102.5424448853796, 811.8051667599851, 819.5656302159746, 820.1142765813026, 823.7199352220274, 930.3441074042784, 6208.50331973441, 6211.65835879022, 6214.689265536705, 6220.315765265817, 6260.0, 1017.4404077757351, 1023.4115383654429, 1032.2928793776287, 1036.2176556699794, 1036.8859425463193, 4751.881202969884, 4793.736344501086, 4802.423709154924, 4809.038192361541, 4809.110314591811, 7696.538207707556, 7999.080105787909, 8209.055958564722, 8251.669933202726, 8261.421700481029, 7678.347340476123, 7754.844903102019, 7785.961070194726, 7793.0, 7802.205492736703, 6377.872442551123, 6433.839154021093, 6456.0, 6468.450181734511, 6523.967380163069, 5959.910601340896, 6065.939340606537, 6087.8782424350375, 6090.69546522681, 6099.817005489843, 7121.394681452135, 7242.058532390755, 7259.0, 7276.963615182102, 7382.6677799498075, 7337.669804858688, 7514.699412023458, 7530.472866899265, 7532.322091011835, 7653.846923061396, 6108.389161083856, 6176.166217560572, 6182.7217775201125, 6183.072539119168, 6194.5354098443695, 6489.1888513935755, 6500.837479063061, 6563.540552161494, 6565.310642382672, 6592.967035164986, 6057.515398768176, 6059.33347331802, 6081.772145583251, 6189.721462534107, 6200.844978875564, 5996.730147143477, 6020.608660437058, 6027.819165425044, 6070.423309785563, 6130.570860039755, 6055.788047418319, 6068.908966365596, 6105.114758359924, 6122.142899993915, 6123.9693801532485, 5498.202760599771, 5707.514861236841, 5745.770169193185, 5752.33848107473, 5772.076467765138, 5789.594728368974, 5807.332156801853, 5810.970945145247, 5814.796482123105, 5821.505172060422], "unit": "ms", "name": "mootools.html", "value": 3920.5123950775683}, {"lowerIsBetter": false, "replicates": [304.58424250897525, 311.08230719377826, 311.56692197844984, 311.7755216244303, 313.89484522684893, 5150.562202212812, 5212.166053431447, 5233.947660523394, 5235.84292471226, 5239.083160446926, 5177.741112944356, 5193.402758682752, 5195.272661827347, 5204.32343795307, 5214.243934629486, 3927.5483319418204, 4026.879193624196, 4162.458880345566, 4175.54069052404, 4178.937315940263, 4059.9594004060023, 4105.712600117993, 4127.401526778615, 4140.0270936329935, 4143.4199212110325, 4090.284200264957, 4099.89750256243, 4104.97947510262, 4105.0, 4112.342025275956, 3911.3937339712247, 3998.300297447935, 4038.697097717683, 4111.342185250361, 4114.074333275019, 3651.233241019389, 3665.9083522911874, 3667.504886840269, 3668.596454390015, 3675.117971686803, 5026.145555255579, 5027.824026159067, 5038.672486288379, 5045.823396181153, 5048.091343558158, 4753.191957367256, 4760.928586071212, 4765.499622539618, 4766.356541866873, 4767.69010014348, 5437.6465529740835, 5537.418571050062, 5546.584006199551, 5554.333479982388, 5571.749271282802, 3970.66249368804, 3972.602739726033, 3974.3839704845795, 3978.5822488638855, 3979.1643754811525, 5856.472917437409, 5865.413458654143, 5870.97064514679, 5871.2073870027425, 5872.412758724136, 4079.7144199906315, 4083.34666453372, 4089.5297040840683, 4099.282625540519, 4104.199681062164, 4062.837486500566, 4165.333546632524, 4170.020045289354, 4170.35359519275, 4185.24665560196, 4727.7163370197895, 4733.786979585927, 4734.029523947583, 4735.12400205963, 4746.644001699887, 5585.916211256835, 5595.188697638901, 5597.356304025007, 5598.888022239614, 5600.159976003551, 1457.2203870929213, 1467.1783801071433, 1473.351725240912, 1473.6315921019745, 1481.1557412275115, 1015.4871789746279, 1017.8778546574458, 1023.518946095334, 1029.902159294866, 1043.5669197283194, 4852.490488498727, 4880.902381952341, 4887.902241955141, 4892.951070489249, 4893.412790465167, 5771.480566749013, 5772.5670574707065, 5772.913406298909, 5779.075347944308, 5779.393163717833, 4886.755662216875, 4889.3888263967, 4890.804367825247, 4894.143524883202, 4896.387951506062, 2916.4992086056177, 2956.9556456652736, 3007.3912153832944, 3085.5834462347298, 3124.937501249962, 5367.973160134175, 5473.863153421196, 5495.780168793203, 5498.8075417361, 5502.257195278667, 5958.165856780054, 5960.433758792908, 5967.6419414835245, 5975.701214939236, 5978.641281523122, 5313.574914006793, 5451.809186678447, 5466.508014278734, 5471.343438787371, 5476.835694929238, 5813.418658134153, 5820.447057529528, 5820.563457740602, 5837.912431313449, 5842.357340692605, 5714.457126572969, 5722.055860783091, 5722.942770572407, 5724.227229324155, 5724.627899186539, 5483.588730845282, 5483.8080667176455, 5487.560995120461, 5494.890102197854, 5496.708273555631, 3864.4976153099915, 3992.1017771001293, 3993.660538854114, 4103.733257338264, 4111.732737372061, 5774.566907481872, 5774.797882074107, 5776.480116789509, 5777.480026797609, 5780.826575202751, 5579.163125531203, 5584.274044374205, 5584.86037849057, 5586.636868603528, 5590.972045139748, 5457.7271136443815, 5570.554355651457, 5574.08027675429, 5578.944210557843, 5582.944170558242, 5516.779328826802, 5522.641028333145, 5522.944770552243, 5529.253550770755, 5530.474604912527, 5667.619599768025, 5668.716564171693, 5677.1768093627015, 5679.0, 5679.375268720355, 5531.778728850801, 5532.03189441838, 5537.0, 5540.501354877919, 5542.63972841764], "unit": "ms", "name": "prototype.html", "value": 4213.016438230888}, {"lowerIsBetter": false, "replicates": [591.4292707537226, 613.7268915332679, 671.0839703804305, 733.6038539188837, 752.7478294771253, 11542.307461552302, 11732.120090993189, 11772.587959421433, 11814.940925295372, 11872.7625447491, 10892.019718225358, 10921.290116142445, 11016.559337626486, 11017.44912754361, 11027.283226590285, 599.4365296621183, 600.9399060093978, 750.2235186581876, 758.4614923404389, 762.4815125714512, 748.5246868238653, 753.4575105923726, 754.4077898849405, 754.7320701151067, 757.685560492395, 791.0230864881867, 793.3018943329862, 793.305857374797, 793.3256731777972, 794.737736546941, 628.691940948934, 630.4987534909735, 778.634042000259, 781.6248200863561, 788.6372268756379, 578.2482772395869, 579.2556564814194, 581.5870731780441, 583.0554501707219, 584.1471451680552, 10847.02376786093, 10948.835767463494, 10957.890421095766, 10959.342439453658, 10982.06652434544, 10584.153267738562, 11390.487428065757, 11408.71478213043, 11687.41562921859, 11738.06095512357, 9497.857532137023, 9522.0, 9582.425054496753, 9601.711948641552, 9669.90330096704, 3242.8054316740836, 3289.4243507386113, 3296.423125952949, 3300.1254667513126, 3306.2230375861654, 43033.1393372134, 43081.0, 43469.78265108686, 43712.34431483498, 43810.0, 9042.3542436528, 9353.532323383804, 9649.0, 9662.903370966342, 9728.464934428534, 16414.507564773077, 16420.01479911209, 16435.5891102721, 16436.260368283456, 16475.752863707054, 6041.909371359433, 6103.298120716086, 6121.418465245794, 6155.538334624921, 6360.681965901686, 3548.8757893473603, 3570.107473131717, 3596.4065929121925, 3598.784072955631, 3630.7276954228537, 2770.279727270924, 2772.2514920971225, 2798.3423895384567, 2804.971950280512, 2808.0, 484.5808375754947, 491.2851800630075, 491.56005375189005, 493.3586337760897, 525.6845892464568, 536.1769683535754, 541.775163307231, 559.9020171469977, 570.1106274212242, 574.5202755698955, 7469.365103966224, 7559.357454616309, 7560.9621951889885, 7690.846183076307, 7720.073591169095, 386.48597365503815, 420.9410682504452, 438.5439143291005, 518.028696194635, 556.1407625218966, 3338.2822693121097, 3388.423967925459, 3502.1594817244186, 3548.840302186408, 3575.4994300797907, 47450.28824567634, 48467.5153248463, 48977.75511122493, 49368.25947610789, 49790.0, 43752.781236094255, 44527.33209001867, 44719.32921006188, 44801.77599111984, 45079.32381014287, 41577.584224157974, 41687.0, 41909.371359429635, 41939.580604193565, 42221.788891055345, 7148.883486179042, 7353.338199561851, 7421.443391745533, 7421.517601355895, 7425.9628701856145, 30320.848395758763, 30767.538486922265, 31390.68609313969, 31435.685643143275, 31535.47716182654, 41172.588274118076, 41233.793831030656, 41509.37735933903, 41885.79057104695, 41960.79019604882, 9398.201152901807, 9472.715818525456, 9507.904920950701, 9771.657991970247, 9793.755156121155, 10684.89315106839, 10717.839232411365, 10804.837927430937, 10831.783364332827, 11304.321740695585, 9673.516324183622, 9769.804603908024, 9775.120239178508, 9884.950575247078, 10008.299419040888, 10089.89910100919, 10108.646197383056, 10146.441945693057, 10479.318844275098, 10665.360078395011, 9756.902430975599, 9804.117629413387, 9821.5089245536, 9927.0, 10119.696409107739, 8799.868001979847, 8868.600912958804, 8882.689105881263, 9156.771080723036, 9187.67843125514, 7894.9199375801645, 8249.79375515593, 8685.435446695945, 8923.955380223057, 8955.955220223857], "unit": "ms", "name": "yui.html", "value": 5540.077832329934}], "name": "dromaeo_css"}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 113.0, 107.0, 114.0, 112.0, 114.0, 103.0, 112.0, 112.0, 105.0], "unit": "ms", "name": "ai-astar", "value": 110.2}, {"lowerIsBetter": true, "replicates": [150.0, 129.0, 161.0, 166.0, 131.0, 153.0, 157.0, 131.0, 164.0, 139.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.1}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 160.0, 160.0, 161.0, 160.0, 160.0, 162.0, 162.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 80.0, 105.0, 72.0, 72.0, 71.0, 92.0, 91.0, 75.0], "unit": "ms", "name": "audio-fft", "value": 80.3}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 132.0, 94.0, 95.0, 94.0, 130.0, 94.0, 95.0, 133.0], "unit": "ms", "name": "audio-oscillator", "value": 105.6}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 110.0, 109.0, 110.0, 109.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [146.0, 148.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 71.0, 72.0, 72.0, 71.0, 72.0, 71.0, 72.0, 73.0], "unit": "ms", "name": "json-parse-financial", "value": 71.9}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 68.0, 69.0, 69.0, 69.0, 69.0, 69.0, 69.0, 71.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.1}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 84.0, 83.0, 84.0, 84.0, 84.0, 83.0, 84.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.6}, {"lowerIsBetter": true, "replicates": [126.0, 128.0, 127.0, 130.0, 123.0, 122.0, 127.0, 120.0, 133.0, 123.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 125.9}, {"lowerIsBetter": true, "replicates": [140.0, 139.0, 151.0, 146.0, 160.0, 137.0, 138.0, 148.0, 146.0, 135.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.0}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 68.0, 71.0, 69.0, 67.0, 69.0, 68.0, 70.0, 67.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.3}], "name": "kraken"}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.257555847569], "unit": "score", "name": "Richards", "value": 214.918576}, {"lowerIsBetter": false, "replicates": [192.04916458613405], "unit": "score", "name": "DeltaBlue", "value": 344.276426}, {"lowerIsBetter": false, "replicates": [277.0850651149903], "unit": "score", "name": "Encrypt", "value": 960.647229}, {"lowerIsBetter": false, "replicates": [5133.333333333333], "unit": "score", "name": "Decrypt", "value": 51.85344155844158}, {"lowerIsBetter": false, "replicates": [1984.126984126984], "unit": "score", "name": "RayTrace", "value": 372.9544560000001}, {"lowerIsBetter": false, "replicates": [804.5052292839904], "unit": "score", "name": "Earley", "value": 828.4135089999997}, {"lowerIsBetter": false, "replicates": [12207.317073170732], "unit": "score", "name": "Boyer", "value": 54.595370629370635}, {"lowerIsBetter": false, "replicates": [26102.5641025641], "unit": "score", "name": "RegExp", "value": 34.90021119842827}, {"lowerIsBetter": false, "replicates": [612.369871402327], "unit": "score", "name": "Splay", "value": 133.07480300000003}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7"}]} 01:23:42 INFO - RETURN: dromaeo_css: 6282.38 01:23:42 INFO - RETURN: kraken: 1519.10 01:23:42 INFO - RETURN: v8_7: 19792.04 01:23:42 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19792.04"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1519.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6282.38"}}} 01:23:42 INFO - Return code: 0 01:23:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:23:42 INFO - # TBPL SUCCESS # 01:23:42 INFO - Running post-action listener: _resource_record_post_action 01:23:42 INFO - Running post-run listener: _resource_record_post_run 01:23:43 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 4096; Write bytes: 511086592; Read time: 4; Write time: 491432 01:23:43 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 235397120; Read time: 0; Write time: 312760 01:23:43 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 0; Write bytes: 275689472; Read time: 0; Write time: 178672 01:23:43 INFO - Running post-run listener: _upload_blobber_files 01:23:43 INFO - Blob upload gear active. 01:23:43 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 01:23:43 INFO - Copying logs to upload dir... 01:23:43 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1267.774945 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2015-11-25 01:23:43.051747) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-25 01:23:43.060876) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1448441783.99007-1808360845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/2HwmPeEVSQKLx5NQKDe_3A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009940 build_url: 'https://queue.taskcluster.net/v1/task/2HwmPeEVSQKLx5NQKDe_3A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-25 01:23:43.118385) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 01:23:43.118855) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1448441783.99007-1808360845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004588 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 01:23:43.168184) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-25 01:23:43.171681) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-25 01:23:43.172116) ========= ========= Total master_lag: 0.27 =========