builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-005 starttime: 1475219888.12 results: success (0) buildid: 20160930001723 builduid: d18b2d10e32542ec902049f2341d094f revision: f6a964152400fa1e5340e9909615ac938610f931 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-30 00:18:08.116938) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-30 00:18:08.118220) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-30 00:18:08.119331) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-30 00:18:08.159763) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 00:18:08.160326) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1475210871.443077-1444644456 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-30 00:18:08-- 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% 221M=0s 2016-09-30 00:18:08 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.074078 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 00:18:08.254249) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 00:18:08.254581) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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=7fc86f70bae03e018da0b1d8000001c4-1475210871.443077-1444644456 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018788 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 00:18:08.307501) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 00:18:08.308281) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f6a964152400fa1e5340e9909615ac938610f931 --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 f6a964152400fa1e5340e9909615ac938610f931 --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=7fc86f70bae03e018da0b1d8000001c4-1475210871.443077-1444644456 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-30 00:18:09,034 truncating revision to first 12 chars 2016-09-30 00:18:09,034 Setting DEBUG logging. 2016-09-30 00:18:09,034 attempt 1/10 2016-09-30 00:18:09,034 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f6a964152400?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-30 00:18:09,357 unpacking tar archive at: fx-team-f6a964152400/testing/mozharness/ program finished with exit code 0 elapsedTime=0.648268 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 00:18:08.974303) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-30 00:18:08.974637) ========= script_repo_revision: f6a964152400fa1e5340e9909615ac938610f931 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-30 00:18:08.975096) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-30 00:18:08.975398) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-30 00:18:08.985422) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-09-30 00:18:08.985764) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=7fc86f70bae03e018da0b1d8000001c4-1475210871.443077-1444644456 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:18:09 INFO - MultiFileLogger online at 20160930 00:18:09 in /builds/slave/test 00:18:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 00:18:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:18:09 INFO - {'append_to_log': False, 00:18:09 INFO - 'base_work_dir': '/builds/slave/test', 00:18:09 INFO - 'blob_upload_branch': 'Fx-Team', 00:18:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:18:09 INFO - 'branch': 'Fx-Team', 00:18:09 INFO - 'buildbot_json_path': 'buildprops.json', 00:18:09 INFO - 'config_files': ('talos/linux_config.py',), 00:18:09 INFO - 'default_actions': ('clobber', 00:18:09 INFO - 'read-buildbot-config', 00:18:09 INFO - 'download-and-extract', 00:18:09 INFO - 'populate-webroot', 00:18:09 INFO - 'create-virtualenv', 00:18:09 INFO - 'install', 00:18:09 INFO - 'run-tests'), 00:18:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:18:09 INFO - 'download_minidump_stackwalk': True, 00:18:09 INFO - 'download_symbols': 'ondemand', 00:18:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:18:09 INFO - 'tooltool.py': '/tools/tooltool.py', 00:18:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:18:09 INFO - '/tools/misc-python/virtualenv.py')}, 00:18:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:18:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:18:09 INFO - 'installer_path': 'installer.exe', 00:18:09 INFO - 'log_level': 'info', 00:18:09 INFO - 'log_name': 'talos', 00:18:09 INFO - 'log_to_console': True, 00:18:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:18:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:18:09 INFO - 'opt_config_files': (), 00:18:09 INFO - 'pip_index': False, 00:18:09 INFO - 'sps_profile': False, 00:18:09 INFO - 'sps_profile_interval': 0, 00:18:09 INFO - 'suite': 'dromaeojs', 00:18:09 INFO - 'system_bits': '32', 00:18:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:18:09 INFO - 'title': 'talos-linux64-ix-005', 00:18:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:18:09 INFO - 'use_talos_json': True, 00:18:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:18:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:18:09 INFO - 'work_dir': 'build'} 00:18:09 INFO - [mozharness: 2016-09-30 07:18:09.806553Z] Running clobber step. 00:18:09 INFO - Running pre-action listener: _resource_record_pre_action 00:18:09 INFO - Running main action method: clobber 00:18:09 INFO - rmtree: /builds/slave/test/build 00:18:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:18:10 INFO - Running post-action listener: _resource_record_post_action 00:18:10 INFO - [mozharness: 2016-09-30 07:18:10.266092Z] Finished clobber step (success) 00:18:10 INFO - [mozharness: 2016-09-30 07:18:10.266193Z] Running read-buildbot-config step. 00:18:10 INFO - Running pre-action listener: _resource_record_pre_action 00:18:10 INFO - Running main action method: read_buildbot_config 00:18:10 INFO - Using buildbot properties: 00:18:10 INFO - { 00:18:10 INFO - "project": "", 00:18:10 INFO - "product": "firefox", 00:18:10 INFO - "script_repo_revision": "production", 00:18:10 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 00:18:10 INFO - "repository": "", 00:18:10 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 00:18:10 INFO - "buildid": "20160930001723", 00:18:10 INFO - "stage_platform": "linux64-pgo", 00:18:10 INFO - "basedir": "/builds/slave/test", 00:18:10 INFO - "buildnumber": 1097, 00:18:10 INFO - "platform": "ubuntu64_hw", 00:18:10 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 00:18:10 INFO - "slavebuilddir": "test", 00:18:10 INFO - "branch": "fx-team", 00:18:10 INFO - "revision": "f6a964152400fa1e5340e9909615ac938610f931", 00:18:10 INFO - "slavename": "talos-linux64-ix-005", 00:18:10 INFO - "builduid": "d18b2d10e32542ec902049f2341d094f", 00:18:10 INFO - "repo_path": "integration/fx-team" 00:18:10 INFO - } 00:18:10 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475209894/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 00:18:10 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475209894/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 00:18:10 INFO - Running post-action listener: _resource_record_post_action 00:18:10 INFO - [mozharness: 2016-09-30 07:18:10.268561Z] Finished read-buildbot-config step (success) 00:18:10 INFO - [mozharness: 2016-09-30 07:18:10.268651Z] Running download-and-extract step. 00:18:10 INFO - Running pre-action listener: _resource_record_pre_action 00:18:10 INFO - Running main action method: download_and_extract 00:18:10 INFO - mkdir: /builds/slave/test/build/tests 00:18: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:18:10 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475209894/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 00:18:10 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475209894/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 00:18:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475209894/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 00:18:10 INFO - Downloaded 1361 bytes. 00:18:10 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 00:18:10 INFO - Using the following test package requirements: 00:18:10 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 00:18:10 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:18:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:18:10 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:18:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:18:10 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:18:10 INFO - u'jsshell-linux-x86_64.zip'], 00:18:10 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:18:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:18:10 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 00:18:10 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:18:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:18:10 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:18:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:18:10 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:18:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:18:10 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:18:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:18:10 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:18:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475209894/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 00:18:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475209894/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:18:10 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475209894/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 00:18:10 INFO - Http code: 200 00:18:10 INFO - Content-Encoding: None 00:18:10 INFO - Content-Type: application/zip 00:18:10 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 00:18:10 INFO - x-amz-cf-id: 7mU0j2p75rKD0VqiyH7EExntjoRa1ObJhHUjG8jF81iz6YQ-8__8vQ== 00:18:10 INFO - x-amz-version-id: ugXCdmpoMcWwq6GBM1f0.DXPMQKUN3TT 00:18:10 INFO - x-cache: Hit from cloudfront 00:18:10 INFO - Expected file size: 21989273 00:18:10 INFO - Obtained file size: 21989273 00:18:14 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 00:18:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475209894/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 00:18:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475209894/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:18:14 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475209894/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 00:18:14 INFO - Http code: 200 00:18:14 INFO - Content-Encoding: None 00:18:14 INFO - Content-Type: application/zip 00:18:14 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 00:18:14 INFO - x-amz-cf-id: tl_wvO-2-02sfTzbDQwBA8WMjiukSGYaUgSM9_zND3cr6nedoRxyoA== 00:18:14 INFO - x-amz-version-id: ugXCdmpoMcWwq6GBM1f0.DXPMQKUN3TT 00:18:14 INFO - x-cache: Hit from cloudfront 00:18:15 INFO - Expected file size: 21989273 00:18:15 INFO - Obtained file size: 21989273 00:18:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475209894/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 00:18:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475209894/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 00:18:19 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475209894/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 00:18:19 INFO - Http code: 200 00:18:19 INFO - Content-Encoding: None 00:18:19 INFO - Content-Type: application/zip 00:18:19 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 00:18:19 INFO - x-amz-cf-id: kcrFohRKTP4fyOHk_E45X-3qLVWl1iE8eWfVFNwzdCVTAGFf1xzCvA== 00:18:19 INFO - x-amz-version-id: uVQ6VzMJQ0tNv4NBsph5U8SY1lgdiDVx 00:18:19 INFO - x-cache: Hit from cloudfront 00:18:20 INFO - Expected file size: 14414067 00:18:20 INFO - Obtained file size: 14414067 00:18:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:18:20 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475209894/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 00:18:20 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475209894/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 00:18:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475209894/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 00:18:21 INFO - Downloaded 59677997 bytes. 00:18:21 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475209894/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 00:18:21 INFO - mkdir: /builds/slave/test/properties 00:18:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:18:21 INFO - Writing to file /builds/slave/test/properties/build_url 00:18:21 INFO - Contents: 00:18:21 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475209894/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 00:18:22 INFO - Running post-action listener: _resource_record_post_action 00:18:22 INFO - Running post-action listener: set_extra_try_arguments 00:18:22 INFO - [mozharness: 2016-09-30 07:18:22.160053Z] Finished download-and-extract step (success) 00:18:22 INFO - [mozharness: 2016-09-30 07:18:22.160281Z] Running populate-webroot step. 00:18:22 INFO - Running pre-action listener: _resource_record_pre_action 00:18:22 INFO - Running main action method: populate_webroot 00:18:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:18:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:18:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:18:22 INFO - '--tppagecycles', 00:18:22 INFO - '7'], 00:18:22 INFO - 'tests': ['tsvgm']}}, 00:18:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:18:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:18:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:18:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:18:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:18:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:18:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:18:22 INFO - 'talos_options': ['--disable-e10s'], 00:18:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:18:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:18:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:18:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:18:22 INFO - 'talos_options': ['--disable-e10s'], 00:18:22 INFO - 'tests': ['damp', 'tps']}, 00:18:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:18:22 INFO - 'tests': ['damp', 'tps']}, 00:18:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:18:22 INFO - 'tests': ['dromaeo_dom']}, 00:18:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:18:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:18:22 INFO - 'tests': ['basic_compositor_video']}, 00:18:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:18:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:18:22 INFO - 'tests': ['a11yr', 00:18:22 INFO - 'ts_paint', 00:18:22 INFO - 'tpaint', 00:18:22 INFO - 'sessionrestore', 00:18:22 INFO - 'sessionrestore_no_auto_restore', 00:18:22 INFO - 'tabpaint']}, 00:18:22 INFO - 'other-e10s': {'tests': ['a11yr', 00:18:22 INFO - 'ts_paint', 00:18:22 INFO - 'tpaint', 00:18:22 INFO - 'sessionrestore', 00:18:22 INFO - 'sessionrestore_no_auto_restore', 00:18:22 INFO - 'tabpaint']}, 00:18:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:18:22 INFO - 'ts_paint', 00:18:22 INFO - 'tpaint', 00:18:22 INFO - 'sessionrestore', 00:18:22 INFO - 'sessionrestore_no_auto_restore', 00:18:22 INFO - 'tabpaint']}, 00:18:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:18:22 INFO - 'ts_paint', 00:18:22 INFO - 'tpaint', 00:18:22 INFO - 'sessionrestore', 00:18:22 INFO - 'sessionrestore_no_auto_restore', 00:18:22 INFO - 'tabpaint']}, 00:18:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:18:22 INFO - 'tests': ['a11yr', 00:18:22 INFO - 'ts_paint', 00:18:22 INFO - 'tpaint', 00:18:22 INFO - 'sessionrestore', 00:18:22 INFO - 'sessionrestore_no_auto_restore', 00:18:22 INFO - 'tabpaint']}, 00:18:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:18:22 INFO - 'tests': ['a11yr', 00:18:22 INFO - 'ts_paint', 00:18:22 INFO - 'tpaint', 00:18:22 INFO - 'sessionrestore', 00:18:22 INFO - 'sessionrestore_no_auto_restore', 00:18:22 INFO - 'tabpaint']}, 00:18:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:18:22 INFO - 'tests': ['tsvgx', 00:18:22 INFO - 'tsvgr_opacity', 00:18:22 INFO - 'tart', 00:18:22 INFO - 'tscrollx', 00:18:22 INFO - 'cart']}, 00:18:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:18:22 INFO - 'tsvgr_opacity', 00:18:22 INFO - 'tart', 00:18:22 INFO - 'tscrollx', 00:18:22 INFO - 'cart']}, 00:18:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:18:22 INFO - 'talos_options': ['--disable-e10s'], 00:18:22 INFO - 'tests': ['tp5o']}, 00:18:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:18:22 INFO - 'tests': ['tp5o']}, 00:18:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:18:22 INFO - 'talos_options': ['--disable-e10s', 00:18:22 INFO - '--xperf_path', 00:18:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:18:22 INFO - 'tests': ['tp5n']}, 00:18:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:18:22 INFO - 'talos_options': ['--xperf_path', 00:18:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:18:22 INFO - 'tests': ['tp5n']}}, 00:18:22 INFO - 'talos.zip': {'path': '', 00:18:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:18:22 INFO - Running post-action listener: _resource_record_post_action 00:18:22 INFO - [mozharness: 2016-09-30 07:18:22.175752Z] Finished populate-webroot step (success) 00:18:22 INFO - [mozharness: 2016-09-30 07:18:22.175842Z] Running create-virtualenv step. 00:18:22 INFO - Running pre-action listener: _resource_record_pre_action 00:18:22 INFO - Running main action method: create_virtualenv 00:18:22 INFO - Creating virtualenv /builds/slave/test/build/venv 00:18:22 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 00:18:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:18:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:18:22 INFO - Using real prefix '/usr' 00:18:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:18:22 INFO - Installing distribute.............................................................................................................................................................................................done. 00:18:24 INFO - Installing pip.................done. 00:18:24 INFO - Return code: 0 00:18:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:18:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:18:25 INFO - Reading from file tmpfile_stdout 00:18:25 INFO - Output received: 00:18:25 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 00:18:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:18:25 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:18:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:25 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:18:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:18:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f3f63707f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2709790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2706930>, '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 0x2707830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2707cc0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1475210871.443077-1444644456', '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 00:18:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 00:18:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 00:18:25 INFO - Using env: {'DISPLAY': ':0', 00:18:25 INFO - 'HOME': '/home/cltbld', 00:18:25 INFO - 'LANG': 'en_US.UTF-8', 00:18:25 INFO - 'LANGUAGE': 'en_US:en', 00:18:25 INFO - 'LOGNAME': 'cltbld', 00:18:25 INFO - 'MAIL': '/var/mail/cltbld', 00:18:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:18:25 INFO - 'MOZ_NO_REMOTE': '1', 00:18:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:18:25 INFO - 'NO_EM_RESTART': '1', 00:18:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:18:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:18:25 INFO - 'PWD': '/builds/slave/test', 00:18:25 INFO - 'SHELL': '/bin/bash', 00:18:25 INFO - 'SHLVL': '1', 00:18:25 INFO - 'TERM': 'linux', 00:18:25 INFO - 'TMOUT': '86400', 00:18:25 INFO - 'USER': 'cltbld', 00:18:25 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1475210871.443077-1444644456', 00:18:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:18:25 INFO - '_': '/tools/buildbot/bin/python'} 00:18:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:18:25 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 00:18:25 INFO - Cleaning up... 00:18:25 INFO - Return code: 0 00:18:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:18:25 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:18:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:25 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:18:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:18:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3f63707f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2709790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2706930>, '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 0x2707830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2707cc0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1475210871.443077-1444644456', '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 00:18:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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>=3.1.1'] in /builds/slave/test/build 00:18:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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>=3.1.1 00:18:25 INFO - Using env: {'DISPLAY': ':0', 00:18:25 INFO - 'HOME': '/home/cltbld', 00:18:25 INFO - 'LANG': 'en_US.UTF-8', 00:18:25 INFO - 'LANGUAGE': 'en_US:en', 00:18:25 INFO - 'LOGNAME': 'cltbld', 00:18:25 INFO - 'MAIL': '/var/mail/cltbld', 00:18:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:18:25 INFO - 'MOZ_NO_REMOTE': '1', 00:18:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:18:25 INFO - 'NO_EM_RESTART': '1', 00:18:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:18:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:18:25 INFO - 'PWD': '/builds/slave/test', 00:18:25 INFO - 'SHELL': '/bin/bash', 00:18:25 INFO - 'SHLVL': '1', 00:18:25 INFO - 'TERM': 'linux', 00:18:25 INFO - 'TMOUT': '86400', 00:18:25 INFO - 'USER': 'cltbld', 00:18:25 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1475210871.443077-1444644456', 00:18:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:18:25 INFO - '_': '/tools/buildbot/bin/python'} 00:18:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:18:25 INFO - Downloading/unpacking psutil>=3.1.1 00:18:25 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 00:18:25 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 00:18:25 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 00:18:25 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 00:18:25 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 00:18:25 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 00:18:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:18:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:18:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:18:27 INFO - Installing collected packages: psutil 00:18:27 INFO - Running setup.py install for psutil 00:18:27 INFO - building 'psutil._psutil_linux' extension 00:18:27 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 00:18:27 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 00:18:27 INFO - building 'psutil._psutil_posix' extension 00:18:27 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 00:18:27 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 00:18:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:18:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:18:27 INFO - Successfully installed psutil 00:18:27 INFO - Cleaning up... 00:18:28 INFO - Return code: 0 00:18:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:18:28 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:18:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:18:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:28 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:18:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:18:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3f63707f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2709790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2706930>, '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 0x2707830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2707cc0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1475210871.443077-1444644456', '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 00:18:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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.3'] in /builds/slave/test/build 00:18:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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.3 00:18:28 INFO - Using env: {'DISPLAY': ':0', 00:18:28 INFO - 'HOME': '/home/cltbld', 00:18:28 INFO - 'LANG': 'en_US.UTF-8', 00:18:28 INFO - 'LANGUAGE': 'en_US:en', 00:18:28 INFO - 'LOGNAME': 'cltbld', 00:18:28 INFO - 'MAIL': '/var/mail/cltbld', 00:18:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:18:28 INFO - 'MOZ_NO_REMOTE': '1', 00:18:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:18:28 INFO - 'NO_EM_RESTART': '1', 00:18:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:18:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:18:28 INFO - 'PWD': '/builds/slave/test', 00:18:28 INFO - 'SHELL': '/bin/bash', 00:18:28 INFO - 'SHLVL': '1', 00:18:28 INFO - 'TERM': 'linux', 00:18:28 INFO - 'TMOUT': '86400', 00:18:28 INFO - 'USER': 'cltbld', 00:18:28 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1475210871.443077-1444644456', 00:18:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:18:28 INFO - '_': '/tools/buildbot/bin/python'} 00:18:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:18:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:18:28 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 00:18:28 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 00:18:28 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 00:18:28 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 00:18:28 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 00:18:28 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 00:18:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:18:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:18:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:18:30 INFO - Installing collected packages: mozsystemmonitor 00:18:30 INFO - Running setup.py install for mozsystemmonitor 00:18:30 INFO - Successfully installed mozsystemmonitor 00:18:30 INFO - Cleaning up... 00:18:30 INFO - Return code: 0 00:18:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:18: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:18:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:18:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:18:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3f63707f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2709790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2706930>, '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 0x2707830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2707cc0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1475210871.443077-1444644456', '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 00:18:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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==2.5.1'] in /builds/slave/test/build 00:18:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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==2.5.1 00:18:30 INFO - Using env: {'DISPLAY': ':0', 00:18:30 INFO - 'HOME': '/home/cltbld', 00:18:30 INFO - 'LANG': 'en_US.UTF-8', 00:18:30 INFO - 'LANGUAGE': 'en_US:en', 00:18:30 INFO - 'LOGNAME': 'cltbld', 00:18:30 INFO - 'MAIL': '/var/mail/cltbld', 00:18:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:18:30 INFO - 'MOZ_NO_REMOTE': '1', 00:18:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:18:30 INFO - 'NO_EM_RESTART': '1', 00:18:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:18:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:18:30 INFO - 'PWD': '/builds/slave/test', 00:18:30 INFO - 'SHELL': '/bin/bash', 00:18:30 INFO - 'SHLVL': '1', 00:18:30 INFO - 'TERM': 'linux', 00:18:30 INFO - 'TMOUT': '86400', 00:18:30 INFO - 'USER': 'cltbld', 00:18:30 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1475210871.443077-1444644456', 00:18:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:18:30 INFO - '_': '/tools/buildbot/bin/python'} 00:18:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:18:30 INFO - Downloading/unpacking jsonschema==2.5.1 00:18:30 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 00:18:30 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 00:18:30 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 00:18:30 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 00:18:30 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 00:18:30 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 00:18:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:18:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:18:32 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 00:18:32 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 00:18:32 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 00:18:32 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 00:18:32 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 00:18:32 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 00:18:32 INFO - Downloading functools32-3.2.3-2.tar.gz 00:18:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:18:32 INFO - warning: no files found matching '*.txt' 00:18:32 INFO - no previously-included directories found matching 'build' 00:18:32 INFO - no previously-included directories found matching 'dist' 00:18:32 INFO - no previously-included directories found matching '.git*' 00:18:32 INFO - Installing collected packages: jsonschema, functools32 00:18:32 INFO - Running setup.py install for functools32 00:18:32 INFO - warning: no files found matching '*.txt' 00:18:32 INFO - no previously-included directories found matching 'build' 00:18:32 INFO - no previously-included directories found matching 'dist' 00:18:32 INFO - no previously-included directories found matching '.git*' 00:18:32 INFO - Successfully installed jsonschema functools32 00:18:32 INFO - Cleaning up... 00:18:32 INFO - Return code: 0 00:18:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:18:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:18:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:18:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:18:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:18:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3f63707f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2709790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2706930>, '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 0x2707830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2707cc0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1475210871.443077-1444644456', '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 00:18:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'functools32==3.2.3-2'] in /builds/slave/test/build 00:18:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 functools32==3.2.3-2 00:18:32 INFO - Using env: {'DISPLAY': ':0', 00:18:32 INFO - 'HOME': '/home/cltbld', 00:18:32 INFO - 'LANG': 'en_US.UTF-8', 00:18:32 INFO - 'LANGUAGE': 'en_US:en', 00:18:32 INFO - 'LOGNAME': 'cltbld', 00:18:32 INFO - 'MAIL': '/var/mail/cltbld', 00:18:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:18:32 INFO - 'MOZ_NO_REMOTE': '1', 00:18:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:18:32 INFO - 'NO_EM_RESTART': '1', 00:18:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:18:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:18:32 INFO - 'PWD': '/builds/slave/test', 00:18:32 INFO - 'SHELL': '/bin/bash', 00:18:32 INFO - 'SHLVL': '1', 00:18:32 INFO - 'TERM': 'linux', 00:18:32 INFO - 'TMOUT': '86400', 00:18:32 INFO - 'USER': 'cltbld', 00:18:32 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1475210871.443077-1444644456', 00:18:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:18:32 INFO - '_': '/tools/buildbot/bin/python'} 00:18:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:18:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:18:33 INFO - Cleaning up... 00:18:33 INFO - Return code: 0 00:18:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:18:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:18:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:18:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:18:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:18:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f3f63707f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2709790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2706930>, '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 0x2707830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2707cc0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1475210871.443077-1444644456', '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 00:18:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 00:18:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 00:18:33 INFO - Using env: {'DISPLAY': ':0', 00:18:33 INFO - 'HOME': '/home/cltbld', 00:18:33 INFO - 'LANG': 'en_US.UTF-8', 00:18:33 INFO - 'LANGUAGE': 'en_US:en', 00:18:33 INFO - 'LOGNAME': 'cltbld', 00:18:33 INFO - 'MAIL': '/var/mail/cltbld', 00:18:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:18:33 INFO - 'MOZ_NO_REMOTE': '1', 00:18:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:18:33 INFO - 'NO_EM_RESTART': '1', 00:18:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:18:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:18:33 INFO - 'PWD': '/builds/slave/test', 00:18:33 INFO - 'SHELL': '/bin/bash', 00:18:33 INFO - 'SHLVL': '1', 00:18:33 INFO - 'TERM': 'linux', 00:18:33 INFO - 'TMOUT': '86400', 00:18:33 INFO - 'USER': 'cltbld', 00:18:33 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1475210871.443077-1444644456', 00:18:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:18:33 INFO - '_': '/tools/buildbot/bin/python'} 00:18:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:18:33 INFO - Downloading/unpacking blobuploader==1.2.4 00:18:33 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 00:18:33 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 00:18:33 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 00:18:33 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 00:18:33 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 00:18:33 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 00:18:35 INFO - Downloading blobuploader-1.2.4.tar.gz 00:18:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:18:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:18:35 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 00:18:35 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 00:18:35 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 00:18:35 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 00:18:35 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 00:18:35 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 00:18:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:18:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:18:35 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 00:18:35 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 00:18:35 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 00:18:35 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 00:18:35 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 00:18:35 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 00:18:35 INFO - Downloading docopt-0.6.1.tar.gz 00:18:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:18:36 INFO - Installing collected packages: blobuploader, requests, docopt 00:18:36 INFO - Running setup.py install for blobuploader 00:18:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:18:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:18:36 INFO - Running setup.py install for requests 00:18:36 INFO - Running setup.py install for docopt 00:18:36 INFO - Successfully installed blobuploader requests docopt 00:18:36 INFO - Cleaning up... 00:18:36 INFO - Return code: 0 00:18:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:18: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:18:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:18:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:18:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7f3f63707f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2709790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2706930>, '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 0x2707830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2707cc0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1475210871.443077-1444644456', '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 00:18:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 00:18:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --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 00:18:36 INFO - Using env: {'DISPLAY': ':0', 00:18:36 INFO - 'HOME': '/home/cltbld', 00:18:36 INFO - 'LANG': 'en_US.UTF-8', 00:18:36 INFO - 'LANGUAGE': 'en_US:en', 00:18:36 INFO - 'LOGNAME': 'cltbld', 00:18:36 INFO - 'MAIL': '/var/mail/cltbld', 00:18:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:18:36 INFO - 'MOZ_NO_REMOTE': '1', 00:18:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:18:36 INFO - 'NO_EM_RESTART': '1', 00:18:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:18:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:18:36 INFO - 'PWD': '/builds/slave/test', 00:18:36 INFO - 'SHELL': '/bin/bash', 00:18:36 INFO - 'SHLVL': '1', 00:18:36 INFO - 'TERM': 'linux', 00:18:36 INFO - 'TMOUT': '86400', 00:18:36 INFO - 'USER': 'cltbld', 00:18:36 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1475210871.443077-1444644456', 00:18:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:18:36 INFO - '_': '/tools/buildbot/bin/python'} 00:18:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:18:36 INFO - Running setup.py (path:/tmp/pip-79NEvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:18:36 INFO - Running setup.py (path:/tmp/pip-_EcuKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:18:37 INFO - Running setup.py (path:/tmp/pip-y7lE1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:18:37 INFO - Running setup.py (path:/tmp/pip-a6Cu58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:18:37 INFO - Running setup.py (path:/tmp/pip-syDEN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:18:37 INFO - Running setup.py (path:/tmp/pip-rBo1C3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:18:37 INFO - Running setup.py (path:/tmp/pip-TepvPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:18:37 INFO - Running setup.py (path:/tmp/pip-f8YTTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:18:37 INFO - Running setup.py (path:/tmp/pip-r03KbQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:18:37 INFO - Running setup.py (path:/tmp/pip-NfMgmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:18:37 INFO - Running setup.py (path:/tmp/pip-p71cgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:18:37 INFO - Running setup.py (path:/tmp/pip-oT7FJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:18:37 INFO - Running setup.py (path:/tmp/pip-J96QBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:18:37 INFO - Running setup.py (path:/tmp/pip-h0y07W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:18:37 INFO - Running setup.py (path:/tmp/pip-L7mVNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:18:37 INFO - Running setup.py (path:/tmp/pip-PxzM4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:18:38 INFO - Running setup.py (path:/tmp/pip-_32nIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:18:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:18:38 INFO - Running setup.py install for manifestparser 00:18:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:18:38 INFO - Running setup.py install for mozcrash 00:18:38 INFO - Running setup.py install for mozdebug 00:18:38 INFO - Running setup.py install for mozdevice 00:18:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:18:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:18:38 INFO - Running setup.py install for mozfile 00:18:38 INFO - Running setup.py install for mozhttpd 00:18:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:18:38 INFO - Running setup.py install for mozinfo 00:18:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:18:38 INFO - Running setup.py install for mozInstall 00:18:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:18:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:18:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:18:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:18:38 INFO - Running setup.py install for mozleak 00:18:39 INFO - Running setup.py install for mozlog 00:18:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:18:39 INFO - Running setup.py install for moznetwork 00:18:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:18:39 INFO - Running setup.py install for mozprocess 00:18:39 INFO - Running setup.py install for mozprofile 00:18:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:18:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:18:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:18:39 INFO - Running setup.py install for mozrunner 00:18:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:18:39 INFO - Running setup.py install for mozscreenshot 00:18:39 INFO - Running setup.py install for moztest 00:18:39 INFO - Running setup.py install for mozversion 00:18:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:18:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:18:39 INFO - Cleaning up... 00:18:39 INFO - Return code: 0 00:18:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:18: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:18:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:18:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:18:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f3f63707f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2709790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2706930>, '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 0x2707830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2707cc0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1475210871.443077-1444644456', '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 00:18:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 00:18:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 00:18:39 INFO - Using env: {'DISPLAY': ':0', 00:18:39 INFO - 'HOME': '/home/cltbld', 00:18:39 INFO - 'LANG': 'en_US.UTF-8', 00:18:39 INFO - 'LANGUAGE': 'en_US:en', 00:18:39 INFO - 'LOGNAME': 'cltbld', 00:18:39 INFO - 'MAIL': '/var/mail/cltbld', 00:18:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:18:39 INFO - 'MOZ_NO_REMOTE': '1', 00:18:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:18:39 INFO - 'NO_EM_RESTART': '1', 00:18:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:18:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:18:39 INFO - 'PWD': '/builds/slave/test', 00:18:39 INFO - 'SHELL': '/bin/bash', 00:18:39 INFO - 'SHLVL': '1', 00:18:39 INFO - 'TERM': 'linux', 00:18:39 INFO - 'TMOUT': '86400', 00:18:39 INFO - 'USER': 'cltbld', 00:18:39 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1475210871.443077-1444644456', 00:18:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:18:39 INFO - '_': '/tools/buildbot/bin/python'} 00:18:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:18:40 INFO - Running setup.py (path:/tmp/pip-McuDQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:18:40 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)) 00:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:18:40 INFO - Running setup.py (path:/tmp/pip-Espg0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:18:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 00:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:18:40 INFO - Running setup.py (path:/tmp/pip-XOZzo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:18:40 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)) 00:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:18:40 INFO - Running setup.py (path:/tmp/pip-xw5jGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:18:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 00:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:18:40 INFO - Running setup.py (path:/tmp/pip-gtgPD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:18:40 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)) 00:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:18:40 INFO - Running setup.py (path:/tmp/pip-iWEKq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:18:40 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)) 00:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:18:40 INFO - Running setup.py (path:/tmp/pip-BcXqlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:18:40 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)) 00:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:18:40 INFO - Running setup.py (path:/tmp/pip-bZ4Ke7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:18:40 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)) 00:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:18:40 INFO - Running setup.py (path:/tmp/pip-NtLngR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:18:40 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)) 00:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:18:40 INFO - Running setup.py (path:/tmp/pip-aANWLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:18:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 00:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:18:40 INFO - Running setup.py (path:/tmp/pip-lseuOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:18:40 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)) 00:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:18:40 INFO - Running setup.py (path:/tmp/pip-JGDhOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:18:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 00:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:18:41 INFO - Running setup.py (path:/tmp/pip-w9AIjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:18:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 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)) 00:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:18:41 INFO - Running setup.py (path:/tmp/pip-Qq5d3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:18:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 00:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:18:41 INFO - Running setup.py (path:/tmp/pip-895V67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:18:41 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)) 00:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:18:41 INFO - Running setup.py (path:/tmp/pip-wg90f7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:18:41 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)) 00:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:18:41 INFO - Running setup.py (path:/tmp/pip-X4J0d6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:18:41 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)) 00:18:41 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:18:41 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:18:41 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)) 00:18:41 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:18:41 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:18:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:18:41 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 00:18:41 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 00:18:41 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 00:18:41 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 00:18:41 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 00:18:41 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 00:18:43 INFO - Downloading blessings-1.6.tar.gz 00:18:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:18:43 INFO - Installing collected packages: blessings 00:18:43 INFO - Running setup.py install for blessings 00:18:43 INFO - Successfully installed blessings 00:18:43 INFO - Cleaning up... 00:18:43 INFO - Return code: 0 00:18:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:18:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:18:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:18:43 INFO - Reading from file tmpfile_stdout 00:18:43 INFO - Current package versions: 00:18:43 INFO - argparse == 1.2.1 00:18:43 INFO - blessings == 1.6 00:18:43 INFO - blobuploader == 1.2.4 00:18:43 INFO - docopt == 0.6.1 00:18:43 INFO - functools32 == 3.2.3-2 00:18:43 INFO - jsonschema == 2.5.1 00:18:43 INFO - manifestparser == 1.1 00:18:43 INFO - mozInstall == 1.12 00:18:43 INFO - mozcrash == 0.17 00:18:43 INFO - mozdebug == 0.1 00:18:43 INFO - mozdevice == 0.48 00:18:43 INFO - mozfile == 1.2 00:18:43 INFO - mozhttpd == 0.7 00:18:43 INFO - mozinfo == 0.9 00:18:43 INFO - mozleak == 0.1 00:18:43 INFO - mozlog == 3.4 00:18:43 INFO - moznetwork == 0.27 00:18:43 INFO - mozprocess == 0.23 00:18:43 INFO - mozprofile == 0.28 00:18:43 INFO - mozrunner == 6.12 00:18:43 INFO - mozscreenshot == 0.1 00:18:43 INFO - mozsystemmonitor == 0.3 00:18:43 INFO - moztest == 0.7 00:18:43 INFO - mozversion == 1.4 00:18:43 INFO - psutil == 3.1.1 00:18:43 INFO - requests == 1.2.3 00:18:43 INFO - wsgiref == 0.1.2 00:18:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:18:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:18:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:18:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:18:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:18:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f3f63707f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2709790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2706930>, '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 0x2707830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2707cc0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1475210871.443077-1444644456', '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 00:18:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 00:18:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 00:18:43 INFO - Using env: {'DISPLAY': ':0', 00:18:43 INFO - 'HOME': '/home/cltbld', 00:18:43 INFO - 'LANG': 'en_US.UTF-8', 00:18:43 INFO - 'LANGUAGE': 'en_US:en', 00:18:43 INFO - 'LOGNAME': 'cltbld', 00:18:43 INFO - 'MAIL': '/var/mail/cltbld', 00:18:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:18:43 INFO - 'MOZ_NO_REMOTE': '1', 00:18:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:18:43 INFO - 'NO_EM_RESTART': '1', 00:18:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:18:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:18:43 INFO - 'PWD': '/builds/slave/test', 00:18:43 INFO - 'SHELL': '/bin/bash', 00:18:43 INFO - 'SHLVL': '1', 00:18:43 INFO - 'TERM': 'linux', 00:18:43 INFO - 'TMOUT': '86400', 00:18:43 INFO - 'USER': 'cltbld', 00:18:43 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1475210871.443077-1444644456', 00:18:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:18:43 INFO - '_': '/tools/buildbot/bin/python'} 00:18:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:18:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 00:18:43 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 2)) 00:18:43 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 3)) 00:18:43 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 4)) 00:18:43 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 5)) 00:18:43 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 6)) 00:18:43 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 7)) 00:18:43 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 8)) 00:18:43 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 9)) 00:18:43 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.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 00:18:43 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 4)) 00:18:43 INFO - Cleaning up... 00:18:44 INFO - Return code: 0 00:18:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:18:44 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:18:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:44 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:18:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:18:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f3f63707f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2709790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2706930>, '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 0x2707830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2707cc0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1475210871.443077-1444644456', '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 00:18:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 00:18:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 00:18:44 INFO - Using env: {'DISPLAY': ':0', 00:18:44 INFO - 'HOME': '/home/cltbld', 00:18:44 INFO - 'LANG': 'en_US.UTF-8', 00:18:44 INFO - 'LANGUAGE': 'en_US:en', 00:18:44 INFO - 'LOGNAME': 'cltbld', 00:18:44 INFO - 'MAIL': '/var/mail/cltbld', 00:18:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:18:44 INFO - 'MOZ_NO_REMOTE': '1', 00:18:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:18:44 INFO - 'NO_EM_RESTART': '1', 00:18:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:18:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:18:44 INFO - 'PWD': '/builds/slave/test', 00:18:44 INFO - 'SHELL': '/bin/bash', 00:18:44 INFO - 'SHLVL': '1', 00:18:44 INFO - 'TERM': 'linux', 00:18:44 INFO - 'TMOUT': '86400', 00:18:44 INFO - 'USER': 'cltbld', 00:18:44 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1475210871.443077-1444644456', 00:18:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:18:44 INFO - '_': '/tools/buildbot/bin/python'} 00:18:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:18:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:18:44 INFO - Cleaning up... 00:18:44 INFO - Return code: 0 00:18:44 INFO - Running post-action listener: _resource_record_post_action 00:18:44 INFO - Running post-action listener: _start_resource_monitoring 00:18:44 INFO - Starting resource monitoring. 00:18:44 INFO - [mozharness: 2016-09-30 07:18:44.269603Z] Finished create-virtualenv step (success) 00:18:44 INFO - [mozharness: 2016-09-30 07:18:44.270109Z] Running install step. 00:18:44 INFO - Running pre-action listener: _resource_record_pre_action 00:18:44 INFO - Running main action method: install 00:18:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:18:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:18:44 INFO - Reading from file tmpfile_stdout 00:18:44 INFO - Detecting whether we're running mozinstall >=1.0... 00:18:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:18:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:18:44 INFO - Reading from file tmpfile_stdout 00:18:44 INFO - Output received: 00:18:44 INFO - Usage: mozinstall [options] installer 00:18:44 INFO - Options: 00:18:44 INFO - -h, --help show this help message and exit 00:18:44 INFO - -d DEST, --destination=DEST 00:18:44 INFO - Directory to install application into. [default: 00:18:44 INFO - "/builds/slave/test"] 00:18:44 INFO - --app=APP Application being installed. [default: firefox] 00:18:44 INFO - mkdir: /builds/slave/test/build/application 00:18:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 00:18:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 00:19:01 INFO - Reading from file tmpfile_stdout 00:19:01 INFO - Output received: 00:19:01 INFO - /builds/slave/test/build/application/firefox/firefox 00:19:01 INFO - Running post-action listener: _resource_record_post_action 00:19:01 INFO - [mozharness: 2016-09-30 07:19:01.569556Z] Finished install step (success) 00:19:01 INFO - [mozharness: 2016-09-30 07:19:01.569893Z] Running run-tests step. 00:19:01 INFO - Running pre-action listener: _resource_record_pre_action 00:19:01 INFO - Running main action method: run_tests 00:19:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:19:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:19:01 INFO - Python 2.7.3 00:19:01 INFO - Return code: 0 00:19:01 INFO - grabbing minidump binary from tooltool 00:19:01 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:19:01 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2706930>, '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 0x2707830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2707cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:19:01 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 00:19:01 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 00:19:01 INFO - Calling ['/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'] with output_timeout 600 00:19:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:19:01 INFO - Return code: 0 00:19:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:19:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:19:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:19:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:19:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:19:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475209894/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 00:19:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475209894/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 00:19:01 INFO - Using env: {'DISPLAY': ':0', 00:19:01 INFO - 'HOME': '/home/cltbld', 00:19:01 INFO - 'LANG': 'en_US.UTF-8', 00:19:01 INFO - 'LANGUAGE': 'en_US:en', 00:19:01 INFO - 'LOGNAME': 'cltbld', 00:19:01 INFO - 'MAIL': '/var/mail/cltbld', 00:19:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:19:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:19:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:19:01 INFO - 'MOZ_NO_REMOTE': '1', 00:19:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:19:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:19:01 INFO - 'NO_EM_RESTART': '1', 00:19:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:19:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:19:01 INFO - 'PWD': '/builds/slave/test', 00:19:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:19:01 INFO - 'SHELL': '/bin/bash', 00:19:01 INFO - 'SHLVL': '1', 00:19:01 INFO - 'TERM': 'linux', 00:19:01 INFO - 'TMOUT': '86400', 00:19:01 INFO - 'USER': 'cltbld', 00:19:01 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1475210871.443077-1444644456', 00:19:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:19:01 INFO - '_': '/tools/buildbot/bin/python'} 00:19:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475209894/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 00:19:01 INFO - mozversion application_buildid: 20160929213134 00:19:01 INFO - mozversion application_changeset: f6a964152400fa1e5340e9909615ac938610f931 00:19:01 INFO - mozversion application_display_name: Nightly 00:19:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:19:01 INFO - mozversion application_name: Firefox 00:19:01 INFO - mozversion application_remotingname: firefox 00:19:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 00:19:01 INFO - mozversion application_vendor: Mozilla 00:19:01 INFO - mozversion application_version: 52.0a1 00:19:01 INFO - mozversion platform_buildid: 20160929213134 00:19:01 INFO - mozversion platform_changeset: f6a964152400fa1e5340e9909615ac938610f931 00:19:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 00:19:01 INFO - mozversion platform_version: 52.0a1 00:19:01 INFO - using testdate: 1475219941 00:19:01 INFO - actual date: 1475219941 00:19:01 INFO - starting webserver on 'localhost:34283' 00:19:01 INFO - SUITE-START | Running 2 tests 00:19:01 INFO - TEST-START | dromaeo_css 00:19:01 INFO - operating with platform_type : linux_ 00:19:01 INFO - Initialising browser for dromaeo_css test... 00:19:01 INFO - TEST-INFO | started process 13127 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsf5o0i/profile http://localhost:34283/getInfo.html) 00:19:06 INFO - PROCESS | 13127 | __metrics Screen width/height:1600/1200 00:19:06 INFO - PROCESS | 13127 | colorDepth:24 00:19:06 INFO - PROCESS | 13127 | Browser inner width/height: 1024/697 00:19:06 INFO - PROCESS | 13127 | __metrics 00:19:06 INFO - PROCESS | 13127 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:19:06 INFO - PROCESS | 13127 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:19:07 INFO - PROCESS | 13127 | console.error: PushService: 00:19:07 INFO - PROCESS | 13127 | stateChangeProcessEnqueue: Error transitioning state 00:19:07 INFO - PROCESS | 13127 | UnknownError 00:19:07 INFO - TEST-INFO | 13127: exit 0 00:19:07 INFO - Browser initialized. 00:19:07 INFO - Running cycle 1/1 for dromaeo_css test... 00:19:07 INFO - TEST-INFO | started process 13211 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsf5o0i/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:19:19 INFO - PROCESS | 13211 | RSS: Main: 173920256 00:19:19 INFO - PROCESS | 13211 | 00:20:11 INFO - PROCESS | 13211 | 1475220011159 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] 00:22:20 INFO - PROCESS | 13211 | Cycle 1(1): loaded http://localhost:34283/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34283/tests/dromaeo/cssquery-ext.html) 00:22:21 INFO - PROCESS | 13211 | RSS: Main: 321323008 00:22:21 INFO - PROCESS | 13211 | 00:25:24 INFO - PROCESS | 13211 | Cycle 1(1): loaded http://localhost:34283/tests/dromaeo/cssquery-ext.html (next: http://localhost:34283/tests/dromaeo/cssquery-jquery.html) 00:25:24 INFO - PROCESS | 13211 | RSS: Main: 277491712 00:25:24 INFO - PROCESS | 13211 | 00:28:26 INFO - PROCESS | 13211 | Cycle 1(1): loaded http://localhost:34283/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34283/tests/dromaeo/cssquery-mootools.html) 00:28:27 INFO - PROCESS | 13211 | RSS: Main: 275587072 00:28:27 INFO - PROCESS | 13211 | 00:31:29 INFO - PROCESS | 13211 | Cycle 1(1): loaded http://localhost:34283/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34283/tests/dromaeo/cssquery-prototype.html) 00:31:30 INFO - PROCESS | 13211 | RSS: Main: 269533184 00:31:30 INFO - PROCESS | 13211 | 00:34:32 INFO - PROCESS | 13211 | Cycle 1(1): loaded http://localhost:34283/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34283/tests/dromaeo/cssquery-yui.html) 00:34:33 INFO - PROCESS | 13211 | RSS: Main: 215994368 00:34:33 INFO - PROCESS | 13211 | 00:37:36 INFO - PROCESS | 13211 | Cycle 1(1): loaded http://localhost:34283/tests/dromaeo/cssquery-yui.html (next: http://localhost:34283/tests/dromaeo/cssquery-dojo.html) 00:37:36 INFO - PROCESS | 13211 | RSS: Main: 288849920 00:37:36 INFO - PROCESS | 13211 | 00:37:36 INFO - PROCESS | 13211 | __start_tp_report 00:37:36 INFO - PROCESS | 13211 | _x_x_mozilla_page_load 00:37:36 INFO - PROCESS | 13211 | _x_x_mozilla_page_load_details 00:37:36 INFO - PROCESS | 13211 | |i|pagename|runs| 00:37:36 INFO - PROCESS | 13211 | |0;dojo.html;3018.3812318474716;3055.4041961817456;3059.418710445015;3087.536869469581;3107.269791598974;5179.766910489027;5197.558207552358;5259.421463639006;5289.5503882170015;5307.230451584523;5238.842834714955;5299.947000529994;5350.250964864922;5387.973060134694;5449.291592093023;4734.597559207472;4784.091022705692;4797.544233297831;4810.134175848346;4847.878803029917;4877.537681672809;4885.193942999401;4915;4927.088488629597;4963.726995015273;4718.363020992157;4735.810567577293;4824.565789079;4874.512548745132;4910.803567857281;4874.366332376804;4937.23472861707;4942;4953.529414705597;4955.653104282702;4819.662623616348;4829.710217386968;4854.7572621369145;4860.684055536379;4905.411350637911;5120.897582048376;5302.125149350352;5302.893942121136;5311.176767601028;5315.282436871012;5454.4545545445535;5537.750801213955;5541.390447050821;5609.52319052881;5615.185798059259;5641.68970706611;5658.971705141489;5660.773569057233;5663.631863928873;5717.313922329306;5293.444188360205;5306.469353064701;5308.442613525602;5309.601779866487;5362.088444964365;5613.522850557748;5616.550675945915;5680.034394153004;5748.166515855178;5764.452377024176;5525.668459892419;5568.693721845257;5571.052921003439;5579.581531385163;5587.0502014656795;5595.272614560081;5598.86002849932;5601.8599535011135;5611.466910643482;5615.719214039282;5665.688387138747;5723.141528770718;5723.656580605094;5733.111367738007;5736.282964629421;5654.038813401731;5654.095344744821;5658.462446067617;5662.801801936995;5685.147227915846;4242.193983143193;4357.542458041923;4358.65130789536;4363;4416.4258646375765;3801.486799282117;3869.438931354994;3886.7862267575556;3931.4495970564144;3973.0663294125857;5431.755570999315;5461.044317244467;5474.452554744574;5523.7790488380015;5532.75102620383;5726.284214473191;5728.169415434739;5741;5750.7987220447085;5753.51095156908;5207.635465517453;5231.895362092737;5325.760340784674;5453.890922181534;5464.808731694372;4910;4961.801527938842;4962.305277261186;5011.273365362002;5019.698818070928;5920.763169473259;5928.3775203603;5930.2587176602065;5933.792317268875;5946.10808378738;5562.110062389998;5645.40723224072;5668.03643380618;5669.54643628517;5739.053056245672;5818.738156782871;5867.178594996619;5911.970440147772;5917.053271476543;6019.127226552037;5552.743621043773;5598.552115830642;5603.35561410443;5604.635698679573;5613.242212301287;5638.436156384329;5693.971530142323;5696.458836410535;5703.600747947769;5711.257536520226;5315.468453154654;5339.973300133474;5463.399026107205;5496.367917689517;5519.172124181405;5532.08720561119;5534.861628459321;5540.556755459473;5540.69526176048;5593.133064375028;5459.454054594509;5464.098423760035;5464.590155738415;5467.316585426822;5535.833924982257;5415.891682166413;5457.208704737712;5525.0883604204855;5539.612227144061;5551;5438.265834112344;5481.123020316731;5494.1758736189895;5543.417941116286;5549.944500554942 00:37:36 INFO - PROCESS | 13211 | |1;ext.html;560.0599780543872;593.0599999001582;604.2054698072033;605.4823126227074;609.1198218574161;31501.369972600532;41970.58029419705;43232.56767432325;43281.567184328145;43320.56679433209;43946;44502.55497445024;44509.554904450946;44583.108337833226;44605.33092003623;8851.867221991659;9009.909900900973;9016.774580635503;9019.639214431414;9020.41367311126;8829.381943263974;8925.419847709878;8926.821463570725;8927.41971771836;8929.464232146092;8971.730848074569;9048.276137908952;9058.637654493812;9060.77348066297;9065.637374505044;8975.416597921147;9015.81968360629;9018.503982280972;9018.819623607491;9022.639094436214;8857.911420885774;8911.688090916852;8933.6873209438;8942.776430589221;8944.28445724347;42663;42805.57194428047;42963.57036429627;43056;43115.35326970098;3463.2034632034774;3502.509648649191;3562.8574857005688;3607.9458808117897;3648.7081033517256;31206;31512.527312090107;32028.836251287416;32280.677193228003;32964.50553241703;4155.605217504332;4207.221663992141;4331.480222373335;4412.249917513998;4537.3647689323525;352180;353674;354244;354822;355775;48819.75590122027;50026.49973500219;56235.71882140563;56553;56595.71702141463;57990.710046449494;59464.40535594675;59968.70015649894;63743.68128159329;64591.67704161543;15171.924140379228;15331.540053798404;15336.923315383352;15337.079775213522;15352.23238838076;11836.70408239801;11892.762144757056;11911.52353905834;11928.224665396721;11932.821007684892;14627;14977.550673479813;15475.767863482057;15954.441594544136;16013;5920.875033743575;5966.703973139332;6004.729787159588;6056.273247210363;6186.876262474725;944.7354740672623;969.3795970578835;1017.5573625472795;1071.5553045486192;1080.68660088575;30503.084907452812;31040.379192416025;31526.36947261042;31674.208144796565;32115.34327522496;1074.790415868898;1075.3762817565794;1093.5953697131954;1164.2606944590245;1183.7810005149074;15039.924800375928;16011.563574739663;16026.19869006545;16059.678806423806;16275.674486510203;543658;546921;547261;547780;547945;54981.175282370794;55036;55176;55181;55227;1312.2913626641698;1335.4391155714623;1357.4027427931678;1364.4337599895932;1391.1027387335112;28199;29346.853265733534;29869;29880.85059574775;30437.391252175275;47622.761886191736;47869;47910.28134577914;48000.51999479961;48026;482229;484555;484699;485365;485625;24348.147814826396;24537.877310613334;25118.874405627856;27104.32239194036;27491.450170996868;44909.775451122536;45001;45045.54954450545;45623.31565026593;46614.87236403925;38668.0064589989;39466.605333946296;40284.3957340646;41222.79388603038;41311.793441032605;39100.608993910835;39459.80270098746;40253.19493610053;40270.39594406028;41616.58383416127;38986.2202755949;40291;40818.591814081476;40948.590514094474;43192.56807431886;31389.686103138676;35560.82219588989;36315.45526817047;36630.45054324134;36890.44664329984;27917.72082279151;27966.440671186054;28018.71981280161;28260.293492662848;28291.858540707166 00:37:36 INFO - PROCESS | 13211 | |2;jquery.html;383.2947376826638;386.57476775546917;393.38828122269877;400.39740191012527;419.1533103131672;14081.64795880101;16165.595860103504;17763.20065597048;19505.219791208354;19518.121684524194;14416.855831441682;14477.131372117654;17391.39130130446;17657.028863412506;17949.282028718837;5394.865128371793;5843.678597677126;5876.2067120938555;5881.323647780518;5885.7939972100985;5643.4074422185695;5711.600187986843;5861.677607731573;5875.735591898353;5876.882462350751;5778.306603207621;5806.825795226129;5819.24349834523;5821.214136091637;5821.621594596359;5574.749136288877;5723.227364305849;5792.189093526888;5792.594518383715;5793.7392817323325;5147.047796157723;5148.2020286855595;5153.252778347156;5155.639105262633;5159.432462429129;16832.9900205988;20556.177752889867;21224.575508489743;21266.680999785014;21975.890120549455;2097;2188.7045248891354;2342.906283748648;2790.1350581319857;2839.9148025559266;9981.950090249502;10266.486675666187;10318.58725650973;10726.678199654023;14103.717925641533;1890.1305399516239;1892.0728842867034;1916.4059141666128;1919.9808001919941;1924.441911845563;81918.18081819166;82193;82321.58839205826;84471.5776421114;86655.13344866534;10386.376817390981;10472.371657700562;10473.214508911862;10635.41505217205;10788.622398216025;15474.767878481833;15502.9224853875;15509.612259693373;15521.534353969399;15611.453599123975;6663.233728121231;7021.648917554204;7135.964320178366;7233.602151881697;7417.332440080419;7302.429977554852;7392.519486233377;7461.515001524992;7597.696092156362;7600.8479830403085;4660.627149828006;4688.203005489075;4692.108499385175;4755.857324280277;4880.219164933594;1876.6340563590243;1950.8634395592455;1959.5884864178397;2050.846186536016;2074.802893725094;875.8117004843862;932.5567014422122;956.6030097509456;972.0304469844551;1071.405370019631;17311.48065558035;18536.814631853507;18682.53293667642;18812.717809232872;19173.904130479536;954.2795189631784;963.0562845149103;984.7341217871135;1009.7526106104051;1024.5952848624752;10309.948450257702;10537.84193237102;10591.682249532527;10605.856429145313;10715.19636027301;405682;417048;420603;421044;422092;85267;87230.56384718035;87531.56234218788;88604;90800.5459972696;933.4119504712123;950.5532399772096;963.8120566489607;973.9318247722733;977.2524019125375;15825.928637865938;15922.203889805694;15984.200789960689;16877.746833797257;17052.232649531048;38389;39815;41791;41923;42917.1416571673;42085;54982.45017549773;58690;60100.69949650224;62120.68939655273;8170.754877353689;8214.4660597061;8515.403921725667;8542.18849209324;8813.91186088131;10741.838872417076;12488.43802028929;12771.10602257833;12904.870951290743;12932.676683082998;10261.486925653538;10624.309419887682;10822.891771082188;10836.729081773019;11516.366599837089;10441.843372349269;10691.946540267249;10859.83710244331;10964;11264.718382040186;10976.451177441255;11288.32270063766;11340.659780206277;11860.110491712983;11966.401679916144;8460.365472589458;8567.485950842969;8622.094680058755;8632.741017769476;8775.22665253947;10799.352038877692;11046.447677616248;11318.830217546578;11458.369789661649;11542.134339924707 00:37:36 INFO - PROCESS | 13211 | |3;mootools.html;1452.1214665127595;1498.9025713328633;1615.2408368067013;1697.388939981607;1777.155850970789;7946.92053079469;8179.018517777875;8531.402801803877;9215.447073175606;9224.077592240772;8565.914340856589;8847.601857916394;8853.158949899766;9097.408668436547;9097.4989126794;2297.8046866016407;2311.641695537194;2325.383773300077;2326.8836558172106;2327.6159433693506;1974.9901250493726;2033.9084741186607;2310.1683393978155;2314.3057082875152;2364.6689463475127;2248.5390494948497;2322.8606283623035;2339.251439539348;2343.9179628713;2344.038944032947;2304.412374844421;2305.0549274797336;2308.3421224950807;2342.250479846433;2349.295211436562;2328.1734984080745;2335.801456876168;2343.7304709958403;2348.624220124772;2350.717913850332;9183.127602877716;9232.492212928286;9298;9303.348765586412;9314.86027709578;5021.17150670139;5152.510511501401;5158.123119069767;5180.715060671661;5181.404138524081;3251.138448311199;3377.172592714776;3477.4262246729513;3481.9651803481893;3513.578370595545;1060.512164404375;1097.4896673047072;1113.8496302999072;1119.641714651312;1145.8911403416662;12535.059870509749;12682.302473363961;12732;12737.681557961032;12746.80879786804;4355.8475453359615;4572.102577430395;4678.719276843401;4740.597049250852;4752.382190315306;10631.415272159951;10644.308119972176;10644.893551064544;10650.254482186327;10655.520501577448;5093.337866077386;5127.487251274917;5129.563987061141;5137.8201762938115;5140.203268493389;4554.795034223468;4644.907101857944;4650.534946505322;4665.510121437268;4677.204875171229;3888.863889763845;3914.667253283446;4003.2994226010333;4019.3569028955812;4029.6776257899296;1145.3585991844593;1178.251810100575;1214.6416807041944;1257.2770656872335;1260.785666436708;822.116225058065;837.991590403166;903.7740564858785;932.9504307653889;936.6487567162314;5675.035244008528;5695.772169113272;5874.882502350015;6060.757569697251;6166.167567378437;944.9622015119455;945.9432434053979;955.4649396338073;956.7993614686194;984.227381505529;3765.2093060457064;3802.296575133609;3807.162424266657;3891.2412079644764;3899.2786334527636;10907.618233361794;11131.944340278247;11351.772964540829;11439.485223164978;11600.477978490988;11302.886971130183;11303;11305.94347028276;11311.321320720783;11333.659990200307;8221.342292616577;8547.786305342415;8669.739907802776;8671.349648776368;8673.479591224674;5568.387477377566;5655.264815573949;5656.23640808502;5704.629199102045;5891.9116213255975;10445.477726113511;10499.212559057949;10566.101881340172;10615.89384106149;10771.084457821173;10157.1366433851;10635.94682026585;10654.14766818668;10724.088452481314;10949.288296260718;8030.674938635059;8153.3477321812925;8158;8165.387595930448;8204.466709663853;8483.363747718822;8642.567871606268;8672.869906951528;8687.174718401742;8703.651853925772;7651.808704782425;7712.383009359126;7722.26638469367;7732.420068494773;7779.7666070017995;7795.688172473265;7807.765767026998;7873.881891771513;7887.605619718876;8129.065157506726;6595.571287866273;6798.878185099601;6845.657717114224;6974.128233970754;7041.647917604202;4763.16644587189;4805.9759701202665;4839.2983017462975;4883.145449546386;4958.826441074545;5099.107656160231;5138.665986710852;5190;5215.617861266692;5258.2375555544995 00:37:36 INFO - PROCESS | 13211 | |4;prototype.html;323.47112471109716;326.19755401711785;331.69318380498044;333.85654134589043;344.4093379853551;5061.367329083864;5113.440400677791;5119.488051194879;5193.376794784626;5204.9739751301195;5174.404943431507;5200.297959775429;5202.739863006854;5222.973885130569;5240.790368385269;4177.415161877339;4177.811998460076;4184.430838435586;4185.414042034117;4204.705670603059;4091.1817636472674;4161.126163505653;4166.562510936338;4189.581041895802;4194.832206711728;4121.1757648470275;4148.771817550033;4150.128473020669;4151;4158.480189976253;4087.6087488819076;4092.4475195848477;4103.7948102594755;4115.094679170577;4147.979260103711;3653.2510835278704;3658.4695219193336;3680.3191409589313;3680.871169509081;3688.5020522229424;4835.734034628094;5076.263941728465;5078.873028174326;5093.567046801027;5103.362079740033;4715.740634265114;4722.5513576210205;4723.94508388852;4736.158305016997;4737.857864264078;5299.33758280215;5425.159100339453;5441.945580544183;5451.509364157205;5460.235567020621;3911.765294082364;3978.9403158952637;3986.142979259473;3994.980025099856;3996.200759848013;5344.43883392246;5579.581531385122;5684.63049901755;5698.373178950312;5702.401247868997;4029.657479114308;4127.442795222607;4128.793560321972;4147.345698752801;4159.667226621924;4188.874333769992;4196.349565817303;4197.811098500575;4202.096549241927;4202.886235147688;4519.344695019204;4690.390249267573;4704.1767690654;4704.717716936994;4724.574788269072;5447.809326673548;5464.26232458621;5464.3442786865835;5467.4532546745;5476.945230547723;1434.784782282666;1448.8551144885428;1449.7970284160226;1450.789635502846;1453.62932452224;883.3639779358851;950.5627411390838;958.2573505533128;959.5729900194347;964.5611246882792;4698.224792909132;4715.269133284346;4717.764111794397;4724.834630787906;4754.643401744883;4920.3603531541385;4924.4090709115135;4924.7441902315395;4935.555799978019;4936.3829521309835;4700.482946875841;4709.905801884011;4712.787924543404;4739.952600473951;5026.773795179226;2943.190622578765;2988.701129886994;2988.9850550747105;2991.491446454108;2991.536311871663;5877;5877.764889404461;5883.499902508334;5890.352061273256;5907;5552.972700050504;5742.368339482654;5769.769209231584;5786.913196302059;5816.621919575214;5905.852353691106;5908.261467316585;5910.970445147746;5912.320083190488;5919.852003699856;5411.864703382447;5663.272701825983;5665.320161580472;5674.631148975303;5675.587875153126;5593.216949626974;5621.662700237999;5622;5646.689432081275;5647.29408823897;5626.774929002958;5726.685032323096;5805.274340707411;5939.613925094855;5946.959282125697;4037.798110094425;4044.170944956336;4057.594240575919;4062.8984275392168;4065.390191471303;5600.85997850057;5625.46558076982;5627.409122042127;5641.971790141023;5650.23721797552;5291.3385826771655;5477.603211181124;5502.80740174092;5507.862303442446;5531.474509921551;5484.917726234189;5488.204210389391;5499.1476321170285;5506.889862202814;5521.282233309644;5298.602604804578;5441.5374693151525;5451.946909730564;5454.036546843054;5484.753186106715;5556.444355564411;5576.553875690016;5578.246936663499;5589.5248903842;5591.245181900392;5348.679079255257;5369.731513424235;5382.67703937765;5395.649282796606;5450.563954883679 00:37:36 INFO - PROCESS | 13211 | |5;yui.html;686.9793906182815;717.4296434334703;771.0862627786074;780.6526095887332;793.0562630469742;15776.84223157768;16991.83008169918;17007.65984680307;17074.402395916146;17091.23089460974;14659.486917957873;14729.410823567072;14831.55505334839;14858;14895;662.2615783401496;685.4413652872918;776.1462391369505;798.7683571764196;810.0562844286429;784.7331907151568;802.4864086984335;802.7511471443842;805.0098378993812;807.4065561812064;861.9569021548929;862.7541150772031;864.394923553512;864.9005364383082;865.0786911938796;690.8618276344752;713.6681443128919;821.0229826506497;859.3168431097292;860.3977215948829;618.0759764152621;627.6359711367396;627.9120923070774;627.9434850863398;628;15104.320305586274;15134.772978405334;15151.696966060726;15153;15154.393824247018;13515.391807368693;13533.458661653522;13569.1858488491;13870.791938120936;13877.791833122512;11488.425578721031;11627.302361858316;11654.417279136094;11817.645470635895;11882.28706277626;4263.5736426357425;4268.338407546835;4336.046069864625;4360.21516127097;4386.210482113218;80039;80945.78581321285;81651.5917420415;82540;84964.57517712371;10161.695149145537;10217.1826253901;10240.897591024144;10289.845652315222;10658.094062004662;21363.572728545343;21407.46481337948;21419.57160856774;21421.571568568543;21460.356189314032;8242.134575869448;8246.587670616445;8453.408261421764;8609.5695215239;8660.826783464296;4442.244818380883;4609.101225261042;4742.881427964328;4778.235482322882;4900.460949295574;3503.5270238517473;3582.5163602913794;3590.7486475946957;3595.7662751921566;3604.3692353837973;602.6384169498266;616.9413905678954;641.6150309814075;643.0996604753383;643.2184895352076;554.3984776517524;572.8453317604307;591.4440425999546;599.9700014999232;623.9001759718424;8799.956000220085;9136.954315228515;9218.492982886006;9253.103993083972;9312.580933857993;616;628.9308176100625;701.5475018613068;759.8746206875915;766.325633442567;4256.638185754246;4466.9106617867465;4487.865364039084;4534.954650453453;4721.5750582447745;65758.34241657618;82132.58933705294;106762.46618766857;108641.82740305904;108657.45671271592;89993;90353.54823225841;92445.53777231071;93542;95084.52457737667;73564.63217683985;74261;74974.25025749672;76073;76917.23082769212;8964.955175224082;9013.774655633662;9287.6284948604;9608;9694.418334899929;50324.24513632372;51152.23271650854;51222.74388628033;51930.74034629803;53878.461215387346;43677;70766;71718.64140679264;71724;72599;11968.16222864391;12199.390030498262;12323.876761232274;12489.375531223584;12502.624921252376;13547.25490098054;13586.796198057235;14106.153630782186;14139.575812725634;14680.192589407257;12992.480300787862;13621.591352259447;13682.384292706653;13964.2319672419;14022.439102435788;12958.481660733465;13380.598582042554;13639.454421823017;13820.792688109485;14061.437542498596;11868.703282418008;11990.460429280878;12486.313252771184;12624.305663188245;12807.871921280668;10366.585336586753;10643.201759867887;10790.460476976277;10936.398498082683;10939.945300273448;10051;10241.641542545975;10494.632687855888;11506.367149806507;11767.411629418666 00:37:36 INFO - PROCESS | 13211 | __end_tp_report 00:37:36 INFO - PROCESS | 13211 | __start_cc_report 00:37:36 INFO - PROCESS | 13211 | _x_x_mozilla_cycle_collect,1180 00:37:36 INFO - PROCESS | 13211 | __end_cc_report 00:37:36 INFO - PROCESS | 13211 | __startTimestamp1475221056842__endTimestamp 00:37:36 INFO - PROCESS | 13211 | 00:37:36 INFO - PROCESS | 13211 | ------- Summary: start ------- 00:37:36 INFO - PROCESS | 13211 | Number of tests: 6 00:37:36 INFO - PROCESS | 13211 | 00:37:36 INFO - PROCESS | 13211 | [#0] dojo.html Cycles:165 Average:5273.12 Median:5467.32 stddev:589.27 (10.8%) stddev-sans-first:563.90 00:37:36 INFO - PROCESS | 13211 | Values: 3018.4 3055.4 3059.4 3087.5 3107.3 5179.8 5197.6 5259.4 5289.6 5307.2 5238.8 5299.9 5350.3 5388.0 5449.3 4734.6 4784.1 4797.5 4810.1 4847.9 4877.5 4885.2 4915.0 4927.1 4963.7 4718.4 4735.8 4824.6 4874.5 4910.8 4874.4 4937.2 4942.0 4953.5 4955.7 4819.7 4829.7 4854.8 4860.7 4905.4 5120.9 5302.1 5302.9 5311.2 5315.3 5454.5 5537.8 5541.4 5609.5 5615.2 5641.7 5659.0 5660.8 5663.6 5717.3 5293.4 5306.5 5308.4 5309.6 5362.1 5613.5 5616.6 5680.0 5748.2 5764.5 5525.7 5568.7 5571.1 5579.6 5587.1 5595.3 5598.9 5601.9 5611.5 5615.7 5665.7 5723.1 5723.7 5733.1 5736.3 5654.0 5654.1 5658.5 5662.8 5685.1 4242.2 4357.5 4358.7 4363.0 4416.4 3801.5 3869.4 3886.8 3931.4 3973.1 5431.8 5461.0 5474.5 5523.8 5532.8 5726.3 5728.2 5741.0 5750.8 5753.5 5207.6 5231.9 5325.8 5453.9 5464.8 4910.0 4961.8 4962.3 5011.3 5019.7 5920.8 5928.4 5930.3 5933.8 5946.1 5562.1 5645.4 5668.0 5669.5 5739.1 5818.7 5867.2 5912.0 5917.1 6019.1 5552.7 5598.6 5603.4 5604.6 5613.2 5638.4 5694.0 5696.5 5703.6 5711.3 5315.5 5340.0 5463.4 5496.4 5519.2 5532.1 5534.9 5540.6 5540.7 5593.1 5459.5 5464.1 5464.6 5467.3 5535.8 5415.9 5457.2 5525.1 5539.6 5551.0 5438.3 5481.1 5494.2 5543.4 5549.9 00:37:36 INFO - PROCESS | 13211 | 00:37:36 INFO - PROCESS | 13211 | [#1] ext.html Cycles:180 Average:61144.95 Median:23435.11 stddev:124600.85 (531.7%) stddev-sans-first:124867.36 00:37:36 INFO - PROCESS | 13211 | Values: 560.1 593.1 604.2 605.5 609.1 31501.4 41970.6 43232.6 43281.6 43320.6 43946.0 44502.6 44509.6 44583.1 44605.3 8851.9 9009.9 9016.8 9019.6 9020.4 8829.4 8925.4 8926.8 8927.4 8929.5 8971.7 9048.3 9058.6 9060.8 9065.6 8975.4 9015.8 9018.5 9018.8 9022.6 8857.9 8911.7 8933.7 8942.8 8944.3 42663.0 42805.6 42963.6 43056.0 43115.4 3463.2 3502.5 3562.9 3607.9 3648.7 31206.0 31512.5 32028.8 32280.7 32964.5 4155.6 4207.2 4331.5 4412.2 4537.4 352180.0 353674.0 354244.0 354822.0 355775.0 48819.8 50026.5 56235.7 56553.0 56595.7 57990.7 59464.4 59968.7 63743.7 64591.7 15171.9 15331.5 15336.9 15337.1 15352.2 11836.7 11892.8 11911.5 11928.2 11932.8 14627.0 14977.6 15475.8 15954.4 16013.0 5920.9 5966.7 6004.7 6056.3 6186.9 944.7 969.4 1017.6 1071.6 1080.7 30503.1 31040.4 31526.4 31674.2 32115.3 1074.8 1075.4 1093.6 1164.3 1183.8 15039.9 16011.6 16026.2 16059.7 16275.7 543658.0 546921.0 547261.0 547780.0 547945.0 54981.2 55036.0 55176.0 55181.0 55227.0 1312.3 1335.4 1357.4 1364.4 1391.1 28199.0 29346.9 29869.0 29880.9 30437.4 47622.8 47869.0 47910.3 48000.5 48026.0 482229.0 484555.0 484699.0 485365.0 485625.0 24348.1 24537.9 25118.9 27104.3 27491.5 44909.8 45001.0 45045.5 45623.3 46614.9 38668.0 39466.6 40284.4 41222.8 41311.8 39100.6 39459.8 40253.2 40270.4 41616.6 38986.2 40291.0 40818.6 40948.6 43192.6 31389.7 35560.8 36315.5 36630.5 36890.4 27917.7 27966.4 28018.7 28260.3 28291.9 00:37:36 INFO - PROCESS | 13211 | 00:37:36 INFO - PROCESS | 13211 | [#2] jquery.html Cycles:180 Average:26471.61 Median:20104.19 stddev:69266.82 (344.5%) stddev-sans-first:69433.44 00:37:36 INFO - PROCESS | 13211 | Values: 383.3 386.6 393.4 400.4 419.2 14081.6 16165.6 17763.2 19505.2 19518.1 14416.9 14477.1 17391.4 17657.0 17949.3 5394.9 5843.7 5876.2 5881.3 5885.8 5643.4 5711.6 5861.7 5875.7 5876.9 5778.3 5806.8 5819.2 5821.2 5821.6 5574.7 5723.2 5792.2 5792.6 5793.7 5147.0 5148.2 5153.3 5155.6 5159.4 16833.0 20556.2 21224.6 21266.7 21975.9 2097.0 2188.7 2342.9 2790.1 2839.9 9982.0 10266.5 10318.6 10726.7 14103.7 1890.1 1892.1 1916.4 1920.0 1924.4 81918.2 82193.0 82321.6 84471.6 86655.1 10386.4 10472.4 10473.2 10635.4 10788.6 15474.8 15502.9 15509.6 15521.5 15611.5 6663.2 7021.6 7136.0 7233.6 7417.3 7302.4 7392.5 7461.5 7597.7 7600.8 4660.6 4688.2 4692.1 4755.9 4880.2 1876.6 1950.9 1959.6 2050.8 2074.8 875.8 932.6 956.6 972.0 1071.4 17311.5 18536.8 18682.5 18812.7 19173.9 954.3 963.1 984.7 1009.8 1024.6 10309.9 10537.8 10591.7 10605.9 10715.2 405682.0 417048.0 420603.0 421044.0 422092.0 85267.0 87230.6 87531.6 88604.0 90800.5 933.4 950.6 963.8 973.9 977.3 15825.9 15922.2 15984.2 16877.7 17052.2 38389.0 39815.0 41791.0 41923.0 42917.1 42085.0 54982.5 58690.0 60100.7 62120.7 8170.8 8214.5 8515.4 8542.2 8813.9 10741.8 12488.4 12771.1 12904.9 12932.7 10261.5 10624.3 10822.9 10836.7 11516.4 10441.8 10691.9 10859.8 10964.0 11264.7 10976.5 11288.3 11340.7 11860.1 11966.4 8460.4 8567.5 8622.1 8632.7 8775.2 10799.4 11046.4 11318.8 11458.4 11542.1 00:37:36 INFO - PROCESS | 13211 | 00:37:36 INFO - PROCESS | 13211 | [#3] mootools.html Cycles:180 Average:5871.04 Median:4671.36 stddev:3446.23 (73.8%) stddev-sans-first:3439.90 00:37:36 INFO - PROCESS | 13211 | Values: 1452.1 1498.9 1615.2 1697.4 1777.2 7946.9 8179.0 8531.4 9215.4 9224.1 8565.9 8847.6 8853.2 9097.4 9097.5 2297.8 2311.6 2325.4 2326.9 2327.6 1975.0 2033.9 2310.2 2314.3 2364.7 2248.5 2322.9 2339.3 2343.9 2344.0 2304.4 2305.1 2308.3 2342.3 2349.3 2328.2 2335.8 2343.7 2348.6 2350.7 9183.1 9232.5 9298.0 9303.3 9314.9 5021.2 5152.5 5158.1 5180.7 5181.4 3251.1 3377.2 3477.4 3482.0 3513.6 1060.5 1097.5 1113.8 1119.6 1145.9 12535.1 12682.3 12732.0 12737.7 12746.8 4355.8 4572.1 4678.7 4740.6 4752.4 10631.4 10644.3 10644.9 10650.3 10655.5 5093.3 5127.5 5129.6 5137.8 5140.2 4554.8 4644.9 4650.5 4665.5 4677.2 3888.9 3914.7 4003.3 4019.4 4029.7 1145.4 1178.3 1214.6 1257.3 1260.8 822.1 838.0 903.8 933.0 936.6 5675.0 5695.8 5874.9 6060.8 6166.2 945.0 945.9 955.5 956.8 984.2 3765.2 3802.3 3807.2 3891.2 3899.3 10907.6 11131.9 11351.8 11439.5 11600.5 11302.9 11303.0 11305.9 11311.3 11333.7 8221.3 8547.8 8669.7 8671.3 8673.5 5568.4 5655.3 5656.2 5704.6 5891.9 10445.5 10499.2 10566.1 10615.9 10771.1 10157.1 10635.9 10654.1 10724.1 10949.3 8030.7 8153.3 8158.0 8165.4 8204.5 8483.4 8642.6 8672.9 8687.2 8703.7 7651.8 7712.4 7722.3 7732.4 7779.8 7795.7 7807.8 7873.9 7887.6 8129.1 6595.6 6798.9 6845.7 6974.1 7041.6 4763.2 4806.0 4839.3 4883.1 4958.8 5099.1 5138.7 5190.0 5215.6 5258.2 00:37:36 INFO - PROCESS | 13211 | 00:37:36 INFO - PROCESS | 13211 | [#4] prototype.html Cycles:180 Average:4599.52 Median:5108.40 stddev:1332.34 (26.1%) stddev-sans-first:1296.85 00:37:36 INFO - PROCESS | 13211 | Values: 323.5 326.2 331.7 333.9 344.4 5061.4 5113.4 5119.5 5193.4 5205.0 5174.4 5200.3 5202.7 5223.0 5240.8 4177.4 4177.8 4184.4 4185.4 4204.7 4091.2 4161.1 4166.6 4189.6 4194.8 4121.2 4148.8 4150.1 4151.0 4158.5 4087.6 4092.4 4103.8 4115.1 4148.0 3653.3 3658.5 3680.3 3680.9 3688.5 4835.7 5076.3 5078.9 5093.6 5103.4 4715.7 4722.6 4723.9 4736.2 4737.9 5299.3 5425.2 5441.9 5451.5 5460.2 3911.8 3978.9 3986.1 3995.0 3996.2 5344.4 5579.6 5684.6 5698.4 5702.4 4029.7 4127.4 4128.8 4147.3 4159.7 4188.9 4196.3 4197.8 4202.1 4202.9 4519.3 4690.4 4704.2 4704.7 4724.6 5447.8 5464.3 5464.3 5467.5 5476.9 1434.8 1448.9 1449.8 1450.8 1453.6 883.4 950.6 958.3 959.6 964.6 4698.2 4715.3 4717.8 4724.8 4754.6 4920.4 4924.4 4924.7 4935.6 4936.4 4700.5 4709.9 4712.8 4740.0 5026.8 2943.2 2988.7 2989.0 2991.5 2991.5 5877.0 5877.8 5883.5 5890.4 5907.0 5553.0 5742.4 5769.8 5786.9 5816.6 5905.9 5908.3 5911.0 5912.3 5919.9 5411.9 5663.3 5665.3 5674.6 5675.6 5593.2 5621.7 5622.0 5646.7 5647.3 5626.8 5726.7 5805.3 5939.6 5947.0 4037.8 4044.2 4057.6 4062.9 4065.4 5600.9 5625.5 5627.4 5642.0 5650.2 5291.3 5477.6 5502.8 5507.9 5531.5 5484.9 5488.2 5499.1 5506.9 5521.3 5298.6 5441.5 5451.9 5454.0 5484.8 5556.4 5576.6 5578.2 5589.5 5591.2 5348.7 5369.7 5382.7 5395.6 5450.6 00:37:36 INFO - PROCESS | 13211 | 00:37:36 INFO - PROCESS | 13211 | [#5] yui.html Cycles:180 Average:19538.69 Median:4732.23 stddev:27251.44 (575.9%) stddev-sans-first:27291.12 00:37:36 INFO - PROCESS | 13211 | Values: 687.0 717.4 771.1 780.7 793.1 15776.8 16991.8 17007.7 17074.4 17091.2 14659.5 14729.4 14831.6 14858.0 14895.0 662.3 685.4 776.1 798.8 810.1 784.7 802.5 802.8 805.0 807.4 862.0 862.8 864.4 864.9 865.1 690.9 713.7 821.0 859.3 860.4 618.1 627.6 627.9 627.9 628.0 15104.3 15134.8 15151.7 15153.0 15154.4 13515.4 13533.5 13569.2 13870.8 13877.8 11488.4 11627.3 11654.4 11817.6 11882.3 4263.6 4268.3 4336.0 4360.2 4386.2 80039.0 80945.8 81651.6 82540.0 84964.6 10161.7 10217.2 10240.9 10289.8 10658.1 21363.6 21407.5 21419.6 21421.6 21460.4 8242.1 8246.6 8453.4 8609.6 8660.8 4442.2 4609.1 4742.9 4778.2 4900.5 3503.5 3582.5 3590.7 3595.8 3604.4 602.6 616.9 641.6 643.1 643.2 554.4 572.8 591.4 600.0 623.9 8800.0 9137.0 9218.5 9253.1 9312.6 616.0 628.9 701.5 759.9 766.3 4256.6 4466.9 4487.9 4535.0 4721.6 65758.3 82132.6 106762.5 108641.8 108657.5 89993.0 90353.5 92445.5 93542.0 95084.5 73564.6 74261.0 74974.3 76073.0 76917.2 8965.0 9013.8 9287.6 9608.0 9694.4 50324.2 51152.2 51222.7 51930.7 53878.5 43677.0 70766.0 71718.6 71724.0 72599.0 11968.2 12199.4 12323.9 12489.4 12502.6 13547.3 13586.8 14106.2 14139.6 14680.2 12992.5 13621.6 13682.4 13964.2 14022.4 12958.5 13380.6 13639.5 13820.8 14061.4 11868.7 11990.5 12486.3 12624.3 12807.9 10366.6 10643.2 10790.5 10936.4 10939.9 10051.0 10241.6 10494.6 11506.4 11767.4 00:37:36 INFO - PROCESS | 13211 | -------- Summary: end -------- 00:37:36 INFO - PROCESS | 13211 | 00:37:37 INFO - TEST-INFO | 13211: exit 0 00:37:37 INFO - TEST-OK | dromaeo_css | took 1115876ms 00:37:37 INFO - TEST-START | kraken 00:37:37 INFO - operating with platform_type : linux_ 00:37:37 INFO - Initialising browser for kraken test... 00:37:37 INFO - TEST-INFO | started process 13521 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGZcDV5/profile http://localhost:34283/getInfo.html) 00:37:41 INFO - PROCESS | 13521 | __metrics Screen width/height:1600/1200 00:37:41 INFO - PROCESS | 13521 | colorDepth:24 00:37:41 INFO - PROCESS | 13521 | Browser inner width/height: 1024/697 00:37:41 INFO - PROCESS | 13521 | __metrics 00:37:42 INFO - PROCESS | 13521 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:37:42 INFO - PROCESS | 13521 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:37:42 INFO - PROCESS | 13521 | console.error: PushService: 00:37:42 INFO - PROCESS | 13521 | stateChangeProcessEnqueue: Error transitioning state 00:37:42 INFO - PROCESS | 13521 | UnknownError 00:37:43 INFO - TEST-INFO | 13521: exit 0 00:37:43 INFO - Browser initialized. 00:37:43 INFO - Running cycle 1/1 for kraken test... 00:37:43 INFO - TEST-INFO | started process 13606 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGZcDV5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:37:55 INFO - PROCESS | 13606 | RSS: Main: 173969408 00:37:55 INFO - PROCESS | 13606 | 00:37:58 INFO - PROCESS | 13606 | Cycle 1(1): loaded http://localhost:34283/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34283/tests/kraken/driver.html?testName=audio-beat-detection) 00:37:59 INFO - PROCESS | 13606 | RSS: Main: 232808448 00:37:59 INFO - PROCESS | 13606 | 00:38:01 INFO - PROCESS | 13606 | Cycle 1(1): loaded http://localhost:34283/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34283/tests/kraken/driver.html?testName=audio-dft) 00:38:02 INFO - PROCESS | 13606 | RSS: Main: 217210880 00:38:02 INFO - PROCESS | 13606 | 00:38:05 INFO - PROCESS | 13606 | Cycle 1(1): loaded http://localhost:34283/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34283/tests/kraken/driver.html?testName=audio-fft) 00:38:05 INFO - PROCESS | 13606 | RSS: Main: 298528768 00:38:05 INFO - PROCESS | 13606 | 00:38:08 INFO - PROCESS | 13606 | Cycle 1(1): loaded http://localhost:34283/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34283/tests/kraken/driver.html?testName=audio-oscillator) 00:38:08 INFO - PROCESS | 13606 | RSS: Main: 209252352 00:38:08 INFO - PROCESS | 13606 | 00:38:10 INFO - PROCESS | 13606 | Cycle 1(1): loaded http://localhost:34283/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34283/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:38:11 INFO - PROCESS | 13606 | RSS: Main: 212480000 00:38:11 INFO - PROCESS | 13606 | 00:38:14 INFO - PROCESS | 13606 | Cycle 1(1): loaded http://localhost:34283/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34283/tests/kraken/driver.html?testName=imaging-darkroom) 00:38:15 INFO - PROCESS | 13606 | RSS: Main: 249618432 00:38:15 INFO - PROCESS | 13606 | 00:38:18 INFO - PROCESS | 13606 | Cycle 1(1): loaded http://localhost:34283/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34283/tests/kraken/driver.html?testName=imaging-desaturate) 00:38:18 INFO - PROCESS | 13606 | RSS: Main: 249151488 00:38:18 INFO - PROCESS | 13606 | 00:38:21 INFO - PROCESS | 13606 | Cycle 1(1): loaded http://localhost:34283/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34283/tests/kraken/driver.html?testName=json-parse-financial) 00:38:22 INFO - PROCESS | 13606 | RSS: Main: 248479744 00:38:22 INFO - PROCESS | 13606 | 00:38:23 INFO - PROCESS | 13606 | Cycle 1(1): loaded http://localhost:34283/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34283/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:38:24 INFO - PROCESS | 13606 | RSS: Main: 210776064 00:38:24 INFO - PROCESS | 13606 | 00:38:26 INFO - PROCESS | 13606 | Cycle 1(1): loaded http://localhost:34283/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34283/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:38:26 INFO - PROCESS | 13606 | RSS: Main: 217276416 00:38:26 INFO - PROCESS | 13606 | 00:38:28 INFO - PROCESS | 13606 | Cycle 1(1): loaded http://localhost:34283/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34283/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:38:29 INFO - PROCESS | 13606 | RSS: Main: 222306304 00:38:29 INFO - PROCESS | 13606 | 00:38:32 INFO - PROCESS | 13606 | Cycle 1(1): loaded http://localhost:34283/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:38:32 INFO - PROCESS | 13606 | RSS: Main: 224157696 00:38:32 INFO - PROCESS | 13606 | 00:38:35 INFO - PROCESS | 13606 | Cycle 1(1): loaded http://localhost:34283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:38:36 INFO - PROCESS | 13606 | RSS: Main: 221769728 00:38:36 INFO - PROCESS | 13606 | 00:38:37 INFO - PROCESS | 13606 | Cycle 1(1): loaded http://localhost:34283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34283/tests/kraken/driver.html?testName=ai-astar) 00:38:37 INFO - PROCESS | 13606 | RSS: Main: 273231872 00:38:37 INFO - PROCESS | 13606 | 00:38:37 INFO - PROCESS | 13606 | __start_tp_report 00:38:37 INFO - PROCESS | 13606 | _x_x_mozilla_page_load 00:38:37 INFO - PROCESS | 13606 | _x_x_mozilla_page_load_details 00:38:37 INFO - PROCESS | 13606 | |i|pagename|runs| 00:38:37 INFO - PROCESS | 13606 | |0;ai-astar;108;111;111;111;111;110;110;110;112;111 00:38:37 INFO - PROCESS | 13606 | |1;audio-beat-detection;150;121;117;170;120;119;117;122;160;120 00:38:37 INFO - PROCESS | 13606 | |2;audio-dft;160;160;160;159;160;161;161;161;161;160 00:38:37 INFO - PROCESS | 13606 | |3;audio-fft;74;75;75;121;76;76;76;75;116;76 00:38:37 INFO - PROCESS | 13606 | |4;audio-oscillator;82;81;120;83;83;82;108;84;84;110 00:38:37 INFO - PROCESS | 13606 | |5;imaging-gaussian-blur;116;116;116;117;116;117;117;116;117;117 00:38:37 INFO - PROCESS | 13606 | |6;imaging-darkroom;147;145;150;145;146;147;146;146;146;145 00:38:37 INFO - PROCESS | 13606 | |7;imaging-desaturate;96;95;95;95;95;95;95;95;96;95 00:38:37 INFO - PROCESS | 13606 | |8;json-parse-financial;52;51;51;50;52;52;51;52;51;52 00:38:37 INFO - PROCESS | 13606 | |9;json-stringify-tinderbox;60;60;59;60;59;60;60;59;59;61 00:38:37 INFO - PROCESS | 13606 | |10;stanford-crypto-aes;80;79;78;78;86;79;78;80;78;78 00:38:37 INFO - PROCESS | 13606 | |11;stanford-crypto-ccm;132;127;121;122;126;127;134;123;171;123 00:38:37 INFO - PROCESS | 13606 | |12;stanford-crypto-pbkdf2;163;168;166;167;165;163;162;160;165;165 00:38:37 INFO - PROCESS | 13606 | |13;stanford-crypto-sha256-iterative;63;64;68;64;65;66;65;65;63;64 00:38:37 INFO - PROCESS | 13606 | __end_tp_report 00:38:37 INFO - PROCESS | 13606 | __start_cc_report 00:38:37 INFO - PROCESS | 13606 | _x_x_mozilla_cycle_collect,1599 00:38:37 INFO - PROCESS | 13606 | __end_cc_report 00:38:37 INFO - PROCESS | 13606 | __startTimestamp1475221117963__endTimestamp 00:38:37 INFO - PROCESS | 13606 | 00:38:37 INFO - PROCESS | 13606 | ------- Summary: start ------- 00:38:37 INFO - PROCESS | 13606 | Number of tests: 14 00:38:37 INFO - PROCESS | 13606 | 00:38:37 INFO - PROCESS | 13606 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:1.08 (1.0%) stddev-sans-first:0.67 00:38:37 INFO - PROCESS | 13606 | Values: 108.0 111.0 111.0 111.0 111.0 110.0 110.0 110.0 112.0 111.0 00:38:37 INFO - PROCESS | 13606 | 00:38:37 INFO - PROCESS | 13606 | [#1] audio-beat-detection Cycles:10 Average:131.60 Median:121.50 stddev:20.22 (16.6%) stddev-sans-first:20.32 00:38:37 INFO - PROCESS | 13606 | Values: 150.0 121.0 117.0 170.0 120.0 119.0 117.0 122.0 160.0 120.0 00:38:37 INFO - PROCESS | 13606 | 00:38:37 INFO - PROCESS | 13606 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.50 stddev:0.67 (0.4%) stddev-sans-first:0.71 00:38:37 INFO - PROCESS | 13606 | Values: 160.0 160.0 160.0 159.0 160.0 161.0 161.0 161.0 161.0 160.0 00:38:37 INFO - PROCESS | 13606 | 00:38:37 INFO - PROCESS | 13606 | [#3] audio-fft Cycles:10 Average:84.00 Median:75.50 stddev:18.23 (24.1%) stddev-sans-first:18.98 00:38:37 INFO - PROCESS | 13606 | Values: 74.0 75.0 75.0 121.0 76.0 76.0 76.0 75.0 116.0 76.0 00:38:37 INFO - PROCESS | 13606 | 00:38:37 INFO - PROCESS | 13606 | [#4] audio-oscillator Cycles:10 Average:91.70 Median:82.50 stddev:14.81 (18.0%) stddev-sans-first:15.29 00:38:37 INFO - PROCESS | 13606 | Values: 82.0 81.0 120.0 83.0 83.0 82.0 108.0 84.0 84.0 110.0 00:38:37 INFO - PROCESS | 13606 | 00:38:37 INFO - PROCESS | 13606 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 00:38:37 INFO - PROCESS | 13606 | Values: 116.0 116.0 116.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 00:38:37 INFO - PROCESS | 13606 | 00:38:37 INFO - PROCESS | 13606 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:1.49 (1.0%) stddev-sans-first:1.56 00:38:37 INFO - PROCESS | 13606 | Values: 147.0 145.0 150.0 145.0 146.0 147.0 146.0 146.0 146.0 145.0 00:38:37 INFO - PROCESS | 13606 | 00:38:37 INFO - PROCESS | 13606 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 00:38:37 INFO - PROCESS | 13606 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 00:38:37 INFO - PROCESS | 13606 | 00:38:37 INFO - PROCESS | 13606 | [#8] json-parse-financial Cycles:10 Average:51.40 Median:52.00 stddev:0.70 (1.3%) stddev-sans-first:0.71 00:38:37 INFO - PROCESS | 13606 | Values: 52.0 51.0 51.0 50.0 52.0 52.0 51.0 52.0 51.0 52.0 00:38:37 INFO - PROCESS | 13606 | 00:38:37 INFO - PROCESS | 13606 | [#9] json-stringify-tinderbox Cycles:10 Average:59.70 Median:60.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 00:38:37 INFO - PROCESS | 13606 | Values: 60.0 60.0 59.0 60.0 59.0 60.0 60.0 59.0 59.0 61.0 00:38:37 INFO - PROCESS | 13606 | 00:38:37 INFO - PROCESS | 13606 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:79.00 stddev:2.46 (3.1%) stddev-sans-first:2.60 00:38:37 INFO - PROCESS | 13606 | Values: 80.0 79.0 78.0 78.0 86.0 79.0 78.0 80.0 78.0 78.0 00:38:37 INFO - PROCESS | 13606 | 00:38:37 INFO - PROCESS | 13606 | [#11] stanford-crypto-ccm Cycles:10 Average:130.60 Median:127.00 stddev:14.81 (11.7%) stddev-sans-first:15.70 00:38:37 INFO - PROCESS | 13606 | Values: 132.0 127.0 121.0 122.0 126.0 127.0 134.0 123.0 171.0 123.0 00:38:37 INFO - PROCESS | 13606 | 00:38:37 INFO - PROCESS | 13606 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.40 Median:165.00 stddev:2.41 (1.5%) stddev-sans-first:2.51 00:38:37 INFO - PROCESS | 13606 | Values: 163.0 168.0 166.0 167.0 165.0 163.0 162.0 160.0 165.0 165.0 00:38:37 INFO - PROCESS | 13606 | 00:38:37 INFO - PROCESS | 13606 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:65.00 stddev:1.49 (2.3%) stddev-sans-first:1.45 00:38:37 INFO - PROCESS | 13606 | Values: 63.0 64.0 68.0 64.0 65.0 66.0 65.0 65.0 63.0 64.0 00:38:37 INFO - PROCESS | 13606 | -------- Summary: end -------- 00:38:37 INFO - PROCESS | 13606 | 00:38:39 INFO - TEST-INFO | 13606: exit 0 00:38:39 INFO - TEST-OK | kraken | took 61490ms 00:38:39 INFO - SUITE-END | took 1177s 00:38:39 INFO - Completed test suite (00:19:37) 00:38:39 INFO - javascript benchmark 00:38:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3018.3812318474716, 3055.4041961817456, 3059.418710445015, 3087.536869469581, 3107.269791598974, 5179.766910489027, 5197.558207552358, 5259.421463639006, 5289.5503882170015, 5307.230451584523, 5238.842834714955, 5299.947000529994, 5350.250964864922, 5387.973060134694, 5449.291592093023, 4734.597559207472, 4784.091022705692, 4797.544233297831, 4810.134175848346, 4847.878803029917, 4877.537681672809, 4885.193942999401, 4915.0, 4927.088488629597, 4963.726995015273, 4718.363020992157, 4735.810567577293, 4824.565789079, 4874.512548745132, 4910.803567857281, 4874.366332376804, 4937.23472861707, 4942.0, 4953.529414705597, 4955.653104282702, 4819.662623616348, 4829.710217386968, 4854.7572621369145, 4860.684055536379, 4905.411350637911, 5120.897582048376, 5302.125149350352, 5302.893942121136, 5311.176767601028, 5315.282436871012, 5454.4545545445535, 5537.750801213955, 5541.390447050821, 5609.52319052881, 5615.185798059259, 5641.68970706611, 5658.971705141489, 5660.773569057233, 5663.631863928873, 5717.313922329306, 5293.444188360205, 5306.469353064701, 5308.442613525602, 5309.601779866487, 5362.088444964365, 5613.522850557748, 5616.550675945915, 5680.034394153004, 5748.166515855178, 5764.452377024176, 5525.668459892419, 5568.693721845257, 5571.052921003439, 5579.581531385163, 5587.0502014656795, 5595.272614560081, 5598.86002849932, 5601.8599535011135, 5611.466910643482, 5615.719214039282, 5665.688387138747, 5723.141528770718, 5723.656580605094, 5733.111367738007, 5736.282964629421, 5654.038813401731, 5654.095344744821, 5658.462446067617, 5662.801801936995, 5685.147227915846, 4242.193983143193, 4357.542458041923, 4358.65130789536, 4363.0, 4416.4258646375765, 3801.486799282117, 3869.438931354994, 3886.7862267575556, 3931.4495970564144, 3973.0663294125857, 5431.755570999315, 5461.044317244467, 5474.452554744574, 5523.7790488380015, 5532.75102620383, 5726.284214473191, 5728.169415434739, 5741.0, 5750.7987220447085, 5753.51095156908, 5207.635465517453, 5231.895362092737, 5325.760340784674, 5453.890922181534, 5464.808731694372, 4910.0, 4961.801527938842, 4962.305277261186, 5011.273365362002, 5019.698818070928, 5920.763169473259, 5928.3775203603, 5930.2587176602065, 5933.792317268875, 5946.10808378738, 5562.110062389998, 5645.40723224072, 5668.03643380618, 5669.54643628517, 5739.053056245672, 5818.738156782871, 5867.178594996619, 5911.970440147772, 5917.053271476543, 6019.127226552037, 5552.743621043773, 5598.552115830642, 5603.35561410443, 5604.635698679573, 5613.242212301287, 5638.436156384329, 5693.971530142323, 5696.458836410535, 5703.600747947769, 5711.257536520226, 5315.468453154654, 5339.973300133474, 5463.399026107205, 5496.367917689517, 5519.172124181405, 5532.08720561119, 5534.861628459321, 5540.556755459473, 5540.69526176048, 5593.133064375028, 5459.454054594509, 5464.098423760035, 5464.590155738415, 5467.316585426822, 5535.833924982257, 5415.891682166413, 5457.208704737712, 5525.0883604204855, 5539.612227144061, 5551.0, 5438.265834112344, 5481.123020316731, 5494.1758736189895, 5543.417941116286, 5549.944500554942], "value": 5233.738776199094, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.0599780543872, 593.0599999001582, 604.2054698072033, 605.4823126227074, 609.1198218574161, 31501.369972600532, 41970.58029419705, 43232.56767432325, 43281.567184328145, 43320.56679433209, 43946.0, 44502.55497445024, 44509.554904450946, 44583.108337833226, 44605.33092003623, 8851.867221991659, 9009.909900900973, 9016.774580635503, 9019.639214431414, 9020.41367311126, 8829.381943263974, 8925.419847709878, 8926.821463570725, 8927.41971771836, 8929.464232146092, 8971.730848074569, 9048.276137908952, 9058.637654493812, 9060.77348066297, 9065.637374505044, 8975.416597921147, 9015.81968360629, 9018.503982280972, 9018.819623607491, 9022.639094436214, 8857.911420885774, 8911.688090916852, 8933.6873209438, 8942.776430589221, 8944.28445724347, 42663.0, 42805.57194428047, 42963.57036429627, 43056.0, 43115.35326970098, 3463.2034632034774, 3502.509648649191, 3562.8574857005688, 3607.9458808117897, 3648.7081033517256, 31206.0, 31512.527312090107, 32028.836251287416, 32280.677193228003, 32964.50553241703, 4155.605217504332, 4207.221663992141, 4331.480222373335, 4412.249917513998, 4537.3647689323525, 352180.0, 353674.0, 354244.0, 354822.0, 355775.0, 48819.75590122027, 50026.49973500219, 56235.71882140563, 56553.0, 56595.71702141463, 57990.710046449494, 59464.40535594675, 59968.70015649894, 63743.68128159329, 64591.67704161543, 15171.924140379228, 15331.540053798404, 15336.923315383352, 15337.079775213522, 15352.23238838076, 11836.70408239801, 11892.762144757056, 11911.52353905834, 11928.224665396721, 11932.821007684892, 14627.0, 14977.550673479813, 15475.767863482057, 15954.441594544136, 16013.0, 5920.875033743575, 5966.703973139332, 6004.729787159588, 6056.273247210363, 6186.876262474725, 944.7354740672623, 969.3795970578835, 1017.5573625472795, 1071.5553045486192, 1080.68660088575, 30503.084907452812, 31040.379192416025, 31526.36947261042, 31674.208144796565, 32115.34327522496, 1074.790415868898, 1075.3762817565794, 1093.5953697131954, 1164.2606944590245, 1183.7810005149074, 15039.924800375928, 16011.563574739663, 16026.19869006545, 16059.678806423806, 16275.674486510203, 543658.0, 546921.0, 547261.0, 547780.0, 547945.0, 54981.175282370794, 55036.0, 55176.0, 55181.0, 55227.0, 1312.2913626641698, 1335.4391155714623, 1357.4027427931678, 1364.4337599895932, 1391.1027387335112, 28199.0, 29346.853265733534, 29869.0, 29880.85059574775, 30437.391252175275, 47622.761886191736, 47869.0, 47910.28134577914, 48000.51999479961, 48026.0, 482229.0, 484555.0, 484699.0, 485365.0, 485625.0, 24348.147814826396, 24537.877310613334, 25118.874405627856, 27104.32239194036, 27491.450170996868, 44909.775451122536, 45001.0, 45045.54954450545, 45623.31565026593, 46614.87236403925, 38668.0064589989, 39466.605333946296, 40284.3957340646, 41222.79388603038, 41311.793441032605, 39100.608993910835, 39459.80270098746, 40253.19493610053, 40270.39594406028, 41616.58383416127, 38986.2202755949, 40291.0, 40818.591814081476, 40948.590514094474, 43192.56807431886, 31389.686103138676, 35560.82219588989, 36315.45526817047, 36630.45054324134, 36890.44664329984, 27917.72082279151, 27966.440671186054, 28018.71981280161, 28260.293492662848, 28291.858540707166], "value": 19572.115283197414, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.2947376826638, 386.57476775546917, 393.38828122269877, 400.39740191012527, 419.1533103131672, 14081.64795880101, 16165.595860103504, 17763.20065597048, 19505.219791208354, 19518.121684524194, 14416.855831441682, 14477.131372117654, 17391.39130130446, 17657.028863412506, 17949.282028718837, 5394.865128371793, 5843.678597677126, 5876.2067120938555, 5881.323647780518, 5885.7939972100985, 5643.4074422185695, 5711.600187986843, 5861.677607731573, 5875.735591898353, 5876.882462350751, 5778.306603207621, 5806.825795226129, 5819.24349834523, 5821.214136091637, 5821.621594596359, 5574.749136288877, 5723.227364305849, 5792.189093526888, 5792.594518383715, 5793.7392817323325, 5147.047796157723, 5148.2020286855595, 5153.252778347156, 5155.639105262633, 5159.432462429129, 16832.9900205988, 20556.177752889867, 21224.575508489743, 21266.680999785014, 21975.890120549455, 2097.0, 2188.7045248891354, 2342.906283748648, 2790.1350581319857, 2839.9148025559266, 9981.950090249502, 10266.486675666187, 10318.58725650973, 10726.678199654023, 14103.717925641533, 1890.1305399516239, 1892.0728842867034, 1916.4059141666128, 1919.9808001919941, 1924.441911845563, 81918.18081819166, 82193.0, 82321.58839205826, 84471.5776421114, 86655.13344866534, 10386.376817390981, 10472.371657700562, 10473.214508911862, 10635.41505217205, 10788.622398216025, 15474.767878481833, 15502.9224853875, 15509.612259693373, 15521.534353969399, 15611.453599123975, 6663.233728121231, 7021.648917554204, 7135.964320178366, 7233.602151881697, 7417.332440080419, 7302.429977554852, 7392.519486233377, 7461.515001524992, 7597.696092156362, 7600.8479830403085, 4660.627149828006, 4688.203005489075, 4692.108499385175, 4755.857324280277, 4880.219164933594, 1876.6340563590243, 1950.8634395592455, 1959.5884864178397, 2050.846186536016, 2074.802893725094, 875.8117004843862, 932.5567014422122, 956.6030097509456, 972.0304469844551, 1071.405370019631, 17311.48065558035, 18536.814631853507, 18682.53293667642, 18812.717809232872, 19173.904130479536, 954.2795189631784, 963.0562845149103, 984.7341217871135, 1009.7526106104051, 1024.5952848624752, 10309.948450257702, 10537.84193237102, 10591.682249532527, 10605.856429145313, 10715.19636027301, 405682.0, 417048.0, 420603.0, 421044.0, 422092.0, 85267.0, 87230.56384718035, 87531.56234218788, 88604.0, 90800.5459972696, 933.4119504712123, 950.5532399772096, 963.8120566489607, 973.9318247722733, 977.2524019125375, 15825.928637865938, 15922.203889805694, 15984.200789960689, 16877.746833797257, 17052.232649531048, 38389.0, 39815.0, 41791.0, 41923.0, 42917.1416571673, 42085.0, 54982.45017549773, 58690.0, 60100.69949650224, 62120.68939655273, 8170.754877353689, 8214.4660597061, 8515.403921725667, 8542.18849209324, 8813.91186088131, 10741.838872417076, 12488.43802028929, 12771.10602257833, 12904.870951290743, 12932.676683082998, 10261.486925653538, 10624.309419887682, 10822.891771082188, 10836.729081773019, 11516.366599837089, 10441.843372349269, 10691.946540267249, 10859.83710244331, 10964.0, 11264.718382040186, 10976.451177441255, 11288.32270063766, 11340.659780206277, 11860.110491712983, 11966.401679916144, 8460.365472589458, 8567.485950842969, 8622.094680058755, 8632.741017769476, 8775.22665253947, 10799.352038877692, 11046.447677616248, 11318.830217546578, 11458.369789661649, 11542.134339924707], "value": 8907.406665752216, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1452.1214665127595, 1498.9025713328633, 1615.2408368067013, 1697.388939981607, 1777.155850970789, 7946.92053079469, 8179.018517777875, 8531.402801803877, 9215.447073175606, 9224.077592240772, 8565.914340856589, 8847.601857916394, 8853.158949899766, 9097.408668436547, 9097.4989126794, 2297.8046866016407, 2311.641695537194, 2325.383773300077, 2326.8836558172106, 2327.6159433693506, 1974.9901250493726, 2033.9084741186607, 2310.1683393978155, 2314.3057082875152, 2364.6689463475127, 2248.5390494948497, 2322.8606283623035, 2339.251439539348, 2343.9179628713, 2344.038944032947, 2304.412374844421, 2305.0549274797336, 2308.3421224950807, 2342.250479846433, 2349.295211436562, 2328.1734984080745, 2335.801456876168, 2343.7304709958403, 2348.624220124772, 2350.717913850332, 9183.127602877716, 9232.492212928286, 9298.0, 9303.348765586412, 9314.86027709578, 5021.17150670139, 5152.510511501401, 5158.123119069767, 5180.715060671661, 5181.404138524081, 3251.138448311199, 3377.172592714776, 3477.4262246729513, 3481.9651803481893, 3513.578370595545, 1060.512164404375, 1097.4896673047072, 1113.8496302999072, 1119.641714651312, 1145.8911403416662, 12535.059870509749, 12682.302473363961, 12732.0, 12737.681557961032, 12746.80879786804, 4355.8475453359615, 4572.102577430395, 4678.719276843401, 4740.597049250852, 4752.382190315306, 10631.415272159951, 10644.308119972176, 10644.893551064544, 10650.254482186327, 10655.520501577448, 5093.337866077386, 5127.487251274917, 5129.563987061141, 5137.8201762938115, 5140.203268493389, 4554.795034223468, 4644.907101857944, 4650.534946505322, 4665.510121437268, 4677.204875171229, 3888.863889763845, 3914.667253283446, 4003.2994226010333, 4019.3569028955812, 4029.6776257899296, 1145.3585991844593, 1178.251810100575, 1214.6416807041944, 1257.2770656872335, 1260.785666436708, 822.116225058065, 837.991590403166, 903.7740564858785, 932.9504307653889, 936.6487567162314, 5675.035244008528, 5695.772169113272, 5874.882502350015, 6060.757569697251, 6166.167567378437, 944.9622015119455, 945.9432434053979, 955.4649396338073, 956.7993614686194, 984.227381505529, 3765.2093060457064, 3802.296575133609, 3807.162424266657, 3891.2412079644764, 3899.2786334527636, 10907.618233361794, 11131.944340278247, 11351.772964540829, 11439.485223164978, 11600.477978490988, 11302.886971130183, 11303.0, 11305.94347028276, 11311.321320720783, 11333.659990200307, 8221.342292616577, 8547.786305342415, 8669.739907802776, 8671.349648776368, 8673.479591224674, 5568.387477377566, 5655.264815573949, 5656.23640808502, 5704.629199102045, 5891.9116213255975, 10445.477726113511, 10499.212559057949, 10566.101881340172, 10615.89384106149, 10771.084457821173, 10157.1366433851, 10635.94682026585, 10654.14766818668, 10724.088452481314, 10949.288296260718, 8030.674938635059, 8153.3477321812925, 8158.0, 8165.387595930448, 8204.466709663853, 8483.363747718822, 8642.567871606268, 8672.869906951528, 8687.174718401742, 8703.651853925772, 7651.808704782425, 7712.383009359126, 7722.26638469367, 7732.420068494773, 7779.7666070017995, 7795.688172473265, 7807.765767026998, 7873.881891771513, 7887.605619718876, 8129.065157506726, 6595.571287866273, 6798.878185099601, 6845.657717114224, 6974.128233970754, 7041.647917604202, 4763.16644587189, 4805.9759701202665, 4839.2983017462975, 4883.145449546386, 4958.826441074545, 5099.107656160231, 5138.665986710852, 5190.0, 5215.617861266692, 5258.2375555544995], "value": 4643.259616929683, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.47112471109716, 326.19755401711785, 331.69318380498044, 333.85654134589043, 344.4093379853551, 5061.367329083864, 5113.440400677791, 5119.488051194879, 5193.376794784626, 5204.9739751301195, 5174.404943431507, 5200.297959775429, 5202.739863006854, 5222.973885130569, 5240.790368385269, 4177.415161877339, 4177.811998460076, 4184.430838435586, 4185.414042034117, 4204.705670603059, 4091.1817636472674, 4161.126163505653, 4166.562510936338, 4189.581041895802, 4194.832206711728, 4121.1757648470275, 4148.771817550033, 4150.128473020669, 4151.0, 4158.480189976253, 4087.6087488819076, 4092.4475195848477, 4103.7948102594755, 4115.094679170577, 4147.979260103711, 3653.2510835278704, 3658.4695219193336, 3680.3191409589313, 3680.871169509081, 3688.5020522229424, 4835.734034628094, 5076.263941728465, 5078.873028174326, 5093.567046801027, 5103.362079740033, 4715.740634265114, 4722.5513576210205, 4723.94508388852, 4736.158305016997, 4737.857864264078, 5299.33758280215, 5425.159100339453, 5441.945580544183, 5451.509364157205, 5460.235567020621, 3911.765294082364, 3978.9403158952637, 3986.142979259473, 3994.980025099856, 3996.200759848013, 5344.43883392246, 5579.581531385122, 5684.63049901755, 5698.373178950312, 5702.401247868997, 4029.657479114308, 4127.442795222607, 4128.793560321972, 4147.345698752801, 4159.667226621924, 4188.874333769992, 4196.349565817303, 4197.811098500575, 4202.096549241927, 4202.886235147688, 4519.344695019204, 4690.390249267573, 4704.1767690654, 4704.717716936994, 4724.574788269072, 5447.809326673548, 5464.26232458621, 5464.3442786865835, 5467.4532546745, 5476.945230547723, 1434.784782282666, 1448.8551144885428, 1449.7970284160226, 1450.789635502846, 1453.62932452224, 883.3639779358851, 950.5627411390838, 958.2573505533128, 959.5729900194347, 964.5611246882792, 4698.224792909132, 4715.269133284346, 4717.764111794397, 4724.834630787906, 4754.643401744883, 4920.3603531541385, 4924.4090709115135, 4924.7441902315395, 4935.555799978019, 4936.3829521309835, 4700.482946875841, 4709.905801884011, 4712.787924543404, 4739.952600473951, 5026.773795179226, 2943.190622578765, 2988.701129886994, 2988.9850550747105, 2991.491446454108, 2991.536311871663, 5877.0, 5877.764889404461, 5883.499902508334, 5890.352061273256, 5907.0, 5552.972700050504, 5742.368339482654, 5769.769209231584, 5786.913196302059, 5816.621919575214, 5905.852353691106, 5908.261467316585, 5910.970445147746, 5912.320083190488, 5919.852003699856, 5411.864703382447, 5663.272701825983, 5665.320161580472, 5674.631148975303, 5675.587875153126, 5593.216949626974, 5621.662700237999, 5622.0, 5646.689432081275, 5647.29408823897, 5626.774929002958, 5726.685032323096, 5805.274340707411, 5939.613925094855, 5946.959282125697, 4037.798110094425, 4044.170944956336, 4057.594240575919, 4062.8984275392168, 4065.390191471303, 5600.85997850057, 5625.46558076982, 5627.409122042127, 5641.971790141023, 5650.23721797552, 5291.3385826771655, 5477.603211181124, 5502.80740174092, 5507.862303442446, 5531.474509921551, 5484.917726234189, 5488.204210389391, 5499.1476321170285, 5506.889862202814, 5521.282233309644, 5298.602604804578, 5441.5374693151525, 5451.946909730564, 5454.036546843054, 5484.753186106715, 5556.444355564411, 5576.553875690016, 5578.246936663499, 5589.5248903842, 5591.245181900392, 5348.679079255257, 5369.731513424235, 5382.67703937765, 5395.649282796606, 5450.563954883679], "value": 4178.792048155887, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [686.9793906182815, 717.4296434334703, 771.0862627786074, 780.6526095887332, 793.0562630469742, 15776.84223157768, 16991.83008169918, 17007.65984680307, 17074.402395916146, 17091.23089460974, 14659.486917957873, 14729.410823567072, 14831.55505334839, 14858.0, 14895.0, 662.2615783401496, 685.4413652872918, 776.1462391369505, 798.7683571764196, 810.0562844286429, 784.7331907151568, 802.4864086984335, 802.7511471443842, 805.0098378993812, 807.4065561812064, 861.9569021548929, 862.7541150772031, 864.394923553512, 864.9005364383082, 865.0786911938796, 690.8618276344752, 713.6681443128919, 821.0229826506497, 859.3168431097292, 860.3977215948829, 618.0759764152621, 627.6359711367396, 627.9120923070774, 627.9434850863398, 628.0, 15104.320305586274, 15134.772978405334, 15151.696966060726, 15153.0, 15154.393824247018, 13515.391807368693, 13533.458661653522, 13569.1858488491, 13870.791938120936, 13877.791833122512, 11488.425578721031, 11627.302361858316, 11654.417279136094, 11817.645470635895, 11882.28706277626, 4263.5736426357425, 4268.338407546835, 4336.046069864625, 4360.21516127097, 4386.210482113218, 80039.0, 80945.78581321285, 81651.5917420415, 82540.0, 84964.57517712371, 10161.695149145537, 10217.1826253901, 10240.897591024144, 10289.845652315222, 10658.094062004662, 21363.572728545343, 21407.46481337948, 21419.57160856774, 21421.571568568543, 21460.356189314032, 8242.134575869448, 8246.587670616445, 8453.408261421764, 8609.5695215239, 8660.826783464296, 4442.244818380883, 4609.101225261042, 4742.881427964328, 4778.235482322882, 4900.460949295574, 3503.5270238517473, 3582.5163602913794, 3590.7486475946957, 3595.7662751921566, 3604.3692353837973, 602.6384169498266, 616.9413905678954, 641.6150309814075, 643.0996604753383, 643.2184895352076, 554.3984776517524, 572.8453317604307, 591.4440425999546, 599.9700014999232, 623.9001759718424, 8799.956000220085, 9136.954315228515, 9218.492982886006, 9253.103993083972, 9312.580933857993, 616.0, 628.9308176100625, 701.5475018613068, 759.8746206875915, 766.325633442567, 4256.638185754246, 4466.9106617867465, 4487.865364039084, 4534.954650453453, 4721.5750582447745, 65758.34241657618, 82132.58933705294, 106762.46618766857, 108641.82740305904, 108657.45671271592, 89993.0, 90353.54823225841, 92445.53777231071, 93542.0, 95084.52457737667, 73564.63217683985, 74261.0, 74974.25025749672, 76073.0, 76917.23082769212, 8964.955175224082, 9013.774655633662, 9287.6284948604, 9608.0, 9694.418334899929, 50324.24513632372, 51152.23271650854, 51222.74388628033, 51930.74034629803, 53878.461215387346, 43677.0, 70766.0, 71718.64140679264, 71724.0, 72599.0, 11968.16222864391, 12199.390030498262, 12323.876761232274, 12489.375531223584, 12502.624921252376, 13547.25490098054, 13586.796198057235, 14106.153630782186, 14139.575812725634, 14680.192589407257, 12992.480300787862, 13621.591352259447, 13682.384292706653, 13964.2319672419, 14022.439102435788, 12958.481660733465, 13380.598582042554, 13639.454421823017, 13820.792688109485, 14061.437542498596, 11868.703282418008, 11990.460429280878, 12486.313252771184, 12624.305663188245, 12807.871921280668, 10366.585336586753, 10643.201759867887, 10790.460476976277, 10936.398498082683, 10939.945300273448, 10051.0, 10241.641542545975, 10494.632687855888, 11506.367149806507, 11767.411629418666], "value": 7316.085575344488, "unit": "score"}], "name": "dromaeo_css", "value": 7113.221513552668, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 111.0, 111.0, 111.0, 111.0, 110.0, 110.0, 110.0, 112.0, 111.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 121.0, 117.0, 170.0, 120.0, 119.0, 117.0, 122.0, 160.0, 120.0], "value": 131.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 159.0, 160.0, 161.0, 161.0, 161.0, 161.0, 160.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 121.0, 76.0, 76.0, 76.0, 75.0, 116.0, 76.0], "value": 84.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 120.0, 83.0, 83.0, 82.0, 108.0, 84.0, 84.0, 110.0], "value": 91.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 150.0, 145.0, 146.0, 147.0, 146.0, 146.0, 146.0, 145.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 51.0, 50.0, 52.0, 52.0, 51.0, 52.0, 51.0, 52.0], "value": 51.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 60.0, 59.0, 60.0, 60.0, 59.0, 59.0, 61.0], "value": 59.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 78.0, 78.0, 86.0, 79.0, 78.0, 80.0, 78.0, 78.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 127.0, 121.0, 122.0, 126.0, 127.0, 134.0, 123.0, 171.0, 123.0], "value": 130.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 168.0, 166.0, 167.0, 165.0, 163.0, 162.0, 160.0, 165.0, 165.0], "value": 164.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 68.0, 64.0, 65.0, 66.0, 65.0, 65.0, 63.0, 64.0], "value": 64.7, "unit": "score"}], "name": "kraken", "value": 1486.3000000000002, "alertThreshold": 2.0}]} 00:38:39 INFO - Return code: 0 00:38:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:38:39 INFO - # TBPL SUCCESS # 00:38:39 INFO - Running post-action listener: _resource_record_post_action 00:38:39 INFO - [mozharness: 2016-09-30 07:38:39.759104Z] Finished run-tests step (success) 00:38:39 INFO - Running post-run listener: _resource_record_post_run 00:38:39 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 0; Write bytes: 404221952; Read time: 0; Write time: 302336 00:38:39 INFO - TinderboxPrint: CPU usage
13.0% 00:38:39 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 00:38:39 INFO - TinderboxPrint: I/O write bytes / time
404,221,952 / 302,336 00:38:39 INFO - TinderboxPrint: CPU idle
8,290.4 (86.9%) 00:38:39 INFO - TinderboxPrint: CPU user
1,194.6 (12.5%) 00:38:39 INFO - TinderboxPrint: Swap in / out
0 / 0 00:38:39 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 115699712; Read time: 0; Write time: 102452 00:38:39 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 288522240; Read time: 0; Write time: 199884 00:38:40 INFO - Running post-run listener: _upload_blobber_files 00:38:40 INFO - Blob upload gear active. 00:38:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:38:40 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 00:38:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:38:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:38:40 INFO - (blobuploader) - INFO - Open directory for files ... 00:38:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:38:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:38:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:38:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:38:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:38:41 INFO - (blobuploader) - INFO - Done attempting. 00:38:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:38:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:38:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:38:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:38:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:38:42 INFO - (blobuploader) - INFO - Done attempting. 00:38:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:38:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:38:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:38:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:38:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:38:45 INFO - (blobuploader) - INFO - Done attempting. 00:38:45 INFO - (blobuploader) - INFO - Iteration through files over. 00:38:45 INFO - Return code: 0 00:38:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:38:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:38:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a0123a77772f3250328bfa85c0908c387ba7bbf1462ce363a76748f1bcea7bc1242bc2c0b49629580de6d94b7870aa3acc6ab0087b63ab3eef1398d9c72095fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c85c026476513a6118b675dca4a79eb086fd51b003ec6b6702e0199e1166ae47608160bef088a3bc1721231ec3b7f147dc668f3652783b9f5189fada8731fec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6b60163deed76b5960a2c68f72af5c247cf6b5a2c3bf7e38cf2c0d2941965a20ecea3a7eb8f11aa52e9bebd6c6b1c2eef938524ee3a56f9ab0c45181ad63989a"} 00:38:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:38:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:38:45 INFO - Contents: 00:38:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a0123a77772f3250328bfa85c0908c387ba7bbf1462ce363a76748f1bcea7bc1242bc2c0b49629580de6d94b7870aa3acc6ab0087b63ab3eef1398d9c72095fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c85c026476513a6118b675dca4a79eb086fd51b003ec6b6702e0199e1166ae47608160bef088a3bc1721231ec3b7f147dc668f3652783b9f5189fada8731fec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6b60163deed76b5960a2c68f72af5c247cf6b5a2c3bf7e38cf2c0d2941965a20ecea3a7eb8f11aa52e9bebd6c6b1c2eef938524ee3a56f9ab0c45181ad63989a"} 00:38:45 INFO - Running post-run listener: copy_logs_to_upload_dir 00:38:45 INFO - Copying logs to upload dir... 00:38:45 INFO - mkdir: /builds/slave/test/build/upload/logs 00:38:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.116349 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-09-30 00:38:45.125147) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-30 00:38:45.129077) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1475210871.443077-1444644456 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a0123a77772f3250328bfa85c0908c387ba7bbf1462ce363a76748f1bcea7bc1242bc2c0b49629580de6d94b7870aa3acc6ab0087b63ab3eef1398d9c72095fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c85c026476513a6118b675dca4a79eb086fd51b003ec6b6702e0199e1166ae47608160bef088a3bc1721231ec3b7f147dc668f3652783b9f5189fada8731fec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6b60163deed76b5960a2c68f72af5c247cf6b5a2c3bf7e38cf2c0d2941965a20ecea3a7eb8f11aa52e9bebd6c6b1c2eef938524ee3a56f9ab0c45181ad63989a"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475209894/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011444 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1475209894/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a0123a77772f3250328bfa85c0908c387ba7bbf1462ce363a76748f1bcea7bc1242bc2c0b49629580de6d94b7870aa3acc6ab0087b63ab3eef1398d9c72095fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c85c026476513a6118b675dca4a79eb086fd51b003ec6b6702e0199e1166ae47608160bef088a3bc1721231ec3b7f147dc668f3652783b9f5189fada8731fec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6b60163deed76b5960a2c68f72af5c247cf6b5a2c3bf7e38cf2c0d2941965a20ecea3a7eb8f11aa52e9bebd6c6b1c2eef938524ee3a56f9ab0c45181ad63989a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-30 00:38:45.157942) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 00:38:45.158252) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1475210871.443077-1444644456 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004566 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 00:38:45.240297) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-30 00:38:45.240575) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-30 00:38:45.240841) ========= ========= Total master_lag: 0.19 =========