builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-065 starttime: 1448040803.54 results: success (0) buildid: 20151120090417 builduid: c2c74bcb0ff64d68b1d1583b80cb60bc revision: 67a9dd1470e731be61744b89693dd2e4103fd9e7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 09:33:23.540698) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 09:33:23.541341) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 09:33:23.541675) ========= 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=20aa3857bbc5a756c598c738000001bb-1448040804.57017-1030338775 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006448 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 09:33:23.563241) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 09:33:23.563797) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 09:33:23.574826) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 09:33:23.575372) ========= 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=20aa3857bbc5a756c598c738000001bb-1448040804.57017-1030338775 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004637 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 09:33:23.628575) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 09:33:23.629271) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 09:33:23.630003) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 09:33:23.630430) ========= 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=20aa3857bbc5a756c598c738000001bb-1448040804.57017-1030338775 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-20 09:33:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 217M=0s 2015-11-20 09:33:25 (217 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.197669 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 09:33:23.845796) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 09:33:23.846510) ========= 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=20aa3857bbc5a756c598c738000001bb-1448040804.57017-1030338775 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020386 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 09:33:23.900543) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 09:33:23.901322) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 67a9dd1470e731be61744b89693dd2e4103fd9e7 --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 67a9dd1470e731be61744b89693dd2e4103fd9e7 --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=20aa3857bbc5a756c598c738000001bb-1448040804.57017-1030338775 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-20 09:33:25,286 truncating revision to first 12 chars 2015-11-20 09:33:25,286 Setting DEBUG logging. 2015-11-20 09:33:25,286 attempt 1/10 2015-11-20 09:33:25,286 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/67a9dd1470e7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-20 09:33:25,533 unpacking tar archive at: fx-team-67a9dd1470e7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.531007 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 09:33:24.451182) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 09:33:24.451967) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 09:33:24.463651) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 09:33:24.464598) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 09:33:24.465856) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2015-11-20 09:33:24.466763) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=20aa3857bbc5a756c598c738000001bb-1448040804.57017-1030338775 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:33:25 INFO - MultiFileLogger online at 20151120 09:33:25 in /builds/slave/test 09:33:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 09:33:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:33:25 INFO - {'append_to_log': False, 09:33:25 INFO - 'base_work_dir': '/builds/slave/test', 09:33:25 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:33:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:33:25 INFO - 'branch': 'Fx-Team-Non-PGO', 09:33:25 INFO - 'buildbot_json_path': 'buildprops.json', 09:33:25 INFO - 'config_files': ('talos/linux_config.py',), 09:33:25 INFO - 'default_actions': ('clobber', 09:33:25 INFO - 'read-buildbot-config', 09:33:25 INFO - 'download-and-extract', 09:33:25 INFO - 'populate-webroot', 09:33:25 INFO - 'create-virtualenv', 09:33:25 INFO - 'install', 09:33:25 INFO - 'run-tests'), 09:33:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:33:25 INFO - 'download_minidump_stackwalk': True, 09:33:25 INFO - 'download_symbols': 'ondemand', 09:33:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:33:25 INFO - 'tooltool.py': '/tools/tooltool.py', 09:33:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:33:25 INFO - '/tools/misc-python/virtualenv.py')}, 09:33:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:33:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:33:25 INFO - 'installer_path': 'installer.exe', 09:33:25 INFO - 'log_level': 'info', 09:33:25 INFO - 'log_name': 'talos', 09:33:25 INFO - 'log_to_console': True, 09:33:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:33:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:33:25 INFO - 'opt_config_files': (), 09:33:25 INFO - 'pip_index': False, 09:33:25 INFO - 'sps_profile': False, 09:33:25 INFO - 'sps_profile_interval': 0, 09:33:25 INFO - 'suite': 'dromaeojs-e10s', 09:33:25 INFO - 'system_bits': '64', 09:33:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:33:25 INFO - 'title': 'talos-linux64-ix-065', 09:33:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:33:25 INFO - 'use_talos_json': True, 09:33:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:33:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:33:25 INFO - 'work_dir': 'build'} 09:33:25 INFO - ##### 09:33:25 INFO - ##### Running clobber step. 09:33:25 INFO - ##### 09:33:25 INFO - Running pre-action listener: _resource_record_pre_action 09:33:25 INFO - Running main action method: clobber 09:33:25 INFO - rmtree: /builds/slave/test/build 09:33:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:33:26 INFO - Running post-action listener: _resource_record_post_action 09:33:26 INFO - ##### 09:33:26 INFO - ##### Running read-buildbot-config step. 09:33:26 INFO - ##### 09:33:26 INFO - Running pre-action listener: _resource_record_pre_action 09:33:26 INFO - Running main action method: read_buildbot_config 09:33:26 INFO - Using buildbot properties: 09:33:26 INFO - { 09:33:26 INFO - "properties": { 09:33:26 INFO - "buildnumber": 490, 09:33:26 INFO - "product": "firefox", 09:33:26 INFO - "script_repo_revision": "production", 09:33:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 09:33:26 INFO - "repository": "", 09:33:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 09:33:26 INFO - "buildid": "20151120090417", 09:33:26 INFO - "slavename": "talos-linux64-ix-065", 09:33:26 INFO - "pgo_build": "False", 09:33:26 INFO - "basedir": "/builds/slave/test", 09:33:26 INFO - "project": "", 09:33:26 INFO - "platform": "ubuntu64_hw", 09:33:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:33:26 INFO - "slavebuilddir": "test", 09:33:26 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:33:26 INFO - "branch": "fx-team", 09:33:26 INFO - "repo_path": "integration/fx-team", 09:33:26 INFO - "stage_platform": "linux64", 09:33:26 INFO - "builduid": "c2c74bcb0ff64d68b1d1583b80cb60bc", 09:33:26 INFO - "revision": "67a9dd1470e731be61744b89693dd2e4103fd9e7" 09:33:26 INFO - }, 09:33:26 INFO - "sourcestamp": { 09:33:26 INFO - "repository": "", 09:33:26 INFO - "hasPatch": false, 09:33:26 INFO - "project": "", 09:33:26 INFO - "branch": "fx-team-linux64-talos", 09:33:26 INFO - "changes": [ 09:33:26 INFO - { 09:33:26 INFO - "category": null, 09:33:26 INFO - "files": [ 09:33:26 INFO - { 09:33:26 INFO - "url": null, 09:33:26 INFO - "name": "https://queue.taskcluster.net/v1/task/6LtkHRJiQwiKji4qOJAWug/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 09:33:26 INFO - } 09:33:26 INFO - ], 09:33:26 INFO - "repository": "", 09:33:26 INFO - "rev": "67a9dd1470e731be61744b89693dd2e4103fd9e7", 09:33:26 INFO - "who": "mfinkle@mozilla.com", 09:33:26 INFO - "when": 1448040783, 09:33:26 INFO - "number": 6689643, 09:33:26 INFO - "comments": "Bug 1223526 - Create an empty theme for mobile/native UI r=margaret,mossop,gbrown", 09:33:26 INFO - "project": "", 09:33:26 INFO - "at": "Fri 20 Nov 2015 09:33:03", 09:33:26 INFO - "branch": "fx-team-linux64-talos", 09:33:26 INFO - "revlink": "", 09:33:26 INFO - "properties": [ 09:33:26 INFO - [ 09:33:26 INFO - "buildid", 09:33:26 INFO - "20151120090417", 09:33:26 INFO - "Change" 09:33:26 INFO - ], 09:33:26 INFO - [ 09:33:26 INFO - "builduid", 09:33:26 INFO - "c2c74bcb0ff64d68b1d1583b80cb60bc", 09:33:26 INFO - "Change" 09:33:26 INFO - ], 09:33:26 INFO - [ 09:33:26 INFO - "pgo_build", 09:33:26 INFO - "False", 09:33:26 INFO - "Change" 09:33:26 INFO - ] 09:33:26 INFO - ], 09:33:26 INFO - "revision": "67a9dd1470e731be61744b89693dd2e4103fd9e7" 09:33:26 INFO - } 09:33:26 INFO - ], 09:33:26 INFO - "revision": "67a9dd1470e731be61744b89693dd2e4103fd9e7" 09:33:26 INFO - } 09:33:26 INFO - } 09:33:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/6LtkHRJiQwiKji4qOJAWug/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 09:33:26 INFO - Running post-action listener: _resource_record_post_action 09:33:26 INFO - ##### 09:33:26 INFO - ##### Running download-and-extract step. 09:33:26 INFO - ##### 09:33:26 INFO - Running pre-action listener: _resource_record_pre_action 09:33:26 INFO - Running main action method: download_and_extract 09:33:26 INFO - mkdir: /builds/slave/test/build/tests 09:33:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:26 INFO - https://queue.taskcluster.net/v1/task/6LtkHRJiQwiKji4qOJAWug/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:33:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6LtkHRJiQwiKji4qOJAWug/artifacts/public/build/test_packages.json 09:33:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6LtkHRJiQwiKji4qOJAWug/artifacts/public/build/test_packages.json 09:33:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6LtkHRJiQwiKji4qOJAWug/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:33:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6LtkHRJiQwiKji4qOJAWug/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:33:33 INFO - Downloaded 1302 bytes. 09:33:33 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:33:33 INFO - Using the following test package requirements: 09:33:33 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:33:33 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:33:33 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:33:33 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:33:33 INFO - u'jsshell-linux-x86_64.zip'], 09:33:33 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:33:33 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:33:33 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:33:33 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:33:33 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:33:33 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:33:33 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:33:33 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:33:33 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:33:33 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:33:33 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:33:33 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:33:33 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:33:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:33 INFO - https://queue.taskcluster.net/v1/task/6LtkHRJiQwiKji4qOJAWug/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:33:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6LtkHRJiQwiKji4qOJAWug/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:33:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6LtkHRJiQwiKji4qOJAWug/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:33:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6LtkHRJiQwiKji4qOJAWug/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:33:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6LtkHRJiQwiKji4qOJAWug/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:33:39 INFO - Downloaded 21340206 bytes. 09:33:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 09:33:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:33:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 09:33:40 INFO - Return code: 0 09:33:40 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:33:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:40 INFO - https://queue.taskcluster.net/v1/task/6LtkHRJiQwiKji4qOJAWug/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:33:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6LtkHRJiQwiKji4qOJAWug/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:33:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6LtkHRJiQwiKji4qOJAWug/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:33:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6LtkHRJiQwiKji4qOJAWug/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:33:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6LtkHRJiQwiKji4qOJAWug/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:33:42 INFO - Downloaded 21340206 bytes. 09:33:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 09:33:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:33:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 09:33:43 INFO - Return code: 0 09:33:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:43 INFO - https://queue.taskcluster.net/v1/task/6LtkHRJiQwiKji4qOJAWug/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:33:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6LtkHRJiQwiKji4qOJAWug/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:33:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6LtkHRJiQwiKji4qOJAWug/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:33:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6LtkHRJiQwiKji4qOJAWug/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:33:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6LtkHRJiQwiKji4qOJAWug/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:33:44 INFO - Downloaded 11130997 bytes. 09:33:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 09:33:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:33:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 09:33:45 INFO - Return code: 0 09:33:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:45 INFO - https://queue.taskcluster.net/v1/task/6LtkHRJiQwiKji4qOJAWug/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:33:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6LtkHRJiQwiKji4qOJAWug/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:33:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6LtkHRJiQwiKji4qOJAWug/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:33:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6LtkHRJiQwiKji4qOJAWug/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:33:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6LtkHRJiQwiKji4qOJAWug/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:33:46 INFO - Downloaded 55782158 bytes. 09:33:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/6LtkHRJiQwiKji4qOJAWug/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:33:46 INFO - mkdir: /builds/slave/test/properties 09:33:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:33:46 INFO - Writing to file /builds/slave/test/properties/build_url 09:33:46 INFO - Contents: 09:33:46 INFO - build_url:https://queue.taskcluster.net/v1/task/6LtkHRJiQwiKji4qOJAWug/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:33:46 INFO - Running post-action listener: _resource_record_post_action 09:33:46 INFO - Running post-action listener: set_extra_try_arguments 09:33:46 INFO - ##### 09:33:46 INFO - ##### Running populate-webroot step. 09:33:46 INFO - ##### 09:33:46 INFO - Running pre-action listener: _resource_record_pre_action 09:33:46 INFO - Running main action method: populate_webroot 09:33:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:33:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:33:46 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 09:33:46 INFO - '../fennec_ids.txt'], 09:33:46 INFO - 'tests': ['tcheck2']}, 09:33:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:33:46 INFO - '--tppagecycles', 09:33:46 INFO - '7'], 09:33:46 INFO - 'tests': ['tsvgm']}}, 09:33:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:33:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:33:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:33:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:33:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:33:46 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:33:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:33:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:46 INFO - 'talos_options': ['--e10s'], 09:33:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:33:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:46 INFO - 'tests': ['damp', 'tps']}, 09:33:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:46 INFO - 'talos_options': ['--e10s'], 09:33:46 INFO - 'tests': ['damp', 'tps']}, 09:33:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:33:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:33:46 INFO - 'other': {'tests': ['a11yr', 09:33:46 INFO - 'ts_paint', 09:33:46 INFO - 'tpaint', 09:33:46 INFO - 'sessionrestore', 09:33:46 INFO - 'sessionrestore_no_auto_restore']}, 09:33:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:33:46 INFO - 'tests': ['a11yr', 09:33:46 INFO - 'ts_paint', 09:33:46 INFO - 'tpaint', 09:33:46 INFO - 'sessionrestore', 09:33:46 INFO - 'sessionrestore_no_auto_restore']}, 09:33:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:33:46 INFO - 'tests': ['a11yr', 09:33:46 INFO - 'ts_paint', 09:33:46 INFO - 'tpaint', 09:33:46 INFO - 'sessionrestore', 09:33:46 INFO - 'sessionrestore_no_auto_restore']}, 09:33:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:33:46 INFO - 'tests': ['a11yr', 09:33:46 INFO - 'ts_paint', 09:33:46 INFO - 'tpaint', 09:33:46 INFO - 'sessionrestore', 09:33:46 INFO - 'sessionrestore_no_auto_restore']}, 09:33:46 INFO - 'other_l64': {'tests': ['a11yr', 09:33:46 INFO - 'ts_paint', 09:33:46 INFO - 'tpaint', 09:33:46 INFO - 'sessionrestore', 09:33:46 INFO - 'sessionrestore_no_auto_restore']}, 09:33:46 INFO - 'other_nol64': {'tests': ['a11yr', 09:33:46 INFO - 'ts_paint', 09:33:46 INFO - 'tpaint', 09:33:46 INFO - 'sessionrestore', 09:33:46 INFO - 'sessionrestore_no_auto_restore']}, 09:33:46 INFO - 'svgr': {'tests': ['tsvgx', 09:33:46 INFO - 'tsvgr_opacity', 09:33:46 INFO - 'tart', 09:33:46 INFO - 'tscrollx', 09:33:46 INFO - 'cart']}, 09:33:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:33:46 INFO - 'tests': ['tsvgx', 09:33:46 INFO - 'tsvgr_opacity', 09:33:46 INFO - 'tart', 09:33:46 INFO - 'tscrollx', 09:33:46 INFO - 'cart']}, 09:33:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:46 INFO - 'tests': ['tp5o']}, 09:33:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:46 INFO - 'talos_options': ['--e10s'], 09:33:46 INFO - 'tests': ['tp5o']}, 09:33:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:46 INFO - 'talos_options': ['--xperf_path', 09:33:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:33:46 INFO - 'tests': ['tp5n']}, 09:33:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:46 INFO - 'talos_options': ['--e10s', 09:33:46 INFO - '--xperf_path', 09:33:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:33:46 INFO - 'tests': ['tp5n']}}, 09:33:46 INFO - 'talos.zip': {'path': '', 09:33:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:33:46 INFO - Running post-action listener: _resource_record_post_action 09:33:46 INFO - ##### 09:33:46 INFO - ##### Running create-virtualenv step. 09:33:46 INFO - ##### 09:33:46 INFO - Running pre-action listener: _resource_record_pre_action 09:33:46 INFO - Running main action method: create_virtualenv 09:33:46 INFO - Creating virtualenv /builds/slave/test/build/venv 09:33:46 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:33:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:33:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:33:46 INFO - Using real prefix '/usr' 09:33:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:33:47 INFO - Installing distribute.............................................................................................................................................................................................done. 09:33:49 INFO - Installing pip.................done. 09:33:49 INFO - Return code: 0 09:33:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:33:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:49 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 0x7f726164ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a46c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2155900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219bb70>, '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 0x21ecdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ed250>, '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': '20aa3857bbc5a756c598c738000001bb-1448040804.57017-1030338775', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:33:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:33:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:33:49 INFO - Using env: {'DISPLAY': ':0', 09:33:49 INFO - 'HOME': '/home/cltbld', 09:33:49 INFO - 'LANG': 'en_US.UTF-8', 09:33:49 INFO - 'LANGUAGE': 'en_US:en', 09:33:49 INFO - 'LOGNAME': 'cltbld', 09:33:49 INFO - 'MAIL': '/var/mail/cltbld', 09:33:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:49 INFO - 'MOZ_NO_REMOTE': '1', 09:33:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:49 INFO - 'NO_EM_RESTART': '1', 09:33:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:49 INFO - 'PWD': '/builds/slave/test', 09:33:49 INFO - 'SHELL': '/bin/bash', 09:33:49 INFO - 'SHLVL': '1', 09:33:49 INFO - 'TERM': 'linux', 09:33:49 INFO - 'TMOUT': '86400', 09:33:49 INFO - 'USER': 'cltbld', 09:33:49 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1448040804.57017-1030338775', 09:33:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:49 INFO - '_': '/tools/buildbot/bin/python'} 09:33:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:49 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:33:49 INFO - Cleaning up... 09:33:49 INFO - Return code: 0 09:33:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:33:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:49 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 0x7f726164ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a46c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2155900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219bb70>, '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 0x21ecdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ed250>, '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': '20aa3857bbc5a756c598c738000001bb-1448040804.57017-1030338775', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:33:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 09:33:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:33:49 INFO - Using env: {'DISPLAY': ':0', 09:33:49 INFO - 'HOME': '/home/cltbld', 09:33:49 INFO - 'LANG': 'en_US.UTF-8', 09:33:49 INFO - 'LANGUAGE': 'en_US:en', 09:33:49 INFO - 'LOGNAME': 'cltbld', 09:33:49 INFO - 'MAIL': '/var/mail/cltbld', 09:33:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:49 INFO - 'MOZ_NO_REMOTE': '1', 09:33:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:49 INFO - 'NO_EM_RESTART': '1', 09:33:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:49 INFO - 'PWD': '/builds/slave/test', 09:33:49 INFO - 'SHELL': '/bin/bash', 09:33:49 INFO - 'SHLVL': '1', 09:33:49 INFO - 'TERM': 'linux', 09:33:49 INFO - 'TMOUT': '86400', 09:33:49 INFO - 'USER': 'cltbld', 09:33:49 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1448040804.57017-1030338775', 09:33:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:49 INFO - '_': '/tools/buildbot/bin/python'} 09:33:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:49 INFO - Downloading/unpacking psutil>=0.7.1 09:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:51 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 09:33:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:33:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:33:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:33:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:33:51 INFO - Installing collected packages: psutil 09:33:51 INFO - Running setup.py install for psutil 09:33:51 INFO - building 'psutil._psutil_linux' extension 09:33:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:33:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:33:51 INFO - building 'psutil._psutil_posix' extension 09:33:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:33:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:33:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:33:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:33:51 INFO - Successfully installed psutil 09:33:51 INFO - Cleaning up... 09:33:51 INFO - Return code: 0 09:33:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:33:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:51 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 0x7f726164ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a46c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2155900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219bb70>, '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 0x21ecdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ed250>, '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': '20aa3857bbc5a756c598c738000001bb-1448040804.57017-1030338775', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:33:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:33:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:33:51 INFO - Using env: {'DISPLAY': ':0', 09:33:51 INFO - 'HOME': '/home/cltbld', 09:33:51 INFO - 'LANG': 'en_US.UTF-8', 09:33:51 INFO - 'LANGUAGE': 'en_US:en', 09:33:51 INFO - 'LOGNAME': 'cltbld', 09:33:51 INFO - 'MAIL': '/var/mail/cltbld', 09:33:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:51 INFO - 'MOZ_NO_REMOTE': '1', 09:33:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:51 INFO - 'NO_EM_RESTART': '1', 09:33:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:51 INFO - 'PWD': '/builds/slave/test', 09:33:51 INFO - 'SHELL': '/bin/bash', 09:33:51 INFO - 'SHLVL': '1', 09:33:51 INFO - 'TERM': 'linux', 09:33:51 INFO - 'TMOUT': '86400', 09:33:51 INFO - 'USER': 'cltbld', 09:33:51 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1448040804.57017-1030338775', 09:33:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:51 INFO - '_': '/tools/buildbot/bin/python'} 09:33:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:33:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:33:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:33:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:33:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:33:53 INFO - Installing collected packages: mozsystemmonitor 09:33:53 INFO - Running setup.py install for mozsystemmonitor 09:33:53 INFO - Successfully installed mozsystemmonitor 09:33:53 INFO - Cleaning up... 09:33:53 INFO - Return code: 0 09:33:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:33:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f726164ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a46c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2155900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219bb70>, '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 0x21ecdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ed250>, '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': '20aa3857bbc5a756c598c738000001bb-1448040804.57017-1030338775', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:33:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:33:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:33:53 INFO - Using env: {'DISPLAY': ':0', 09:33:53 INFO - 'HOME': '/home/cltbld', 09:33:53 INFO - 'LANG': 'en_US.UTF-8', 09:33:53 INFO - 'LANGUAGE': 'en_US:en', 09:33:53 INFO - 'LOGNAME': 'cltbld', 09:33:53 INFO - 'MAIL': '/var/mail/cltbld', 09:33:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:53 INFO - 'MOZ_NO_REMOTE': '1', 09:33:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:53 INFO - 'NO_EM_RESTART': '1', 09:33:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:53 INFO - 'PWD': '/builds/slave/test', 09:33:53 INFO - 'SHELL': '/bin/bash', 09:33:53 INFO - 'SHLVL': '1', 09:33:53 INFO - 'TERM': 'linux', 09:33:53 INFO - 'TMOUT': '86400', 09:33:53 INFO - 'USER': 'cltbld', 09:33:53 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1448040804.57017-1030338775', 09:33:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:53 INFO - '_': '/tools/buildbot/bin/python'} 09:33:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:54 INFO - Downloading/unpacking blobuploader==1.2.4 09:33:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:55 INFO - Downloading blobuploader-1.2.4.tar.gz 09:33:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:33:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:33:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:33: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 09:33: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 09:33: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 09:33: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 09:33: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 09:33: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 09:33:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:33:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:33:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:33:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:56 INFO - Downloading docopt-0.6.1.tar.gz 09:33:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:33:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:33:56 INFO - Installing collected packages: blobuploader, requests, docopt 09:33:56 INFO - Running setup.py install for blobuploader 09:33:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:33:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:33:56 INFO - Running setup.py install for requests 09:33:57 INFO - Running setup.py install for docopt 09:33:57 INFO - Successfully installed blobuploader requests docopt 09:33:57 INFO - Cleaning up... 09:33:57 INFO - Return code: 0 09:33:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:33: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')]} 09:33:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33: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')]} 09:33:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:57 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 0x7f726164ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a46c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2155900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219bb70>, '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 0x21ecdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ed250>, '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': '20aa3857bbc5a756c598c738000001bb-1448040804.57017-1030338775', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:33:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:33:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:33:57 INFO - Using env: {'DISPLAY': ':0', 09:33:57 INFO - 'HOME': '/home/cltbld', 09:33:57 INFO - 'LANG': 'en_US.UTF-8', 09:33:57 INFO - 'LANGUAGE': 'en_US:en', 09:33:57 INFO - 'LOGNAME': 'cltbld', 09:33:57 INFO - 'MAIL': '/var/mail/cltbld', 09:33:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:57 INFO - 'MOZ_NO_REMOTE': '1', 09:33:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:57 INFO - 'NO_EM_RESTART': '1', 09:33:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:57 INFO - 'PWD': '/builds/slave/test', 09:33:57 INFO - 'SHELL': '/bin/bash', 09:33:57 INFO - 'SHLVL': '1', 09:33:57 INFO - 'TERM': 'linux', 09:33:57 INFO - 'TMOUT': '86400', 09:33:57 INFO - 'USER': 'cltbld', 09:33:57 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1448040804.57017-1030338775', 09:33:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:57 INFO - '_': '/tools/buildbot/bin/python'} 09:33:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:33:57 INFO - Running setup.py (path:/tmp/pip-UDBQk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:33:57 INFO - Running setup.py (path:/tmp/pip-1rN7jz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:33:57 INFO - Running setup.py (path:/tmp/pip-4w1ILO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:33:57 INFO - Running setup.py (path:/tmp/pip-CT0Mt9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:33:57 INFO - Running setup.py (path:/tmp/pip-j4uuq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:33:57 INFO - Running setup.py (path:/tmp/pip-dLETNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:33:57 INFO - Running setup.py (path:/tmp/pip-y2qOrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:33:57 INFO - Running setup.py (path:/tmp/pip-EGSa6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:33:57 INFO - Running setup.py (path:/tmp/pip-OwKcrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:33:58 INFO - Running setup.py (path:/tmp/pip-bbJ8kh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:33:58 INFO - Running setup.py (path:/tmp/pip-2qC_an-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:33:58 INFO - Running setup.py (path:/tmp/pip-cPSYyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:33:58 INFO - Running setup.py (path:/tmp/pip-yIDwjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:33:58 INFO - Running setup.py (path:/tmp/pip-txbkeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:58 INFO - Running setup.py (path:/tmp/pip-pOUAYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:33:58 INFO - Running setup.py (path:/tmp/pip-JISKaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:33:58 INFO - Running setup.py (path:/tmp/pip-Yeup9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:33:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:33:58 INFO - Running setup.py install for manifestparser 09:33:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:33:58 INFO - Running setup.py install for mozcrash 09:33:58 INFO - Running setup.py install for mozdebug 09:33:58 INFO - Running setup.py install for mozdevice 09:33:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:33:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:33:59 INFO - Running setup.py install for mozfile 09:33:59 INFO - Running setup.py install for mozhttpd 09:33:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:33:59 INFO - Running setup.py install for mozinfo 09:33:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:33:59 INFO - Running setup.py install for mozInstall 09:33:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:33:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:33:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:33:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:33:59 INFO - Running setup.py install for mozleak 09:33:59 INFO - Running setup.py install for mozlog 09:33:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:33:59 INFO - Running setup.py install for moznetwork 09:33:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:33:59 INFO - Running setup.py install for mozprocess 09:33:59 INFO - Running setup.py install for mozprofile 09:33:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:33:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:33:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:33:59 INFO - Running setup.py install for mozrunner 09:34:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:34:00 INFO - Running setup.py install for mozscreenshot 09:34:00 INFO - Running setup.py install for moztest 09:34:00 INFO - Running setup.py install for mozversion 09:34:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:34:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:34:00 INFO - Cleaning up... 09:34:00 INFO - Return code: 0 09:34:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:34:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:34:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:34:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:34:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:34:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f726164ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a46c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2155900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219bb70>, '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 0x21ecdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ed250>, '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': '20aa3857bbc5a756c598c738000001bb-1448040804.57017-1030338775', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:34:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:34:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:34:00 INFO - Using env: {'DISPLAY': ':0', 09:34:00 INFO - 'HOME': '/home/cltbld', 09:34:00 INFO - 'LANG': 'en_US.UTF-8', 09:34:00 INFO - 'LANGUAGE': 'en_US:en', 09:34:00 INFO - 'LOGNAME': 'cltbld', 09:34:00 INFO - 'MAIL': '/var/mail/cltbld', 09:34:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:34:00 INFO - 'MOZ_NO_REMOTE': '1', 09:34:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:34:00 INFO - 'NO_EM_RESTART': '1', 09:34:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:34:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:34:00 INFO - 'PWD': '/builds/slave/test', 09:34:00 INFO - 'SHELL': '/bin/bash', 09:34:00 INFO - 'SHLVL': '1', 09:34:00 INFO - 'TERM': 'linux', 09:34:00 INFO - 'TMOUT': '86400', 09:34:00 INFO - 'USER': 'cltbld', 09:34:00 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1448040804.57017-1030338775', 09:34:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:34:00 INFO - '_': '/tools/buildbot/bin/python'} 09:34:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:34:00 INFO - Running setup.py (path:/tmp/pip-IGfZhi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:34:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:34:00 INFO - Running setup.py (path:/tmp/pip-rcf_0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:34:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:34:00 INFO - Running setup.py (path:/tmp/pip-ypJJvv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:34:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:34:00 INFO - Running setup.py (path:/tmp/pip-FTG_7e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:34:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:34:00 INFO - Running setup.py (path:/tmp/pip-SVa859-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:34:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:34:00 INFO - Running setup.py (path:/tmp/pip-dqVTo_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:34:01 INFO - Running setup.py (path:/tmp/pip-foUuHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:34:01 INFO - Running setup.py (path:/tmp/pip-0qHJqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:34:01 INFO - Running setup.py (path:/tmp/pip-VHvGZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:34:01 INFO - Running setup.py (path:/tmp/pip-KBJsWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:34:01 INFO - Running setup.py (path:/tmp/pip-h9TYKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:34:01 INFO - Running setup.py (path:/tmp/pip-wu8zgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:34:01 INFO - Running setup.py (path:/tmp/pip-ZqJnVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:34:01 INFO - Running setup.py (path:/tmp/pip-hjMAw8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:34:01 INFO - Running setup.py (path:/tmp/pip-Aw9an5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:34:01 INFO - Running setup.py (path:/tmp/pip-zLpfxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:34:01 INFO - Running setup.py (path:/tmp/pip-4lhJRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:34:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:34:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:34:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:34:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:34:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:34:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:34:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:34:03 INFO - Downloading blessings-1.5.1.tar.gz 09:34:03 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 09:34:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:34:03 INFO - Installing collected packages: blessings 09:34:03 INFO - Running setup.py install for blessings 09:34:03 INFO - Successfully installed blessings 09:34:03 INFO - Cleaning up... 09:34:03 INFO - Return code: 0 09:34:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:34:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:34:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:34:03 INFO - Reading from file tmpfile_stdout 09:34:03 INFO - Current package versions: 09:34:03 INFO - argparse == 1.2.1 09:34:03 INFO - blessings == 1.5.1 09:34:03 INFO - blobuploader == 1.2.4 09:34:03 INFO - docopt == 0.6.1 09:34:03 INFO - manifestparser == 1.1 09:34:03 INFO - mozInstall == 1.12 09:34:03 INFO - mozcrash == 0.16 09:34:03 INFO - mozdebug == 0.1 09:34:03 INFO - mozdevice == 0.47 09:34:03 INFO - mozfile == 1.2 09:34:03 INFO - mozhttpd == 0.7 09:34:03 INFO - mozinfo == 0.9 09:34:03 INFO - mozleak == 0.1 09:34:03 INFO - mozlog == 3.0 09:34:03 INFO - moznetwork == 0.27 09:34:03 INFO - mozprocess == 0.22 09:34:03 INFO - mozprofile == 0.27 09:34:03 INFO - mozrunner == 6.11 09:34:03 INFO - mozscreenshot == 0.1 09:34:03 INFO - mozsystemmonitor == 0.0 09:34:03 INFO - moztest == 0.7 09:34:03 INFO - mozversion == 1.4 09:34:03 INFO - psutil == 3.1.1 09:34:03 INFO - requests == 1.2.3 09:34:03 INFO - wsgiref == 0.1.2 09:34:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:34:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:34:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:34:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:34:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:34:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f726164ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a46c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2155900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219bb70>, '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 0x21ecdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ed250>, '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': '20aa3857bbc5a756c598c738000001bb-1448040804.57017-1030338775', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:34:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:34:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:34:03 INFO - Using env: {'DISPLAY': ':0', 09:34:03 INFO - 'HOME': '/home/cltbld', 09:34:03 INFO - 'LANG': 'en_US.UTF-8', 09:34:03 INFO - 'LANGUAGE': 'en_US:en', 09:34:03 INFO - 'LOGNAME': 'cltbld', 09:34:03 INFO - 'MAIL': '/var/mail/cltbld', 09:34:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:34:03 INFO - 'MOZ_NO_REMOTE': '1', 09:34:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:34:03 INFO - 'NO_EM_RESTART': '1', 09:34:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:34:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:34:03 INFO - 'PWD': '/builds/slave/test', 09:34:03 INFO - 'SHELL': '/bin/bash', 09:34:03 INFO - 'SHLVL': '1', 09:34:03 INFO - 'TERM': 'linux', 09:34:03 INFO - 'TMOUT': '86400', 09:34:03 INFO - 'USER': 'cltbld', 09:34:03 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1448040804.57017-1030338775', 09:34:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:34:03 INFO - '_': '/tools/buildbot/bin/python'} 09:34:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:34:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:34:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:34:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:34:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:34:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:34:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:34:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:34:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:34:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:34:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:34:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:34:04 INFO - Cleaning up... 09:34:04 INFO - Return code: 0 09:34:04 INFO - Running post-action listener: _resource_record_post_action 09:34:04 INFO - Running post-action listener: _start_resource_monitoring 09:34:04 INFO - Starting resource monitoring. 09:34:04 INFO - ##### 09:34:04 INFO - ##### Running install step. 09:34:04 INFO - ##### 09:34:04 INFO - Running pre-action listener: _resource_record_pre_action 09:34:04 INFO - Running main action method: install 09:34:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:34:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:34:04 INFO - Reading from file tmpfile_stdout 09:34:04 INFO - Detecting whether we're running mozinstall >=1.0... 09:34:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:34:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:34:04 INFO - Reading from file tmpfile_stdout 09:34:04 INFO - Output received: 09:34:04 INFO - Usage: mozinstall [options] installer 09:34:04 INFO - Options: 09:34:04 INFO - -h, --help show this help message and exit 09:34:04 INFO - -d DEST, --destination=DEST 09:34:04 INFO - Directory to install application into. [default: 09:34:04 INFO - "/builds/slave/test"] 09:34:04 INFO - --app=APP Application being installed. [default: firefox] 09:34:04 INFO - mkdir: /builds/slave/test/build/application 09:34:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:34:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:34:18 INFO - Reading from file tmpfile_stdout 09:34:18 INFO - Output received: 09:34:18 INFO - /builds/slave/test/build/application/firefox/firefox 09:34:18 INFO - Running post-action listener: _resource_record_post_action 09:34:18 INFO - ##### 09:34:18 INFO - ##### Running run-tests step. 09:34:18 INFO - ##### 09:34:18 INFO - Running pre-action listener: _resource_record_pre_action 09:34:18 INFO - Running main action method: run_tests 09:34:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:34:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:34:18 INFO - Python 2.7.3 09:34:18 INFO - Return code: 0 09:34:18 INFO - grabbing minidump binary from tooltool 09:34:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:34:18 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 0x219bb70>, '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 0x21ecdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ed250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:34:18 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:34:18 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:34:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:34:18 INFO - Return code: 0 09:34:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:34:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:34:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:34:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:34:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:34:18 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/6LtkHRJiQwiKji4qOJAWug/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost'] in /builds/slave/test/build 09:34:18 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/6LtkHRJiQwiKji4qOJAWug/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --webServer localhost 09:34:18 INFO - Using env: {'DISPLAY': ':0', 09:34:18 INFO - 'HOME': '/home/cltbld', 09:34:18 INFO - 'LANG': 'en_US.UTF-8', 09:34:18 INFO - 'LANGUAGE': 'en_US:en', 09:34:18 INFO - 'LOGNAME': 'cltbld', 09:34:18 INFO - 'MAIL': '/var/mail/cltbld', 09:34:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:34:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:34:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:34:18 INFO - 'MOZ_NO_REMOTE': '1', 09:34:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:34:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:34:18 INFO - 'NO_EM_RESTART': '1', 09:34:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:34:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:34:18 INFO - 'PWD': '/builds/slave/test', 09:34:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:34:18 INFO - 'SHELL': '/bin/bash', 09:34:18 INFO - 'SHLVL': '1', 09:34:18 INFO - 'TERM': 'linux', 09:34:18 INFO - 'TMOUT': '86400', 09:34:18 INFO - 'USER': 'cltbld', 09:34:18 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1448040804.57017-1030338775', 09:34:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:34:18 INFO - '_': '/tools/buildbot/bin/python'} 09:34:18 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/6LtkHRJiQwiKji4qOJAWug/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost'] with output_timeout 3600 09:34:18 INFO - mozversion INFO | application_buildid: 20151120090417 09:34:18 INFO - mozversion INFO | application_changeset: 67a9dd1470e731be61744b89693dd2e4103fd9e7 09:34:18 INFO - mozversion INFO | application_display_name: Nightly 09:34:18 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:34:18 INFO - mozversion INFO | application_name: Firefox 09:34:18 INFO - mozversion INFO | application_remotingname: firefox 09:34:18 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 09:34:18 INFO - mozversion INFO | application_vendor: Mozilla 09:34:18 INFO - mozversion INFO | application_version: 45.0a1 09:34:18 INFO - mozversion INFO | platform_buildid: 20151120090417 09:34:18 INFO - mozversion INFO | platform_changeset: 67a9dd1470e731be61744b89693dd2e4103fd9e7 09:34:18 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 09:34:18 INFO - mozversion INFO | platform_version: 45.0a1 09:34:18 INFO - 2015-11-20 09:34:18,833 DEBUG : using testdate: 1448040858 09:34:18 INFO - 2015-11-20 09:34:18,833 DEBUG : actual date: 1448040858 09:34:18 INFO - 2015-11-20 09:34:18,850 INFO : starting webserver on 'localhost:44549' 09:34:18 INFO - 2015-11-20 09:34:18,851 INFO : Starting test suite talos-linux64-ix-065.e 09:34:18 INFO - 2015-11-20 09:34:18,851 INFO : Starting test dromaeo_css 09:34:18 INFO - 2015-11-20 09:34:18,852 DEBUG : operating with platform_type : linux_ 09:34:18 INFO - 2015-11-20 09:34:18,853 INFO : Initialising browser for dromaeo_css test... 09:34:18 INFO - 2015-11-20 09:34:18,867 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiT6bdH/profile http://localhost:44549/getInfo.html 09:34:25 INFO - 2015-11-20 09:34:25,834 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:34:25 INFO - 2015-11-20 09:34:25,835 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:34:25 INFO - 2015-11-20 09:34:25,835 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:34:25 INFO - 2015-11-20 09:34:25,835 DEBUG : BROWSER_OUTPUT: __metrics 09:34:26 INFO - 2015-11-20 09:34:26,965 INFO : Browser initialized. 09:34:26 INFO - 2015-11-20 09:34:26,966 INFO : Running cycle 1/1 for dromaeo_css test... 09:34:26 INFO - 2015-11-20 09:34:26,966 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiT6bdH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:34:38 INFO - 2015-11-20 09:34:38,881 DEBUG : BROWSER_OUTPUT: RSS: Main: 139739136 09:34:38 INFO - 2015-11-20 09:34:38,882 DEBUG : BROWSER_OUTPUT: 09:35:28 INFO - 2015-11-20 09:35:28,540 DEBUG : BROWSER_OUTPUT: 1448040928534 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:37:40 INFO - 2015-11-20 09:37:40,529 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44549/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44549/tests/dromaeo/cssquery-ext.html) 09:37:41 INFO - 2015-11-20 09:37:41,541 DEBUG : BROWSER_OUTPUT: RSS: Main: 145186816 09:37:41 INFO - 2015-11-20 09:37:41,541 DEBUG : BROWSER_OUTPUT: 09:40:43 INFO - 2015-11-20 09:40:43,480 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44549/tests/dromaeo/cssquery-ext.html (next: http://localhost:44549/tests/dromaeo/cssquery-jquery.html) 09:40:44 INFO - 2015-11-20 09:40:44,069 DEBUG : BROWSER_OUTPUT: RSS: Main: 143790080 09:40:44 INFO - 2015-11-20 09:40:44,069 DEBUG : BROWSER_OUTPUT: 09:43:45 INFO - 2015-11-20 09:43:45,943 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44549/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44549/tests/dromaeo/cssquery-mootools.html) 09:43:46 INFO - 2015-11-20 09:43:46,543 DEBUG : BROWSER_OUTPUT: RSS: Main: 141623296 09:43:46 INFO - 2015-11-20 09:43:46,544 DEBUG : BROWSER_OUTPUT: 09:46:48 INFO - 2015-11-20 09:46:48,341 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44549/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44549/tests/dromaeo/cssquery-prototype.html) 09:46:48 INFO - 2015-11-20 09:46:48,942 DEBUG : BROWSER_OUTPUT: RSS: Main: 140021760 09:46:48 INFO - 2015-11-20 09:46:48,943 DEBUG : BROWSER_OUTPUT: 09:49:51 INFO - 2015-11-20 09:49:51,491 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44549/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44549/tests/dromaeo/cssquery-yui.html) 09:49:52 INFO - 2015-11-20 09:49:52,120 DEBUG : BROWSER_OUTPUT: RSS: Main: 141762560 09:49:52 INFO - 2015-11-20 09:49:52,120 DEBUG : BROWSER_OUTPUT: 09:52:54 INFO - 2015-11-20 09:52:54,577 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44549/tests/dromaeo/cssquery-yui.html (next: http://localhost:44549/tests/dromaeo/cssquery-dojo.html) 09:52:54 INFO - 2015-11-20 09:52:54,835 DEBUG : BROWSER_OUTPUT: RSS: Main: 143806464 09:52:54 INFO - 2015-11-20 09:52:54,835 DEBUG : BROWSER_OUTPUT: 09:52:54 INFO - 2015-11-20 09:52:54,835 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:52:54 INFO - 2015-11-20 09:52:54,835 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:52:54 INFO - 2015-11-20 09:52:54,835 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:52:54 INFO - 2015-11-20 09:52:54,836 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:52:54 INFO - 2015-11-20 09:52:54,836 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2706.5534186859168;2771.210205091549;2808.115443635256;2810.3957649105437;2815.00067476046;4662.347271382009;4859.757012149392;4869.951300486994;4900.9754951225195;4951.975240123799;4726.90546189076;4803.135435621587;4821.590164835993;4972.453030166679;4977.029479251547;4445.844395446168;4487.573680500347;4556.931646025296;4568.84009059683;4588.724676519403;4530.592246697796;4587.288970209623;4625;4642.605378542811;4648.604868586157;4252.744835309892;4397.032652816375;4441.800118994653;4468.486124095738;4537.773111344452;4468;4480.529544397824;4487.596116349511;4511.954880451219;4513.7743112844555;4415.845445409427;4441.622462090726;4460.643148548108;4477.194105061088;4479.372887795711;4538.977305113486;4620.722756634613;4693.178693728618;4854.101991131617;4885.218365061609;5243.423223445456;5248.790048398059;5252.789888404497;5272.314599102092;5299.152135658276;4930.728809915453;5259.421463638997;5264.789408423659;5270.420253772082;5272.367315922075;4755.429348478205;4791.4250289965075;4803.807847686124;4840.975795121002;4897.363342765489;5302.522772950453;5439.558516993;5442.809501667422;5474.890502189934;5492.615516913857;4965.180745177077;5024.899502009939;5201.141811601044;5239.371275446971;5259.132243179833;5069.315642388304;5112.3865136183895;5168.457311982263;5182.067227898939;5234.712090835041;5132.358455193101;5212.817551385683;5216.165413533817;5232.110541208004;5241.13521268994;4858.1012512685265;4980.103581355391;5097;5176.767045482962;5200.24596433515;4343.04453020335;4367.847125350598;4381.255186618282;4417.779111044435;4421.38100665907;3808.914459379119;3813.599572044951;3816;3848.365019771706;3848.8845334640005;4292.48490181174;4419.801108950105;4448.911021779546;4476.46282446102;4572.337011133367;5247.449017853147;5278.049951008778;5290.365156181283;5312.521873031368;5313.388960269618;4511.413516242933;4515.345274935116;4532.818687252539;4533.569310915458;4547.954520454753;4478.037221997286;4534.2745160774775;4582.473015603248;4607.6083532900075;4651.2557990721325;4905.8037678492465;4934.827281045146;4934.827281045218;4965.553100220997;5009.724465154306;5008.424031236309;5238.5023422774775;5250.26496290512;5255.211718242294;5289.312389389354;4872.098661747588;4906.705597664151;4953.975230123826;4991.775370108427;5042.621803364689;5149.0474262261605;5204.609654275869;5232.110541207928;5247.55395791362;5261.421243663118;4952.925706114339;5064.240363945438;5328.014317351302;5340;5341;4971.154903666313;5039;5056.873578160428;5058.873528161678;5109.591232701449;5063.822766203165;5105.948940510547;5109.897802044013;5113.974430127825;5126;4730.929036064393;4792.376990991149;4889.828855990023;5011.098002359465;5013.749312534432;5126.512981266774;5130.358705161855;5131.948680513147;5137.5889928806355;5140.177571588528;4987.476314986874;5000.449950505369;5009.348784657971;5012.323336349692;5039.269305950544 09:52:54 INFO - 2015-11-20 09:52:54,836 DEBUG : BROWSER_OUTPUT: |1;ext.html;548.2762753165823;572.3246569048521;574.1359254322246;574.8965186266475;582.877595704902;27029.324266893313;27750.86124569377;36033.63966360339;36431.63568364316;36506.81746591263;34957.3008539829;35266.64733352666;35327.4700879487;35413.46879796805;35510.467342989876;7936.603169841514;8144.389170812213;8145.389095817808;8147.633356498942;8161.591920403986;7787.922120778776;7976.481528700616;8001.239882211181;8014.398920080988;8022.318102961255;7917.722879699211;7986.041674999008;8037.598120094001;8044.879326810103;8058.234467725557;7923.088844782837;8021.438499305051;8028;8028.036635603736;8052.033755949265;7833.334166595846;7945.245201705887;7981.281684648351;8000.479968802009;8006.119326874097;37286.62713372859;37843;38035.80982095099;38062;38086;2793.4971705093076;3101.364220334826;3354.8168080315972;3590.910227244314;3700.648438398348;27777;27837.443251134864;27963.440731185263;28060.438791224264;28245.43509129806;3125.312431265118;3129.5156277836145;3180.761442891769;3215.4051500472488;3236.951445728316;218666;220523;221105;221141;221676;48985.510144898806;49994;52316.73841630767;53901.460985390426;55000;41361.793191034456;41630;41680.58319416828;41689.791551042654;41775.1644967105;12893.484260629657;13029.47882084706;13057;13062;13091.279979601213;9107.635694572275;9109.68116115946;9118.361714679908;9138.68014619485;9243.168114869693;15362.078275303518;15524.37902483888;15552.377904883904;15561.455349062955;15616.4534241301;6925.722971081101;6945.340192681788;7071.222165561784;7072.575645461186;7157.785266442015;788.1645455816853;836.4145098431001;871.8997315308694;925.3430064654171;1011.0546638892658;25013.249602511954;26149.73850261511;26192.8690356547;26507.469850603266;29100.272493187415;955.4362925873768;959.4818797849223;974.541965276319;982.9262805289632;1005.5424781724444;11910.344931028703;12596.874031259571;12696.238225706302;12791.168574042844;12804.359782011048;268923;273691;274139;274296;274858;44496.77751611221;44504.3324350135;44581.777091114986;44591.55408445939;44645.33032004523;1240.3674126195524;1240.5968060380412;1247.3887794980394;1250.87491250876;1265.0954567484293;23936.88031559831;24124.87937560301;24497.31251216504;24551.87724061368;24566.63150052715;37781;38293.23413531658;38378.61621383862;38388.232235355696;38489.23021539609;255453;257117;257646;258037;260283;27885.860570697016;28457.573136402556;29011.41977160403;29049.854750726958;29356.412871742872;34606.82696586501;34650.82674586712;35261.118472038404;35287;37810.62189378071;29461.26346841346;30082.54876176903;30111.397772043998;30264;30725.01307563964;28708.39652007323;29085.7091429083;29422;29541.26146846346;30172.09483715492;30369;30455.086347409615;30464.390712185188;30560.847195764767;32351;26902;29296.267593309483;29412.55881161827;29625;29773.702262977095;22465;23164.420889477224;23466.413339666644;23811.166609168595;23823.404414889766 09:52:54 INFO - 2015-11-20 09:52:54,836 DEBUG : BROWSER_OUTPUT: |2;jquery.html;325.68083278387167;328.6023911067608;329.31173846660477;339.2113336492655;340.78849689354337;15174.08955462673;15698.764518532216;15877.682446351066;16000.279987400565;16538.917305413484;9566.712998610035;9806.460644664541;12833.614991550268;14471.276436178201;14522.491712790055;4634.096351211507;4791.47293797682;4796.064767370364;4937.5556199942;5118.744062796845;4942.555170034696;4961.727105009223;4991.900161996758;5009.6242781791325;5029.572486338666;4937.308776771255;4968.701877887338;5129.6409251352425;5136.306598609177;5258.763355649005;5072.594192464594;5121.769520371555;5122.462141475147;5132.948670513303;6405.19935008124;6399.8080057598345;6402.167718196604;6410.61536307823;6423.132877061584;6423.325550817191;19425.611487770166;20808.687869681966;21046;21106.366808995754;21436.892815535823;1952.375239923225;1959.8334141597982;2039.1027947702962;2073.6060148571723;2144.8713077215416;12664.936675316656;13126.86873131266;13197.538086166938;13752.724945501133;13906.235157066358;1749.6063385738235;1780.8753387262898;1870.635226130905;1939.7284380186786;1993.1230258686132;59831.401685983015;65782.01326980146;66487.3351266486;67047.66476167589;67834;15559.611009724847;15667;15712.528624141294;15720.60698482547;15747.212639367986;23561.7643823563;23653.290401287988;23801.166959156348;23809.404764881016;24046.27861164168;8287.668493260202;8320.334373250125;8366.372522060748;8366.456180348257;8423.747287581382;6882.208546017172;6921.238663746984;6923.238443771181;6967.79096627102;6976.651167441608;7708.49894756839;7712.383009359238;7712.845743085107;7738.303552680286;7763.641362761494;1725.3781445441246;3003.2491877030743;3007.0978706387996;3021.9395612088074;3086.382723455318;374.80322830513654;379.8044007336224;771.726037256777;892.2282225874571;915.2540679346312;9531.220571179394;10185.643502477526;15189.848101519065;15431.537053888402;16043.037417754738;832.2177153475714;903.8734577159203;917.9862302065475;942.4863449420083;988.4859872866069;8257.95871020641;8369.707060252862;8421.115782842713;8593.613287402082;8600.13998600135;446050;447532;472774;475778;477319;67076;68127.31872681309;68634;69105.3089469109;70895.2910470899;1110.722319420145;1112.060309038877;1156.9652910412701;1172.1384782185087;1176.9411529423667;13797.51708690191;14044.438222470986;14239.288035597972;14320.355583998537;14468.348924298221;28708.282292942007;29082;29112.27219319534;29694.851525742233;31871.203219919687;41126.58873411227;41292.1741565173;43097;43336.133277334906;48454.515454845;8249.79375515593;8392.664293428195;8493.830123397622;8512.957435213031;8634.266087382643;10449.425281609585;10493.2130090242;10517.526711297856;10789.838152427878;16852.494425166773;12488.250704957369;12639.747205055663;12867.613971580493;13126.409311581192;13502.594922152352;12774;13020.674483137997;13084.607461776162;13522.729545409233;13576.728465430439;12736.044796640474;12775.425105870445;13229.237474508976;13276.468941242241;13435.932820335836;8298.751037468886;8616.956915215384;8869.309256331726;8917.73246802597;9005.549722513979;12498.875011249771;13257.867421325664;13745;14011.719765604834;14029.3686784097 09:52:54 INFO - 2015-11-20 09:52:54,836 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1359.1912811876937;1403.1931639307402;1408.6971301170247;1603.2705119170778;1688.2740421618703;6080.483158931496;6145.293291271505;6975.2675969023285;7145.892811607823;7167.211606723263;6799.252082270947;7180.533265337749;7184.1738200107;7229.855402891939;7234.3489085982255;2046.0690385874466;2081.3131666550003;2093.2045822587397;2095.6751703485984;2102.148629804924;2022.7673817510954;2061.443410279224;2066.276803118911;2068.617305798432;2069.058578346856;2060.423081537172;2061.2476446097144;2065.793420657937;2082.3232449453913;2092.665173572229;2103.13771353745;2129.9254526091513;2132.0086159935627;2132.616129096762;2133.7332833395826;2078.906449209789;2102.4113248290505;2118.131566057909;2122.2678176029244;2123.055240418015;7204.891926621105;7264.128304603481;7303.269673032707;7303.415726741848;7323.450741194431;4196.3705444183315;4231.767252801094;4247.5964783345535;4264.616184543406;4280.593343632381;2781.5118911382515;2785.874635641401;2803.4112836304403;2804.1447358555633;2808.101407549585;854.6068808348167;860.4622111180512;871.773338931876;909.3725329522608;911.9694744938244;9646.180074693659;9707.61169553217;9712.514374281329;9725.367851089657;9746.512674366253;3961.425593288957;3978.9403158952637;4012.3580227163516;4026.4966879140106;4060.147369052473;8401.369897257608;8401.873971890303;8402.159784021671;8402.831943361221;8408.32733381328;4211.515675697273;4222.915541689149;4260.8721738347895;4263.829446822155;4273.252180868336;3750.3436898542645;3865.40086286626;3869.5743468218475;3875.0893540018074;3876.8643097491454;3323.5347051412823;3345.0466617014035;3357.496375543688;3359.7480188985437;3373.578302712161;1002.2332915319786;1006.8741407324085;1007.9899201008043;1030.2633616963906;1038.8805287391895;1158.2645020412099;1163.4648061891626;1164.371239530661;1183.2131632464316;1187.1155988788234;6817.693203805741;6829.317068293131;6851.862962740817;6865.862682746317;6876.621785801829;436.6332280884009;441.2322558747756;442.601658507346;1117.5027112934665;1140.1790710688292;5170.40540337866;5296.894062118736;5306.151015837448;5306.6550674206055;5336.91994620081;8257.38069644779;8420.747377578682;8430.072692003998;8461.957690211633;8469.66121355139;8297.087320394752;8387.706430274911;8423.789405264917;8439;8492.065872753992;6659.800205993828;6698.12924319845;6703.497237707192;6716.261211266757;6733.158355205599;6539.280679125388;6540.117084193763;6571.310012448624;6572.76995305162;6592.670366481752;7428.368588670023;7440.776776696708;7461.4776965614055;7566.24337566239;7652.349550288288;7659.119201291923;7769.300762931363;7770.883436748566;7855.214478552099;7881.935938648209;5622.409646987007;5828.94171058301;5843.970780146072;6360.173177487082;6363.713632886439;6893.655317234018;6915.792526224222;6915.896261556181;6944.923536851796;6950.026996220432;6358.1734374531015;6399.6800159992745;6446.5165112615805;6533.314002029909;6538.346165383424;6147.44672979434;6190.876182476415;6218.533609979179;6244.063390491463;6280.497560195265;6505.186851643544;6566.080748695091;6566.376194261537;6572.572782769104;6575.2767195607485;5674.517665998436;5984.251968503937;6017.939820601738;6024.307204671519;6029.698515074141;6175.876482470236;6228.532860035606;6228.56400051992;6246.656433896179;6251.312355640966 09:52:54 INFO - 2015-11-20 09:52:54,836 DEBUG : BROWSER_OUTPUT: |4;prototype.html;304.6709553682024;314.7529189586174;316.288351209778;317.82996097088056;320.6905336350424;5592.552595792332;5681.431856814327;5730.3123625164935;5778.884422311557;5796.536277097833;5659.122835960422;5662.263905692264;5720.399358067395;5723.599348045638;5730.455606717355;4191.057012172252;4293.03406733484;4293.055527783882;4404.4054052702795;4406.294992801152;4331.350297455376;4332.870013899572;4340.262155433568;4345;4350.434443522354;4290.69965102443;4291.8712438626735;4295.463067116611;4296.162248361571;4301.505326887417;4304.504981927087;4309.525952145262;4310.482742070956;4312.331588603755;4319.611234988866;3716.5168528091444;3720.8325625346924;3724.571674257468;3771.868439468176;3856.9807150964066;5415.458454154593;5491.862703432406;5516.613837031409;5518.255035570187;5522.475364840334;5071.39143302806;5090.9236361454605;5115.411727651293;5122.692638441668;5128.538431541142;6055.091736239555;6055.7274922628585;6066.211392518944;6079.817605471843;6092.238470191226;4157.210130075276;4238.215930052919;4240.554741752102;4255.340422234559;4258.680598955059;6240.126382306481;6308.558400911938;6329.968350158219;6348.396902294321;6362.713677884506;4374.19077470669;4376.124775045004;4376.584224498668;4380.8904777380185;4393.692441529062;4449.1101779644205;4449.354843547668;4466.6873318867365;4467.419235499429;4477.171723231213;4949.554540091409;5076.060928728123;5085.593152547787;5093.439721630618;5097.592192624581;6026.758929642853;6036.547258955508;6038.607490513103;6040.365761595057;6052.334243233241;1539.4457995121747;1589.0306912783194;1592.0129519697862;1592.243684249972;1594.7448408254625;1047.204124865108;1047.895210478946;1070.4059247117768;1071.8767341755797;1076.359566058194;5208.921866172011;5220.791168353299;5221.32122824038;5224.373075230997;5225.790968361223;6267.71795269214;6271.278802937721;6276.309605943343;6288.496920246369;6297.685115744286;5185.948140518622;5231.8168864089575;5236.528712415825;5237;5242.1088414969545;3338;3377.3920694274775;3383.3909896218915;3392.6946574808385;3399.2351720862607;5718.285214348207;5838.065909454467;5845.386234445407;5917.792877249276;5920.141579470953;6426.775062872777;6464.095026696266;6503.447206987365;6511.0558968949235;6517.348265173445;5878.882422351529;5910.822675319747;5916.3787802281;5918.082697181943;5919.970400148058;6197.411245931629;6222.377762223922;6308.432241098323;6321.1782468278825;6330.240371155491;6133.570650054453;6154.569180157346;6155;6174.197354343906;6179.474744646755;5796.101604251347;5812.389699081536;5814.273215848019;5873.970630146822;5894.911576326273;4222.2611043067955;4266.0827921996915;4270.252705776539;4274.893127671833;4282.507511636201;6094.695265236809;6312.337204593451;6315.400036996478;6341.143945567289;6344.936550634435;5945.672987985702;6049.758009679564;6077.604955677867;6080.574359794772;6086.452219300107;6054.697265136813;6099.634021958696;6104.603200791934;6110.114033465212;6117.571769976237;5725.541956643375;5902.2327097477055;5932.940670593239;5957.76168953237;5965.492933100735;6120.571559990936;6123.2958209804665;6133.44798968095;6141.662208578571;6150.35421280777;5954.464098231007;5964.075568286922;5965.612235204698;5975.55183361241;5980.162777211107 09:52:54 INFO - 2015-11-20 09:52:54,837 DEBUG : BROWSER_OUTPUT: |5;yui.html;635.174273444522;670.7384120193125;720.3228964773115;720.8738470767614;763.1147868472566;11861.584844530444;12155.75688486232;12187;12279.201851879632;12281.754364912707;11613.709657258572;11844.58543950962;12803.743925121493;13030.348482575857;13192.868071319308;617.4597227426002;626.1797045869902;627.4071002902259;627.86500902306;787.5707739282105;805.4200975297776;810.805406702393;815.2173913043486;815.4577206157898;815.8776183572481;832.8667413213886;839.8908141941539;841.3311417423133;842.321930845669;846.4836449765638;830.0578843013163;833.9291160251386;834.0491839303199;838.3712215838121;839.5634270179534;622.2501885228289;623.3050149083784;624.618982420723;625.1154616218046;627.8493161641173;11695.532178712927;11715;11758.470868810924;11798.46906889192;11841.5855445059;10129.544170512345;10395.272330936838;10799.784004319949;11254.943725281402;11689.064874809996;8785.165409286108;8893;9001.459912405277;9033.728988130366;9571.425714457086;3185.2992341684794;3213.855376508039;3228.8708451661905;3248.4964830451318;3327.8169700666454;42331.57668423307;42416.78791606053;42583.787081064394;42679.786601067106;42721;8785.341099417441;9079.863802042975;9151.35940484173;9344.95327523358;9392.530373481299;15505.224738763016;15626.921865390601;15642.921785391229;15657.451989180552;15680.05919644825;6241.21984751906;6526.543141980016;6636.435902948304;6655.800325990228;6776.898346524806;3575.4279315309946;3625.782453052825;3692.113892665741;3696.5748938872375;3772.660460558508;2606.89572417105;2625.960610590843;2636.0905487606747;2638.155790147173;2647.3646324882275;465.2463009923945;473.6849994753519;478.3255609590461;478.4019975031211;480.0686667864332;453.40603809009644;471.1354664191247;487.63671065056053;563.6505366672607;576.4293349583882;7456.96271518639;7562.962185189149;7825.256600622932;8440.366972477088;8529.872051919227;496.3175633503932;533.8474086156994;601.3265143039823;628.3151365012159;665.8335416145964;3397.2016576104597;3452;3556.91107722309;3841.0397400649836;3854.4218367244575;52816;53413.46586534085;53594.73202633962;53609.73195133999;53618.731906340996;47246.291305630446;47446.762766186635;47571.524284757405;48687.51312486901;48751.756241218565;43255.56744432578;43487.565124348985;43568.3464748029;43591.910202244566;44424.555754442044;7735.574543400167;7754.573498457414;7896.09194942589;8006.519608823489;8057.597120144086;31600.525992110597;31984;32542;32614;32650.673493264763;38681.6131838678;41327.793361033;41330;41352.58647413487;41631;9385.38994965325;9617.471039092918;9848.606055757977;10008.549615267184;10129.64546240878;11291.153163512605;11348.716282093013;11470.197086203885;11756.529738810694;12132.939335303266;10550.8417373741;10804.297720648132;10918.781624367628;11247.550097995989;11333.716657083638;10233.385996840214;10520.473976301308;10575.048245657928;10708.625198118028;10999.120070394509;8613.3109351253;9970.900290996997;10630.362178269328;11011.669649910515;11235.101191904465;8613.827723445622;8781;8873.334499912662;8980.101989800967;9105.635774568944;8352.958235208785;8883.822323553364;8951.194392504705;9032.059797371061;9168 09:52:54 INFO - 2015-11-20 09:52:54,837 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:52:54 INFO - 2015-11-20 09:52:54,837 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:52:54 INFO - 2015-11-20 09:52:54,837 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,329 09:52:54 INFO - 2015-11-20 09:52:54,837 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:52:54 INFO - 2015-11-20 09:52:54,839 DEBUG : BROWSER_OUTPUT: __startTimestamp1448041974829__endTimestamp 09:52:54 INFO - 2015-11-20 09:52:54,839 DEBUG : BROWSER_OUTPUT: 09:52:54 INFO - 2015-11-20 09:52:54,839 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:52:54 INFO - 2015-11-20 09:52:54,839 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:52:54 INFO - 2015-11-20 09:52:54,839 DEBUG : BROWSER_OUTPUT: 09:52:54 INFO - 2015-11-20 09:52:54,840 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4810.47 Median:4951.98 stddev:507.93 (10.3%) stddev-sans-first:481.92 09:52:54 INFO - 2015-11-20 09:52:54,841 DEBUG : BROWSER_OUTPUT: Values: 2706.6 2771.2 2808.1 2810.4 2815.0 4662.3 4859.8 4870.0 4901.0 4952.0 4726.9 4803.1 4821.6 4972.5 4977.0 4445.8 4487.6 4556.9 4568.8 4588.7 4530.6 4587.3 4625.0 4642.6 4648.6 4252.7 4397.0 4441.8 4468.5 4537.8 4468.0 4480.5 4487.6 4512.0 4513.8 4415.8 4441.6 4460.6 4477.2 4479.4 4539.0 4620.7 4693.2 4854.1 4885.2 5243.4 5248.8 5252.8 5272.3 5299.2 4930.7 5259.4 5264.8 5270.4 5272.4 4755.4 4791.4 4803.8 4841.0 4897.4 5302.5 5439.6 5442.8 5474.9 5492.6 4965.2 5024.9 5201.1 5239.4 5259.1 5069.3 5112.4 5168.5 5182.1 5234.7 5132.4 5212.8 5216.2 5232.1 5241.1 4858.1 4980.1 5097.0 5176.8 5200.2 4343.0 4367.8 4381.3 4417.8 4421.4 3808.9 3813.6 3816.0 3848.4 3848.9 4292.5 4419.8 4448.9 4476.5 4572.3 5247.4 5278.0 5290.4 5312.5 5313.4 4511.4 4515.3 4532.8 4533.6 4548.0 4478.0 4534.3 4582.5 4607.6 4651.3 4905.8 4934.8 4934.8 4965.6 5009.7 5008.4 5238.5 5250.3 5255.2 5289.3 4872.1 4906.7 4954.0 4991.8 5042.6 5149.0 5204.6 5232.1 5247.6 5261.4 4952.9 5064.2 5328.0 5340.0 5341.0 4971.2 5039.0 5056.9 5058.9 5109.6 5063.8 5105.9 5109.9 5114.0 5126.0 4730.9 4792.4 4889.8 5011.1 5013.7 5126.5 5130.4 5131.9 5137.6 5140.2 4987.5 5000.4 5009.3 5012.3 5039.3 09:52:54 INFO - 2015-11-20 09:52:54,841 DEBUG : BROWSER_OUTPUT: 09:52:54 INFO - 2015-11-20 09:52:54,841 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39647.08 Median:3295.88 stddev:65615.98 (1990.8%) stddev-sans-first:65734.38 09:52:54 INFO - 2015-11-20 09:52:54,842 DEBUG : BROWSER_OUTPUT: Values: 548.3 572.3 574.1 574.9 582.9 27029.3 27750.9 36033.6 36431.6 36506.8 34957.3 35266.6 35327.5 35413.5 35510.5 7936.6 8144.4 8145.4 8147.6 8161.6 7787.9 7976.5 8001.2 8014.4 8022.3 7917.7 7986.0 8037.6 8044.9 8058.2 7923.1 8021.4 8028.0 8028.0 8052.0 7833.3 7945.2 7981.3 8000.5 8006.1 37286.6 37843.0 38035.8 38062.0 38086.0 2793.5 3101.4 3354.8 3590.9 3700.6 27777.0 27837.4 27963.4 28060.4 28245.4 3125.3 3129.5 3180.8 3215.4 3237.0 218666.0 220523.0 221105.0 221141.0 221676.0 48985.5 49994.0 52316.7 53901.5 55000.0 41361.8 41630.0 41680.6 41689.8 41775.2 12893.5 13029.5 13057.0 13062.0 13091.3 9107.6 9109.7 9118.4 9138.7 9243.2 15362.1 15524.4 15552.4 15561.5 15616.5 6925.7 6945.3 7071.2 7072.6 7157.8 788.2 836.4 871.9 925.3 1011.1 25013.2 26149.7 26192.9 26507.5 29100.3 955.4 959.5 974.5 982.9 1005.5 11910.3 12596.9 12696.2 12791.2 12804.4 268923.0 273691.0 274139.0 274296.0 274858.0 44496.8 44504.3 44581.8 44591.6 44645.3 1240.4 1240.6 1247.4 1250.9 1265.1 23936.9 24124.9 24497.3 24551.9 24566.6 37781.0 38293.2 38378.6 38388.2 38489.2 255453.0 257117.0 257646.0 258037.0 260283.0 27885.9 28457.6 29011.4 29049.9 29356.4 34606.8 34650.8 35261.1 35287.0 37810.6 29461.3 30082.5 30111.4 30264.0 30725.0 28708.4 29085.7 29422.0 29541.3 30172.1 30369.0 30455.1 30464.4 30560.8 32351.0 26902.0 29296.3 29412.6 29625.0 29773.7 22465.0 23164.4 23466.4 23811.2 23823.4 09:52:54 INFO - 2015-11-20 09:52:54,842 DEBUG : BROWSER_OUTPUT: 09:52:54 INFO - 2015-11-20 09:52:54,842 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26387.58 Median:340.00 stddev:75807.18 (22296.2%) stddev-sans-first:75994.58 09:52:54 INFO - 2015-11-20 09:52:54,842 DEBUG : BROWSER_OUTPUT: Values: 325.7 328.6 329.3 339.2 340.8 15174.1 15698.8 15877.7 16000.3 16538.9 9566.7 9806.5 12833.6 14471.3 14522.5 4634.1 4791.5 4796.1 4937.6 5118.7 4942.6 4961.7 4991.9 5009.6 5029.6 4937.3 4968.7 5129.6 5136.3 5258.8 5072.6 5121.8 5122.5 5132.9 6405.2 6399.8 6402.2 6410.6 6423.1 6423.3 19425.6 20808.7 21046.0 21106.4 21436.9 1952.4 1959.8 2039.1 2073.6 2144.9 12664.9 13126.9 13197.5 13752.7 13906.2 1749.6 1780.9 1870.6 1939.7 1993.1 59831.4 65782.0 66487.3 67047.7 67834.0 15559.6 15667.0 15712.5 15720.6 15747.2 23561.8 23653.3 23801.2 23809.4 24046.3 8287.7 8320.3 8366.4 8366.5 8423.7 6882.2 6921.2 6923.2 6967.8 6976.7 7708.5 7712.4 7712.8 7738.3 7763.6 1725.4 3003.2 3007.1 3021.9 3086.4 374.8 379.8 771.7 892.2 915.3 9531.2 10185.6 15189.8 15431.5 16043.0 832.2 903.9 918.0 942.5 988.5 8258.0 8369.7 8421.1 8593.6 8600.1 446050.0 447532.0 472774.0 475778.0 477319.0 67076.0 68127.3 68634.0 69105.3 70895.3 1110.7 1112.1 1157.0 1172.1 1176.9 13797.5 14044.4 14239.3 14320.4 14468.3 28708.3 29082.0 29112.3 29694.9 31871.2 41126.6 41292.2 43097.0 43336.1 48454.5 8249.8 8392.7 8493.8 8513.0 8634.3 10449.4 10493.2 10517.5 10789.8 16852.5 12488.3 12639.7 12867.6 13126.4 13502.6 12774.0 13020.7 13084.6 13522.7 13576.7 12736.0 12775.4 13229.2 13276.5 13435.9 8298.8 8617.0 8869.3 8917.7 9005.5 12498.9 13257.9 13745.0 14011.7 14029.4 09:52:54 INFO - 2015-11-20 09:52:54,843 DEBUG : BROWSER_OUTPUT: 09:52:54 INFO - 2015-11-20 09:52:54,843 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4980.00 Median:6161.66 stddev:2576.62 (41.8%) stddev-sans-first:2569.48 09:52:54 INFO - 2015-11-20 09:52:54,843 DEBUG : BROWSER_OUTPUT: Values: 1359.2 1403.2 1408.7 1603.3 1688.3 6080.5 6145.3 6975.3 7145.9 7167.2 6799.3 7180.5 7184.2 7229.9 7234.3 2046.1 2081.3 2093.2 2095.7 2102.1 2022.8 2061.4 2066.3 2068.6 2069.1 2060.4 2061.2 2065.8 2082.3 2092.7 2103.1 2129.9 2132.0 2132.6 2133.7 2078.9 2102.4 2118.1 2122.3 2123.1 7204.9 7264.1 7303.3 7303.4 7323.5 4196.4 4231.8 4247.6 4264.6 4280.6 2781.5 2785.9 2803.4 2804.1 2808.1 854.6 860.5 871.8 909.4 912.0 9646.2 9707.6 9712.5 9725.4 9746.5 3961.4 3978.9 4012.4 4026.5 4060.1 8401.4 8401.9 8402.2 8402.8 8408.3 4211.5 4222.9 4260.9 4263.8 4273.3 3750.3 3865.4 3869.6 3875.1 3876.9 3323.5 3345.0 3357.5 3359.7 3373.6 1002.2 1006.9 1008.0 1030.3 1038.9 1158.3 1163.5 1164.4 1183.2 1187.1 6817.7 6829.3 6851.9 6865.9 6876.6 436.6 441.2 442.6 1117.5 1140.2 5170.4 5296.9 5306.2 5306.7 5336.9 8257.4 8420.7 8430.1 8462.0 8469.7 8297.1 8387.7 8423.8 8439.0 8492.1 6659.8 6698.1 6703.5 6716.3 6733.2 6539.3 6540.1 6571.3 6572.8 6592.7 7428.4 7440.8 7461.5 7566.2 7652.3 7659.1 7769.3 7770.9 7855.2 7881.9 5622.4 5828.9 5844.0 6360.2 6363.7 6893.7 6915.8 6915.9 6944.9 6950.0 6358.2 6399.7 6446.5 6533.3 6538.3 6147.4 6190.9 6218.5 6244.1 6280.5 6505.2 6566.1 6566.4 6572.6 6575.3 5674.5 5984.3 6017.9 6024.3 6029.7 6175.9 6228.5 6228.6 6246.7 6251.3 09:52:54 INFO - 2015-11-20 09:52:54,843 DEBUG : BROWSER_OUTPUT: 09:52:54 INFO - 2015-11-20 09:52:54,843 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4996.21 Median:5625.84 stddev:1479.91 (26.3%) stddev-sans-first:1441.55 09:52:54 INFO - 2015-11-20 09:52:54,844 DEBUG : BROWSER_OUTPUT: Values: 304.7 314.8 316.3 317.8 320.7 5592.6 5681.4 5730.3 5778.9 5796.5 5659.1 5662.3 5720.4 5723.6 5730.5 4191.1 4293.0 4293.1 4404.4 4406.3 4331.4 4332.9 4340.3 4345.0 4350.4 4290.7 4291.9 4295.5 4296.2 4301.5 4304.5 4309.5 4310.5 4312.3 4319.6 3716.5 3720.8 3724.6 3771.9 3857.0 5415.5 5491.9 5516.6 5518.3 5522.5 5071.4 5090.9 5115.4 5122.7 5128.5 6055.1 6055.7 6066.2 6079.8 6092.2 4157.2 4238.2 4240.6 4255.3 4258.7 6240.1 6308.6 6330.0 6348.4 6362.7 4374.2 4376.1 4376.6 4380.9 4393.7 4449.1 4449.4 4466.7 4467.4 4477.2 4949.6 5076.1 5085.6 5093.4 5097.6 6026.8 6036.5 6038.6 6040.4 6052.3 1539.4 1589.0 1592.0 1592.2 1594.7 1047.2 1047.9 1070.4 1071.9 1076.4 5208.9 5220.8 5221.3 5224.4 5225.8 6267.7 6271.3 6276.3 6288.5 6297.7 5185.9 5231.8 5236.5 5237.0 5242.1 3338.0 3377.4 3383.4 3392.7 3399.2 5718.3 5838.1 5845.4 5917.8 5920.1 6426.8 6464.1 6503.4 6511.1 6517.3 5878.9 5910.8 5916.4 5918.1 5920.0 6197.4 6222.4 6308.4 6321.2 6330.2 6133.6 6154.6 6155.0 6174.2 6179.5 5796.1 5812.4 5814.3 5874.0 5894.9 4222.3 4266.1 4270.3 4274.9 4282.5 6094.7 6312.3 6315.4 6341.1 6344.9 5945.7 6049.8 6077.6 6080.6 6086.5 6054.7 6099.6 6104.6 6110.1 6117.6 5725.5 5902.2 5932.9 5957.8 5965.5 6120.6 6123.3 6133.4 6141.7 6150.4 5954.5 5964.1 5965.6 5975.6 5980.2 09:52:54 INFO - 2015-11-20 09:52:54,844 DEBUG : BROWSER_OUTPUT: 09:52:54 INFO - 2015-11-20 09:52:54,844 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12623.53 Median:47509.14 stddev:14723.97 (31.0%) stddev-sans-first:14737.75 09:52:54 INFO - 2015-11-20 09:52:54,844 DEBUG : BROWSER_OUTPUT: Values: 635.2 670.7 720.3 720.9 763.1 11861.6 12155.8 12187.0 12279.2 12281.8 11613.7 11844.6 12803.7 13030.3 13192.9 617.5 626.2 627.4 627.9 787.6 805.4 810.8 815.2 815.5 815.9 832.9 839.9 841.3 842.3 846.5 830.1 833.9 834.0 838.4 839.6 622.3 623.3 624.6 625.1 627.8 11695.5 11715.0 11758.5 11798.5 11841.6 10129.5 10395.3 10799.8 11254.9 11689.1 8785.2 8893.0 9001.5 9033.7 9571.4 3185.3 3213.9 3228.9 3248.5 3327.8 42331.6 42416.8 42583.8 42679.8 42721.0 8785.3 9079.9 9151.4 9345.0 9392.5 15505.2 15626.9 15642.9 15657.5 15680.1 6241.2 6526.5 6636.4 6655.8 6776.9 3575.4 3625.8 3692.1 3696.6 3772.7 2606.9 2626.0 2636.1 2638.2 2647.4 465.2 473.7 478.3 478.4 480.1 453.4 471.1 487.6 563.7 576.4 7457.0 7563.0 7825.3 8440.4 8529.9 496.3 533.8 601.3 628.3 665.8 3397.2 3452.0 3556.9 3841.0 3854.4 52816.0 53413.5 53594.7 53609.7 53618.7 47246.3 47446.8 47571.5 48687.5 48751.8 43255.6 43487.6 43568.3 43591.9 44424.6 7735.6 7754.6 7896.1 8006.5 8057.6 31600.5 31984.0 32542.0 32614.0 32650.7 38681.6 41327.8 41330.0 41352.6 41631.0 9385.4 9617.5 9848.6 10008.5 10129.6 11291.2 11348.7 11470.2 11756.5 12132.9 10550.8 10804.3 10918.8 11247.6 11333.7 10233.4 10520.5 10575.0 10708.6 10999.1 8613.3 9970.9 10630.4 11011.7 11235.1 8613.8 8781.0 8873.3 8980.1 9105.6 8353.0 8883.8 8951.2 9032.1 9168.0 09:52:54 INFO - 2015-11-20 09:52:54,844 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:52:54 INFO - 2015-11-20 09:52:54,844 DEBUG : BROWSER_OUTPUT: 09:52:55 INFO - 2015-11-20 09:52:55,592 INFO : Browser exited with error code: 0 09:52:55 INFO - 2015-11-20 09:52:55,607 INFO : Completed test dromaeo_css (00:18:36) 09:52:55 INFO - 2015-11-20 09:52:55,607 INFO : Starting test kraken 09:52:55 INFO - 2015-11-20 09:52:55,607 DEBUG : operating with platform_type : linux_ 09:52:55 INFO - 2015-11-20 09:52:55,607 INFO : Initialising browser for kraken test... 09:52:55 INFO - 2015-11-20 09:52:55,613 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEXkP1G/profile http://localhost:44549/getInfo.html 09:53:00 INFO - 2015-11-20 09:53:00,559 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:53:00 INFO - 2015-11-20 09:53:00,559 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:53:00 INFO - 2015-11-20 09:53:00,559 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:53:00 INFO - 2015-11-20 09:53:00,559 DEBUG : BROWSER_OUTPUT: __metrics 09:53:01 INFO - 2015-11-20 09:53:01,629 INFO : Browser initialized. 09:53:01 INFO - 2015-11-20 09:53:01,629 INFO : Running cycle 1/1 for kraken test... 09:53:01 INFO - 2015-11-20 09:53:01,630 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEXkP1G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:53:13 INFO - 2015-11-20 09:53:13,551 DEBUG : BROWSER_OUTPUT: RSS: Main: 141398016 09:53:13 INFO - 2015-11-20 09:53:13,551 DEBUG : BROWSER_OUTPUT: 09:53:16 INFO - 2015-11-20 09:53:16,168 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44549/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44549/tests/kraken/driver.html?testName=audio-beat-detection) 09:53:16 INFO - 2015-11-20 09:53:16,775 DEBUG : BROWSER_OUTPUT: RSS: Main: 140984320 09:53:16 INFO - 2015-11-20 09:53:16,775 DEBUG : BROWSER_OUTPUT: 09:53:19 INFO - 2015-11-20 09:53:19,538 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44549/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44549/tests/kraken/driver.html?testName=audio-dft) 09:53:20 INFO - 2015-11-20 09:53:20,140 DEBUG : BROWSER_OUTPUT: RSS: Main: 141279232 09:53:20 INFO - 2015-11-20 09:53:20,140 DEBUG : BROWSER_OUTPUT: 09:53:23 INFO - 2015-11-20 09:53:23,064 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44549/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44549/tests/kraken/driver.html?testName=audio-fft) 09:53:23 INFO - 2015-11-20 09:53:23,645 DEBUG : BROWSER_OUTPUT: RSS: Main: 136912896 09:53:23 INFO - 2015-11-20 09:53:23,645 DEBUG : BROWSER_OUTPUT: 09:53:25 INFO - 2015-11-20 09:53:25,698 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44549/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44549/tests/kraken/driver.html?testName=audio-oscillator) 09:53:26 INFO - 2015-11-20 09:53:26,310 DEBUG : BROWSER_OUTPUT: RSS: Main: 138072064 09:53:26 INFO - 2015-11-20 09:53:26,311 DEBUG : BROWSER_OUTPUT: 09:53:28 INFO - 2015-11-20 09:53:28,585 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44549/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44549/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:53:29 INFO - 2015-11-20 09:53:29,166 DEBUG : BROWSER_OUTPUT: RSS: Main: 137216000 09:53:29 INFO - 2015-11-20 09:53:29,166 DEBUG : BROWSER_OUTPUT: 09:53:32 INFO - 2015-11-20 09:53:32,231 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44549/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44549/tests/kraken/driver.html?testName=imaging-darkroom) 09:53:32 INFO - 2015-11-20 09:53:32,824 DEBUG : BROWSER_OUTPUT: RSS: Main: 137744384 09:53:32 INFO - 2015-11-20 09:53:32,824 DEBUG : BROWSER_OUTPUT: 09:53:36 INFO - 2015-11-20 09:53:36,287 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44549/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44549/tests/kraken/driver.html?testName=imaging-desaturate) 09:53:36 INFO - 2015-11-20 09:53:36,888 DEBUG : BROWSER_OUTPUT: RSS: Main: 136409088 09:53:36 INFO - 2015-11-20 09:53:36,889 DEBUG : BROWSER_OUTPUT: 09:53:39 INFO - 2015-11-20 09:53:39,821 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44549/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44549/tests/kraken/driver.html?testName=json-parse-financial) 09:53:40 INFO - 2015-11-20 09:53:40,414 DEBUG : BROWSER_OUTPUT: RSS: Main: 137121792 09:53:40 INFO - 2015-11-20 09:53:40,414 DEBUG : BROWSER_OUTPUT: 09:53:42 INFO - 2015-11-20 09:53:42,185 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44549/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44549/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:53:42 INFO - 2015-11-20 09:53:42,772 DEBUG : BROWSER_OUTPUT: RSS: Main: 138817536 09:53:42 INFO - 2015-11-20 09:53:42,773 DEBUG : BROWSER_OUTPUT: 09:53:44 INFO - 2015-11-20 09:53:44,651 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44549/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44549/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:53:45 INFO - 2015-11-20 09:53:45,278 DEBUG : BROWSER_OUTPUT: RSS: Main: 138321920 09:53:45 INFO - 2015-11-20 09:53:45,278 DEBUG : BROWSER_OUTPUT: 09:53:47 INFO - 2015-11-20 09:53:47,511 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44549/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44549/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:53:48 INFO - 2015-11-20 09:53:48,098 DEBUG : BROWSER_OUTPUT: RSS: Main: 138928128 09:53:48 INFO - 2015-11-20 09:53:48,098 DEBUG : BROWSER_OUTPUT: 09:53:50 INFO - 2015-11-20 09:53:50,682 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44549/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44549/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:53:51 INFO - 2015-11-20 09:53:51,284 DEBUG : BROWSER_OUTPUT: RSS: Main: 138866688 09:53:51 INFO - 2015-11-20 09:53:51,284 DEBUG : BROWSER_OUTPUT: 09:53:53 INFO - 2015-11-20 09:53:53,880 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44549/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44549/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:53:54 INFO - 2015-11-20 09:53:54,467 DEBUG : BROWSER_OUTPUT: RSS: Main: 137826304 09:53:54 INFO - 2015-11-20 09:53:54,467 DEBUG : BROWSER_OUTPUT: 09:53:56 INFO - 2015-11-20 09:53:56,258 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44549/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44549/tests/kraken/driver.html?testName=ai-astar) 09:53:56 INFO - 2015-11-20 09:53:56,501 DEBUG : BROWSER_OUTPUT: RSS: Main: 138678272 09:53:56 INFO - 2015-11-20 09:53:56,502 DEBUG : BROWSER_OUTPUT: 09:53:56 INFO - 2015-11-20 09:53:56,505 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:53:56 INFO - 2015-11-20 09:53:56,505 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:53:56 INFO - 2015-11-20 09:53:56,505 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:53:56 INFO - 2015-11-20 09:53:56,506 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:53:56 INFO - 2015-11-20 09:53:56,506 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;108;111;112;114;123;113;112;114;111 09:53:56 INFO - 2015-11-20 09:53:56,506 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;130;157;166;133;157;163;131;176;133 09:53:56 INFO - 2015-11-20 09:53:56,506 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;174;164;166;164;167;174;164;167;164 09:53:56 INFO - 2015-11-20 09:53:56,506 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;75;73;74;74;74;133;73;72;73 09:53:56 INFO - 2015-11-20 09:53:56,506 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;92;135;91;92;92;140;92;92;129 09:53:56 INFO - 2015-11-20 09:53:56,506 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;110;110;110;110;110;110;111;110;111 09:53:56 INFO - 2015-11-20 09:53:56,506 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;148;149;150;149;151;148;148;147;149 09:53:56 INFO - 2015-11-20 09:53:56,507 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;97;107;96;96;96;95;97;96;96 09:53:56 INFO - 2015-11-20 09:53:56,507 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;73;72;74;75;75;78;75;73;73 09:53:56 INFO - 2015-11-20 09:53:56,507 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;68;68;67;68;69;70;71;69 09:53:56 INFO - 2015-11-20 09:53:56,507 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;83;83;85;83;87;93;85;92;86 09:53:56 INFO - 2015-11-20 09:53:56,507 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;126;136;131;123;136;125;130;123;129;123 09:53:56 INFO - 2015-11-20 09:53:56,507 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;152;148;146;145;134;147;145;137;145 09:53:56 INFO - 2015-11-20 09:53:56,507 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;71;71;73;70;81;69;72;70;69 09:53:56 INFO - 2015-11-20 09:53:56,508 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:53:56 INFO - 2015-11-20 09:53:56,508 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:53:56 INFO - 2015-11-20 09:53:56,508 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,758 09:53:56 INFO - 2015-11-20 09:53:56,508 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:53:56 INFO - 2015-11-20 09:53:56,508 DEBUG : BROWSER_OUTPUT: __startTimestamp1448042036503__endTimestamp 09:53:56 INFO - 2015-11-20 09:53:56,508 DEBUG : BROWSER_OUTPUT: 09:53:56 INFO - 2015-11-20 09:53:56,512 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:53:56 INFO - 2015-11-20 09:53:56,512 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:53:56 INFO - 2015-11-20 09:53:56,512 DEBUG : BROWSER_OUTPUT: 09:53:56 INFO - 2015-11-20 09:53:56,512 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:113.10 Median:113.00 stddev:3.90 (3.5%) stddev-sans-first:4.14 09:53:56 INFO - 2015-11-20 09:53:56,512 DEBUG : BROWSER_OUTPUT: Values: 113.0 108.0 111.0 112.0 114.0 123.0 113.0 112.0 114.0 111.0 09:53:56 INFO - 2015-11-20 09:53:56,512 DEBUG : BROWSER_OUTPUT: 09:53:56 INFO - 2015-11-20 09:53:56,512 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.20 Median:157.00 stddev:16.91 (10.8%) stddev-sans-first:17.81 09:53:56 INFO - 2015-11-20 09:53:56,512 DEBUG : BROWSER_OUTPUT: Values: 156.0 130.0 157.0 166.0 133.0 157.0 163.0 131.0 176.0 133.0 09:53:56 INFO - 2015-11-20 09:53:56,512 DEBUG : BROWSER_OUTPUT: 09:53:56 INFO - 2015-11-20 09:53:56,512 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:166.70 Median:166.50 stddev:4.08 (2.5%) stddev-sans-first:4.11 09:53:56 INFO - 2015-11-20 09:53:56,512 DEBUG : BROWSER_OUTPUT: Values: 163.0 174.0 164.0 166.0 164.0 167.0 174.0 164.0 167.0 164.0 09:53:56 INFO - 2015-11-20 09:53:56,512 DEBUG : BROWSER_OUTPUT: 09:53:56 INFO - 2015-11-20 09:53:56,513 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.50 Median:74.00 stddev:18.82 (25.4%) stddev-sans-first:19.85 09:53:56 INFO - 2015-11-20 09:53:56,513 DEBUG : BROWSER_OUTPUT: Values: 74.0 75.0 73.0 74.0 74.0 74.0 133.0 73.0 72.0 73.0 09:53:56 INFO - 2015-11-20 09:53:56,513 DEBUG : BROWSER_OUTPUT: 09:53:56 INFO - 2015-11-20 09:53:56,513 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.60 Median:92.00 stddev:20.91 (22.7%) stddev-sans-first:21.60 09:53:56 INFO - 2015-11-20 09:53:56,513 DEBUG : BROWSER_OUTPUT: Values: 91.0 92.0 135.0 91.0 92.0 92.0 140.0 92.0 92.0 129.0 09:53:56 INFO - 2015-11-20 09:53:56,513 DEBUG : BROWSER_OUTPUT: 09:53:56 INFO - 2015-11-20 09:53:56,513 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.30 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 09:53:56 INFO - 2015-11-20 09:53:56,513 DEBUG : BROWSER_OUTPUT: Values: 111.0 110.0 110.0 110.0 110.0 110.0 110.0 111.0 110.0 111.0 09:53:56 INFO - 2015-11-20 09:53:56,513 DEBUG : BROWSER_OUTPUT: 09:53:56 INFO - 2015-11-20 09:53:56,513 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.60 Median:149.00 stddev:1.26 (0.8%) stddev-sans-first:1.20 09:53:56 INFO - 2015-11-20 09:53:56,513 DEBUG : BROWSER_OUTPUT: Values: 147.0 148.0 149.0 150.0 149.0 151.0 148.0 148.0 147.0 149.0 09:53:56 INFO - 2015-11-20 09:53:56,513 DEBUG : BROWSER_OUTPUT: 09:53:56 INFO - 2015-11-20 09:53:56,513 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:97.20 Median:96.00 stddev:3.49 (3.6%) stddev-sans-first:3.67 09:53:56 INFO - 2015-11-20 09:53:56,513 DEBUG : BROWSER_OUTPUT: Values: 96.0 97.0 107.0 96.0 96.0 96.0 95.0 97.0 96.0 96.0 09:53:56 INFO - 2015-11-20 09:53:56,514 DEBUG : BROWSER_OUTPUT: 09:53:56 INFO - 2015-11-20 09:53:56,514 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.10 Median:74.50 stddev:1.73 (2.3%) stddev-sans-first:1.79 09:53:56 INFO - 2015-11-20 09:53:56,514 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 72.0 74.0 75.0 75.0 78.0 75.0 73.0 73.0 09:53:56 INFO - 2015-11-20 09:53:56,514 DEBUG : BROWSER_OUTPUT: 09:53:56 INFO - 2015-11-20 09:53:56,514 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:69.00 stddev:1.16 (1.7%) stddev-sans-first:1.20 09:53:56 INFO - 2015-11-20 09:53:56,514 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 68.0 67.0 68.0 69.0 70.0 71.0 69.0 09:53:56 INFO - 2015-11-20 09:53:56,514 DEBUG : BROWSER_OUTPUT: 09:53:56 INFO - 2015-11-20 09:53:56,514 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:85.50 stddev:3.81 (4.5%) stddev-sans-first:3.77 09:53:56 INFO - 2015-11-20 09:53:56,514 DEBUG : BROWSER_OUTPUT: Values: 82.0 83.0 83.0 85.0 83.0 87.0 93.0 85.0 92.0 86.0 09:53:56 INFO - 2015-11-20 09:53:56,514 DEBUG : BROWSER_OUTPUT: 09:53:56 INFO - 2015-11-20 09:53:56,514 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:128.20 Median:129.50 stddev:5.05 (3.9%) stddev-sans-first:5.29 09:53:56 INFO - 2015-11-20 09:53:56,514 DEBUG : BROWSER_OUTPUT: Values: 126.0 136.0 131.0 123.0 136.0 125.0 130.0 123.0 129.0 123.0 09:53:56 INFO - 2015-11-20 09:53:56,514 DEBUG : BROWSER_OUTPUT: 09:53:56 INFO - 2015-11-20 09:53:56,514 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.40 Median:145.50 stddev:5.99 (4.1%) stddev-sans-first:5.52 09:53:56 INFO - 2015-11-20 09:53:56,514 DEBUG : BROWSER_OUTPUT: Values: 135.0 152.0 148.0 146.0 145.0 134.0 147.0 145.0 137.0 145.0 09:53:56 INFO - 2015-11-20 09:53:56,514 DEBUG : BROWSER_OUTPUT: 09:53:56 INFO - 2015-11-20 09:53:56,515 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.60 Median:71.00 stddev:3.53 (5.0%) stddev-sans-first:3.70 09:53:56 INFO - 2015-11-20 09:53:56,515 DEBUG : BROWSER_OUTPUT: Values: 70.0 71.0 71.0 73.0 70.0 81.0 69.0 72.0 70.0 69.0 09:53:56 INFO - 2015-11-20 09:53:56,515 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:53:56 INFO - 2015-11-20 09:53:56,515 DEBUG : BROWSER_OUTPUT: 09:53:57 INFO - 2015-11-20 09:53:57,473 INFO : Browser exited with error code: 0 09:53:57 INFO - 2015-11-20 09:53:57,523 INFO : Completed test kraken (00:01:01) 09:53:57 INFO - 2015-11-20 09:53:57,523 INFO : Starting test v8_7 09:53:57 INFO - 2015-11-20 09:53:57,523 DEBUG : operating with platform_type : linux_ 09:53:57 INFO - 2015-11-20 09:53:57,523 INFO : Initialising browser for v8_7 test... 09:53:57 INFO - 2015-11-20 09:53:57,529 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMXbb4O/profile http://localhost:44549/getInfo.html 09:54:02 INFO - 2015-11-20 09:54:02,480 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:54:02 INFO - 2015-11-20 09:54:02,480 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:54:02 INFO - 2015-11-20 09:54:02,480 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:54:02 INFO - 2015-11-20 09:54:02,480 DEBUG : BROWSER_OUTPUT: __metrics 09:54:03 INFO - 2015-11-20 09:54:03,589 INFO : Browser initialized. 09:54:03 INFO - 2015-11-20 09:54:03,590 INFO : Running cycle 1/1 for v8_7 test... 09:54:03 INFO - 2015-11-20 09:54:03,590 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMXbb4O/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:54:15 INFO - 2015-11-20 09:54:15,552 DEBUG : BROWSER_OUTPUT: RSS: Main: 141430784 09:54:15 INFO - 2015-11-20 09:54:15,553 DEBUG : BROWSER_OUTPUT: 09:54:36 INFO - 2015-11-20 09:54:36,999 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44549/tests/v8_7/run.html (next: http://localhost:44549/tests/v8_7/run.html) 09:54:37 INFO - 2015-11-20 09:54:37,257 DEBUG : BROWSER_OUTPUT: RSS: Main: 138711040 09:54:37 INFO - 2015-11-20 09:54:37,257 DEBUG : BROWSER_OUTPUT: 09:54:37 INFO - 2015-11-20 09:54:37,258 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:54:37 INFO - 2015-11-20 09:54:37,258 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:54:37 INFO - 2015-11-20 09:54:37,258 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:54:37 INFO - 2015-11-20 09:54:37,258 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:54:37 INFO - 2015-11-20 09:54:37,258 DEBUG : BROWSER_OUTPUT: |0;Richards;164.33853738701725 09:54:37 INFO - 2015-11-20 09:54:37,258 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;183.41892883345562 09:54:37 INFO - 2015-11-20 09:54:37,258 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.8489289740699 09:54:37 INFO - 2015-11-20 09:54:37,259 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5040.201005025126 09:54:37 INFO - 2015-11-20 09:54:37,259 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1078.7486515641856 09:54:37 INFO - 2015-11-20 09:54:37,259 DEBUG : BROWSER_OUTPUT: |5;Earley;717.8750897343862 09:54:37 INFO - 2015-11-20 09:54:37,259 DEBUG : BROWSER_OUTPUT: |6;Boyer;12353.658536585366 09:54:37 INFO - 2015-11-20 09:54:37,259 DEBUG : BROWSER_OUTPUT: |7;RegExp;25820.51282051282 09:54:37 INFO - 2015-11-20 09:54:37,259 DEBUG : BROWSER_OUTPUT: |8;Splay;609.3845216331505 09:54:37 INFO - 2015-11-20 09:54:37,259 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4850.241545893719 09:54:37 INFO - 2015-11-20 09:54:37,260 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:54:37 INFO - 2015-11-20 09:54:37,260 DEBUG : BROWSER_OUTPUT: __startTimestamp1448042077251__endTimestamp 09:54:37 INFO - 2015-11-20 09:54:37,260 DEBUG : BROWSER_OUTPUT: 09:54:37 INFO - 2015-11-20 09:54:37,260 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:54:37 INFO - 2015-11-20 09:54:37,260 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:54:37 INFO - 2015-11-20 09:54:37,260 DEBUG : BROWSER_OUTPUT: 09:54:37 INFO - 2015-11-20 09:54:37,260 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.34 Median:164.34 stddev:0.00 (0.0%) 09:54:37 INFO - 2015-11-20 09:54:37,260 DEBUG : BROWSER_OUTPUT: Values: 164.3 09:54:37 INFO - 2015-11-20 09:54:37,261 DEBUG : BROWSER_OUTPUT: 09:54:37 INFO - 2015-11-20 09:54:37,261 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:183.42 Median:183.42 stddev:0.00 (0.0%) 09:54:37 INFO - 2015-11-20 09:54:37,261 DEBUG : BROWSER_OUTPUT: Values: 183.4 09:54:37 INFO - 2015-11-20 09:54:37,261 DEBUG : BROWSER_OUTPUT: 09:54:37 INFO - 2015-11-20 09:54:37,261 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.85 Median:281.85 stddev:0.00 (0.0%) 09:54:37 INFO - 2015-11-20 09:54:37,261 DEBUG : BROWSER_OUTPUT: Values: 281.8 09:54:37 INFO - 2015-11-20 09:54:37,261 DEBUG : BROWSER_OUTPUT: 09:54:37 INFO - 2015-11-20 09:54:37,262 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5040.20 Median:5040.20 stddev:0.00 (0.0%) 09:54:37 INFO - 2015-11-20 09:54:37,262 DEBUG : BROWSER_OUTPUT: Values: 5040.2 09:54:37 INFO - 2015-11-20 09:54:37,262 DEBUG : BROWSER_OUTPUT: 09:54:37 INFO - 2015-11-20 09:54:37,262 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1078.75 Median:1078.75 stddev:0.00 (0.0%) 09:54:37 INFO - 2015-11-20 09:54:37,262 DEBUG : BROWSER_OUTPUT: Values: 1078.7 09:54:37 INFO - 2015-11-20 09:54:37,262 DEBUG : BROWSER_OUTPUT: 09:54:37 INFO - 2015-11-20 09:54:37,262 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:717.88 Median:717.88 stddev:0.00 (0.0%) 09:54:37 INFO - 2015-11-20 09:54:37,262 DEBUG : BROWSER_OUTPUT: Values: 717.9 09:54:37 INFO - 2015-11-20 09:54:37,262 DEBUG : BROWSER_OUTPUT: 09:54:37 INFO - 2015-11-20 09:54:37,262 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12353.66 Median:12353.66 stddev:0.00 (0.0%) 09:54:37 INFO - 2015-11-20 09:54:37,262 DEBUG : BROWSER_OUTPUT: Values: 12353.7 09:54:37 INFO - 2015-11-20 09:54:37,262 DEBUG : BROWSER_OUTPUT: 09:54:37 INFO - 2015-11-20 09:54:37,262 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25820.51 Median:25820.51 stddev:0.00 (0.0%) 09:54:37 INFO - 2015-11-20 09:54:37,263 DEBUG : BROWSER_OUTPUT: Values: 25820.5 09:54:37 INFO - 2015-11-20 09:54:37,263 DEBUG : BROWSER_OUTPUT: 09:54:37 INFO - 2015-11-20 09:54:37,263 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:609.38 Median:609.38 stddev:0.00 (0.0%) 09:54:37 INFO - 2015-11-20 09:54:37,263 DEBUG : BROWSER_OUTPUT: Values: 609.4 09:54:37 INFO - 2015-11-20 09:54:37,263 DEBUG : BROWSER_OUTPUT: 09:54:37 INFO - 2015-11-20 09:54:37,263 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 09:54:37 INFO - 2015-11-20 09:54:37,263 DEBUG : BROWSER_OUTPUT: Values: 4850.2 09:54:37 INFO - 2015-11-20 09:54:37,263 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:54:37 INFO - 2015-11-20 09:54:37,263 DEBUG : BROWSER_OUTPUT: 09:54:38 INFO - 2015-11-20 09:54:38,313 INFO : Browser exited with error code: 0 09:54:38 INFO - 2015-11-20 09:54:38,330 INFO : Completed test v8_7 (00:00:40) 09:54:38 INFO - 2015-11-20 09:54:38,726 INFO : Completed test suite (00:20:19) 09:54:38 INFO - 2015-11-20 09:54:38,726 DEBUG : Working with test: dromaeo_css 09:54:38 INFO - 2015-11-20 09:54:38,726 DEBUG : Generating results file: dromaeo_css 09:54:38 INFO - 2015-11-20 09:54:38,727 DEBUG : Working with test: kraken 09:54:38 INFO - 2015-11-20 09:54:38,727 DEBUG : Generating results file: kraken 09:54:38 INFO - 2015-11-20 09:54:38,727 INFO : javascript benchmark 09:54:38 INFO - 2015-11-20 09:54:38,728 DEBUG : Working with test: v8_7 09:54:38 INFO - 2015-11-20 09:54:38,728 DEBUG : Generating results file: v8_7 09:54:38 INFO - 2015-11-20 09:54:38,728 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:54:38 INFO - 2015-11-20 09:54:38,778 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 09:54:38 INFO - 2015-11-20 09:54:38,778 DEBUG : process_Request line: dromaeo_css 6442.67 graph.html#tests=[[72,132,43]] 09:54:38 INFO - 2015-11-20 09:54:38,778 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:54:38 INFO - 2015-11-20 09:54:38,806 DEBUG : process_Request line: kraken 1542.10 graph.html#tests=[[232,132,43]] 09:54:38 INFO - 2015-11-20 09:54:38,806 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:54:38 INFO - 2015-11-20 09:54:38,836 DEBUG : process_Request line: v8_7 21378.14 graph.html#tests=[[230,132,43]] 09:54:38 INFO - 2015-11-20 09:54:38,837 INFO : javascript benchmark 09:54:38 INFO - 2015-11-20 09:54:38,841 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2706.5534186859168, 2771.210205091549, 2808.115443635256, 2810.3957649105437, 2815.00067476046, 4662.347271382009, 4859.757012149392, 4869.951300486994, 4900.9754951225195, 4951.975240123799, 4726.90546189076, 4803.135435621587, 4821.590164835993, 4972.453030166679, 4977.029479251547, 4445.844395446168, 4487.573680500347, 4556.931646025296, 4568.84009059683, 4588.724676519403, 4530.592246697796, 4587.288970209623, 4625.0, 4642.605378542811, 4648.604868586157, 4252.744835309892, 4397.032652816375, 4441.800118994653, 4468.486124095738, 4537.773111344452, 4468.0, 4480.529544397824, 4487.596116349511, 4511.954880451219, 4513.7743112844555, 4415.845445409427, 4441.622462090726, 4460.643148548108, 4477.194105061088, 4479.372887795711, 4538.977305113486, 4620.722756634613, 4693.178693728618, 4854.101991131617, 4885.218365061609, 5243.423223445456, 5248.790048398059, 5252.789888404497, 5272.314599102092, 5299.152135658276, 4930.728809915453, 5259.421463638997, 5264.789408423659, 5270.420253772082, 5272.367315922075, 4755.429348478205, 4791.4250289965075, 4803.807847686124, 4840.975795121002, 4897.363342765489, 5302.522772950453, 5439.558516993, 5442.809501667422, 5474.890502189934, 5492.615516913857, 4965.180745177077, 5024.899502009939, 5201.141811601044, 5239.371275446971, 5259.132243179833, 5069.315642388304, 5112.3865136183895, 5168.457311982263, 5182.067227898939, 5234.712090835041, 5132.358455193101, 5212.817551385683, 5216.165413533817, 5232.110541208004, 5241.13521268994, 4858.1012512685265, 4980.103581355391, 5097.0, 5176.767045482962, 5200.24596433515, 4343.04453020335, 4367.847125350598, 4381.255186618282, 4417.779111044435, 4421.38100665907, 3808.914459379119, 3813.599572044951, 3816.0, 3848.365019771706, 3848.8845334640005, 4292.48490181174, 4419.801108950105, 4448.911021779546, 4476.46282446102, 4572.337011133367, 5247.449017853147, 5278.049951008778, 5290.365156181283, 5312.521873031368, 5313.388960269618, 4511.413516242933, 4515.345274935116, 4532.818687252539, 4533.569310915458, 4547.954520454753, 4478.037221997286, 4534.2745160774775, 4582.473015603248, 4607.6083532900075, 4651.2557990721325, 4905.8037678492465, 4934.827281045146, 4934.827281045218, 4965.553100220997, 5009.724465154306, 5008.424031236309, 5238.5023422774775, 5250.26496290512, 5255.211718242294, 5289.312389389354, 4872.098661747588, 4906.705597664151, 4953.975230123826, 4991.775370108427, 5042.621803364689, 5149.0474262261605, 5204.609654275869, 5232.110541207928, 5247.55395791362, 5261.421243663118, 4952.925706114339, 5064.240363945438, 5328.014317351302, 5340.0, 5341.0, 4971.154903666313, 5039.0, 5056.873578160428, 5058.873528161678, 5109.591232701449, 5063.822766203165, 5105.948940510547, 5109.897802044013, 5113.974430127825, 5126.0, 4730.929036064393, 4792.376990991149, 4889.828855990023, 5011.098002359465, 5013.749312534432, 5126.512981266774, 5130.358705161855, 5131.948680513147, 5137.5889928806355, 5140.177571588528, 4987.476314986874, 5000.449950505369, 5009.348784657971, 5012.323336349692, 5039.269305950544], "unit": "ms", "name": "dojo.html", "value": 4778.861273859994}, {"lowerIsBetter": false, "replicates": [548.2762753165823, 572.3246569048521, 574.1359254322246, 574.8965186266475, 582.877595704902, 27029.324266893313, 27750.86124569377, 36033.63966360339, 36431.63568364316, 36506.81746591263, 34957.3008539829, 35266.64733352666, 35327.4700879487, 35413.46879796805, 35510.467342989876, 7936.603169841514, 8144.389170812213, 8145.389095817808, 8147.633356498942, 8161.591920403986, 7787.922120778776, 7976.481528700616, 8001.239882211181, 8014.398920080988, 8022.318102961255, 7917.722879699211, 7986.041674999008, 8037.598120094001, 8044.879326810103, 8058.234467725557, 7923.088844782837, 8021.438499305051, 8028.0, 8028.036635603736, 8052.033755949265, 7833.334166595846, 7945.245201705887, 7981.281684648351, 8000.479968802009, 8006.119326874097, 37286.62713372859, 37843.0, 38035.80982095099, 38062.0, 38086.0, 2793.4971705093076, 3101.364220334826, 3354.8168080315972, 3590.910227244314, 3700.648438398348, 27777.0, 27837.443251134864, 27963.440731185263, 28060.438791224264, 28245.43509129806, 3125.312431265118, 3129.5156277836145, 3180.761442891769, 3215.4051500472488, 3236.951445728316, 218666.0, 220523.0, 221105.0, 221141.0, 221676.0, 48985.510144898806, 49994.0, 52316.73841630767, 53901.460985390426, 55000.0, 41361.793191034456, 41630.0, 41680.58319416828, 41689.791551042654, 41775.1644967105, 12893.484260629657, 13029.47882084706, 13057.0, 13062.0, 13091.279979601213, 9107.635694572275, 9109.68116115946, 9118.361714679908, 9138.68014619485, 9243.168114869693, 15362.078275303518, 15524.37902483888, 15552.377904883904, 15561.455349062955, 15616.4534241301, 6925.722971081101, 6945.340192681788, 7071.222165561784, 7072.575645461186, 7157.785266442015, 788.1645455816853, 836.4145098431001, 871.8997315308694, 925.3430064654171, 1011.0546638892658, 25013.249602511954, 26149.73850261511, 26192.8690356547, 26507.469850603266, 29100.272493187415, 955.4362925873768, 959.4818797849223, 974.541965276319, 982.9262805289632, 1005.5424781724444, 11910.344931028703, 12596.874031259571, 12696.238225706302, 12791.168574042844, 12804.359782011048, 268923.0, 273691.0, 274139.0, 274296.0, 274858.0, 44496.77751611221, 44504.3324350135, 44581.777091114986, 44591.55408445939, 44645.33032004523, 1240.3674126195524, 1240.5968060380412, 1247.3887794980394, 1250.87491250876, 1265.0954567484293, 23936.88031559831, 24124.87937560301, 24497.31251216504, 24551.87724061368, 24566.63150052715, 37781.0, 38293.23413531658, 38378.61621383862, 38388.232235355696, 38489.23021539609, 255453.0, 257117.0, 257646.0, 258037.0, 260283.0, 27885.860570697016, 28457.573136402556, 29011.41977160403, 29049.854750726958, 29356.412871742872, 34606.82696586501, 34650.82674586712, 35261.118472038404, 35287.0, 37810.62189378071, 29461.26346841346, 30082.54876176903, 30111.397772043998, 30264.0, 30725.01307563964, 28708.39652007323, 29085.7091429083, 29422.0, 29541.26146846346, 30172.09483715492, 30369.0, 30455.086347409615, 30464.390712185188, 30560.847195764767, 32351.0, 26902.0, 29296.267593309483, 29412.55881161827, 29625.0, 29773.702262977095, 22465.0, 23164.420889477224, 23466.413339666644, 23811.166609168595, 23823.404414889766], "unit": "ms", "name": "ext.html", "value": 16133.24325302678}, {"lowerIsBetter": false, "replicates": [325.68083278387167, 328.6023911067608, 329.31173846660477, 339.2113336492655, 340.78849689354337, 15174.08955462673, 15698.764518532216, 15877.682446351066, 16000.279987400565, 16538.917305413484, 9566.712998610035, 9806.460644664541, 12833.614991550268, 14471.276436178201, 14522.491712790055, 4634.096351211507, 4791.47293797682, 4796.064767370364, 4937.5556199942, 5118.744062796845, 4942.555170034696, 4961.727105009223, 4991.900161996758, 5009.6242781791325, 5029.572486338666, 4937.308776771255, 4968.701877887338, 5129.6409251352425, 5136.306598609177, 5258.763355649005, 5072.594192464594, 5121.769520371555, 5122.462141475147, 5132.948670513303, 6405.19935008124, 6399.8080057598345, 6402.167718196604, 6410.61536307823, 6423.132877061584, 6423.325550817191, 19425.611487770166, 20808.687869681966, 21046.0, 21106.366808995754, 21436.892815535823, 1952.375239923225, 1959.8334141597982, 2039.1027947702962, 2073.6060148571723, 2144.8713077215416, 12664.936675316656, 13126.86873131266, 13197.538086166938, 13752.724945501133, 13906.235157066358, 1749.6063385738235, 1780.8753387262898, 1870.635226130905, 1939.7284380186786, 1993.1230258686132, 59831.401685983015, 65782.01326980146, 66487.3351266486, 67047.66476167589, 67834.0, 15559.611009724847, 15667.0, 15712.528624141294, 15720.60698482547, 15747.212639367986, 23561.7643823563, 23653.290401287988, 23801.166959156348, 23809.404764881016, 24046.27861164168, 8287.668493260202, 8320.334373250125, 8366.372522060748, 8366.456180348257, 8423.747287581382, 6882.208546017172, 6921.238663746984, 6923.238443771181, 6967.79096627102, 6976.651167441608, 7708.49894756839, 7712.383009359238, 7712.845743085107, 7738.303552680286, 7763.641362761494, 1725.3781445441246, 3003.2491877030743, 3007.0978706387996, 3021.9395612088074, 3086.382723455318, 374.80322830513654, 379.8044007336224, 771.726037256777, 892.2282225874571, 915.2540679346312, 9531.220571179394, 10185.643502477526, 15189.848101519065, 15431.537053888402, 16043.037417754738, 832.2177153475714, 903.8734577159203, 917.9862302065475, 942.4863449420083, 988.4859872866069, 8257.95871020641, 8369.707060252862, 8421.115782842713, 8593.613287402082, 8600.13998600135, 446050.0, 447532.0, 472774.0, 475778.0, 477319.0, 67076.0, 68127.31872681309, 68634.0, 69105.3089469109, 70895.2910470899, 1110.722319420145, 1112.060309038877, 1156.9652910412701, 1172.1384782185087, 1176.9411529423667, 13797.51708690191, 14044.438222470986, 14239.288035597972, 14320.355583998537, 14468.348924298221, 28708.282292942007, 29082.0, 29112.27219319534, 29694.851525742233, 31871.203219919687, 41126.58873411227, 41292.1741565173, 43097.0, 43336.133277334906, 48454.515454845, 8249.79375515593, 8392.664293428195, 8493.830123397622, 8512.957435213031, 8634.266087382643, 10449.425281609585, 10493.2130090242, 10517.526711297856, 10789.838152427878, 16852.494425166773, 12488.250704957369, 12639.747205055663, 12867.613971580493, 13126.409311581192, 13502.594922152352, 12774.0, 13020.674483137997, 13084.607461776162, 13522.729545409233, 13576.728465430439, 12736.044796640474, 12775.425105870445, 13229.237474508976, 13276.468941242241, 13435.932820335836, 8298.751037468886, 8616.956915215384, 8869.309256331726, 8917.73246802597, 9005.549722513979, 12498.875011249771, 13257.867421325664, 13745.0, 14011.719765604834, 14029.3686784097], "unit": "ms", "name": "jquery.html", "value": 8812.980119016245}, {"lowerIsBetter": false, "replicates": [1359.1912811876937, 1403.1931639307402, 1408.6971301170247, 1603.2705119170778, 1688.2740421618703, 6080.483158931496, 6145.293291271505, 6975.2675969023285, 7145.892811607823, 7167.211606723263, 6799.252082270947, 7180.533265337749, 7184.1738200107, 7229.855402891939, 7234.3489085982255, 2046.0690385874466, 2081.3131666550003, 2093.2045822587397, 2095.6751703485984, 2102.148629804924, 2022.7673817510954, 2061.443410279224, 2066.276803118911, 2068.617305798432, 2069.058578346856, 2060.423081537172, 2061.2476446097144, 2065.793420657937, 2082.3232449453913, 2092.665173572229, 2103.13771353745, 2129.9254526091513, 2132.0086159935627, 2132.616129096762, 2133.7332833395826, 2078.906449209789, 2102.4113248290505, 2118.131566057909, 2122.2678176029244, 2123.055240418015, 7204.891926621105, 7264.128304603481, 7303.269673032707, 7303.415726741848, 7323.450741194431, 4196.3705444183315, 4231.767252801094, 4247.5964783345535, 4264.616184543406, 4280.593343632381, 2781.5118911382515, 2785.874635641401, 2803.4112836304403, 2804.1447358555633, 2808.101407549585, 854.6068808348167, 860.4622111180512, 871.773338931876, 909.3725329522608, 911.9694744938244, 9646.180074693659, 9707.61169553217, 9712.514374281329, 9725.367851089657, 9746.512674366253, 3961.425593288957, 3978.9403158952637, 4012.3580227163516, 4026.4966879140106, 4060.147369052473, 8401.369897257608, 8401.873971890303, 8402.159784021671, 8402.831943361221, 8408.32733381328, 4211.515675697273, 4222.915541689149, 4260.8721738347895, 4263.829446822155, 4273.252180868336, 3750.3436898542645, 3865.40086286626, 3869.5743468218475, 3875.0893540018074, 3876.8643097491454, 3323.5347051412823, 3345.0466617014035, 3357.496375543688, 3359.7480188985437, 3373.578302712161, 1002.2332915319786, 1006.8741407324085, 1007.9899201008043, 1030.2633616963906, 1038.8805287391895, 1158.2645020412099, 1163.4648061891626, 1164.371239530661, 1183.2131632464316, 1187.1155988788234, 6817.693203805741, 6829.317068293131, 6851.862962740817, 6865.862682746317, 6876.621785801829, 436.6332280884009, 441.2322558747756, 442.601658507346, 1117.5027112934665, 1140.1790710688292, 5170.40540337866, 5296.894062118736, 5306.151015837448, 5306.6550674206055, 5336.91994620081, 8257.38069644779, 8420.747377578682, 8430.072692003998, 8461.957690211633, 8469.66121355139, 8297.087320394752, 8387.706430274911, 8423.789405264917, 8439.0, 8492.065872753992, 6659.800205993828, 6698.12924319845, 6703.497237707192, 6716.261211266757, 6733.158355205599, 6539.280679125388, 6540.117084193763, 6571.310012448624, 6572.76995305162, 6592.670366481752, 7428.368588670023, 7440.776776696708, 7461.4776965614055, 7566.24337566239, 7652.349550288288, 7659.119201291923, 7769.300762931363, 7770.883436748566, 7855.214478552099, 7881.935938648209, 5622.409646987007, 5828.94171058301, 5843.970780146072, 6360.173177487082, 6363.713632886439, 6893.655317234018, 6915.792526224222, 6915.896261556181, 6944.923536851796, 6950.026996220432, 6358.1734374531015, 6399.6800159992745, 6446.5165112615805, 6533.314002029909, 6538.346165383424, 6147.44672979434, 6190.876182476415, 6218.533609979179, 6244.063390491463, 6280.497560195265, 6505.186851643544, 6566.080748695091, 6566.376194261537, 6572.572782769104, 6575.2767195607485, 5674.517665998436, 5984.251968503937, 6017.939820601738, 6024.307204671519, 6029.698515074141, 6175.876482470236, 6228.532860035606, 6228.56400051992, 6246.656433896179, 6251.312355640966], "unit": "ms", "name": "mootools.html", "value": 4070.142422740886}, {"lowerIsBetter": false, "replicates": [304.6709553682024, 314.7529189586174, 316.288351209778, 317.82996097088056, 320.6905336350424, 5592.552595792332, 5681.431856814327, 5730.3123625164935, 5778.884422311557, 5796.536277097833, 5659.122835960422, 5662.263905692264, 5720.399358067395, 5723.599348045638, 5730.455606717355, 4191.057012172252, 4293.03406733484, 4293.055527783882, 4404.4054052702795, 4406.294992801152, 4331.350297455376, 4332.870013899572, 4340.262155433568, 4345.0, 4350.434443522354, 4290.69965102443, 4291.8712438626735, 4295.463067116611, 4296.162248361571, 4301.505326887417, 4304.504981927087, 4309.525952145262, 4310.482742070956, 4312.331588603755, 4319.611234988866, 3716.5168528091444, 3720.8325625346924, 3724.571674257468, 3771.868439468176, 3856.9807150964066, 5415.458454154593, 5491.862703432406, 5516.613837031409, 5518.255035570187, 5522.475364840334, 5071.39143302806, 5090.9236361454605, 5115.411727651293, 5122.692638441668, 5128.538431541142, 6055.091736239555, 6055.7274922628585, 6066.211392518944, 6079.817605471843, 6092.238470191226, 4157.210130075276, 4238.215930052919, 4240.554741752102, 4255.340422234559, 4258.680598955059, 6240.126382306481, 6308.558400911938, 6329.968350158219, 6348.396902294321, 6362.713677884506, 4374.19077470669, 4376.124775045004, 4376.584224498668, 4380.8904777380185, 4393.692441529062, 4449.1101779644205, 4449.354843547668, 4466.6873318867365, 4467.419235499429, 4477.171723231213, 4949.554540091409, 5076.060928728123, 5085.593152547787, 5093.439721630618, 5097.592192624581, 6026.758929642853, 6036.547258955508, 6038.607490513103, 6040.365761595057, 6052.334243233241, 1539.4457995121747, 1589.0306912783194, 1592.0129519697862, 1592.243684249972, 1594.7448408254625, 1047.204124865108, 1047.895210478946, 1070.4059247117768, 1071.8767341755797, 1076.359566058194, 5208.921866172011, 5220.791168353299, 5221.32122824038, 5224.373075230997, 5225.790968361223, 6267.71795269214, 6271.278802937721, 6276.309605943343, 6288.496920246369, 6297.685115744286, 5185.948140518622, 5231.8168864089575, 5236.528712415825, 5237.0, 5242.1088414969545, 3338.0, 3377.3920694274775, 3383.3909896218915, 3392.6946574808385, 3399.2351720862607, 5718.285214348207, 5838.065909454467, 5845.386234445407, 5917.792877249276, 5920.141579470953, 6426.775062872777, 6464.095026696266, 6503.447206987365, 6511.0558968949235, 6517.348265173445, 5878.882422351529, 5910.822675319747, 5916.3787802281, 5918.082697181943, 5919.970400148058, 6197.411245931629, 6222.377762223922, 6308.432241098323, 6321.1782468278825, 6330.240371155491, 6133.570650054453, 6154.569180157346, 6155.0, 6174.197354343906, 6179.474744646755, 5796.101604251347, 5812.389699081536, 5814.273215848019, 5873.970630146822, 5894.911576326273, 4222.2611043067955, 4266.0827921996915, 4270.252705776539, 4274.893127671833, 4282.507511636201, 6094.695265236809, 6312.337204593451, 6315.400036996478, 6341.143945567289, 6344.936550634435, 5945.672987985702, 6049.758009679564, 6077.604955677867, 6080.574359794772, 6086.452219300107, 6054.697265136813, 6099.634021958696, 6104.603200791934, 6110.114033465212, 6117.571769976237, 5725.541956643375, 5902.2327097477055, 5932.940670593239, 5957.76168953237, 5965.492933100735, 6120.571559990936, 6123.2958209804665, 6133.44798968095, 6141.662208578571, 6150.35421280777, 5954.464098231007, 5964.075568286922, 5965.612235204698, 5975.55183361241, 5980.162777211107], "unit": "ms", "name": "prototype.html", "value": 4519.275791180968}, {"lowerIsBetter": false, "replicates": [635.174273444522, 670.7384120193125, 720.3228964773115, 720.8738470767614, 763.1147868472566, 11861.584844530444, 12155.75688486232, 12187.0, 12279.201851879632, 12281.754364912707, 11613.709657258572, 11844.58543950962, 12803.743925121493, 13030.348482575857, 13192.868071319308, 617.4597227426002, 626.1797045869902, 627.4071002902259, 627.86500902306, 787.5707739282105, 805.4200975297776, 810.805406702393, 815.2173913043486, 815.4577206157898, 815.8776183572481, 832.8667413213886, 839.8908141941539, 841.3311417423133, 842.321930845669, 846.4836449765638, 830.0578843013163, 833.9291160251386, 834.0491839303199, 838.3712215838121, 839.5634270179534, 622.2501885228289, 623.3050149083784, 624.618982420723, 625.1154616218046, 627.8493161641173, 11695.532178712927, 11715.0, 11758.470868810924, 11798.46906889192, 11841.5855445059, 10129.544170512345, 10395.272330936838, 10799.784004319949, 11254.943725281402, 11689.064874809996, 8785.165409286108, 8893.0, 9001.459912405277, 9033.728988130366, 9571.425714457086, 3185.2992341684794, 3213.855376508039, 3228.8708451661905, 3248.4964830451318, 3327.8169700666454, 42331.57668423307, 42416.78791606053, 42583.787081064394, 42679.786601067106, 42721.0, 8785.341099417441, 9079.863802042975, 9151.35940484173, 9344.95327523358, 9392.530373481299, 15505.224738763016, 15626.921865390601, 15642.921785391229, 15657.451989180552, 15680.05919644825, 6241.21984751906, 6526.543141980016, 6636.435902948304, 6655.800325990228, 6776.898346524806, 3575.4279315309946, 3625.782453052825, 3692.113892665741, 3696.5748938872375, 3772.660460558508, 2606.89572417105, 2625.960610590843, 2636.0905487606747, 2638.155790147173, 2647.3646324882275, 465.2463009923945, 473.6849994753519, 478.3255609590461, 478.4019975031211, 480.0686667864332, 453.40603809009644, 471.1354664191247, 487.63671065056053, 563.6505366672607, 576.4293349583882, 7456.96271518639, 7562.962185189149, 7825.256600622932, 8440.366972477088, 8529.872051919227, 496.3175633503932, 533.8474086156994, 601.3265143039823, 628.3151365012159, 665.8335416145964, 3397.2016576104597, 3452.0, 3556.91107722309, 3841.0397400649836, 3854.4218367244575, 52816.0, 53413.46586534085, 53594.73202633962, 53609.73195133999, 53618.731906340996, 47246.291305630446, 47446.762766186635, 47571.524284757405, 48687.51312486901, 48751.756241218565, 43255.56744432578, 43487.565124348985, 43568.3464748029, 43591.910202244566, 44424.555754442044, 7735.574543400167, 7754.573498457414, 7896.09194942589, 8006.519608823489, 8057.597120144086, 31600.525992110597, 31984.0, 32542.0, 32614.0, 32650.673493264763, 38681.6131838678, 41327.793361033, 41330.0, 41352.58647413487, 41631.0, 9385.38994965325, 9617.471039092918, 9848.606055757977, 10008.549615267184, 10129.64546240878, 11291.153163512605, 11348.716282093013, 11470.197086203885, 11756.529738810694, 12132.939335303266, 10550.8417373741, 10804.297720648132, 10918.781624367628, 11247.550097995989, 11333.716657083638, 10233.385996840214, 10520.473976301308, 10575.048245657928, 10708.625198118028, 10999.120070394509, 8613.3109351253, 9970.900290996997, 10630.362178269328, 11011.669649910515, 11235.101191904465, 8613.827723445622, 8781.0, 8873.334499912662, 8980.101989800967, 9105.635774568944, 8352.958235208785, 8883.822323553364, 8951.194392504705, 9032.059797371061, 9168.0], "unit": "ms", "name": "yui.html", "value": 5721.454964216549}], "name": "dromaeo_css", "value": 6442.669571372901}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 108.0, 111.0, 112.0, 114.0, 123.0, 113.0, 112.0, 114.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 113.1}, {"lowerIsBetter": true, "replicates": [156.0, 130.0, 157.0, 166.0, 133.0, 157.0, 163.0, 131.0, 176.0, 133.0], "unit": "ms", "name": "audio-beat-detection", "value": 150.2}, {"lowerIsBetter": true, "replicates": [163.0, 174.0, 164.0, 166.0, 164.0, 167.0, 174.0, 164.0, 167.0, 164.0], "unit": "ms", "name": "audio-dft", "value": 166.7}, {"lowerIsBetter": true, "replicates": [74.0, 75.0, 73.0, 74.0, 74.0, 74.0, 133.0, 73.0, 72.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 79.5}, {"lowerIsBetter": true, "replicates": [91.0, 92.0, 135.0, 91.0, 92.0, 92.0, 140.0, 92.0, 92.0, 129.0], "unit": "ms", "name": "audio-oscillator", "value": 104.6}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0, 111.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.3}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 149.0, 150.0, 149.0, 151.0, 148.0, 148.0, 147.0, 149.0], "unit": "ms", "name": "imaging-darkroom", "value": 148.6}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 107.0, 96.0, 96.0, 96.0, 95.0, 97.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 97.2}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 72.0, 74.0, 75.0, 75.0, 78.0, 75.0, 73.0, 73.0], "unit": "ms", "name": "json-parse-financial", "value": 74.1}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 68.0, 67.0, 68.0, 69.0, 70.0, 71.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 83.0, 85.0, 83.0, 87.0, 93.0, 85.0, 92.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.9}, {"lowerIsBetter": true, "replicates": [126.0, 136.0, 131.0, 123.0, 136.0, 125.0, 130.0, 123.0, 129.0, 123.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 128.2}, {"lowerIsBetter": true, "replicates": [135.0, 152.0, 148.0, 146.0, 145.0, 134.0, 147.0, 145.0, 137.0, 145.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 143.4}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 71.0, 73.0, 70.0, 81.0, 69.0, 72.0, 70.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 71.6}], "name": "kraken", "value": 1542.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.33853738701725], "unit": "score", "name": "Richards", "value": 214.81267000000008}, {"lowerIsBetter": false, "replicates": [183.41892883345562], "unit": "score", "name": "DeltaBlue", "value": 360.4753359999998}, {"lowerIsBetter": false, "replicates": [281.8489289740699], "unit": "score", "name": "Encrypt", "value": 944.410188}, {"lowerIsBetter": false, "replicates": [5040.201005025126], "unit": "score", "name": "Decrypt", "value": 52.81158424725827}, {"lowerIsBetter": false, "replicates": [1078.7486515641856], "unit": "score", "name": "RayTrace", "value": 685.9698030000003}, {"lowerIsBetter": false, "replicates": [717.8750897343862], "unit": "score", "name": "Earley", "value": 928.3829590000004}, {"lowerIsBetter": false, "replicates": [12353.658536585366], "unit": "score", "name": "Boyer", "value": 53.948633761105626}, {"lowerIsBetter": false, "replicates": [25820.51282051282], "unit": "score", "name": "RegExp", "value": 35.28144488579943}, {"lowerIsBetter": false, "replicates": [609.3845216331505], "unit": "score", "name": "Splay", "value": 133.72673099999997}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 21378.141092738173}]} 09:54:38 INFO - RETURN: dromaeo_css: 6442.67 09:54:38 INFO - RETURN: kraken: 1542.10 09:54:38 INFO - RETURN: v8_7: 21378.14 09:54:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21378.14"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1542.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6442.67"}}} 09:54:38 INFO - Return code: 0 09:54:38 INFO - # TBPL SUCCESS # 09:54:38 INFO - Running post-action listener: _resource_record_post_action 09:54:38 INFO - Running post-run listener: _resource_record_post_run 09:54:40 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 0; Write bytes: 497319936; Read time: 0; Write time: 428408 09:54:40 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 121667584; Read time: 0; Write time: 90316 09:54:40 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 0; Write bytes: 375652352; Read time: 0; Write time: 338092 09:54:40 INFO - Running post-run listener: _upload_blobber_files 09:54:40 INFO - Blob upload gear active. 09:54:40 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:54:40 INFO - Copying logs to upload dir... 09:54:40 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1274.252686 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2015-11-20 09:54:38.730442) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 09:54:38.734239) ========= 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=20aa3857bbc5a756c598c738000001bb-1448040804.57017-1030338775 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/6LtkHRJiQwiKji4qOJAWug/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010079 build_url: 'https://queue.taskcluster.net/v1/task/6LtkHRJiQwiKji4qOJAWug/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 09:54:38.787686) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 09:54:38.788058) ========= 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=20aa3857bbc5a756c598c738000001bb-1448040804.57017-1030338775 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004539 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 09:54:38.837469) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 09:54:38.837792) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 09:54:38.838095) ========= ========= Total master_lag: 0.23 =========