builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-025 starttime: 1450403013.53 results: success (0) buildid: 20151217170055 builduid: 768dda47749b4f908b79ab54e5c16d8b revision: e4aca954089ddf8bf8c33f7b13cec453c5dd259f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 17:43:33.533741) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 17:43:33.534160) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 17:43:33.534510) ========= 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=3cd289541638898829117e0a000001bd-1450402760.304205-685097297 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006418 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 17:43:33.604967) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 17:43:33.605271) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 17:43:33.652499) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 17:43:33.652778) ========= 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=3cd289541638898829117e0a000001bd-1450402760.304205-685097297 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004702 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 17:43:33.715442) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 17:43:33.715746) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 17:43:33.716180) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 17:43:33.716511) ========= 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=3cd289541638898829117e0a000001bd-1450402760.304205-685097297 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-17 17:43:34-- 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% 46.8M=0s 2015-12-17 17:43:34 (46.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.137697 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 17:43:33.872209) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 17:43:33.872530) ========= 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=3cd289541638898829117e0a000001bd-1450402760.304205-685097297 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022222 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 17:43:33.930160) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-17 17:43:33.930567) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e4aca954089ddf8bf8c33f7b13cec453c5dd259f --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 e4aca954089ddf8bf8c33f7b13cec453c5dd259f --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=3cd289541638898829117e0a000001bd-1450402760.304205-685097297 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-17 17:43:34,338 truncating revision to first 12 chars 2015-12-17 17:43:34,338 Setting DEBUG logging. 2015-12-17 17:43:34,338 attempt 1/10 2015-12-17 17:43:34,338 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e4aca954089d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-17 17:43:35,380 unpacking tar archive at: fx-team-e4aca954089d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.314791 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-17 17:43:35.262590) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 17:43:35.262907) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 17:43:35.270147) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 17:43:35.270418) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 17:43:35.270782) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2015-12-17 17:43:35.271056) ========= /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=3cd289541638898829117e0a000001bd-1450402760.304205-685097297 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:43:35 INFO - MultiFileLogger online at 20151217 17:43:35 in /builds/slave/test 17:43:35 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 17:43:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:43:35 INFO - {'append_to_log': False, 17:43:35 INFO - 'base_work_dir': '/builds/slave/test', 17:43:35 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 17:43:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:43:35 INFO - 'branch': 'Fx-Team-Non-PGO', 17:43:35 INFO - 'buildbot_json_path': 'buildprops.json', 17:43:35 INFO - 'config_files': ('talos/linux_config.py',), 17:43:35 INFO - 'default_actions': ('clobber', 17:43:35 INFO - 'read-buildbot-config', 17:43:35 INFO - 'download-and-extract', 17:43:35 INFO - 'populate-webroot', 17:43:35 INFO - 'create-virtualenv', 17:43:35 INFO - 'install', 17:43:35 INFO - 'run-tests'), 17:43:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:43:35 INFO - 'download_minidump_stackwalk': True, 17:43:35 INFO - 'download_symbols': 'ondemand', 17:43:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:43:35 INFO - 'tooltool.py': '/tools/tooltool.py', 17:43:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:43:35 INFO - '/tools/misc-python/virtualenv.py')}, 17:43:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:43:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:43:35 INFO - 'installer_path': 'installer.exe', 17:43:35 INFO - 'log_level': 'info', 17:43:35 INFO - 'log_name': 'talos', 17:43:35 INFO - 'log_to_console': True, 17:43:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:43:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:43:35 INFO - 'opt_config_files': (), 17:43:35 INFO - 'pip_index': False, 17:43:35 INFO - 'sps_profile': False, 17:43:35 INFO - 'sps_profile_interval': 0, 17:43:35 INFO - 'suite': 'dromaeojs-e10s', 17:43:35 INFO - 'system_bits': '64', 17:43:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:43:35 INFO - 'title': 'talos-linux64-ix-025', 17:43:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:43:35 INFO - 'use_talos_json': True, 17:43:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:43:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:43:35 INFO - 'work_dir': 'build'} 17:43:35 INFO - ##### 17:43:35 INFO - ##### Running clobber step. 17:43:35 INFO - ##### 17:43:35 INFO - Running pre-action listener: _resource_record_pre_action 17:43:35 INFO - Running main action method: clobber 17:43:35 INFO - rmtree: /builds/slave/test/build 17:43:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:43:36 INFO - Running post-action listener: _resource_record_post_action 17:43:36 INFO - ##### 17:43:36 INFO - ##### Running read-buildbot-config step. 17:43:36 INFO - ##### 17:43:36 INFO - Running pre-action listener: _resource_record_pre_action 17:43:36 INFO - Running main action method: read_buildbot_config 17:43:36 INFO - Using buildbot properties: 17:43:36 INFO - { 17:43:36 INFO - "project": "", 17:43:36 INFO - "product": "firefox", 17:43:36 INFO - "script_repo_revision": "production", 17:43:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:43:36 INFO - "repository": "", 17:43:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 17:43:36 INFO - "buildid": "20151217170055", 17:43:36 INFO - "pgo_build": "False", 17:43:36 INFO - "basedir": "/builds/slave/test", 17:43:36 INFO - "buildnumber": 599, 17:43:36 INFO - "slavename": "talos-linux64-ix-025", 17:43:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:43:36 INFO - "platform": "ubuntu64_hw", 17:43:36 INFO - "scheduler": "tests-fx-team-linux64-talos", 17:43:36 INFO - "branch": "fx-team", 17:43:36 INFO - "repo_path": "integration/fx-team", 17:43:36 INFO - "revision": "e4aca954089ddf8bf8c33f7b13cec453c5dd259f", 17:43:36 INFO - "stage_platform": "linux64", 17:43:36 INFO - "builduid": "768dda47749b4f908b79ab54e5c16d8b", 17:43:36 INFO - "slavebuilddir": "test" 17:43:36 INFO - } 17:43:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 17:43:36 INFO - Running post-action listener: _resource_record_post_action 17:43:36 INFO - ##### 17:43:36 INFO - ##### Running download-and-extract step. 17:43:36 INFO - ##### 17:43:36 INFO - Running pre-action listener: _resource_record_pre_action 17:43:36 INFO - Running main action method: download_and_extract 17:43:36 INFO - mkdir: /builds/slave/test/build/tests 17:43:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:36 INFO - https://queue.taskcluster.net/v1/task/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:43:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/test_packages.json 17:43:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/test_packages.json 17:43:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 17:43:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 17:43:39 INFO - Downloaded 1302 bytes. 17:43:39 INFO - Reading from file /builds/slave/test/build/test_packages.json 17:43:39 INFO - Using the following test package requirements: 17:43:39 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:43:39 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:43:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:43:39 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:43:39 INFO - u'jsshell-linux-x86_64.zip'], 17:43:39 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:43:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:43:39 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:43:39 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:43:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:43:39 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:43:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:43:39 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:43:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:43:39 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:43:39 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:43:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:43:39 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:43:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:39 INFO - https://queue.taskcluster.net/v1/task/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:43:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:43:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:43:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:43:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:43:40 INFO - Downloaded 21870957 bytes. 17:43:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 17:43:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:43:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 17:43:41 INFO - Return code: 0 17:43:41 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:43:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:41 INFO - https://queue.taskcluster.net/v1/task/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:43:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:43:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:43:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:43:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:43:47 INFO - Downloaded 21870957 bytes. 17:43:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 17:43:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:43:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 17:43:49 INFO - Return code: 0 17:43: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')]} 17:43:49 INFO - https://queue.taskcluster.net/v1/task/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:43:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:43:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:43:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:43:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:43:50 INFO - Downloaded 11132039 bytes. 17:43:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 17:43:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:43:50 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 17:43:50 INFO - Return code: 0 17:43:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:50 INFO - https://queue.taskcluster.net/v1/task/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:43:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:43:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:43:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:43:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:43:52 INFO - Downloaded 53019173 bytes. 17:43:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:43:52 INFO - mkdir: /builds/slave/test/properties 17:43:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:43:52 INFO - Writing to file /builds/slave/test/properties/build_url 17:43:52 INFO - Contents: 17:43:52 INFO - build_url:https://queue.taskcluster.net/v1/task/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:43:52 INFO - Running post-action listener: _resource_record_post_action 17:43:52 INFO - Running post-action listener: set_extra_try_arguments 17:43:52 INFO - ##### 17:43:52 INFO - ##### Running populate-webroot step. 17:43:52 INFO - ##### 17:43:52 INFO - Running pre-action listener: _resource_record_pre_action 17:43:52 INFO - Running main action method: populate_webroot 17:43:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:43:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:43:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:43:52 INFO - '--tppagecycles', 17:43:52 INFO - '7'], 17:43:52 INFO - 'tests': ['tsvgm']}}, 17:43:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:43:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:43:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:43:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:43:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:43:52 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:43:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:43:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:43:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:43:52 INFO - 'talos_options': ['--e10s'], 17:43:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:43:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:43:52 INFO - 'tests': ['damp', 'tps']}, 17:43:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:43:52 INFO - 'talos_options': ['--e10s'], 17:43:52 INFO - 'tests': ['damp', 'tps']}, 17:43:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:43:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:43:52 INFO - 'other': {'tests': ['a11yr', 17:43:52 INFO - 'ts_paint', 17:43:52 INFO - 'tpaint', 17:43:52 INFO - 'sessionrestore', 17:43:52 INFO - 'sessionrestore_no_auto_restore']}, 17:43:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:43:52 INFO - 'tests': ['a11yr', 17:43:52 INFO - 'ts_paint', 17:43:52 INFO - 'tpaint', 17:43:52 INFO - 'sessionrestore', 17:43:52 INFO - 'sessionrestore_no_auto_restore']}, 17:43:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:43:52 INFO - 'tests': ['a11yr', 17:43:52 INFO - 'ts_paint', 17:43:52 INFO - 'tpaint', 17:43:52 INFO - 'sessionrestore', 17:43:52 INFO - 'sessionrestore_no_auto_restore']}, 17:43:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:43:52 INFO - 'tests': ['a11yr', 17:43:52 INFO - 'ts_paint', 17:43:52 INFO - 'tpaint', 17:43:52 INFO - 'sessionrestore', 17:43:52 INFO - 'sessionrestore_no_auto_restore']}, 17:43:52 INFO - 'other_l64': {'tests': ['a11yr', 17:43:52 INFO - 'ts_paint', 17:43:52 INFO - 'tpaint', 17:43:52 INFO - 'sessionrestore', 17:43:52 INFO - 'sessionrestore_no_auto_restore']}, 17:43:52 INFO - 'other_nol64': {'tests': ['a11yr', 17:43:52 INFO - 'ts_paint', 17:43:52 INFO - 'tpaint', 17:43:52 INFO - 'sessionrestore', 17:43:52 INFO - 'sessionrestore_no_auto_restore']}, 17:43:52 INFO - 'svgr': {'tests': ['tsvgx', 17:43:52 INFO - 'tsvgr_opacity', 17:43:52 INFO - 'tart', 17:43:52 INFO - 'tscrollx', 17:43:52 INFO - 'cart']}, 17:43:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:43:52 INFO - 'tests': ['tsvgx', 17:43:52 INFO - 'tsvgr_opacity', 17:43:52 INFO - 'tart', 17:43:52 INFO - 'tscrollx', 17:43:52 INFO - 'cart']}, 17:43:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:43:52 INFO - 'tests': ['tp5o']}, 17:43:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:43:52 INFO - 'talos_options': ['--e10s'], 17:43:52 INFO - 'tests': ['tp5o']}, 17:43:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:43:52 INFO - 'talos_options': ['--xperf_path', 17:43:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:43:52 INFO - 'tests': ['tp5n']}, 17:43:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:43:52 INFO - 'talos_options': ['--e10s', 17:43:52 INFO - '--xperf_path', 17:43:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:43:52 INFO - 'tests': ['tp5n']}}, 17:43:52 INFO - 'talos.zip': {'path': '', 17:43:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:43:52 INFO - Running post-action listener: _resource_record_post_action 17:43:52 INFO - ##### 17:43:52 INFO - ##### Running create-virtualenv step. 17:43:52 INFO - ##### 17:43:52 INFO - Running pre-action listener: _resource_record_pre_action 17:43:52 INFO - Running main action method: create_virtualenv 17:43:52 INFO - Creating virtualenv /builds/slave/test/build/venv 17:43:52 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 17:43:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:43:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:43:52 INFO - Using real prefix '/usr' 17:43:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:43:52 INFO - Installing distribute.............................................................................................................................................................................................done. 17:43:54 INFO - Installing pip.................done. 17:43:54 INFO - Return code: 0 17:43:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:43:54 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')]} 17:43:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:54 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')]} 17:43:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:54 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 0x7fd374385f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeab240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3a0b0>, '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 0xf3afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf3b440>, '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': '3cd289541638898829117e0a000001bd-1450402760.304205-685097297', '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 17:43:54 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 17:43:54 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 17:43:54 INFO - Using env: {'DISPLAY': ':0', 17:43:54 INFO - 'HOME': '/home/cltbld', 17:43:54 INFO - 'LANG': 'en_US.UTF-8', 17:43:54 INFO - 'LANGUAGE': 'en_US:en', 17:43:54 INFO - 'LOGNAME': 'cltbld', 17:43:54 INFO - 'MAIL': '/var/mail/cltbld', 17:43:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:54 INFO - 'MOZ_NO_REMOTE': '1', 17:43:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:54 INFO - 'NO_EM_RESTART': '1', 17:43:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:54 INFO - 'PWD': '/builds/slave/test', 17:43:54 INFO - 'SHELL': '/bin/bash', 17:43:54 INFO - 'SHLVL': '1', 17:43:54 INFO - 'TERM': 'linux', 17:43:54 INFO - 'TMOUT': '86400', 17:43:54 INFO - 'USER': 'cltbld', 17:43:54 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1450402760.304205-685097297', 17:43:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:54 INFO - '_': '/tools/buildbot/bin/python'} 17:43:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:55 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 17:43:55 INFO - Cleaning up... 17:43:55 INFO - Return code: 0 17:43:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:43:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd374385f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeab240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3a0b0>, '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 0xf3afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf3b440>, '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': '3cd289541638898829117e0a000001bd-1450402760.304205-685097297', '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 17:43:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 17:43:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:43:55 INFO - Using env: {'DISPLAY': ':0', 17:43:55 INFO - 'HOME': '/home/cltbld', 17:43:55 INFO - 'LANG': 'en_US.UTF-8', 17:43:55 INFO - 'LANGUAGE': 'en_US:en', 17:43:55 INFO - 'LOGNAME': 'cltbld', 17:43:55 INFO - 'MAIL': '/var/mail/cltbld', 17:43:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:55 INFO - 'MOZ_NO_REMOTE': '1', 17:43:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:55 INFO - 'NO_EM_RESTART': '1', 17:43:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:55 INFO - 'PWD': '/builds/slave/test', 17:43:55 INFO - 'SHELL': '/bin/bash', 17:43:55 INFO - 'SHLVL': '1', 17:43:55 INFO - 'TERM': 'linux', 17:43:55 INFO - 'TMOUT': '86400', 17:43:55 INFO - 'USER': 'cltbld', 17:43:55 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1450402760.304205-685097297', 17:43:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:55 INFO - '_': '/tools/buildbot/bin/python'} 17:43:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:55 INFO - Downloading/unpacking psutil>=0.7.1 17:43: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 17:43: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 17:43: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 17:43: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 17:43: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 17:43: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 17:43:57 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 17:43:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 17:43:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:43:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:43:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:43:57 INFO - Installing collected packages: psutil 17:43:57 INFO - Running setup.py install for psutil 17:43:57 INFO - building 'psutil._psutil_linux' extension 17:43:57 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 17:43:57 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 17:43:57 INFO - building 'psutil._psutil_posix' extension 17:43:57 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 17:43:57 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 17:43:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:43:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:43:57 INFO - Successfully installed psutil 17:43:57 INFO - Cleaning up... 17:43:57 INFO - Return code: 0 17:43:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:43: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')]} 17:43:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43: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')]} 17:43:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd374385f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeab240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3a0b0>, '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 0xf3afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf3b440>, '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': '3cd289541638898829117e0a000001bd-1450402760.304205-685097297', '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 17:43:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 17:43:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:43:57 INFO - Using env: {'DISPLAY': ':0', 17:43:57 INFO - 'HOME': '/home/cltbld', 17:43:57 INFO - 'LANG': 'en_US.UTF-8', 17:43:57 INFO - 'LANGUAGE': 'en_US:en', 17:43:57 INFO - 'LOGNAME': 'cltbld', 17:43:57 INFO - 'MAIL': '/var/mail/cltbld', 17:43:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:57 INFO - 'MOZ_NO_REMOTE': '1', 17:43:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:57 INFO - 'NO_EM_RESTART': '1', 17:43:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:57 INFO - 'PWD': '/builds/slave/test', 17:43:57 INFO - 'SHELL': '/bin/bash', 17:43:57 INFO - 'SHLVL': '1', 17:43:57 INFO - 'TERM': 'linux', 17:43:57 INFO - 'TMOUT': '86400', 17:43:57 INFO - 'USER': 'cltbld', 17:43:57 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1450402760.304205-685097297', 17:43:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:57 INFO - '_': '/tools/buildbot/bin/python'} 17:43:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:43:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:43:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 17:43:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:43:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:43:59 INFO - Installing collected packages: mozsystemmonitor 17:43:59 INFO - Running setup.py install for mozsystemmonitor 17:43:59 INFO - Successfully installed mozsystemmonitor 17:43:59 INFO - Cleaning up... 17:43:59 INFO - Return code: 0 17:43:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:43:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd374385f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeab240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3a0b0>, '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 0xf3afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf3b440>, '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': '3cd289541638898829117e0a000001bd-1450402760.304205-685097297', '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 17:43:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:43:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:43:59 INFO - Using env: {'DISPLAY': ':0', 17:43:59 INFO - 'HOME': '/home/cltbld', 17:43:59 INFO - 'LANG': 'en_US.UTF-8', 17:43:59 INFO - 'LANGUAGE': 'en_US:en', 17:43:59 INFO - 'LOGNAME': 'cltbld', 17:43:59 INFO - 'MAIL': '/var/mail/cltbld', 17:43:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:59 INFO - 'MOZ_NO_REMOTE': '1', 17:43:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:59 INFO - 'NO_EM_RESTART': '1', 17:43:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:59 INFO - 'PWD': '/builds/slave/test', 17:43:59 INFO - 'SHELL': '/bin/bash', 17:43:59 INFO - 'SHLVL': '1', 17:43:59 INFO - 'TERM': 'linux', 17:43:59 INFO - 'TMOUT': '86400', 17:43:59 INFO - 'USER': 'cltbld', 17:43:59 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1450402760.304205-685097297', 17:43:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:59 INFO - '_': '/tools/buildbot/bin/python'} 17:44:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:00 INFO - Downloading/unpacking blobuploader==1.2.4 17:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:01 INFO - Downloading blobuploader-1.2.4.tar.gz 17:44:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 17:44:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:44:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:44: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 17:44: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 17:44: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 17:44: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 17:44: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 17:44: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 17:44:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 17:44:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:44:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:44:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:02 INFO - Downloading docopt-0.6.1.tar.gz 17:44:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 17:44:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:44:02 INFO - Installing collected packages: blobuploader, requests, docopt 17:44:02 INFO - Running setup.py install for blobuploader 17:44:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:44:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:44:02 INFO - Running setup.py install for requests 17:44:02 INFO - Running setup.py install for docopt 17:44:02 INFO - Successfully installed blobuploader requests docopt 17:44:02 INFO - Cleaning up... 17:44:03 INFO - Return code: 0 17:44:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:44: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')]} 17:44:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44: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')]} 17:44:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:03 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 0x7fd374385f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeab240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3a0b0>, '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 0xf3afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf3b440>, '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': '3cd289541638898829117e0a000001bd-1450402760.304205-685097297', '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 17:44:03 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 17:44:03 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 17:44:03 INFO - Using env: {'DISPLAY': ':0', 17:44:03 INFO - 'HOME': '/home/cltbld', 17:44:03 INFO - 'LANG': 'en_US.UTF-8', 17:44:03 INFO - 'LANGUAGE': 'en_US:en', 17:44:03 INFO - 'LOGNAME': 'cltbld', 17:44:03 INFO - 'MAIL': '/var/mail/cltbld', 17:44:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:03 INFO - 'MOZ_NO_REMOTE': '1', 17:44:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:03 INFO - 'NO_EM_RESTART': '1', 17:44:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:03 INFO - 'PWD': '/builds/slave/test', 17:44:03 INFO - 'SHELL': '/bin/bash', 17:44:03 INFO - 'SHLVL': '1', 17:44:03 INFO - 'TERM': 'linux', 17:44:03 INFO - 'TMOUT': '86400', 17:44:03 INFO - 'USER': 'cltbld', 17:44:03 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1450402760.304205-685097297', 17:44:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:03 INFO - '_': '/tools/buildbot/bin/python'} 17:44:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:44:03 INFO - Running setup.py (path:/tmp/pip-PC4cWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:44:03 INFO - Running setup.py (path:/tmp/pip-ggqoCu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:44:03 INFO - Running setup.py (path:/tmp/pip-ouF336-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:44:03 INFO - Running setup.py (path:/tmp/pip-JxbVP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:44:03 INFO - Running setup.py (path:/tmp/pip-ynBl25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:44:03 INFO - Running setup.py (path:/tmp/pip-cdbjQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:44:03 INFO - Running setup.py (path:/tmp/pip-NnOzxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:44:03 INFO - Running setup.py (path:/tmp/pip-L9CoyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:44:03 INFO - Running setup.py (path:/tmp/pip-vTTnhb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:44:03 INFO - Running setup.py (path:/tmp/pip-9QSPWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:44:03 INFO - Running setup.py (path:/tmp/pip-5_BcTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:44:04 INFO - Running setup.py (path:/tmp/pip-ttYfmH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:44:04 INFO - Running setup.py (path:/tmp/pip-Vin05M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:44:04 INFO - Running setup.py (path:/tmp/pip-B7eEz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:44:04 INFO - Running setup.py (path:/tmp/pip-SQs4Id-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:44:04 INFO - Running setup.py (path:/tmp/pip-PT1dWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:44:04 INFO - Running setup.py (path:/tmp/pip-PADA0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:44:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:44:04 INFO - Running setup.py install for manifestparser 17:44:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:44:04 INFO - Running setup.py install for mozcrash 17:44:04 INFO - Running setup.py install for mozdebug 17:44:04 INFO - Running setup.py install for mozdevice 17:44:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:44:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:44:04 INFO - Running setup.py install for mozfile 17:44:04 INFO - Running setup.py install for mozhttpd 17:44:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:44:05 INFO - Running setup.py install for mozinfo 17:44:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:44:05 INFO - Running setup.py install for mozInstall 17:44:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:44:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:44:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:44:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:44:05 INFO - Running setup.py install for mozleak 17:44:05 INFO - Running setup.py install for mozlog 17:44:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:44:05 INFO - Running setup.py install for moznetwork 17:44:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:44:05 INFO - Running setup.py install for mozprocess 17:44:05 INFO - Running setup.py install for mozprofile 17:44:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:44:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:44:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:44:05 INFO - Running setup.py install for mozrunner 17:44:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:44:05 INFO - Running setup.py install for mozscreenshot 17:44:06 INFO - Running setup.py install for moztest 17:44:06 INFO - Running setup.py install for mozversion 17:44:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:44:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:44:06 INFO - Cleaning up... 17:44:06 INFO - Return code: 0 17:44:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:44:06 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')]} 17:44:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:06 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')]} 17:44:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:06 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 0x7fd374385f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeab240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3a0b0>, '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 0xf3afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf3b440>, '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': '3cd289541638898829117e0a000001bd-1450402760.304205-685097297', '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 17:44:06 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 17:44:06 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 17:44:06 INFO - Using env: {'DISPLAY': ':0', 17:44:06 INFO - 'HOME': '/home/cltbld', 17:44:06 INFO - 'LANG': 'en_US.UTF-8', 17:44:06 INFO - 'LANGUAGE': 'en_US:en', 17:44:06 INFO - 'LOGNAME': 'cltbld', 17:44:06 INFO - 'MAIL': '/var/mail/cltbld', 17:44:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:06 INFO - 'MOZ_NO_REMOTE': '1', 17:44:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:06 INFO - 'NO_EM_RESTART': '1', 17:44:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:06 INFO - 'PWD': '/builds/slave/test', 17:44:06 INFO - 'SHELL': '/bin/bash', 17:44:06 INFO - 'SHLVL': '1', 17:44:06 INFO - 'TERM': 'linux', 17:44:06 INFO - 'TMOUT': '86400', 17:44:06 INFO - 'USER': 'cltbld', 17:44:06 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1450402760.304205-685097297', 17:44:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:06 INFO - '_': '/tools/buildbot/bin/python'} 17:44:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:44:06 INFO - Running setup.py (path:/tmp/pip-xJbbrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:44:06 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)) 17:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:44:06 INFO - Running setup.py (path:/tmp/pip-fAuJpC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:44:06 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)) 17:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:44:06 INFO - Running setup.py (path:/tmp/pip-0IKRVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:44:06 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)) 17:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:44:06 INFO - Running setup.py (path:/tmp/pip-Ma3z5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:44:06 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)) 17:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:44:06 INFO - Running setup.py (path:/tmp/pip-WwJBHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:44:06 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)) 17:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:44:06 INFO - Running setup.py (path:/tmp/pip-qwoxmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:44:06 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)) 17:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:44:06 INFO - Running setup.py (path:/tmp/pip-gmjXkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:44:06 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)) 17:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:44:06 INFO - Running setup.py (path:/tmp/pip-lkJ2Nq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:44:07 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)) 17:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:44:07 INFO - Running setup.py (path:/tmp/pip-45Mznh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:44:07 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)) 17:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:44:07 INFO - Running setup.py (path:/tmp/pip-z7RB1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:44:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:44:07 INFO - Running setup.py (path:/tmp/pip-dyUXWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:44:07 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)) 17:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:44:07 INFO - Running setup.py (path:/tmp/pip-FShCKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:44:07 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)) 17:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:44:07 INFO - Running setup.py (path:/tmp/pip-rChglB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:44:07 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)) 17:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:44:07 INFO - Running setup.py (path:/tmp/pip-WDqtGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:44:07 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)) 17:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:44:07 INFO - Running setup.py (path:/tmp/pip-Mtw4_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:44:07 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)) 17:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:44:07 INFO - Running setup.py (path:/tmp/pip-8nSeJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:44:07 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)) 17:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:44:07 INFO - Running setup.py (path:/tmp/pip-Onxnk5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:44:07 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)) 17:44:07 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)) 17:44:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:44:07 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)) 17:44:07 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)) 17:44:07 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)) 17:44:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:09 INFO - Downloading blessings-1.5.1.tar.gz 17:44:09 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 17:44:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:44:09 INFO - Installing collected packages: blessings 17:44:09 INFO - Running setup.py install for blessings 17:44:09 INFO - Successfully installed blessings 17:44:09 INFO - Cleaning up... 17:44:09 INFO - Return code: 0 17:44:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:44:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:44:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:44:09 INFO - Reading from file tmpfile_stdout 17:44:09 INFO - Current package versions: 17:44:09 INFO - argparse == 1.2.1 17:44:09 INFO - blessings == 1.5.1 17:44:09 INFO - blobuploader == 1.2.4 17:44:09 INFO - docopt == 0.6.1 17:44:09 INFO - manifestparser == 1.1 17:44:09 INFO - mozInstall == 1.12 17:44:09 INFO - mozcrash == 0.16 17:44:09 INFO - mozdebug == 0.1 17:44:09 INFO - mozdevice == 0.47 17:44:09 INFO - mozfile == 1.2 17:44:09 INFO - mozhttpd == 0.7 17:44:09 INFO - mozinfo == 0.9 17:44:09 INFO - mozleak == 0.1 17:44:09 INFO - mozlog == 3.1 17:44:09 INFO - moznetwork == 0.27 17:44:09 INFO - mozprocess == 0.22 17:44:09 INFO - mozprofile == 0.27 17:44:09 INFO - mozrunner == 6.11 17:44:09 INFO - mozscreenshot == 0.1 17:44:09 INFO - mozsystemmonitor == 0.0 17:44:09 INFO - moztest == 0.7 17:44:09 INFO - mozversion == 1.4 17:44:09 INFO - psutil == 3.1.1 17:44:09 INFO - requests == 1.2.3 17:44:09 INFO - wsgiref == 0.1.2 17:44:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:44:09 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')]} 17:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:09 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')]} 17:44:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:09 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 0x7fd374385f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeab240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3a0b0>, '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 0xf3afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf3b440>, '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': '3cd289541638898829117e0a000001bd-1450402760.304205-685097297', '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 17:44:09 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 17:44:09 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 17:44:09 INFO - Using env: {'DISPLAY': ':0', 17:44:09 INFO - 'HOME': '/home/cltbld', 17:44:09 INFO - 'LANG': 'en_US.UTF-8', 17:44:09 INFO - 'LANGUAGE': 'en_US:en', 17:44:09 INFO - 'LOGNAME': 'cltbld', 17:44:09 INFO - 'MAIL': '/var/mail/cltbld', 17:44:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:09 INFO - 'MOZ_NO_REMOTE': '1', 17:44:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:09 INFO - 'NO_EM_RESTART': '1', 17:44:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:09 INFO - 'PWD': '/builds/slave/test', 17:44:09 INFO - 'SHELL': '/bin/bash', 17:44:09 INFO - 'SHLVL': '1', 17:44:09 INFO - 'TERM': 'linux', 17:44:09 INFO - 'TMOUT': '86400', 17:44:09 INFO - 'USER': 'cltbld', 17:44:09 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1450402760.304205-685097297', 17:44:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:09 INFO - '_': '/tools/buildbot/bin/python'} 17:44:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:10 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)) 17:44:10 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)) 17:44:10 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)) 17:44:10 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)) 17:44:10 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)) 17:44:10 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)) 17:44:10 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)) 17:44:10 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)) 17:44:10 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)) 17:44:10 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)) 17:44:10 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)) 17:44:10 INFO - Cleaning up... 17:44:10 INFO - Return code: 0 17:44:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:44:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:44:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd374385f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeab240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3a0b0>, '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 0xf3afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf3b440>, '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': '3cd289541638898829117e0a000001bd-1450402760.304205-685097297', '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 17:44:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:44:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:44:10 INFO - Using env: {'DISPLAY': ':0', 17:44:10 INFO - 'HOME': '/home/cltbld', 17:44:10 INFO - 'LANG': 'en_US.UTF-8', 17:44:10 INFO - 'LANGUAGE': 'en_US:en', 17:44:10 INFO - 'LOGNAME': 'cltbld', 17:44:10 INFO - 'MAIL': '/var/mail/cltbld', 17:44:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:10 INFO - 'MOZ_NO_REMOTE': '1', 17:44:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:10 INFO - 'NO_EM_RESTART': '1', 17:44:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:10 INFO - 'PWD': '/builds/slave/test', 17:44:10 INFO - 'SHELL': '/bin/bash', 17:44:10 INFO - 'SHLVL': '1', 17:44:10 INFO - 'TERM': 'linux', 17:44:10 INFO - 'TMOUT': '86400', 17:44:10 INFO - 'USER': 'cltbld', 17:44:10 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1450402760.304205-685097297', 17:44:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:10 INFO - '_': '/tools/buildbot/bin/python'} 17:44:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:10 INFO - Downloading/unpacking jsonschema 17:44:10 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 17:44:10 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 17:44:10 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 17:44:10 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 17:44:10 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 17:44:10 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 17:44:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:44:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 17:44:11 INFO - Downloading/unpacking functools32 (from jsonschema) 17:44:11 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 17:44:11 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 17:44:11 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 17:44:11 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 17:44:11 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 17:44:11 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 17:44:12 INFO - Downloading functools32-3.2.3-2.tar.gz 17:44:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 17:44:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:44:12 INFO - warning: no files found matching '*.txt' 17:44:12 INFO - no previously-included directories found matching 'build' 17:44:12 INFO - no previously-included directories found matching 'dist' 17:44:12 INFO - no previously-included directories found matching '.git*' 17:44:12 INFO - Installing collected packages: jsonschema, functools32 17:44:12 INFO - Running setup.py install for functools32 17:44:12 INFO - warning: no files found matching '*.txt' 17:44:12 INFO - no previously-included directories found matching 'build' 17:44:12 INFO - no previously-included directories found matching 'dist' 17:44:12 INFO - no previously-included directories found matching '.git*' 17:44:12 INFO - Successfully installed jsonschema functools32 17:44:12 INFO - Cleaning up... 17:44:12 INFO - Return code: 0 17:44:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:44:12 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')]} 17:44:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:12 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')]} 17:44:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:12 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd374385f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeab240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3a0b0>, '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 0xf3afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf3b440>, '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': '3cd289541638898829117e0a000001bd-1450402760.304205-685097297', '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 17:44:12 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', 'flake8'] in /builds/slave/test/build 17:44:12 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 flake8 17:44:12 INFO - Using env: {'DISPLAY': ':0', 17:44:12 INFO - 'HOME': '/home/cltbld', 17:44:12 INFO - 'LANG': 'en_US.UTF-8', 17:44:12 INFO - 'LANGUAGE': 'en_US:en', 17:44:12 INFO - 'LOGNAME': 'cltbld', 17:44:12 INFO - 'MAIL': '/var/mail/cltbld', 17:44:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:12 INFO - 'MOZ_NO_REMOTE': '1', 17:44:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:12 INFO - 'NO_EM_RESTART': '1', 17:44:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:12 INFO - 'PWD': '/builds/slave/test', 17:44:12 INFO - 'SHELL': '/bin/bash', 17:44:12 INFO - 'SHLVL': '1', 17:44:12 INFO - 'TERM': 'linux', 17:44:12 INFO - 'TMOUT': '86400', 17:44:12 INFO - 'USER': 'cltbld', 17:44:12 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1450402760.304205-685097297', 17:44:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:12 INFO - '_': '/tools/buildbot/bin/python'} 17:44:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:12 INFO - Downloading/unpacking flake8 17:44:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:44:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 17:44:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:44:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:44:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 17:44:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:44:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 17:44:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:44:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 17:44:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:44:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:44:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:44:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:44:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:44:14 INFO - no previously-included directories found matching 'docs/_build' 17:44:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:44:15 INFO - Running setup.py install for pep8 17:44:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:44:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:44:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:44:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:44:15 INFO - no previously-included directories found matching 'docs/_build' 17:44:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:44:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:44:15 INFO - Cleaning up... 17:44:15 INFO - Return code: 0 17:44:15 INFO - Running post-action listener: _resource_record_post_action 17:44:15 INFO - Running post-action listener: _start_resource_monitoring 17:44:15 INFO - Starting resource monitoring. 17:44:15 INFO - ##### 17:44:15 INFO - ##### Running install step. 17:44:15 INFO - ##### 17:44:15 INFO - Running pre-action listener: _resource_record_pre_action 17:44:15 INFO - Running main action method: install 17:44:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:44:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:44:15 INFO - Reading from file tmpfile_stdout 17:44:15 INFO - Detecting whether we're running mozinstall >=1.0... 17:44:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:44:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:44:15 INFO - Reading from file tmpfile_stdout 17:44:15 INFO - Output received: 17:44:15 INFO - Usage: mozinstall [options] installer 17:44:15 INFO - Options: 17:44:15 INFO - -h, --help show this help message and exit 17:44:15 INFO - -d DEST, --destination=DEST 17:44:15 INFO - Directory to install application into. [default: 17:44:15 INFO - "/builds/slave/test"] 17:44:15 INFO - --app=APP Application being installed. [default: firefox] 17:44:15 INFO - mkdir: /builds/slave/test/build/application 17:44:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:44:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:44:30 INFO - Reading from file tmpfile_stdout 17:44:30 INFO - Output received: 17:44:30 INFO - /builds/slave/test/build/application/firefox/firefox 17:44:30 INFO - Running post-action listener: _resource_record_post_action 17:44:30 INFO - ##### 17:44:30 INFO - ##### Running run-tests step. 17:44:30 INFO - ##### 17:44:30 INFO - Running pre-action listener: _resource_record_pre_action 17:44:30 INFO - Running main action method: run_tests 17:44:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:44:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:44:30 INFO - Python 2.7.3 17:44:30 INFO - Return code: 0 17:44:30 INFO - grabbing minidump binary from tooltool 17:44:30 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')]} 17:44:30 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 0xf3a0b0>, '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 0xf3afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf3b440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:44:30 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 17:44:30 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 17:44:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:44:30 INFO - Return code: 0 17:44:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:44:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:44:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:44:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:44:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:44:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:44:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:44:31 INFO - Return code: 0 17:44:31 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/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost'] in /builds/slave/test/build 17:44:31 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/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost 17:44:31 INFO - Using env: {'DISPLAY': ':0', 17:44:31 INFO - 'HOME': '/home/cltbld', 17:44:31 INFO - 'LANG': 'en_US.UTF-8', 17:44:31 INFO - 'LANGUAGE': 'en_US:en', 17:44:31 INFO - 'LOGNAME': 'cltbld', 17:44:31 INFO - 'MAIL': '/var/mail/cltbld', 17:44:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:44:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:44:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:31 INFO - 'MOZ_NO_REMOTE': '1', 17:44:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:44:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:31 INFO - 'NO_EM_RESTART': '1', 17:44:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:31 INFO - 'PWD': '/builds/slave/test', 17:44:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:44:31 INFO - 'SHELL': '/bin/bash', 17:44:31 INFO - 'SHLVL': '1', 17:44:31 INFO - 'TERM': 'linux', 17:44:31 INFO - 'TMOUT': '86400', 17:44:31 INFO - 'USER': 'cltbld', 17:44:31 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1450402760.304205-685097297', 17:44:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:31 INFO - '_': '/tools/buildbot/bin/python'} 17:44:31 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/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost'] with output_timeout 3600 17:44:32 INFO - mozversion INFO | application_buildid: 20151217170055 17:44:32 INFO - mozversion INFO | application_changeset: e4aca954089ddf8bf8c33f7b13cec453c5dd259f 17:44:32 INFO - mozversion INFO | application_display_name: Nightly 17:44:32 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:44:32 INFO - mozversion INFO | application_name: Firefox 17:44:32 INFO - mozversion INFO | application_remotingname: firefox 17:44:32 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 17:44:32 INFO - mozversion INFO | application_vendor: Mozilla 17:44:32 INFO - mozversion INFO | application_version: 46.0a1 17:44:32 INFO - mozversion INFO | platform_buildid: 20151217170055 17:44:32 INFO - mozversion INFO | platform_changeset: e4aca954089ddf8bf8c33f7b13cec453c5dd259f 17:44:32 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 17:44:32 INFO - mozversion INFO | platform_version: 46.0a1 17:44:32 INFO - 2015-12-17 17:44:32,142 DEBUG : using testdate: 1450403072 17:44:32 INFO - 2015-12-17 17:44:32,142 DEBUG : actual date: 1450403072 17:44:32 INFO - 2015-12-17 17:44:32,152 INFO : starting webserver on 'localhost:38690' 17:44:32 INFO - 2015-12-17 17:44:32,153 INFO : Starting test suite talos-linux64-ix-025.e 17:44:32 INFO - 2015-12-17 17:44:32,153 INFO : Starting test dromaeo_css 17:44:32 INFO - 2015-12-17 17:44:32,153 DEBUG : operating with platform_type : linux_ 17:44:32 INFO - 2015-12-17 17:44:32,154 INFO : Initialising browser for dromaeo_css test... 17:44:32 INFO - 2015-12-17 17:44:32,170 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFxHP03/profile http://localhost:38690/getInfo.html 17:44:37 INFO - 2015-12-17 17:44:37,114 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:44:37 INFO - 2015-12-17 17:44:37,114 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:44:37 INFO - 2015-12-17 17:44:37,114 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:44:37 INFO - 2015-12-17 17:44:37,114 DEBUG : BROWSER_OUTPUT: __metrics 17:44:37 INFO - 2015-12-17 17:44:37,255 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:44:38 INFO - 2015-12-17 17:44:38,161 INFO : Browser initialized. 17:44:38 INFO - 2015-12-17 17:44:38,162 INFO : Running cycle 1/1 for dromaeo_css test... 17:44:38 INFO - 2015-12-17 17:44:38,162 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFxHP03/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:44:50 INFO - 2015-12-17 17:44:50,168 DEBUG : BROWSER_OUTPUT: RSS: Main: 150548480 17:44:50 INFO - 2015-12-17 17:44:50,169 DEBUG : BROWSER_OUTPUT: 17:45:39 INFO - 2015-12-17 17:45:39,798 DEBUG : BROWSER_OUTPUT: 1450403139794 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] 17:47:51 INFO - 2015-12-17 17:47:51,876 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38690/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38690/tests/dromaeo/cssquery-ext.html) 17:47:52 INFO - 2015-12-17 17:47:52,900 DEBUG : BROWSER_OUTPUT: RSS: Main: 155152384 17:47:52 INFO - 2015-12-17 17:47:52,900 DEBUG : BROWSER_OUTPUT: 17:50:54 INFO - 2015-12-17 17:50:54,926 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38690/tests/dromaeo/cssquery-ext.html (next: http://localhost:38690/tests/dromaeo/cssquery-jquery.html) 17:50:55 INFO - 2015-12-17 17:50:55,527 DEBUG : BROWSER_OUTPUT: RSS: Main: 153034752 17:50:55 INFO - 2015-12-17 17:50:55,528 DEBUG : BROWSER_OUTPUT: 17:53:57 INFO - 2015-12-17 17:53:57,307 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38690/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38690/tests/dromaeo/cssquery-mootools.html) 17:53:57 INFO - 2015-12-17 17:53:57,908 DEBUG : BROWSER_OUTPUT: RSS: Main: 153227264 17:53:57 INFO - 2015-12-17 17:53:57,908 DEBUG : BROWSER_OUTPUT: 17:56:59 INFO - 2015-12-17 17:56:59,666 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38690/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38690/tests/dromaeo/cssquery-prototype.html) 17:57:00 INFO - 2015-12-17 17:57:00,288 DEBUG : BROWSER_OUTPUT: RSS: Main: 152297472 17:57:00 INFO - 2015-12-17 17:57:00,288 DEBUG : BROWSER_OUTPUT: 18:00:02 INFO - 2015-12-17 18:00:02,896 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38690/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38690/tests/dromaeo/cssquery-yui.html) 18:00:03 INFO - 2015-12-17 18:00:03,522 DEBUG : BROWSER_OUTPUT: RSS: Main: 153513984 18:00:03 INFO - 2015-12-17 18:00:03,522 DEBUG : BROWSER_OUTPUT: 18:03:05 INFO - 2015-12-17 18:03:05,899 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38690/tests/dromaeo/cssquery-yui.html (next: http://localhost:38690/tests/dromaeo/cssquery-dojo.html) 18:03:06 INFO - 2015-12-17 18:03:06,157 DEBUG : BROWSER_OUTPUT: RSS: Main: 155197440 18:03:06 INFO - 2015-12-17 18:03:06,157 DEBUG : BROWSER_OUTPUT: 18:03:06 INFO - 2015-12-17 18:03:06,158 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:03:06 INFO - 2015-12-17 18:03:06,158 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:03:06 INFO - 2015-12-17 18:03:06,158 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:03:06 INFO - 2015-12-17 18:03:06,158 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:03:06 INFO - 2015-12-17 18:03:06,160 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2679.7271296134336;2714.3756935904753;2722.959155612666;2751.050887443831;2766.1286694691175;4641.767911604415;4725.999999999995;4740.241561350184;4767.046590681869;4787;4675.8363457279;4715.78778954947;4731.9763401182945;4844.2733589961435;4846.927296090562;4425.468943726757;4463.375127482155;4531.932021019687;4537.523560026183;4541.455025396957;4439.089986552765;4482.551744825524;4501.414816073906;4516.616087632555;4590.311453282001;4283.121959998193;4384.605385515287;4409.096135292258;4415.933760993587;4512.232920403507;4269.594388533115;4396.450443694538;4405.29515277554;4409.853438106115;4415.20526305265;4340.0374158267905;4347.043650396908;4352.564743525654;4369.3009118541195;4418.204723149864;4384.254676704968;4609.539046095397;4648.976755116237;4659.930101048487;4676.134915040729;5125.154349532323;5146.768395422215;5150.330457040598;5153.66501177426;5163.302954101186;5152;5174.197999310113;5175.0943584872875;5179.482051794828;5221.39953905302;4552.180607490651;4658.767061646904;4686.320483529869;4789.425268967746;4833.4441539223435;5279.208118782213;5284.497972692588;5298.417174110845;5303;5307.575393968474;5077.644564880423;5089.491050894955;5113.207452844815;5123.077845987758;5123.487651234921;4853.563179313879;4964.3298154748645;5008.29883816266;5083.085044691917;5155.097857874932;5093.719845408464;5131.1277082895995;5147.073526765218;5151.330327057533;5190.8961820764125;4741.431028276629;5101.566366858859;5108.56577190943;5115.079285728604;5123.538881500683;4126.319157339006;4177.791110444466;4259.339802330644;4261.488621365456;4303.010307629263;3724.1062145084984;3758.3047136279874;3763.0592351912023;3770.2271034437877;3775.4714339992424;4236.6187043166265;4342;4449.933251001237;4464.933026004613;4495.910081798345;5045.974770126126;5110.1568241239775;5150.871228219249;5157.07172708916;5206.947930520722;4402.493713222956;4422.380866678667;4462.598366147063;4490.663200259994;4511.729296242236;4344.674149438804;4443.377927090145;4448.288273876165;4559.52125026874;4577.610903073276;4765.428148622187;4785.042991401664;4837.927431088537;4870.245112007645;4894.339264199359;5043.117454445531;5052.368453943257;5061.670991385548;5074.188129899346;5080.339555857715;4620.930686039645;4739.431268247832;4856.68431551948;4863.392075990501;5004.5746111579465;5115.667481613683;5128.897422051613;5133.460986596354;5136.614753893398;5190.714510701948;5210.635255532076;5218;5221.712805795718;5222.112240918977;5236.319278493924;4736.289556566542;4860.805567777391;4861.295112208639;4974.303597496281;4983.800647974041;5016.974915125401;5068.873278168076;5081.517255860687;5085.898282034264;5125;4688.882777930579;4911.656184067081;4942.901141977212;4967.7019378837385;4974.602031837517;4944.802207911644;4978.4274808397495;5013.197888337994;5050.974745126251;5091.261767043832;4909.852704418873;4935.333729946555;4940.505949405031;4955.231939049453;4967.602591792575 18:03:06 INFO - 2015-12-17 18:03:06,160 DEBUG : BROWSER_OUTPUT: |1;ext.html;548.9890202195957;549.3572520151425;557.381306749508;557.9721013949302;611.2390074357426;35093.47359789602;35579.11052223692;35697.46453803195;35771.10572235692;35930;35873.82063089681;36727;36913;37034.25931481369;37061.81469092658;7731.497452665572;7906.960465197666;7910.683572657087;7915.762527124196;7916.327112195441;7699.461037727361;7832.72585459509;7840.647170877324;7844.529328240295;7851.136374998746;4670.392848929651;4872.853814385574;4948.50514948504;4957.058158949788;5237.764300606463;7760.961195194044;7812.843743125134;7823.608819559056;7825.491343062711;7872.055353357577;7674.731384401575;7803.219678032208;7807.102183248886;7808.336291415179;7816.687332506693;33553.83223083893;34002;34104.14739631504;34115.31769364623;34136;2810.4941110600084;2870.7559857411934;2991.790574659775;3429.3655673700196;3514.894553163409;27495.175144745688;27653.585196221873;27754.722452775415;27768.444631107468;28469.57295640567;3406.0633325835347;3527.6472352764517;3546.847026059275;3562.3231585998838;3592.1558433768046;216895;218748;219064;219123;219132.9999999984;51917.48082519202;53120.734396327774;56289.7185514078;61630.38369616246;63148;54061.72969135129;54226.72886635541;54389;54522.72738636361;54850.72574637101;13357.13178643385;13518.59444216675;13527.52653657137;13533.864661353457;13543.322833858268;9811.509424528746;9871.40771553709;9963.25275604318;9981.301308908307;10012.799744005224;19350.516237094187;19687.606247874963;19738.60522789536;19802;19821.30625428103;7816;7893.250141236574;7924.286814186751;7933.841323173504;8043.058901138517;906.7461110888962;926.4487629860222;978.6330126202674;988.1107003696587;1008.2538921198407;29940.850295748383;30263.848680756455;30293.848530757205;30768;31004.53493197604;985.3102828020415;1050.4432650695144;1087.5704096881686;1099.5821587796586;1108.6895669212633;13397.263150526815;13492.460301587827;13654.86345136536;13779.517716879862;15276.159811210267;312541;312755;314259;316429;317224;47686.76156619264;47909.28136077962;48038.759806200746;48063.519364806605;48515.272270915964;1244.7697176022464;1252.3049707412292;1261.1172179474404;1264.4562837979756;1265.9936700316623;27287.317817054733;27512.174634760988;27571.31071723223;27814;28529.572056419587;38739;39212.41181382225;39410.80294598509;39451.80274098726;39499.40750888681;241795;242618;243204;243353;243616;28809.279768005967;42133.15733685371;42594.740525947156;43026.569734302255;43244.351334730636;44825.55174448344;45814;46023.53976460193;46263;46431.76784116193;31796.414020356504;31824.04527864168;32395.35209295848;32905.50641740328;33072.66927330696;31834.52248216325;32153.678463215067;32428.513572296906;32748.345033099682;32885.342293153524;32074.518882217253;32131;32440.51339229866;32698.673013270516;32748.508772367957;27513.44973100487;28578.714212857605;29439;29539.26151846135;29540.261493462836;22756.20353287693;22771.65842512397;22807;22920.083196671945;23026.654600180675 18:03:06 INFO - 2015-12-17 18:03:06,161 DEBUG : BROWSER_OUTPUT: |2;jquery.html;323.8866396761133;324.3383497664764;325.68789230587026;327.4613261185349;339.80970656432413;14649.04781189222;15016.474423395184;15336.616584585405;15890.84109158908;16433.26050327735;14307.642308942282;14327.068740531884;14333.641658958531;14417.476941535242;14543.418263269457;4442.31144172653;4673.976630116845;4955.281484184791;4979.352684151074;4992.750362481879;4965.379327584052;4986.10250154972;4988.251762235657;4994.950050499485;5003.949960500403;4758.595519380857;4855;4920.335754673127;4929.33453983713;4929.507049295078;4832.301534024543;4891.657583969123;4903.68126071806;4912.459629440758;4932.457429682732;4684.297355396684;5080.491950804927;5095.515925987025;5096.159133742928;5102.158143906251;11264.155188360906;11437.370944598044;13009.544665936646;19140.904295478573;19190.61618767617;1723.1814887928258;1821.1349608935782;1826.4611939477886;1850.195165103171;1871.0831692470592;8950.910490895138;9142.497162656051;11978.880211197864;12543.121981461301;12648.873511264861;1760.4718584424622;1788.320438233476;1791.668541319847;1817.6728188925988;1833.734108554252;54392.456075439135;56720;57300.426995729926;57324.71337643327;57658.423415765305;9248.16766491019;9368.67209647659;9422.246220302359;9461.810763784686;9480.431174129575;11890.76218475643;11899.286042837457;11913.10651701126;11913.58302459427;11915.88084119165;6727.529072964846;6897.241303456616;6936.4797640177185;7055.9294407056295;7209.531380460253;6308.463780578611;6506.41442270198;6522.869542609216;6539.313372095957;6549.541532092708;3787.3561494545993;3835.0987517933263;4010.0776821331256;4013.0569316210667;4097.815598298083;1657.917104144788;1660.3856573068042;1706.1980868991554;1711.7860267466567;1745.0576688588274;735.7719107076823;805.9476134051268;859.9011113721876;865.718641441534;948.4688574398359;15247.161406122548;15619.453319133776;15693;15893.364265429253;16246.350145994027;844;844.4004756622867;847.3094428041127;902.6569903436653;921.0973246218743;8895.555222238992;9309;9531.666391676257;9630.27772917034;9902.405855648683;450559;457717;465118;469753;470932;72685;73403;77268.22731772723;78103.60948195223;78306;1033.5917312661607;1077.8706555213425;1078.4284329305324;1087.2063393722626;1088.3361149698678;13582.185068895898;14400.279986000867;14595;14614.196219208046;14731.779023314873;29452.852735736185;30242.84878575593;30656.386872261985;30952.380952381278;34417.48373774446;42665.14669706526;42963;43186.56813431951;43679.56320436755;44518.55481445144;8823.514706691194;9006;9032.954835225783;9151.86272205904;9181.678641247525;10512.842307365243;10599.417032063002;10635.468226588795;16626.418075367303;16740.49778506647;11039.944800275947;11652.475638596454;13352.599422017354;13646.795298070338;14089.859101408854;13409.396577153857;13505.12216705911;13755;13843.584692459242;13982.230977296347;13997.790033149307;14231.146131232159;14446.927765361106;14506.85493145055;14536.345864435914;8969.820603588023;8972.685955991508;8975;9126.224270937044;9138.908610913806;9492.715218543455;13935.372908218951;14248.35882385316;14319.212443315717;14320.283985800877 18:03:06 INFO - 2015-12-17 18:03:06,162 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1492;1580.462642701482;1587.618971446853;1603.6391811842336;1688.9408870689529;6155.353687862777;6269.247690277173;7132.500724949249;7283.890741638873;7327.12074551054;6582.440492558127;6717.563358381702;6736.461083113351;6783.525153239275;6827.863442731143;1985.3051431998756;2012.30575451469;2018.2734215682342;2018.828399586037;2024.807643273894;1985.6028794241138;1995.630808300469;2008.036142651528;2033.3899830051;2035.389383185046;2022.2820898581012;2023.9392818215404;2054.640437923365;2058.742657167854;2072.0882811562938;2058.9485262868475;2080.781517940617;2082.073477302601;2083.4062292246635;2092.23633373819;2001;2023.7571491420977;2069.6688529835155;2079.812816846476;2079.854410191287;6961.895571566431;7123.643817809088;7131.251218622022;7135.5361901476235;7142.2857714228685;3933.3903244997073;4007.9599204007877;4024.3762216856435;4024.577419370953;4038.575949525287;2549.8087643426816;2624.2520881548667;2627.5795872660283;2635.262126604554;2636.709961904189;869.8173383589453;873.6505397840851;879.2482427524438;890.9955450222773;897.7755561109723;9446.149846513777;9467.857982130274;9505.287103467268;9519.524023798782;9524.095210954949;3682.7237957152784;3724.2923844469465;3725.515682961198;3736.8878933632036;3760.7555508891833;8112.716054938167;8138.186181381814;8147.877781833158;8164.306033987059;8187.590620468953;4091.181763647223;4092.7544347339253;4095.28332541804;4102.856400025985;4131.669466442678;3239.61124665037;3313.3042061166943;3654.6710796028483;3747.9812600937366;3754.249150169977;3379.5944486661265;3403.489476578533;3418;3428.674275943781;3434.175797808508;1052.936823790575;1063.1494804156644;1074.8495210670512;1075.9569617215225;1080.103514083309;1136.2784631758727;1158.3223814068865;1161.6573110932295;1182.674764439786;1216.5437960764714;6630.469562434993;6658.334166583303;6677.265500794909;6681.699323530453;6684.1978962523835;1035.9585616575253;1043.8173319669027;1047.2459828923163;1055.4036969112426;1068.5298468673914;5280.128778751539;5340.49265319794;5342.946570534323;5352.143657014859;5359.276497672764;8137.186281371815;8267.214614611603;8418.705345312885;8452.957735211285;8456.661733530713;8199.590020498952;8257.21556452136;8274.669013239523;8353.540555269397;8406.831863362699;6471.417572418505;6594.307597702268;6598.505112116514;6650.3682150195655;6682.131322927989;6399.840003999937;6405.071264666691;6468.15913931186;6480.189976252968;6513.511486638616;7250.456215783943;7337.889931650922;7452.180260171268;7452.403807695479;7520.323170914644;7378.262173782578;7538.359239464707;7596.050493688289;7624.771256862303;7698.307152356315;5109.616778741683;5467.562594992471;5621.297337832771;5880.088586269135;5940.79207227745;6460.998545225498;6497.220333559814;6514.478841692748;6521.087047813405;6526.412622863775;6297.937020629735;6433.5496515243485;6548.116004339353;6563.9343606565235;6607.47140228771;6274.372562743872;6282.717277722422;6299.779507717208;6393.968030159819;6482.481401487776;6200.689965501617;6230.937690623035;6273.62358258506;6300.369963003663;6300.684965751786;5868.823935281948;5888.057910734433;5911.261092363455;5948.315943666534;5975.701214939322;5937.406259374028;5978.970105149447;5982.611130276518;5983.34183239852;5985.790497332572 18:03:06 INFO - 2015-12-17 18:03:06,162 DEBUG : BROWSER_OUTPUT: |4;prototype.html;288.4490622910242;294.06194240373196;300.22691569209286;300.60020173169676;303.0650443382166;5514.283143191385;5560.499555040045;5588.189712491691;5624;5689.260396148506;5531.944680553193;5549.556035517159;5598.356189038262;5602.719864006804;5607.299087614048;4158.313878210107;4296.226679197735;4305.418768466248;4307.181635489247;4309.482862056542;4220.430241917348;4264.402983582301;4274;4276.508201556814;4277.657787377002;4236;4246.895807090148;4248.490181178263;4248.87253382399;4249.787510624472;4234.618884300412;4235.7246778959425;4239.59723826236;4253.02180498484;4263.722858014219;3687.1888184599347;3692.132348898007;3693.0582701411236;3694.7228957828;3699.815009249554;5181.715005674687;5215.843524694227;5347.893042139174;5349.759260833272;5357.544608708265;4842.903141937177;4857.902841943177;4875.878103047452;4876.487968763265;4878.5365390288225;5835.416458354173;5846.853828654275;5850.414958504116;5853.707314634251;5862.560307976919;3875.8449662013486;3940.4680368150507;3992.7205095643317;3997.38040603704;4005.539362973266;5998.520118390518;6137.11011903276;6140.846478837975;6144.692765361714;6146.907796383058;4103.9179216415505;4113.732607380511;4122.56713045126;4125.360569111793;4129.483814523184;4157.792110394468;4159.8960025999595;4174.958250417518;4178.707490475698;4185.142045880587;4725.362076119749;4803.519648035169;4807.254875494304;4822.855314340575;4825.059113472909;5780.826575202751;5803.303603567599;5811.535077193815;5814.651120932757;5816.912746308809;1450.6445920749484;1468.6475245940896;1468.9632759181106;1469.5003698742264;1469.6987117640858;980.8921018687938;981.7790997025755;983.4001259231862;997.0129571724086;1003.9598416063421;5049.722265275372;5050;5057.468965758616;5061.974690126526;5065.848024559269;6053.303870054912;6058.4244496772735;6065;6070.0591408331775;6086.786962456381;5042.168042273057;5052.7726252318735;5054.469280725544;5064.11378008847;5072.036313100499;3198.520221966677;3258.0714496368423;3271.8854840080485;3282.8030318180986;3291.6050073991273;5636.549076073904;5684.261046063985;5696.6582005079;5699.202111704365;5706.42935706426;6314.084457753692;6326.588771729823;6343.302236753953;6344.936550634527;6347.492200623939;5759.654420734685;5768.855778605568;5771.336296325976;5783.103618939072;5790.27621547315;6143.631382117087;6148.077788331786;6148.47737942262;6157.96921015392;6163.9383606163365;5816.127580862735;5942.435468630473;5989.490893274121;5996.430339117776;6024.939750602438;5750.022496175744;5750.712464376681;5757.165211044291;5785.363610002981;5790.855228619318;4122.464079669624;4170.061736109473;4171.958280417157;4172.102997855475;4181.560936101666;5990.460858522754;6107.572469927062;6119.388061193845;6120.969395152996;6125.356837532173;5866.6480011199465;5876.324222714443;5877.588568800143;5887.264091988502;5888.528917686661;5833.649981001154;5855;5864.648121112747;5874.823755287348;5877.617954832922;5616.85957851057;5706;5736.110902810071;5747.396523365153;5765.625234359753;5861.120831875082;5912.497437717842;5920.141579471038;5932.080527518242;5933.139694744152;5738.971305143447;5745.166950792195;5755.7122143893475;5766.769329226784;5773.653580785166 18:03:06 INFO - 2015-12-17 18:03:06,163 DEBUG : BROWSER_OUTPUT: |5;yui.html;701.9929800701991;718.5293632670599;718.7843646905928;733.3912852332564;733.7651951375559;10637.095846853026;10652.946735266323;10684.358938463678;10717.410542420173;10772.030517253446;11389.202755807097;11642.883571164286;11692.181547291693;11732.589359372403;11773.058155347573;772.5982489105662;778.3189709004621;793.1473665809249;806.4677312973439;809.4576633655436;744.7914583916512;749.9175090740014;756.5460723565844;759.4987308376473;762.222533016323;826.7230477789948;830.2237408023487;835.3108685334593;835.3567752830317;842.2840585502336;817.8159914019298;822.9465084769531;824.3940703582862;825.5129473610568;829.0797215091244;618.3445547719386;618.4248648756654;618.5299172628789;618.7184830901929;619.9659018753966;10622.57509699611;10642.521086551124;10682.839757403644;10685.83971240432;10711.83932241017;10063.849042264372;10198;10429.426381549012;10627.096696780784;10892.346459212393;8975.865362019575;9085.863712044325;9197.21823644991;9280.30397720167;9315.906840931639;3145.7326127279207;3148.7481001520055;3243.351329734039;3256.8697252109887;3280.2127489402374;36724.44913326302;37050.814745926094;37093.81453092717;37183.99999999973;37187;8531.488110713377;8532.488050716976;8587.355948303903;8702.260307873776;8808.5595720215;15368.308426120851;15371.077735335915;15380.230988450532;15404.92297538505;15434.305456254495;6034.879302414015;6043.939560604338;6117.694115294217;6149.877002459926;6152.723127459275;3424.811635360079;3460.3425349183576;3489.5289135966827;3520.6831385175456;3579.329570143172;2501.9249422517355;2505.649209110726;2538.6445897574354;2543.3895864992637;2545.185540627019;436.32587652077615;441.39969641287826;447.44293354773515;448.9797959091849;460.73968207962395;415.29607315600373;468.2274247491666;484.63167992326083;541.5099335101739;544.2299146707444;6676.399124078856;6828.385445309946;7083.574985500783;7244.311790379906;7698.42261830365;458.7797857028645;524.2477045439806;544.1375419959329;575.2090875046811;579.5421616922669;3143.222302100794;3205.9198520037185;3378.239896023375;3412.3175364927115;3464.7401444891734;45608.3158752619;47620.5237947623;48066;48256.5174348259;48566.757166213945;38298;38426.42360364597;38826;40236.39645405321;42304.365434518506;37953.62046379501;38872;39075.60924390776;39247.215055698725;39444.40833387501;7202.639868006683;7266.055412796302;7270.527415717961;7280.526765760209;7295.270472952874;29102.126936191948;29687.10938671843;30313.393732125674;30319.545206822357;30704.692953070182;35522.28955420929;37158.8142059288;37692.24615507729;37869.81065094657;37881.62118378891;9385.718428447157;9409.811803763749;9551.522423878918;9679;9754.219662427131;10420.739481513023;10490.632827850988;10590.258681892194;10688;10688.572457101629;10146.086852183338;10158.441285729356;10181.440020798927;10223;10225.437600931722;9486.33595648298;9990.200783937413;10137.594496220363;10149.289549731448;10153.54309056109;9497.810043799223;10044;10162.39025658463;10170.949145254523;10248.38509689421;8557.400981931454;8677.913220867711;8751.64993400257;8867.866981995405;8919.598618062073;8250.628721707657;8330.458520196167;8444.930991907022;8583.527905965231;8799.91200087991 18:03:06 INFO - 2015-12-17 18:03:06,163 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:03:06 INFO - 2015-12-17 18:03:06,164 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:03:06 INFO - 2015-12-17 18:03:06,164 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,316 18:03:06 INFO - 2015-12-17 18:03:06,164 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:03:06 INFO - 2015-12-17 18:03:06,164 DEBUG : BROWSER_OUTPUT: __startTimestamp1450404186151__endTimestamp 18:03:06 INFO - 2015-12-17 18:03:06,164 DEBUG : BROWSER_OUTPUT: 18:03:06 INFO - 2015-12-17 18:03:06,164 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:03:06 INFO - 2015-12-17 18:03:06,164 DEBUG : BROWSER_OUTPUT: Number of tests: 6 18:03:06 INFO - 2015-12-17 18:03:06,164 DEBUG : BROWSER_OUTPUT: 18:03:06 INFO - 2015-12-17 18:03:06,165 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4725.17 Median:4846.93 stddev:502.34 (10.4%) stddev-sans-first:477.57 18:03:06 INFO - 2015-12-17 18:03:06,165 DEBUG : BROWSER_OUTPUT: Values: 2679.7 2714.4 2723.0 2751.1 2766.1 4641.8 4726.0 4740.2 4767.0 4787.0 4675.8 4715.8 4732.0 4844.3 4846.9 4425.5 4463.4 4531.9 4537.5 4541.5 4439.1 4482.6 4501.4 4516.6 4590.3 4283.1 4384.6 4409.1 4415.9 4512.2 4269.6 4396.5 4405.3 4409.9 4415.2 4340.0 4347.0 4352.6 4369.3 4418.2 4384.3 4609.5 4649.0 4659.9 4676.1 5125.2 5146.8 5150.3 5153.7 5163.3 5152.0 5174.2 5175.1 5179.5 5221.4 4552.2 4658.8 4686.3 4789.4 4833.4 5279.2 5284.5 5298.4 5303.0 5307.6 5077.6 5089.5 5113.2 5123.1 5123.5 4853.6 4964.3 5008.3 5083.1 5155.1 5093.7 5131.1 5147.1 5151.3 5190.9 4741.4 5101.6 5108.6 5115.1 5123.5 4126.3 4177.8 4259.3 4261.5 4303.0 3724.1 3758.3 3763.1 3770.2 3775.5 4236.6 4342.0 4449.9 4464.9 4495.9 5046.0 5110.2 5150.9 5157.1 5206.9 4402.5 4422.4 4462.6 4490.7 4511.7 4344.7 4443.4 4448.3 4559.5 4577.6 4765.4 4785.0 4837.9 4870.2 4894.3 5043.1 5052.4 5061.7 5074.2 5080.3 4620.9 4739.4 4856.7 4863.4 5004.6 5115.7 5128.9 5133.5 5136.6 5190.7 5210.6 5218.0 5221.7 5222.1 5236.3 4736.3 4860.8 4861.3 4974.3 4983.8 5017.0 5068.9 5081.5 5085.9 5125.0 4688.9 4911.7 4942.9 4967.7 4974.6 4944.8 4978.4 5013.2 5051.0 5091.3 4909.9 4935.3 4940.5 4955.2 4967.6 18:03:06 INFO - 2015-12-17 18:03:06,165 DEBUG : BROWSER_OUTPUT: 18:03:06 INFO - 2015-12-17 18:03:06,165 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42054.08 Median:18782.68 stddev:68491.51 (364.7%) stddev-sans-first:68612.75 18:03:06 INFO - 2015-12-17 18:03:06,166 DEBUG : BROWSER_OUTPUT: Values: 549.0 549.4 557.4 558.0 611.2 35093.5 35579.1 35697.5 35771.1 35930.0 35873.8 36727.0 36913.0 37034.3 37061.8 7731.5 7907.0 7910.7 7915.8 7916.3 7699.5 7832.7 7840.6 7844.5 7851.1 4670.4 4872.9 4948.5 4957.1 5237.8 7761.0 7812.8 7823.6 7825.5 7872.1 7674.7 7803.2 7807.1 7808.3 7816.7 33553.8 34002.0 34104.1 34115.3 34136.0 2810.5 2870.8 2991.8 3429.4 3514.9 27495.2 27653.6 27754.7 27768.4 28469.6 3406.1 3527.6 3546.8 3562.3 3592.2 216895.0 218748.0 219064.0 219123.0 219133.0 51917.5 53120.7 56289.7 61630.4 63148.0 54061.7 54226.7 54389.0 54522.7 54850.7 13357.1 13518.6 13527.5 13533.9 13543.3 9811.5 9871.4 9963.3 9981.3 10012.8 19350.5 19687.6 19738.6 19802.0 19821.3 7816.0 7893.3 7924.3 7933.8 8043.1 906.7 926.4 978.6 988.1 1008.3 29940.9 30263.8 30293.8 30768.0 31004.5 985.3 1050.4 1087.6 1099.6 1108.7 13397.3 13492.5 13654.9 13779.5 15276.2 312541.0 312755.0 314259.0 316429.0 317224.0 47686.8 47909.3 48038.8 48063.5 48515.3 1244.8 1252.3 1261.1 1264.5 1266.0 27287.3 27512.2 27571.3 27814.0 28529.6 38739.0 39212.4 39410.8 39451.8 39499.4 241795.0 242618.0 243204.0 243353.0 243616.0 28809.3 42133.2 42594.7 43026.6 43244.4 44825.6 45814.0 46023.5 46263.0 46431.8 31796.4 31824.0 32395.4 32905.5 33072.7 31834.5 32153.7 32428.5 32748.3 32885.3 32074.5 32131.0 32440.5 32698.7 32748.5 27513.4 28578.7 29439.0 29539.3 29540.3 22756.2 22771.7 22807.0 22920.1 23026.7 18:03:06 INFO - 2015-12-17 18:03:06,166 DEBUG : BROWSER_OUTPUT: 18:03:06 INFO - 2015-12-17 18:03:06,167 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25615.55 Median:4055.44 stddev:75741.83 (1867.7%) stddev-sans-first:75930.49 18:03:06 INFO - 2015-12-17 18:03:06,167 DEBUG : BROWSER_OUTPUT: Values: 323.9 324.3 325.7 327.5 339.8 14649.0 15016.5 15336.6 15890.8 16433.3 14307.6 14327.1 14333.6 14417.5 14543.4 4442.3 4674.0 4955.3 4979.4 4992.8 4965.4 4986.1 4988.3 4995.0 5003.9 4758.6 4855.0 4920.3 4929.3 4929.5 4832.3 4891.7 4903.7 4912.5 4932.5 4684.3 5080.5 5095.5 5096.2 5102.2 11264.2 11437.4 13009.5 19140.9 19190.6 1723.2 1821.1 1826.5 1850.2 1871.1 8950.9 9142.5 11978.9 12543.1 12648.9 1760.5 1788.3 1791.7 1817.7 1833.7 54392.5 56720.0 57300.4 57324.7 57658.4 9248.2 9368.7 9422.2 9461.8 9480.4 11890.8 11899.3 11913.1 11913.6 11915.9 6727.5 6897.2 6936.5 7055.9 7209.5 6308.5 6506.4 6522.9 6539.3 6549.5 3787.4 3835.1 4010.1 4013.1 4097.8 1657.9 1660.4 1706.2 1711.8 1745.1 735.8 805.9 859.9 865.7 948.5 15247.2 15619.5 15693.0 15893.4 16246.4 844.0 844.4 847.3 902.7 921.1 8895.6 9309.0 9531.7 9630.3 9902.4 450559.0 457717.0 465118.0 469753.0 470932.0 72685.0 73403.0 77268.2 78103.6 78306.0 1033.6 1077.9 1078.4 1087.2 1088.3 13582.2 14400.3 14595.0 14614.2 14731.8 29452.9 30242.8 30656.4 30952.4 34417.5 42665.1 42963.0 43186.6 43679.6 44518.6 8823.5 9006.0 9033.0 9151.9 9181.7 10512.8 10599.4 10635.5 16626.4 16740.5 11039.9 11652.5 13352.6 13646.8 14089.9 13409.4 13505.1 13755.0 13843.6 13982.2 13997.8 14231.1 14446.9 14506.9 14536.3 8969.8 8972.7 8975.0 9126.2 9138.9 9492.7 13935.4 14248.4 14319.2 14320.3 18:03:06 INFO - 2015-12-17 18:03:06,167 DEBUG : BROWSER_OUTPUT: 18:03:06 INFO - 2015-12-17 18:03:06,167 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4873.32 Median:5977.34 stddev:2505.21 (41.9%) stddev-sans-first:2499.35 18:03:06 INFO - 2015-12-17 18:03:06,168 DEBUG : BROWSER_OUTPUT: Values: 1492.0 1580.5 1587.6 1603.6 1688.9 6155.4 6269.2 7132.5 7283.9 7327.1 6582.4 6717.6 6736.5 6783.5 6827.9 1985.3 2012.3 2018.3 2018.8 2024.8 1985.6 1995.6 2008.0 2033.4 2035.4 2022.3 2023.9 2054.6 2058.7 2072.1 2058.9 2080.8 2082.1 2083.4 2092.2 2001.0 2023.8 2069.7 2079.8 2079.9 6961.9 7123.6 7131.3 7135.5 7142.3 3933.4 4008.0 4024.4 4024.6 4038.6 2549.8 2624.3 2627.6 2635.3 2636.7 869.8 873.7 879.2 891.0 897.8 9446.1 9467.9 9505.3 9519.5 9524.1 3682.7 3724.3 3725.5 3736.9 3760.8 8112.7 8138.2 8147.9 8164.3 8187.6 4091.2 4092.8 4095.3 4102.9 4131.7 3239.6 3313.3 3654.7 3748.0 3754.2 3379.6 3403.5 3418.0 3428.7 3434.2 1052.9 1063.1 1074.8 1076.0 1080.1 1136.3 1158.3 1161.7 1182.7 1216.5 6630.5 6658.3 6677.3 6681.7 6684.2 1036.0 1043.8 1047.2 1055.4 1068.5 5280.1 5340.5 5342.9 5352.1 5359.3 8137.2 8267.2 8418.7 8453.0 8456.7 8199.6 8257.2 8274.7 8353.5 8406.8 6471.4 6594.3 6598.5 6650.4 6682.1 6399.8 6405.1 6468.2 6480.2 6513.5 7250.5 7337.9 7452.2 7452.4 7520.3 7378.3 7538.4 7596.1 7624.8 7698.3 5109.6 5467.6 5621.3 5880.1 5940.8 6461.0 6497.2 6514.5 6521.1 6526.4 6297.9 6433.5 6548.1 6563.9 6607.5 6274.4 6282.7 6299.8 6394.0 6482.5 6200.7 6230.9 6273.6 6300.4 6300.7 5868.8 5888.1 5911.3 5948.3 5975.7 5937.4 5979.0 5982.6 5983.3 5985.8 18:03:06 INFO - 2015-12-17 18:03:06,169 DEBUG : BROWSER_OUTPUT: 18:03:06 INFO - 2015-12-17 18:03:06,169 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4836.43 Median:5593.27 stddev:1445.79 (25.8%) stddev-sans-first:1408.97 18:03:06 INFO - 2015-12-17 18:03:06,169 DEBUG : BROWSER_OUTPUT: Values: 288.4 294.1 300.2 300.6 303.1 5514.3 5560.5 5588.2 5624.0 5689.3 5531.9 5549.6 5598.4 5602.7 5607.3 4158.3 4296.2 4305.4 4307.2 4309.5 4220.4 4264.4 4274.0 4276.5 4277.7 4236.0 4246.9 4248.5 4248.9 4249.8 4234.6 4235.7 4239.6 4253.0 4263.7 3687.2 3692.1 3693.1 3694.7 3699.8 5181.7 5215.8 5347.9 5349.8 5357.5 4842.9 4857.9 4875.9 4876.5 4878.5 5835.4 5846.9 5850.4 5853.7 5862.6 3875.8 3940.5 3992.7 3997.4 4005.5 5998.5 6137.1 6140.8 6144.7 6146.9 4103.9 4113.7 4122.6 4125.4 4129.5 4157.8 4159.9 4175.0 4178.7 4185.1 4725.4 4803.5 4807.3 4822.9 4825.1 5780.8 5803.3 5811.5 5814.7 5816.9 1450.6 1468.6 1469.0 1469.5 1469.7 980.9 981.8 983.4 997.0 1004.0 5049.7 5050.0 5057.5 5062.0 5065.8 6053.3 6058.4 6065.0 6070.1 6086.8 5042.2 5052.8 5054.5 5064.1 5072.0 3198.5 3258.1 3271.9 3282.8 3291.6 5636.5 5684.3 5696.7 5699.2 5706.4 6314.1 6326.6 6343.3 6344.9 6347.5 5759.7 5768.9 5771.3 5783.1 5790.3 6143.6 6148.1 6148.5 6158.0 6163.9 5816.1 5942.4 5989.5 5996.4 6024.9 5750.0 5750.7 5757.2 5785.4 5790.9 4122.5 4170.1 4172.0 4172.1 4181.6 5990.5 6107.6 6119.4 6121.0 6125.4 5866.6 5876.3 5877.6 5887.3 5888.5 5833.6 5855.0 5864.6 5874.8 5877.6 5616.9 5706.0 5736.1 5747.4 5765.6 5861.1 5912.5 5920.1 5932.1 5933.1 5739.0 5745.2 5755.7 5766.8 5773.7 18:03:06 INFO - 2015-12-17 18:03:06,169 DEBUG : BROWSER_OUTPUT: 18:03:06 INFO - 2015-12-17 18:03:06,169 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11492.03 Median:448.21 stddev:12915.33 (2881.5%) stddev-sans-first:12926.14 18:03:06 INFO - 2015-12-17 18:03:06,170 DEBUG : BROWSER_OUTPUT: Values: 702.0 718.5 718.8 733.4 733.8 10637.1 10652.9 10684.4 10717.4 10772.0 11389.2 11642.9 11692.2 11732.6 11773.1 772.6 778.3 793.1 806.5 809.5 744.8 749.9 756.5 759.5 762.2 826.7 830.2 835.3 835.4 842.3 817.8 822.9 824.4 825.5 829.1 618.3 618.4 618.5 618.7 620.0 10622.6 10642.5 10682.8 10685.8 10711.8 10063.8 10198.0 10429.4 10627.1 10892.3 8975.9 9085.9 9197.2 9280.3 9315.9 3145.7 3148.7 3243.4 3256.9 3280.2 36724.4 37050.8 37093.8 37184.0 37187.0 8531.5 8532.5 8587.4 8702.3 8808.6 15368.3 15371.1 15380.2 15404.9 15434.3 6034.9 6043.9 6117.7 6149.9 6152.7 3424.8 3460.3 3489.5 3520.7 3579.3 2501.9 2505.6 2538.6 2543.4 2545.2 436.3 441.4 447.4 449.0 460.7 415.3 468.2 484.6 541.5 544.2 6676.4 6828.4 7083.6 7244.3 7698.4 458.8 524.2 544.1 575.2 579.5 3143.2 3205.9 3378.2 3412.3 3464.7 45608.3 47620.5 48066.0 48256.5 48566.8 38298.0 38426.4 38826.0 40236.4 42304.4 37953.6 38872.0 39075.6 39247.2 39444.4 7202.6 7266.1 7270.5 7280.5 7295.3 29102.1 29687.1 30313.4 30319.5 30704.7 35522.3 37158.8 37692.2 37869.8 37881.6 9385.7 9409.8 9551.5 9679.0 9754.2 10420.7 10490.6 10590.3 10688.0 10688.6 10146.1 10158.4 10181.4 10223.0 10225.4 9486.3 9990.2 10137.6 10149.3 10153.5 9497.8 10044.0 10162.4 10170.9 10248.4 8557.4 8677.9 8751.6 8867.9 8919.6 8250.6 8330.5 8444.9 8583.5 8799.9 18:03:06 INFO - 2015-12-17 18:03:06,170 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:03:06 INFO - 2015-12-17 18:03:06,170 DEBUG : BROWSER_OUTPUT: 18:03:06 INFO - 2015-12-17 18:03:06,933 INFO : Browser exited with error code: 0 18:03:06 INFO - 2015-12-17 18:03:06,949 INFO : Completed test dromaeo_css (00:18:34) 18:03:06 INFO - 2015-12-17 18:03:06,950 INFO : Starting test kraken 18:03:06 INFO - 2015-12-17 18:03:06,950 DEBUG : operating with platform_type : linux_ 18:03:06 INFO - 2015-12-17 18:03:06,950 INFO : Initialising browser for kraken test... 18:03:06 INFO - 2015-12-17 18:03:06,956 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjRleiK/profile http://localhost:38690/getInfo.html 18:03:11 INFO - 2015-12-17 18:03:11,792 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:03:11 INFO - 2015-12-17 18:03:11,792 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:03:11 INFO - 2015-12-17 18:03:11,792 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:03:11 INFO - 2015-12-17 18:03:11,792 DEBUG : BROWSER_OUTPUT: __metrics 18:03:11 INFO - 2015-12-17 18:03:11,921 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 18:03:12 INFO - 2015-12-17 18:03:12,941 INFO : Browser initialized. 18:03:12 INFO - 2015-12-17 18:03:12,942 INFO : Running cycle 1/1 for kraken test... 18:03:12 INFO - 2015-12-17 18:03:12,942 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjRleiK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:03:24 INFO - 2015-12-17 18:03:24,969 DEBUG : BROWSER_OUTPUT: RSS: Main: 150904832 18:03:24 INFO - 2015-12-17 18:03:24,969 DEBUG : BROWSER_OUTPUT: 18:03:27 INFO - 2015-12-17 18:03:27,550 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38690/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38690/tests/kraken/driver.html?testName=audio-beat-detection) 18:03:28 INFO - 2015-12-17 18:03:28,174 DEBUG : BROWSER_OUTPUT: RSS: Main: 151228416 18:03:28 INFO - 2015-12-17 18:03:28,174 DEBUG : BROWSER_OUTPUT: 18:03:30 INFO - 2015-12-17 18:03:30,952 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38690/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38690/tests/kraken/driver.html?testName=audio-dft) 18:03:31 INFO - 2015-12-17 18:03:31,554 DEBUG : BROWSER_OUTPUT: RSS: Main: 151085056 18:03:31 INFO - 2015-12-17 18:03:31,554 DEBUG : BROWSER_OUTPUT: 18:03:34 INFO - 2015-12-17 18:03:34,475 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38690/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38690/tests/kraken/driver.html?testName=audio-fft) 18:03:35 INFO - 2015-12-17 18:03:35,061 DEBUG : BROWSER_OUTPUT: RSS: Main: 145752064 18:03:35 INFO - 2015-12-17 18:03:35,061 DEBUG : BROWSER_OUTPUT: 18:03:37 INFO - 2015-12-17 18:03:37,117 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38690/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38690/tests/kraken/driver.html?testName=audio-oscillator) 18:03:37 INFO - 2015-12-17 18:03:37,698 DEBUG : BROWSER_OUTPUT: RSS: Main: 146161664 18:03:37 INFO - 2015-12-17 18:03:37,698 DEBUG : BROWSER_OUTPUT: 18:03:39 INFO - 2015-12-17 18:03:39,972 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38690/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38690/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:03:40 INFO - 2015-12-17 18:03:40,562 DEBUG : BROWSER_OUTPUT: RSS: Main: 147587072 18:03:40 INFO - 2015-12-17 18:03:40,562 DEBUG : BROWSER_OUTPUT: 18:03:43 INFO - 2015-12-17 18:03:43,605 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38690/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38690/tests/kraken/driver.html?testName=imaging-darkroom) 18:03:44 INFO - 2015-12-17 18:03:44,207 DEBUG : BROWSER_OUTPUT: RSS: Main: 148934656 18:03:44 INFO - 2015-12-17 18:03:44,207 DEBUG : BROWSER_OUTPUT: 18:03:47 INFO - 2015-12-17 18:03:47,690 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38690/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38690/tests/kraken/driver.html?testName=imaging-desaturate) 18:03:48 INFO - 2015-12-17 18:03:48,284 DEBUG : BROWSER_OUTPUT: RSS: Main: 146092032 18:03:48 INFO - 2015-12-17 18:03:48,284 DEBUG : BROWSER_OUTPUT: 18:03:51 INFO - 2015-12-17 18:03:51,183 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38690/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38690/tests/kraken/driver.html?testName=json-parse-financial) 18:03:51 INFO - 2015-12-17 18:03:51,784 DEBUG : BROWSER_OUTPUT: RSS: Main: 147136512 18:03:51 INFO - 2015-12-17 18:03:51,784 DEBUG : BROWSER_OUTPUT: 18:03:53 INFO - 2015-12-17 18:03:53,594 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38690/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38690/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:03:54 INFO - 2015-12-17 18:03:54,176 DEBUG : BROWSER_OUTPUT: RSS: Main: 148123648 18:03:54 INFO - 2015-12-17 18:03:54,176 DEBUG : BROWSER_OUTPUT: 18:03:56 INFO - 2015-12-17 18:03:56,053 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38690/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38690/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:03:56 INFO - 2015-12-17 18:03:56,666 DEBUG : BROWSER_OUTPUT: RSS: Main: 147718144 18:03:56 INFO - 2015-12-17 18:03:56,667 DEBUG : BROWSER_OUTPUT: 18:03:58 INFO - 2015-12-17 18:03:58,832 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38690/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38690/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:03:59 INFO - 2015-12-17 18:03:59,432 DEBUG : BROWSER_OUTPUT: RSS: Main: 147623936 18:03:59 INFO - 2015-12-17 18:03:59,432 DEBUG : BROWSER_OUTPUT: 18:04:01 INFO - 2015-12-17 18:04:01,972 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38690/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38690/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:04:02 INFO - 2015-12-17 18:04:02,565 DEBUG : BROWSER_OUTPUT: RSS: Main: 148135936 18:04:02 INFO - 2015-12-17 18:04:02,566 DEBUG : BROWSER_OUTPUT: 18:04:05 INFO - 2015-12-17 18:04:05,172 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38690/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38690/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:04:05 INFO - 2015-12-17 18:04:05,774 DEBUG : BROWSER_OUTPUT: RSS: Main: 147832832 18:04:05 INFO - 2015-12-17 18:04:05,774 DEBUG : BROWSER_OUTPUT: 18:04:07 INFO - 2015-12-17 18:04:07,524 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38690/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38690/tests/kraken/driver.html?testName=ai-astar) 18:04:07 INFO - 2015-12-17 18:04:07,775 DEBUG : BROWSER_OUTPUT: RSS: Main: 148029440 18:04:07 INFO - 2015-12-17 18:04:07,775 DEBUG : BROWSER_OUTPUT: 18:04:07 INFO - 2015-12-17 18:04:07,776 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:04:07 INFO - 2015-12-17 18:04:07,776 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:04:07 INFO - 2015-12-17 18:04:07,776 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:04:07 INFO - 2015-12-17 18:04:07,776 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:04:07 INFO - 2015-12-17 18:04:07,777 DEBUG : BROWSER_OUTPUT: |0;ai-astar;115;109;115;113;114;123;113;115;113;114 18:04:07 INFO - 2015-12-17 18:04:07,777 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;173;132;156;172;144;151;161;145;169;132 18:04:07 INFO - 2015-12-17 18:04:07,777 DEBUG : BROWSER_OUTPUT: |2;audio-dft;165;164;164;162;170;166;167;163;164;162 18:04:07 INFO - 2015-12-17 18:04:07,777 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;74;76;74;135;72;79;72;74;102 18:04:07 INFO - 2015-12-17 18:04:07,777 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;96;135;95;96;95;129;95;94;132 18:04:07 INFO - 2015-12-17 18:04:07,778 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;110;110;110;110;111;110;110 18:04:07 INFO - 2015-12-17 18:04:07,778 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;148;147;148;155;149;148;148;148;149 18:04:07 INFO - 2015-12-17 18:04:07,778 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;97;98;96;96;96;96;99;95;96 18:04:07 INFO - 2015-12-17 18:04:07,778 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;80;72;73;75;75;74;83;75;72 18:04:07 INFO - 2015-12-17 18:04:07,778 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;67;69;69;69;67;68;69;69 18:04:07 INFO - 2015-12-17 18:04:07,778 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;92;83;84;91;91;84;84;85;83 18:04:07 INFO - 2015-12-17 18:04:07,779 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;121;124;129;122;128;130;129;124;121 18:04:07 INFO - 2015-12-17 18:04:07,779 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;150;147;148;146;139;140;145;149;159 18:04:07 INFO - 2015-12-17 18:04:07,779 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;69;69;70;72;70;69;70;70;69 18:04:07 INFO - 2015-12-17 18:04:07,779 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:04:07 INFO - 2015-12-17 18:04:07,779 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:04:07 INFO - 2015-12-17 18:04:07,780 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,793 18:04:07 INFO - 2015-12-17 18:04:07,780 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:04:07 INFO - 2015-12-17 18:04:07,780 DEBUG : BROWSER_OUTPUT: __startTimestamp1450404247775__endTimestamp 18:04:07 INFO - 2015-12-17 18:04:07,780 DEBUG : BROWSER_OUTPUT: 18:04:07 INFO - 2015-12-17 18:04:07,787 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:04:07 INFO - 2015-12-17 18:04:07,787 DEBUG : BROWSER_OUTPUT: Number of tests: 14 18:04:07 INFO - 2015-12-17 18:04:07,788 DEBUG : BROWSER_OUTPUT: 18:04:07 INFO - 2015-12-17 18:04:07,788 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:114.40 Median:114.50 stddev:3.50 (3.1%) stddev-sans-first:3.71 18:04:07 INFO - 2015-12-17 18:04:07,788 DEBUG : BROWSER_OUTPUT: Values: 115.0 109.0 115.0 113.0 114.0 123.0 113.0 115.0 113.0 114.0 18:04:07 INFO - 2015-12-17 18:04:07,788 DEBUG : BROWSER_OUTPUT: 18:04:07 INFO - 2015-12-17 18:04:07,788 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:153.50 Median:158.50 stddev:15.34 (9.7%) stddev-sans-first:14.56 18:04:07 INFO - 2015-12-17 18:04:07,788 DEBUG : BROWSER_OUTPUT: Values: 173.0 132.0 156.0 172.0 144.0 151.0 161.0 145.0 169.0 132.0 18:04:07 INFO - 2015-12-17 18:04:07,788 DEBUG : BROWSER_OUTPUT: 18:04:07 INFO - 2015-12-17 18:04:07,788 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.70 Median:164.50 stddev:2.45 (1.5%) stddev-sans-first:2.60 18:04:07 INFO - 2015-12-17 18:04:07,788 DEBUG : BROWSER_OUTPUT: Values: 165.0 164.0 164.0 162.0 170.0 166.0 167.0 163.0 164.0 162.0 18:04:07 INFO - 2015-12-17 18:04:07,788 DEBUG : BROWSER_OUTPUT: 18:04:07 INFO - 2015-12-17 18:04:07,788 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:83.20 Median:74.00 stddev:20.26 (27.4%) stddev-sans-first:21.22 18:04:07 INFO - 2015-12-17 18:04:07,788 DEBUG : BROWSER_OUTPUT: Values: 74.0 74.0 76.0 74.0 135.0 72.0 79.0 72.0 74.0 102.0 18:04:07 INFO - 2015-12-17 18:04:07,788 DEBUG : BROWSER_OUTPUT: 18:04:07 INFO - 2015-12-17 18:04:07,789 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.10 Median:95.00 stddev:17.94 (18.9%) stddev-sans-first:18.49 18:04:07 INFO - 2015-12-17 18:04:07,789 DEBUG : BROWSER_OUTPUT: Values: 94.0 96.0 135.0 95.0 96.0 95.0 129.0 95.0 94.0 132.0 18:04:07 INFO - 2015-12-17 18:04:07,789 DEBUG : BROWSER_OUTPUT: 18:04:07 INFO - 2015-12-17 18:04:07,789 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 18:04:07 INFO - 2015-12-17 18:04:07,789 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 110.0 110.0 110.0 110.0 111.0 110.0 110.0 18:04:07 INFO - 2015-12-17 18:04:07,789 DEBUG : BROWSER_OUTPUT: 18:04:07 INFO - 2015-12-17 18:04:07,789 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.70 Median:148.00 stddev:2.31 (1.6%) stddev-sans-first:2.37 18:04:07 INFO - 2015-12-17 18:04:07,789 DEBUG : BROWSER_OUTPUT: Values: 147.0 148.0 147.0 148.0 155.0 149.0 148.0 148.0 148.0 149.0 18:04:07 INFO - 2015-12-17 18:04:07,789 DEBUG : BROWSER_OUTPUT: 18:04:07 INFO - 2015-12-17 18:04:07,789 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.00 stddev:1.18 (1.2%) stddev-sans-first:1.24 18:04:07 INFO - 2015-12-17 18:04:07,790 DEBUG : BROWSER_OUTPUT: Values: 96.0 97.0 98.0 96.0 96.0 96.0 96.0 99.0 95.0 96.0 18:04:07 INFO - 2015-12-17 18:04:07,790 DEBUG : BROWSER_OUTPUT: 18:04:07 INFO - 2015-12-17 18:04:07,790 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:75.20 Median:75.00 stddev:3.58 (4.8%) stddev-sans-first:3.71 18:04:07 INFO - 2015-12-17 18:04:07,790 DEBUG : BROWSER_OUTPUT: Values: 73.0 80.0 72.0 73.0 75.0 75.0 74.0 83.0 75.0 72.0 18:04:07 INFO - 2015-12-17 18:04:07,790 DEBUG : BROWSER_OUTPUT: 18:04:07 INFO - 2015-12-17 18:04:07,790 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:69.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 18:04:07 INFO - 2015-12-17 18:04:07,790 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 67.0 69.0 69.0 69.0 67.0 68.0 69.0 69.0 18:04:07 INFO - 2015-12-17 18:04:07,790 DEBUG : BROWSER_OUTPUT: 18:04:07 INFO - 2015-12-17 18:04:07,790 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:84.50 stddev:3.84 (4.5%) stddev-sans-first:3.81 18:04:07 INFO - 2015-12-17 18:04:07,790 DEBUG : BROWSER_OUTPUT: Values: 82.0 92.0 83.0 84.0 91.0 91.0 84.0 84.0 85.0 83.0 18:04:07 INFO - 2015-12-17 18:04:07,790 DEBUG : BROWSER_OUTPUT: 18:04:07 INFO - 2015-12-17 18:04:07,791 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.70 Median:126.00 stddev:4.00 (3.2%) stddev-sans-first:3.67 18:04:07 INFO - 2015-12-17 18:04:07,791 DEBUG : BROWSER_OUTPUT: Values: 119.0 121.0 124.0 129.0 122.0 128.0 130.0 129.0 124.0 121.0 18:04:07 INFO - 2015-12-17 18:04:07,791 DEBUG : BROWSER_OUTPUT: 18:04:07 INFO - 2015-12-17 18:04:07,791 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.80 Median:147.50 stddev:6.71 (4.6%) stddev-sans-first:5.87 18:04:07 INFO - 2015-12-17 18:04:07,791 DEBUG : BROWSER_OUTPUT: Values: 135.0 150.0 147.0 148.0 146.0 139.0 140.0 145.0 149.0 159.0 18:04:07 INFO - 2015-12-17 18:04:07,791 DEBUG : BROWSER_OUTPUT: 18:04:07 INFO - 2015-12-17 18:04:07,791 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:70.00 stddev:0.99 (1.4%) stddev-sans-first:0.97 18:04:07 INFO - 2015-12-17 18:04:07,791 DEBUG : BROWSER_OUTPUT: Values: 71.0 69.0 69.0 70.0 72.0 70.0 69.0 70.0 70.0 69.0 18:04:07 INFO - 2015-12-17 18:04:07,791 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:04:07 INFO - 2015-12-17 18:04:07,791 DEBUG : BROWSER_OUTPUT: 18:04:08 INFO - 2015-12-17 18:04:08,669 INFO : Browser exited with error code: 0 18:04:08 INFO - 2015-12-17 18:04:08,721 INFO : Completed test kraken (00:01:01) 18:04:08 INFO - 2015-12-17 18:04:08,721 INFO : Starting test v8_7 18:04:08 INFO - 2015-12-17 18:04:08,721 DEBUG : operating with platform_type : linux_ 18:04:08 INFO - 2015-12-17 18:04:08,721 INFO : Initialising browser for v8_7 test... 18:04:08 INFO - 2015-12-17 18:04:08,727 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT6dHpz/profile http://localhost:38690/getInfo.html 18:04:13 INFO - 2015-12-17 18:04:13,497 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:04:13 INFO - 2015-12-17 18:04:13,497 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:04:13 INFO - 2015-12-17 18:04:13,497 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:04:13 INFO - 2015-12-17 18:04:13,497 DEBUG : BROWSER_OUTPUT: __metrics 18:04:13 INFO - 2015-12-17 18:04:13,619 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 18:04:14 INFO - 2015-12-17 18:04:14,505 INFO : Browser initialized. 18:04:14 INFO - 2015-12-17 18:04:14,506 INFO : Running cycle 1/1 for v8_7 test... 18:04:14 INFO - 2015-12-17 18:04:14,506 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT6dHpz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:04:26 INFO - 2015-12-17 18:04:26,505 DEBUG : BROWSER_OUTPUT: RSS: Main: 150700032 18:04:26 INFO - 2015-12-17 18:04:26,505 DEBUG : BROWSER_OUTPUT: 18:04:47 INFO - 2015-12-17 18:04:47,944 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38690/tests/v8_7/run.html (next: http://localhost:38690/tests/v8_7/run.html) 18:04:48 INFO - 2015-12-17 18:04:48,202 DEBUG : BROWSER_OUTPUT: RSS: Main: 145448960 18:04:48 INFO - 2015-12-17 18:04:48,203 DEBUG : BROWSER_OUTPUT: 18:04:48 INFO - 2015-12-17 18:04:48,203 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:04:48 INFO - 2015-12-17 18:04:48,203 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:04:48 INFO - 2015-12-17 18:04:48,203 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:04:48 INFO - 2015-12-17 18:04:48,203 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:04:48 INFO - 2015-12-17 18:04:48,203 DEBUG : BROWSER_OUTPUT: |0;Richards;167.53224995811695 18:04:48 INFO - 2015-12-17 18:04:48,203 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.32391713747646 18:04:48 INFO - 2015-12-17 18:04:48,204 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.0850651149903 18:04:48 INFO - 2015-12-17 18:04:48,204 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5148.717948717948 18:04:48 INFO - 2015-12-17 18:04:48,204 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1088.139281828074 18:04:48 INFO - 2015-12-17 18:04:48,204 DEBUG : BROWSER_OUTPUT: |5;Earley;725.6894049346879 18:04:48 INFO - 2015-12-17 18:04:48,204 DEBUG : BROWSER_OUTPUT: |6;Boyer;12481.481481481482 18:04:48 INFO - 2015-12-17 18:04:48,204 DEBUG : BROWSER_OUTPUT: |7;RegExp;27432.432432432433 18:04:48 INFO - 2015-12-17 18:04:48,204 DEBUG : BROWSER_OUTPUT: |8;Splay;593.4001178550383 18:04:48 INFO - 2015-12-17 18:04:48,204 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 18:04:48 INFO - 2015-12-17 18:04:48,204 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:04:48 INFO - 2015-12-17 18:04:48,204 DEBUG : BROWSER_OUTPUT: __startTimestamp1450404288196__endTimestamp 18:04:48 INFO - 2015-12-17 18:04:48,205 DEBUG : BROWSER_OUTPUT: 18:04:48 INFO - 2015-12-17 18:04:48,205 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:04:48 INFO - 2015-12-17 18:04:48,205 DEBUG : BROWSER_OUTPUT: Number of tests: 10 18:04:48 INFO - 2015-12-17 18:04:48,205 DEBUG : BROWSER_OUTPUT: 18:04:48 INFO - 2015-12-17 18:04:48,205 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.53 Median:167.53 stddev:0.00 (0.0%) 18:04:48 INFO - 2015-12-17 18:04:48,205 DEBUG : BROWSER_OUTPUT: Values: 167.5 18:04:48 INFO - 2015-12-17 18:04:48,205 DEBUG : BROWSER_OUTPUT: 18:04:48 INFO - 2015-12-17 18:04:48,206 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.32 Median:188.32 stddev:0.00 (0.0%) 18:04:48 INFO - 2015-12-17 18:04:48,206 DEBUG : BROWSER_OUTPUT: Values: 188.3 18:04:48 INFO - 2015-12-17 18:04:48,206 DEBUG : BROWSER_OUTPUT: 18:04:48 INFO - 2015-12-17 18:04:48,206 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.09 Median:277.09 stddev:0.00 (0.0%) 18:04:48 INFO - 2015-12-17 18:04:48,206 DEBUG : BROWSER_OUTPUT: Values: 277.1 18:04:48 INFO - 2015-12-17 18:04:48,206 DEBUG : BROWSER_OUTPUT: 18:04:48 INFO - 2015-12-17 18:04:48,206 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5148.72 Median:5148.72 stddev:0.00 (0.0%) 18:04:48 INFO - 2015-12-17 18:04:48,207 DEBUG : BROWSER_OUTPUT: Values: 5148.7 18:04:48 INFO - 2015-12-17 18:04:48,207 DEBUG : BROWSER_OUTPUT: 18:04:48 INFO - 2015-12-17 18:04:48,207 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1088.14 Median:1088.14 stddev:0.00 (0.0%) 18:04:48 INFO - 2015-12-17 18:04:48,207 DEBUG : BROWSER_OUTPUT: Values: 1088.1 18:04:48 INFO - 2015-12-17 18:04:48,207 DEBUG : BROWSER_OUTPUT: 18:04:48 INFO - 2015-12-17 18:04:48,207 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:725.69 Median:725.69 stddev:0.00 (0.0%) 18:04:48 INFO - 2015-12-17 18:04:48,207 DEBUG : BROWSER_OUTPUT: Values: 725.7 18:04:48 INFO - 2015-12-17 18:04:48,207 DEBUG : BROWSER_OUTPUT: 18:04:48 INFO - 2015-12-17 18:04:48,208 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12481.48 Median:12481.48 stddev:0.00 (0.0%) 18:04:48 INFO - 2015-12-17 18:04:48,208 DEBUG : BROWSER_OUTPUT: Values: 12481.5 18:04:48 INFO - 2015-12-17 18:04:48,208 DEBUG : BROWSER_OUTPUT: 18:04:48 INFO - 2015-12-17 18:04:48,208 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27432.43 Median:27432.43 stddev:0.00 (0.0%) 18:04:48 INFO - 2015-12-17 18:04:48,208 DEBUG : BROWSER_OUTPUT: Values: 27432.4 18:04:48 INFO - 2015-12-17 18:04:48,208 DEBUG : BROWSER_OUTPUT: 18:04:48 INFO - 2015-12-17 18:04:48,208 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:593.40 Median:593.40 stddev:0.00 (0.0%) 18:04:48 INFO - 2015-12-17 18:04:48,209 DEBUG : BROWSER_OUTPUT: Values: 593.4 18:04:48 INFO - 2015-12-17 18:04:48,209 DEBUG : BROWSER_OUTPUT: 18:04:48 INFO - 2015-12-17 18:04:48,209 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 18:04:48 INFO - 2015-12-17 18:04:48,209 DEBUG : BROWSER_OUTPUT: Values: 4840.6 18:04:48 INFO - 2015-12-17 18:04:48,209 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:04:48 INFO - 2015-12-17 18:04:48,209 DEBUG : BROWSER_OUTPUT: 18:04:49 INFO - 2015-12-17 18:04:49,085 INFO : Browser exited with error code: 0 18:04:49 INFO - 2015-12-17 18:04:49,100 INFO : Completed test v8_7 (00:00:40) 18:04:49 INFO - 2015-12-17 18:04:49,188 INFO : Completed test suite (00:20:17) 18:04:49 INFO - 2015-12-17 18:04:49,189 DEBUG : Working with test: dromaeo_css 18:04:49 INFO - 2015-12-17 18:04:49,189 DEBUG : Generating results file: dromaeo_css 18:04:49 INFO - 2015-12-17 18:04:49,190 DEBUG : Working with test: kraken 18:04:49 INFO - 2015-12-17 18:04:49,190 DEBUG : Generating results file: kraken 18:04:49 INFO - 2015-12-17 18:04:49,190 INFO : javascript benchmark 18:04:49 INFO - 2015-12-17 18:04:49,191 DEBUG : Working with test: v8_7 18:04:49 INFO - 2015-12-17 18:04:49,191 DEBUG : Generating results file: v8_7 18:04:49 INFO - 2015-12-17 18:04:49,191 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:04:49 INFO - 2015-12-17 18:04:49,247 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 18:04:49 INFO - 2015-12-17 18:04:49,247 DEBUG : process_Request line: dromaeo_css 6286.90 graph.html#tests=[[72,132,43]] 18:04:49 INFO - 2015-12-17 18:04:49,247 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:04:49 INFO - 2015-12-17 18:04:49,279 DEBUG : process_Request line: kraken 1546.90 graph.html#tests=[[232,132,43]] 18:04:49 INFO - 2015-12-17 18:04:49,280 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:04:49 INFO - 2015-12-17 18:04:49,312 DEBUG : process_Request line: v8_7 21144.48 graph.html#tests=[[230,132,43]] 18:04:49 INFO - 2015-12-17 18:04:49,313 INFO : javascript benchmark 18:04:49 INFO - 2015-12-17 18:04:49,317 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2679.7271296134336, 2714.3756935904753, 2722.959155612666, 2751.050887443831, 2766.1286694691175, 4641.767911604415, 4725.999999999995, 4740.241561350184, 4767.046590681869, 4787.0, 4675.8363457279, 4715.78778954947, 4731.9763401182945, 4844.2733589961435, 4846.927296090562, 4425.468943726757, 4463.375127482155, 4531.932021019687, 4537.523560026183, 4541.455025396957, 4439.089986552765, 4482.551744825524, 4501.414816073906, 4516.616087632555, 4590.311453282001, 4283.121959998193, 4384.605385515287, 4409.096135292258, 4415.933760993587, 4512.232920403507, 4269.594388533115, 4396.450443694538, 4405.29515277554, 4409.853438106115, 4415.20526305265, 4340.0374158267905, 4347.043650396908, 4352.564743525654, 4369.3009118541195, 4418.204723149864, 4384.254676704968, 4609.539046095397, 4648.976755116237, 4659.930101048487, 4676.134915040729, 5125.154349532323, 5146.768395422215, 5150.330457040598, 5153.66501177426, 5163.302954101186, 5152.0, 5174.197999310113, 5175.0943584872875, 5179.482051794828, 5221.39953905302, 4552.180607490651, 4658.767061646904, 4686.320483529869, 4789.425268967746, 4833.4441539223435, 5279.208118782213, 5284.497972692588, 5298.417174110845, 5303.0, 5307.575393968474, 5077.644564880423, 5089.491050894955, 5113.207452844815, 5123.077845987758, 5123.487651234921, 4853.563179313879, 4964.3298154748645, 5008.29883816266, 5083.085044691917, 5155.097857874932, 5093.719845408464, 5131.1277082895995, 5147.073526765218, 5151.330327057533, 5190.8961820764125, 4741.431028276629, 5101.566366858859, 5108.56577190943, 5115.079285728604, 5123.538881500683, 4126.319157339006, 4177.791110444466, 4259.339802330644, 4261.488621365456, 4303.010307629263, 3724.1062145084984, 3758.3047136279874, 3763.0592351912023, 3770.2271034437877, 3775.4714339992424, 4236.6187043166265, 4342.0, 4449.933251001237, 4464.933026004613, 4495.910081798345, 5045.974770126126, 5110.1568241239775, 5150.871228219249, 5157.07172708916, 5206.947930520722, 4402.493713222956, 4422.380866678667, 4462.598366147063, 4490.663200259994, 4511.729296242236, 4344.674149438804, 4443.377927090145, 4448.288273876165, 4559.52125026874, 4577.610903073276, 4765.428148622187, 4785.042991401664, 4837.927431088537, 4870.245112007645, 4894.339264199359, 5043.117454445531, 5052.368453943257, 5061.670991385548, 5074.188129899346, 5080.339555857715, 4620.930686039645, 4739.431268247832, 4856.68431551948, 4863.392075990501, 5004.5746111579465, 5115.667481613683, 5128.897422051613, 5133.460986596354, 5136.614753893398, 5190.714510701948, 5210.635255532076, 5218.0, 5221.712805795718, 5222.112240918977, 5236.319278493924, 4736.289556566542, 4860.805567777391, 4861.295112208639, 4974.303597496281, 4983.800647974041, 5016.974915125401, 5068.873278168076, 5081.517255860687, 5085.898282034264, 5125.0, 4688.882777930579, 4911.656184067081, 4942.901141977212, 4967.7019378837385, 4974.602031837517, 4944.802207911644, 4978.4274808397495, 5013.197888337994, 5050.974745126251, 5091.261767043832, 4909.852704418873, 4935.333729946555, 4940.505949405031, 4955.231939049453, 4967.602591792575], "unit": "score", "name": "dojo.html", "value": 4693.599472546088}, {"lowerIsBetter": false, "replicates": [548.9890202195957, 549.3572520151425, 557.381306749508, 557.9721013949302, 611.2390074357426, 35093.47359789602, 35579.11052223692, 35697.46453803195, 35771.10572235692, 35930.0, 35873.82063089681, 36727.0, 36913.0, 37034.25931481369, 37061.81469092658, 7731.497452665572, 7906.960465197666, 7910.683572657087, 7915.762527124196, 7916.327112195441, 7699.461037727361, 7832.72585459509, 7840.647170877324, 7844.529328240295, 7851.136374998746, 4670.392848929651, 4872.853814385574, 4948.50514948504, 4957.058158949788, 5237.764300606463, 7760.961195194044, 7812.843743125134, 7823.608819559056, 7825.491343062711, 7872.055353357577, 7674.731384401575, 7803.219678032208, 7807.102183248886, 7808.336291415179, 7816.687332506693, 33553.83223083893, 34002.0, 34104.14739631504, 34115.31769364623, 34136.0, 2810.4941110600084, 2870.7559857411934, 2991.790574659775, 3429.3655673700196, 3514.894553163409, 27495.175144745688, 27653.585196221873, 27754.722452775415, 27768.444631107468, 28469.57295640567, 3406.0633325835347, 3527.6472352764517, 3546.847026059275, 3562.3231585998838, 3592.1558433768046, 216895.0, 218748.0, 219064.0, 219123.0, 219132.9999999984, 51917.48082519202, 53120.734396327774, 56289.7185514078, 61630.38369616246, 63148.0, 54061.72969135129, 54226.72886635541, 54389.0, 54522.72738636361, 54850.72574637101, 13357.13178643385, 13518.59444216675, 13527.52653657137, 13533.864661353457, 13543.322833858268, 9811.509424528746, 9871.40771553709, 9963.25275604318, 9981.301308908307, 10012.799744005224, 19350.516237094187, 19687.606247874963, 19738.60522789536, 19802.0, 19821.30625428103, 7816.0, 7893.250141236574, 7924.286814186751, 7933.841323173504, 8043.058901138517, 906.7461110888962, 926.4487629860222, 978.6330126202674, 988.1107003696587, 1008.2538921198407, 29940.850295748383, 30263.848680756455, 30293.848530757205, 30768.0, 31004.53493197604, 985.3102828020415, 1050.4432650695144, 1087.5704096881686, 1099.5821587796586, 1108.6895669212633, 13397.263150526815, 13492.460301587827, 13654.86345136536, 13779.517716879862, 15276.159811210267, 312541.0, 312755.0, 314259.0, 316429.0, 317224.0, 47686.76156619264, 47909.28136077962, 48038.759806200746, 48063.519364806605, 48515.272270915964, 1244.7697176022464, 1252.3049707412292, 1261.1172179474404, 1264.4562837979756, 1265.9936700316623, 27287.317817054733, 27512.174634760988, 27571.31071723223, 27814.0, 28529.572056419587, 38739.0, 39212.41181382225, 39410.80294598509, 39451.80274098726, 39499.40750888681, 241795.0, 242618.0, 243204.0, 243353.0, 243616.0, 28809.279768005967, 42133.15733685371, 42594.740525947156, 43026.569734302255, 43244.351334730636, 44825.55174448344, 45814.0, 46023.53976460193, 46263.0, 46431.76784116193, 31796.414020356504, 31824.04527864168, 32395.35209295848, 32905.50641740328, 33072.66927330696, 31834.52248216325, 32153.678463215067, 32428.513572296906, 32748.345033099682, 32885.342293153524, 32074.518882217253, 32131.0, 32440.51339229866, 32698.673013270516, 32748.508772367957, 27513.44973100487, 28578.714212857605, 29439.0, 29539.26151846135, 29540.261493462836, 22756.20353287693, 22771.65842512397, 22807.0, 22920.083196671945, 23026.654600180675], "unit": "score", "name": "ext.html", "value": 16964.359062108506}, {"lowerIsBetter": false, "replicates": [323.8866396761133, 324.3383497664764, 325.68789230587026, 327.4613261185349, 339.80970656432413, 14649.04781189222, 15016.474423395184, 15336.616584585405, 15890.84109158908, 16433.26050327735, 14307.642308942282, 14327.068740531884, 14333.641658958531, 14417.476941535242, 14543.418263269457, 4442.31144172653, 4673.976630116845, 4955.281484184791, 4979.352684151074, 4992.750362481879, 4965.379327584052, 4986.10250154972, 4988.251762235657, 4994.950050499485, 5003.949960500403, 4758.595519380857, 4855.0, 4920.335754673127, 4929.33453983713, 4929.507049295078, 4832.301534024543, 4891.657583969123, 4903.68126071806, 4912.459629440758, 4932.457429682732, 4684.297355396684, 5080.491950804927, 5095.515925987025, 5096.159133742928, 5102.158143906251, 11264.155188360906, 11437.370944598044, 13009.544665936646, 19140.904295478573, 19190.61618767617, 1723.1814887928258, 1821.1349608935782, 1826.4611939477886, 1850.195165103171, 1871.0831692470592, 8950.910490895138, 9142.497162656051, 11978.880211197864, 12543.121981461301, 12648.873511264861, 1760.4718584424622, 1788.320438233476, 1791.668541319847, 1817.6728188925988, 1833.734108554252, 54392.456075439135, 56720.0, 57300.426995729926, 57324.71337643327, 57658.423415765305, 9248.16766491019, 9368.67209647659, 9422.246220302359, 9461.810763784686, 9480.431174129575, 11890.76218475643, 11899.286042837457, 11913.10651701126, 11913.58302459427, 11915.88084119165, 6727.529072964846, 6897.241303456616, 6936.4797640177185, 7055.9294407056295, 7209.531380460253, 6308.463780578611, 6506.41442270198, 6522.869542609216, 6539.313372095957, 6549.541532092708, 3787.3561494545993, 3835.0987517933263, 4010.0776821331256, 4013.0569316210667, 4097.815598298083, 1657.917104144788, 1660.3856573068042, 1706.1980868991554, 1711.7860267466567, 1745.0576688588274, 735.7719107076823, 805.9476134051268, 859.9011113721876, 865.718641441534, 948.4688574398359, 15247.161406122548, 15619.453319133776, 15693.0, 15893.364265429253, 16246.350145994027, 844.0, 844.4004756622867, 847.3094428041127, 902.6569903436653, 921.0973246218743, 8895.555222238992, 9309.0, 9531.666391676257, 9630.27772917034, 9902.405855648683, 450559.0, 457717.0, 465118.0, 469753.0, 470932.0, 72685.0, 73403.0, 77268.22731772723, 78103.60948195223, 78306.0, 1033.5917312661607, 1077.8706555213425, 1078.4284329305324, 1087.2063393722626, 1088.3361149698678, 13582.185068895898, 14400.279986000867, 14595.0, 14614.196219208046, 14731.779023314873, 29452.852735736185, 30242.84878575593, 30656.386872261985, 30952.380952381278, 34417.48373774446, 42665.14669706526, 42963.0, 43186.56813431951, 43679.56320436755, 44518.55481445144, 8823.514706691194, 9006.0, 9032.954835225783, 9151.86272205904, 9181.678641247525, 10512.842307365243, 10599.417032063002, 10635.468226588795, 16626.418075367303, 16740.49778506647, 11039.944800275947, 11652.475638596454, 13352.599422017354, 13646.795298070338, 14089.859101408854, 13409.396577153857, 13505.12216705911, 13755.0, 13843.584692459242, 13982.230977296347, 13997.790033149307, 14231.146131232159, 14446.927765361106, 14506.85493145055, 14536.345864435914, 8969.820603588023, 8972.685955991508, 8975.0, 9126.224270937044, 9138.908610913806, 9492.715218543455, 13935.372908218951, 14248.35882385316, 14319.212443315717, 14320.283985800877], "unit": "score", "name": "jquery.html", "value": 8143.252191418252}, {"lowerIsBetter": false, "replicates": [1492.0, 1580.462642701482, 1587.618971446853, 1603.6391811842336, 1688.9408870689529, 6155.353687862777, 6269.247690277173, 7132.500724949249, 7283.890741638873, 7327.12074551054, 6582.440492558127, 6717.563358381702, 6736.461083113351, 6783.525153239275, 6827.863442731143, 1985.3051431998756, 2012.30575451469, 2018.2734215682342, 2018.828399586037, 2024.807643273894, 1985.6028794241138, 1995.630808300469, 2008.036142651528, 2033.3899830051, 2035.389383185046, 2022.2820898581012, 2023.9392818215404, 2054.640437923365, 2058.742657167854, 2072.0882811562938, 2058.9485262868475, 2080.781517940617, 2082.073477302601, 2083.4062292246635, 2092.23633373819, 2001.0, 2023.7571491420977, 2069.6688529835155, 2079.812816846476, 2079.854410191287, 6961.895571566431, 7123.643817809088, 7131.251218622022, 7135.5361901476235, 7142.2857714228685, 3933.3903244997073, 4007.9599204007877, 4024.3762216856435, 4024.577419370953, 4038.575949525287, 2549.8087643426816, 2624.2520881548667, 2627.5795872660283, 2635.262126604554, 2636.709961904189, 869.8173383589453, 873.6505397840851, 879.2482427524438, 890.9955450222773, 897.7755561109723, 9446.149846513777, 9467.857982130274, 9505.287103467268, 9519.524023798782, 9524.095210954949, 3682.7237957152784, 3724.2923844469465, 3725.515682961198, 3736.8878933632036, 3760.7555508891833, 8112.716054938167, 8138.186181381814, 8147.877781833158, 8164.306033987059, 8187.590620468953, 4091.181763647223, 4092.7544347339253, 4095.28332541804, 4102.856400025985, 4131.669466442678, 3239.61124665037, 3313.3042061166943, 3654.6710796028483, 3747.9812600937366, 3754.249150169977, 3379.5944486661265, 3403.489476578533, 3418.0, 3428.674275943781, 3434.175797808508, 1052.936823790575, 1063.1494804156644, 1074.8495210670512, 1075.9569617215225, 1080.103514083309, 1136.2784631758727, 1158.3223814068865, 1161.6573110932295, 1182.674764439786, 1216.5437960764714, 6630.469562434993, 6658.334166583303, 6677.265500794909, 6681.699323530453, 6684.1978962523835, 1035.9585616575253, 1043.8173319669027, 1047.2459828923163, 1055.4036969112426, 1068.5298468673914, 5280.128778751539, 5340.49265319794, 5342.946570534323, 5352.143657014859, 5359.276497672764, 8137.186281371815, 8267.214614611603, 8418.705345312885, 8452.957735211285, 8456.661733530713, 8199.590020498952, 8257.21556452136, 8274.669013239523, 8353.540555269397, 8406.831863362699, 6471.417572418505, 6594.307597702268, 6598.505112116514, 6650.3682150195655, 6682.131322927989, 6399.840003999937, 6405.071264666691, 6468.15913931186, 6480.189976252968, 6513.511486638616, 7250.456215783943, 7337.889931650922, 7452.180260171268, 7452.403807695479, 7520.323170914644, 7378.262173782578, 7538.359239464707, 7596.050493688289, 7624.771256862303, 7698.307152356315, 5109.616778741683, 5467.562594992471, 5621.297337832771, 5880.088586269135, 5940.79207227745, 6460.998545225498, 6497.220333559814, 6514.478841692748, 6521.087047813405, 6526.412622863775, 6297.937020629735, 6433.5496515243485, 6548.116004339353, 6563.9343606565235, 6607.47140228771, 6274.372562743872, 6282.717277722422, 6299.779507717208, 6393.968030159819, 6482.481401487776, 6200.689965501617, 6230.937690623035, 6273.62358258506, 6300.369963003663, 6300.684965751786, 5868.823935281948, 5888.057910734433, 5911.261092363455, 5948.315943666534, 5975.701214939322, 5937.406259374028, 5978.970105149447, 5982.611130276518, 5983.34183239852, 5985.790497332572], "unit": "score", "name": "mootools.html", "value": 4031.092913754127}, {"lowerIsBetter": false, "replicates": [288.4490622910242, 294.06194240373196, 300.22691569209286, 300.60020173169676, 303.0650443382166, 5514.283143191385, 5560.499555040045, 5588.189712491691, 5624.0, 5689.260396148506, 5531.944680553193, 5549.556035517159, 5598.356189038262, 5602.719864006804, 5607.299087614048, 4158.313878210107, 4296.226679197735, 4305.418768466248, 4307.181635489247, 4309.482862056542, 4220.430241917348, 4264.402983582301, 4274.0, 4276.508201556814, 4277.657787377002, 4236.0, 4246.895807090148, 4248.490181178263, 4248.87253382399, 4249.787510624472, 4234.618884300412, 4235.7246778959425, 4239.59723826236, 4253.02180498484, 4263.722858014219, 3687.1888184599347, 3692.132348898007, 3693.0582701411236, 3694.7228957828, 3699.815009249554, 5181.715005674687, 5215.843524694227, 5347.893042139174, 5349.759260833272, 5357.544608708265, 4842.903141937177, 4857.902841943177, 4875.878103047452, 4876.487968763265, 4878.5365390288225, 5835.416458354173, 5846.853828654275, 5850.414958504116, 5853.707314634251, 5862.560307976919, 3875.8449662013486, 3940.4680368150507, 3992.7205095643317, 3997.38040603704, 4005.539362973266, 5998.520118390518, 6137.11011903276, 6140.846478837975, 6144.692765361714, 6146.907796383058, 4103.9179216415505, 4113.732607380511, 4122.56713045126, 4125.360569111793, 4129.483814523184, 4157.792110394468, 4159.8960025999595, 4174.958250417518, 4178.707490475698, 4185.142045880587, 4725.362076119749, 4803.519648035169, 4807.254875494304, 4822.855314340575, 4825.059113472909, 5780.826575202751, 5803.303603567599, 5811.535077193815, 5814.651120932757, 5816.912746308809, 1450.6445920749484, 1468.6475245940896, 1468.9632759181106, 1469.5003698742264, 1469.6987117640858, 980.8921018687938, 981.7790997025755, 983.4001259231862, 997.0129571724086, 1003.9598416063421, 5049.722265275372, 5050.0, 5057.468965758616, 5061.974690126526, 5065.848024559269, 6053.303870054912, 6058.4244496772735, 6065.0, 6070.0591408331775, 6086.786962456381, 5042.168042273057, 5052.7726252318735, 5054.469280725544, 5064.11378008847, 5072.036313100499, 3198.520221966677, 3258.0714496368423, 3271.8854840080485, 3282.8030318180986, 3291.6050073991273, 5636.549076073904, 5684.261046063985, 5696.6582005079, 5699.202111704365, 5706.42935706426, 6314.084457753692, 6326.588771729823, 6343.302236753953, 6344.936550634527, 6347.492200623939, 5759.654420734685, 5768.855778605568, 5771.336296325976, 5783.103618939072, 5790.27621547315, 6143.631382117087, 6148.077788331786, 6148.47737942262, 6157.96921015392, 6163.9383606163365, 5816.127580862735, 5942.435468630473, 5989.490893274121, 5996.430339117776, 6024.939750602438, 5750.022496175744, 5750.712464376681, 5757.165211044291, 5785.363610002981, 5790.855228619318, 4122.464079669624, 4170.061736109473, 4171.958280417157, 4172.102997855475, 4181.560936101666, 5990.460858522754, 6107.572469927062, 6119.388061193845, 6120.969395152996, 6125.356837532173, 5866.6480011199465, 5876.324222714443, 5877.588568800143, 5887.264091988502, 5888.528917686661, 5833.649981001154, 5855.0, 5864.648121112747, 5874.823755287348, 5877.617954832922, 5616.85957851057, 5706.0, 5736.110902810071, 5747.396523365153, 5765.625234359753, 5861.120831875082, 5912.497437717842, 5920.141579471038, 5932.080527518242, 5933.139694744152, 5738.971305143447, 5745.166950792195, 5755.7122143893475, 5766.769329226784, 5773.653580785166], "unit": "score", "name": "prototype.html", "value": 4363.320673463722}, {"lowerIsBetter": false, "replicates": [701.9929800701991, 718.5293632670599, 718.7843646905928, 733.3912852332564, 733.7651951375559, 10637.095846853026, 10652.946735266323, 10684.358938463678, 10717.410542420173, 10772.030517253446, 11389.202755807097, 11642.883571164286, 11692.181547291693, 11732.589359372403, 11773.058155347573, 772.5982489105662, 778.3189709004621, 793.1473665809249, 806.4677312973439, 809.4576633655436, 744.7914583916512, 749.9175090740014, 756.5460723565844, 759.4987308376473, 762.222533016323, 826.7230477789948, 830.2237408023487, 835.3108685334593, 835.3567752830317, 842.2840585502336, 817.8159914019298, 822.9465084769531, 824.3940703582862, 825.5129473610568, 829.0797215091244, 618.3445547719386, 618.4248648756654, 618.5299172628789, 618.7184830901929, 619.9659018753966, 10622.57509699611, 10642.521086551124, 10682.839757403644, 10685.83971240432, 10711.83932241017, 10063.849042264372, 10198.0, 10429.426381549012, 10627.096696780784, 10892.346459212393, 8975.865362019575, 9085.863712044325, 9197.21823644991, 9280.30397720167, 9315.906840931639, 3145.7326127279207, 3148.7481001520055, 3243.351329734039, 3256.8697252109887, 3280.2127489402374, 36724.44913326302, 37050.814745926094, 37093.81453092717, 37183.99999999973, 37187.0, 8531.488110713377, 8532.488050716976, 8587.355948303903, 8702.260307873776, 8808.5595720215, 15368.308426120851, 15371.077735335915, 15380.230988450532, 15404.92297538505, 15434.305456254495, 6034.879302414015, 6043.939560604338, 6117.694115294217, 6149.877002459926, 6152.723127459275, 3424.811635360079, 3460.3425349183576, 3489.5289135966827, 3520.6831385175456, 3579.329570143172, 2501.9249422517355, 2505.649209110726, 2538.6445897574354, 2543.3895864992637, 2545.185540627019, 436.32587652077615, 441.39969641287826, 447.44293354773515, 448.9797959091849, 460.73968207962395, 415.29607315600373, 468.2274247491666, 484.63167992326083, 541.5099335101739, 544.2299146707444, 6676.399124078856, 6828.385445309946, 7083.574985500783, 7244.311790379906, 7698.42261830365, 458.7797857028645, 524.2477045439806, 544.1375419959329, 575.2090875046811, 579.5421616922669, 3143.222302100794, 3205.9198520037185, 3378.239896023375, 3412.3175364927115, 3464.7401444891734, 45608.3158752619, 47620.5237947623, 48066.0, 48256.5174348259, 48566.757166213945, 38298.0, 38426.42360364597, 38826.0, 40236.39645405321, 42304.365434518506, 37953.62046379501, 38872.0, 39075.60924390776, 39247.215055698725, 39444.40833387501, 7202.639868006683, 7266.055412796302, 7270.527415717961, 7280.526765760209, 7295.270472952874, 29102.126936191948, 29687.10938671843, 30313.393732125674, 30319.545206822357, 30704.692953070182, 35522.28955420929, 37158.8142059288, 37692.24615507729, 37869.81065094657, 37881.62118378891, 9385.718428447157, 9409.811803763749, 9551.522423878918, 9679.0, 9754.219662427131, 10420.739481513023, 10490.632827850988, 10590.258681892194, 10688.0, 10688.572457101629, 10146.086852183338, 10158.441285729356, 10181.440020798927, 10223.0, 10225.437600931722, 9486.33595648298, 9990.200783937413, 10137.594496220363, 10149.289549731448, 10153.54309056109, 9497.810043799223, 10044.0, 10162.39025658463, 10170.949145254523, 10248.38509689421, 8557.400981931454, 8677.913220867711, 8751.64993400257, 8867.866981995405, 8919.598618062073, 8250.628721707657, 8330.458520196167, 8444.930991907022, 8583.527905965231, 8799.91200087991], "unit": "score", "name": "yui.html", "value": 5413.677167778447}], "name": "dromaeo_css", "value": 6286.897128728293}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 109.0, 115.0, 113.0, 114.0, 123.0, 113.0, 115.0, 113.0, 114.0], "unit": "score", "name": "ai-astar", "value": 114.4}, {"lowerIsBetter": true, "replicates": [173.0, 132.0, 156.0, 172.0, 144.0, 151.0, 161.0, 145.0, 169.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 153.5}, {"lowerIsBetter": true, "replicates": [165.0, 164.0, 164.0, 162.0, 170.0, 166.0, 167.0, 163.0, 164.0, 162.0], "unit": "score", "name": "audio-dft", "value": 164.7}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 76.0, 74.0, 135.0, 72.0, 79.0, 72.0, 74.0, 102.0], "unit": "score", "name": "audio-fft", "value": 83.2}, {"lowerIsBetter": true, "replicates": [94.0, 96.0, 135.0, 95.0, 96.0, 95.0, 129.0, 95.0, 94.0, 132.0], "unit": "score", "name": "audio-oscillator", "value": 106.1}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 147.0, 148.0, 155.0, 149.0, 148.0, 148.0, 148.0, 149.0], "unit": "score", "name": "imaging-darkroom", "value": 148.7}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 98.0, 96.0, 96.0, 96.0, 96.0, 99.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [73.0, 80.0, 72.0, 73.0, 75.0, 75.0, 74.0, 83.0, 75.0, 72.0], "unit": "score", "name": "json-parse-financial", "value": 75.2}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 67.0, 69.0, 69.0, 69.0, 67.0, 68.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [82.0, 92.0, 83.0, 84.0, 91.0, 91.0, 84.0, 84.0, 85.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.9}, {"lowerIsBetter": true, "replicates": [119.0, 121.0, 124.0, 129.0, 122.0, 128.0, 130.0, 129.0, 124.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.7}, {"lowerIsBetter": true, "replicates": [135.0, 150.0, 147.0, 148.0, 146.0, 139.0, 140.0, 145.0, 149.0, 159.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.8}, {"lowerIsBetter": true, "replicates": [71.0, 69.0, 69.0, 70.0, 72.0, 70.0, 69.0, 70.0, 70.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.9}], "name": "kraken", "value": 1546.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.53224995811695], "unit": "score", "name": "Richards", "value": 210.71763800000005}, {"lowerIsBetter": false, "replicates": [188.32391713747646], "unit": "score", "name": "DeltaBlue", "value": 351.08658000000014}, {"lowerIsBetter": false, "replicates": [277.0850651149903], "unit": "score", "name": "Encrypt", "value": 960.647229}, {"lowerIsBetter": false, "replicates": [5148.717948717948], "unit": "score", "name": "Decrypt", "value": 51.69850099601596}, {"lowerIsBetter": false, "replicates": [1088.139281828074], "unit": "score", "name": "RayTrace", "value": 680.0498910000001}, {"lowerIsBetter": false, "replicates": [725.6894049346879], "unit": "score", "name": "Earley", "value": 918.3860139999999}, {"lowerIsBetter": false, "replicates": [12481.481481481482], "unit": "score", "name": "Boyer", "value": 53.39614540059344}, {"lowerIsBetter": false, "replicates": [27432.432432432433], "unit": "score", "name": "RegExp", "value": 33.208320197044344}, {"lowerIsBetter": false, "replicates": [593.4001178550383], "unit": "score", "name": "Splay", "value": 137.32892452830194}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 21144.480107709736}]} 18:04:49 INFO - RETURN: dromaeo_css: 6286.90 18:04:49 INFO - RETURN: kraken: 1546.90 18:04:49 INFO - RETURN: v8_7: 21144.48 18:04:49 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21144.48"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1546.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6286.90"}}} 18:04:49 INFO - Return code: 0 18:04:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:04:49 INFO - # TBPL SUCCESS # 18:04:49 INFO - Running post-action listener: _resource_record_post_action 18:04:49 INFO - Running post-run listener: _resource_record_post_run 18:04:50 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 4096; Write bytes: 543121408; Read time: 16; Write time: 380804 18:04:50 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 227704832; Read time: 0; Write time: 212856 18:04:50 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 4096; Write bytes: 315416576; Read time: 16; Write time: 167948 18:04:50 INFO - Running post-run listener: _upload_blobber_files 18:04:50 INFO - Blob upload gear active. 18:04:50 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 18:04:50 INFO - Copying logs to upload dir... 18:04:50 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1274.927104 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2015-12-17 18:04:50.202210) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 18:04:50.205843) ========= 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=3cd289541638898829117e0a000001bd-1450402760.304205-685097297 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010056 build_url: 'https://queue.taskcluster.net/v1/task/fFBFG5OxR1qMaFYQcn2dLw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 18:04:50.256893) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 18:04:50.257207) ========= 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=3cd289541638898829117e0a000001bd-1450402760.304205-685097297 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004493 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 18:04:50.307174) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 18:04:50.307493) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 18:04:50.307807) ========= ========= Total master_lag: 0.28 =========