builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-014 starttime: 1476361709.85 results: success (0) buildid: 20161013051605 builduid: 07fa10b708194dad8bea30049d6af8be revision: f03e2740d604d339ed553dad62a3fc54c317f8fa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 05:28:29.853449) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 05:28:29.853907) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 05:28:29.854179) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 05:28:29.867680) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 05:28:29.867963) ========= 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=31acecf42b6a79ec49471d4a000001bb-1476361709.635707-20032881 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-13 05:28:30-- 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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 30.1M=0s 2016-10-13 05:28:30 (30.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.121761 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 05:28:30.003580) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 05:28:30.003964) ========= 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=31acecf42b6a79ec49471d4a000001bb-1476361709.635707-20032881 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018248 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 05:28:30.053738) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 05:28:30.054086) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f03e2740d604d339ed553dad62a3fc54c317f8fa --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 f03e2740d604d339ed553dad62a3fc54c317f8fa --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=31acecf42b6a79ec49471d4a000001bb-1476361709.635707-20032881 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-13 05:28:30,581 truncating revision to first 12 chars 2016-10-13 05:28:30,581 Setting DEBUG logging. 2016-10-13 05:28:30,581 attempt 1/10 2016-10-13 05:28:30,581 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f03e2740d604?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-13 05:28:30,877 unpacking tar archive at: fx-team-f03e2740d604/testing/mozharness/ program finished with exit code 0 elapsedTime=0.640546 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 05:28:30.709589) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 05:28:30.710101) ========= script_repo_revision: f03e2740d604d339ed553dad62a3fc54c317f8fa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 05:28:30.710716) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 05:28:30.711115) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 05:28:30.722161) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-13 05:28:30.722720) ========= /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=31acecf42b6a79ec49471d4a000001bb-1476361709.635707-20032881 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:28:31 INFO - MultiFileLogger online at 20161013 05:28:31 in /builds/slave/test 05:28:31 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 05:28:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:28:31 INFO - {'append_to_log': False, 05:28:31 INFO - 'base_work_dir': '/builds/slave/test', 05:28:31 INFO - 'blob_upload_branch': 'Fx-Team', 05:28:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:28:31 INFO - 'branch': 'Fx-Team', 05:28:31 INFO - 'buildbot_json_path': 'buildprops.json', 05:28:31 INFO - 'config_files': ('talos/linux_config.py',), 05:28:31 INFO - 'default_actions': ('clobber', 05:28:31 INFO - 'read-buildbot-config', 05:28:31 INFO - 'download-and-extract', 05:28:31 INFO - 'populate-webroot', 05:28:31 INFO - 'create-virtualenv', 05:28:31 INFO - 'install', 05:28:31 INFO - 'run-tests'), 05:28:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:28:31 INFO - 'download_minidump_stackwalk': True, 05:28:31 INFO - 'download_symbols': 'ondemand', 05:28:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:28:31 INFO - 'tooltool.py': '/tools/tooltool.py', 05:28:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:28:31 INFO - '/tools/misc-python/virtualenv.py')}, 05:28:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:28:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:28:31 INFO - 'installer_path': 'installer.exe', 05:28:31 INFO - 'log_level': 'info', 05:28:31 INFO - 'log_name': 'talos', 05:28:31 INFO - 'log_to_console': True, 05:28:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:28:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:28:31 INFO - 'opt_config_files': (), 05:28:31 INFO - 'pip_index': False, 05:28:31 INFO - 'sps_profile': False, 05:28:31 INFO - 'sps_profile_interval': 0, 05:28:31 INFO - 'suite': 'dromaeojs', 05:28:31 INFO - 'system_bits': '32', 05:28:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:28:31 INFO - 'title': 'talos-linux64-ix-014', 05:28:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:28:31 INFO - 'use_talos_json': True, 05:28:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:28:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:28:31 INFO - 'work_dir': 'build'} 05:28:31 INFO - [mozharness: 2016-10-13 12:28:31.352539Z] Running clobber step. 05:28:31 INFO - Running pre-action listener: _resource_record_pre_action 05:28:31 INFO - Running main action method: clobber 05:28:31 INFO - rmtree: /builds/slave/test/build 05:28:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:28:31 INFO - Running post-action listener: _resource_record_post_action 05:28:31 INFO - [mozharness: 2016-10-13 12:28:31.817646Z] Finished clobber step (success) 05:28:31 INFO - [mozharness: 2016-10-13 12:28:31.817748Z] Running read-buildbot-config step. 05:28:31 INFO - Running pre-action listener: _resource_record_pre_action 05:28:31 INFO - Running main action method: read_buildbot_config 05:28:31 INFO - Using buildbot properties: 05:28:31 INFO - { 05:28:31 INFO - "project": "", 05:28:31 INFO - "product": "firefox", 05:28:31 INFO - "script_repo_revision": "production", 05:28:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:28:31 INFO - "repository": "", 05:28:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:28:31 INFO - "buildid": "20161013051605", 05:28:31 INFO - "stage_platform": "linux64-pgo", 05:28:31 INFO - "basedir": "/builds/slave/test", 05:28:31 INFO - "buildnumber": 1124, 05:28:31 INFO - "platform": "ubuntu64_hw", 05:28:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:28:31 INFO - "slavebuilddir": "test", 05:28:31 INFO - "branch": "fx-team", 05:28:31 INFO - "revision": "f03e2740d604d339ed553dad62a3fc54c317f8fa", 05:28:31 INFO - "slavename": "talos-linux64-ix-014", 05:28:31 INFO - "builduid": "07fa10b708194dad8bea30049d6af8be", 05:28:31 INFO - "repo_path": "integration/fx-team" 05:28:31 INFO - } 05:28:31 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476354614/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 05:28:31 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476354614/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 05:28:31 INFO - Running post-action listener: _resource_record_post_action 05:28:31 INFO - [mozharness: 2016-10-13 12:28:31.820139Z] Finished read-buildbot-config step (success) 05:28:31 INFO - [mozharness: 2016-10-13 12:28:31.820228Z] Running download-and-extract step. 05:28:31 INFO - Running pre-action listener: _resource_record_pre_action 05:28:31 INFO - Running main action method: download_and_extract 05:28:31 INFO - mkdir: /builds/slave/test/build/tests 05:28:31 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')]} 05:28:31 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476354614/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:28:31 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476354614/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 05:28:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476354614/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 05:28:31 INFO - Downloaded 1361 bytes. 05:28:31 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:28:31 INFO - Using the following test package requirements: 05:28:31 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 05:28:31 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:28:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:28:31 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:28:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:28:31 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:28:31 INFO - u'jsshell-linux-x86_64.zip'], 05:28:31 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:28:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:28:31 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 05:28:31 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:28:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:28:31 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:28:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:28:31 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:28:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:28:31 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:28:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:28:31 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:28:31 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/1476354614/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 05:28:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476354614/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:28:31 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476354614/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:28:31 INFO - Http code: 200 05:28:31 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 05:28:31 INFO - x-amz-cf-id: DcRQV49SKS19Vs0kZUw0-iLwIVyRn0g5ieeeEzzY9Zu8ug8xD4krOw== 05:28:31 INFO - x-amz-replication-status: COMPLETED 05:28:31 INFO - x-amz-version-id: VOgzYg7BTOJPJM29F9xEWPNoFl1DHCrx 05:28:32 INFO - Expected file size: 22126924 05:28:32 INFO - Obtained file size: 22126924 05:28:36 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 05:28:36 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/1476354614/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 05:28:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476354614/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:28:36 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476354614/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:28:36 INFO - Http code: 200 05:28:36 INFO - via: 1.1 c0740de9f16cf32ffedfd2f9806b8483.cloudfront.net (CloudFront) 05:28:36 INFO - x-amz-cf-id: ezM9usiQy8PecZHS06s6sa55agttMbmOJyxYHV6fogjhpI-8ruL86w== 05:28:36 INFO - x-amz-replication-status: COMPLETED 05:28:36 INFO - x-amz-version-id: VOgzYg7BTOJPJM29F9xEWPNoFl1DHCrx 05:28:36 INFO - Expected file size: 22126924 05:28:36 INFO - Obtained file size: 22126924 05:28:41 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/1476354614/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 05:28:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476354614/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:28:41 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476354614/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 05:28:41 INFO - Http code: 200 05:28:41 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 05:28:41 INFO - x-amz-cf-id: FWTNgafBfli-vLt_AGvjCGj2XD0uegXQVDRGOCSzw8EkknXmswdVcQ== 05:28:41 INFO - x-amz-replication-status: COMPLETED 05:28:41 INFO - x-amz-version-id: HjqP95fpKDPCdTuLodBeY3cH6DU9XA3y 05:28:41 INFO - Expected file size: 14409006 05:28:41 INFO - Obtained file size: 14409006 05:28:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:41 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476354614/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:28:41 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476354614/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 05:28:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476354614/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 05:28:43 INFO - Downloaded 59770454 bytes. 05:28:43 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476354614/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:28:43 INFO - mkdir: /builds/slave/test/properties 05:28:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:28:43 INFO - Writing to file /builds/slave/test/properties/build_url 05:28:43 INFO - Contents: 05:28:43 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476354614/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:28:43 INFO - Running post-action listener: _resource_record_post_action 05:28:43 INFO - Running post-action listener: set_extra_try_arguments 05:28:43 INFO - [mozharness: 2016-10-13 12:28:43.693777Z] Finished download-and-extract step (success) 05:28:43 INFO - [mozharness: 2016-10-13 12:28:43.694005Z] Running populate-webroot step. 05:28:43 INFO - Running pre-action listener: _resource_record_pre_action 05:28:43 INFO - Running main action method: populate_webroot 05:28:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:28:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:28:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:28:43 INFO - '--tppagecycles', 05:28:43 INFO - '7'], 05:28:43 INFO - 'tests': ['tsvgm']}}, 05:28:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:28:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:28:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:28:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:28:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:28:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:28:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:28:43 INFO - 'talos_options': ['--disable-e10s'], 05:28:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:28:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:28:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:28:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:28:43 INFO - 'talos_options': ['--disable-e10s'], 05:28:43 INFO - 'tests': ['damp', 'tps']}, 05:28:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:28:43 INFO - 'tests': ['damp', 'tps']}, 05:28:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:28:43 INFO - 'tests': ['dromaeo_dom']}, 05:28:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:28:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:28:43 INFO - 'tests': ['basic_compositor_video']}, 05:28:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:28:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:28:43 INFO - 'tests': ['a11yr', 05:28:43 INFO - 'ts_paint', 05:28:43 INFO - 'tpaint', 05:28:43 INFO - 'sessionrestore', 05:28:43 INFO - 'sessionrestore_no_auto_restore', 05:28:43 INFO - 'tabpaint']}, 05:28:43 INFO - 'other-e10s': {'tests': ['a11yr', 05:28:43 INFO - 'ts_paint', 05:28:43 INFO - 'tpaint', 05:28:43 INFO - 'sessionrestore', 05:28:43 INFO - 'sessionrestore_no_auto_restore', 05:28:43 INFO - 'tabpaint']}, 05:28:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:28:43 INFO - 'ts_paint', 05:28:43 INFO - 'tpaint', 05:28:43 INFO - 'sessionrestore', 05:28:43 INFO - 'sessionrestore_no_auto_restore', 05:28:43 INFO - 'tabpaint']}, 05:28:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:28:43 INFO - 'ts_paint', 05:28:43 INFO - 'tpaint', 05:28:43 INFO - 'sessionrestore', 05:28:43 INFO - 'sessionrestore_no_auto_restore', 05:28:43 INFO - 'tabpaint']}, 05:28:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:28:43 INFO - 'tests': ['a11yr', 05:28:43 INFO - 'ts_paint', 05:28:43 INFO - 'tpaint', 05:28:43 INFO - 'sessionrestore', 05:28:43 INFO - 'sessionrestore_no_auto_restore', 05:28:43 INFO - 'tabpaint']}, 05:28:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:28:43 INFO - 'tests': ['a11yr', 05:28:43 INFO - 'ts_paint', 05:28:43 INFO - 'tpaint', 05:28:43 INFO - 'sessionrestore', 05:28:43 INFO - 'sessionrestore_no_auto_restore', 05:28:43 INFO - 'tabpaint']}, 05:28:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:28:43 INFO - 'tests': ['tsvgx', 05:28:43 INFO - 'tsvgr_opacity', 05:28:43 INFO - 'tart', 05:28:43 INFO - 'tscrollx', 05:28:43 INFO - 'cart']}, 05:28:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:28:43 INFO - 'tsvgr_opacity', 05:28:43 INFO - 'tart', 05:28:43 INFO - 'tscrollx', 05:28:43 INFO - 'cart']}, 05:28:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:28:43 INFO - 'talos_options': ['--disable-e10s'], 05:28:43 INFO - 'tests': ['tp5o']}, 05:28:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:28:43 INFO - 'tests': ['tp5o']}, 05:28:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:28:43 INFO - 'talos_options': ['--disable-e10s', 05:28:43 INFO - '--xperf_path', 05:28:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:28:43 INFO - 'tests': ['tp5n']}, 05:28:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:28:43 INFO - 'talos_options': ['--xperf_path', 05:28:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:28:43 INFO - 'tests': ['tp5n']}}, 05:28:43 INFO - 'talos.zip': {'path': '', 05:28:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:28:43 INFO - Running post-action listener: _resource_record_post_action 05:28:43 INFO - [mozharness: 2016-10-13 12:28:43.709467Z] Finished populate-webroot step (success) 05:28:43 INFO - [mozharness: 2016-10-13 12:28:43.709556Z] Running create-virtualenv step. 05:28:43 INFO - Running pre-action listener: _resource_record_pre_action 05:28:43 INFO - Running main action method: create_virtualenv 05:28:43 INFO - Creating virtualenv /builds/slave/test/build/venv 05:28:43 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 05:28:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:28:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:28:43 INFO - Using real prefix '/usr' 05:28:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:28:44 INFO - Installing distribute.............................................................................................................................................................................................done. 05:28:46 INFO - Installing pip.................done. 05:28:46 INFO - Return code: 0 05:28:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:28:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:28:46 INFO - Reading from file tmpfile_stdout 05:28:46 INFO - Output received: 05:28:46 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) 05:28:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:28:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:46 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 0x7ffd54250f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe66790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe63930>, '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 0xe64830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe64cc0>, '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': '31acecf42b6a79ec49471d4a000001bb-1476361709.635707-20032881', '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 05:28:46 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 05:28:46 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 05:28:46 INFO - Using env: {'DISPLAY': ':0', 05:28:46 INFO - 'HOME': '/home/cltbld', 05:28:46 INFO - 'LANG': 'en_US.UTF-8', 05:28:46 INFO - 'LANGUAGE': 'en_US:en', 05:28:46 INFO - 'LOGNAME': 'cltbld', 05:28:46 INFO - 'MAIL': '/var/mail/cltbld', 05:28:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:46 INFO - 'MOZ_NO_REMOTE': '1', 05:28:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:28:46 INFO - 'NO_EM_RESTART': '1', 05:28:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:28:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:46 INFO - 'PWD': '/builds/slave/test', 05:28:46 INFO - 'SHELL': '/bin/bash', 05:28:46 INFO - 'SHLVL': '1', 05:28:46 INFO - 'TERM': 'linux', 05:28:46 INFO - 'TMOUT': '86400', 05:28:46 INFO - 'USER': 'cltbld', 05:28:46 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1476361709.635707-20032881', 05:28:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:46 INFO - '_': '/tools/buildbot/bin/python'} 05:28:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:46 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 05:28:46 INFO - Cleaning up... 05:28:46 INFO - Return code: 0 05:28:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:28:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:46 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 0x7ffd54250f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe66790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe63930>, '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 0xe64830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe64cc0>, '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': '31acecf42b6a79ec49471d4a000001bb-1476361709.635707-20032881', '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 05:28:46 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 05:28:46 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 05:28:46 INFO - Using env: {'DISPLAY': ':0', 05:28:46 INFO - 'HOME': '/home/cltbld', 05:28:46 INFO - 'LANG': 'en_US.UTF-8', 05:28:46 INFO - 'LANGUAGE': 'en_US:en', 05:28:46 INFO - 'LOGNAME': 'cltbld', 05:28:46 INFO - 'MAIL': '/var/mail/cltbld', 05:28:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:46 INFO - 'MOZ_NO_REMOTE': '1', 05:28:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:28:46 INFO - 'NO_EM_RESTART': '1', 05:28:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:28:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:46 INFO - 'PWD': '/builds/slave/test', 05:28:46 INFO - 'SHELL': '/bin/bash', 05:28:46 INFO - 'SHLVL': '1', 05:28:46 INFO - 'TERM': 'linux', 05:28:46 INFO - 'TMOUT': '86400', 05:28:46 INFO - 'USER': 'cltbld', 05:28:46 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1476361709.635707-20032881', 05:28:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:46 INFO - '_': '/tools/buildbot/bin/python'} 05:28:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:46 INFO - Downloading/unpacking psutil>=3.1.1 05:28:46 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 05:28:46 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 05:28:46 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 05:28:46 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 05:28:46 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 05:28:46 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 05:28:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:28:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:28:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:28:48 INFO - Installing collected packages: psutil 05:28:48 INFO - Running setup.py install for psutil 05:28:49 INFO - building 'psutil._psutil_linux' extension 05:28:49 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 05:28:49 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 05:28:49 INFO - building 'psutil._psutil_posix' extension 05:28:49 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 05:28:49 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 05:28:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:28:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:28:49 INFO - Successfully installed psutil 05:28:49 INFO - Cleaning up... 05:28:49 INFO - Return code: 0 05:28:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:28:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:49 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 0x7ffd54250f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe66790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe63930>, '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 0xe64830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe64cc0>, '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': '31acecf42b6a79ec49471d4a000001bb-1476361709.635707-20032881', '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 05:28:49 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 05:28:49 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 05:28:49 INFO - Using env: {'DISPLAY': ':0', 05:28:49 INFO - 'HOME': '/home/cltbld', 05:28:49 INFO - 'LANG': 'en_US.UTF-8', 05:28:49 INFO - 'LANGUAGE': 'en_US:en', 05:28:49 INFO - 'LOGNAME': 'cltbld', 05:28:49 INFO - 'MAIL': '/var/mail/cltbld', 05:28:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:49 INFO - 'MOZ_NO_REMOTE': '1', 05:28:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:28:49 INFO - 'NO_EM_RESTART': '1', 05:28:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:28:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:49 INFO - 'PWD': '/builds/slave/test', 05:28:49 INFO - 'SHELL': '/bin/bash', 05:28:49 INFO - 'SHLVL': '1', 05:28:49 INFO - 'TERM': 'linux', 05:28:49 INFO - 'TMOUT': '86400', 05:28:49 INFO - 'USER': 'cltbld', 05:28:49 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1476361709.635707-20032881', 05:28:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:49 INFO - '_': '/tools/buildbot/bin/python'} 05:28:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:28:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:28:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:28:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:28:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:28:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:28:51 INFO - Installing collected packages: mozsystemmonitor 05:28:51 INFO - Running setup.py install for mozsystemmonitor 05:28:51 INFO - Successfully installed mozsystemmonitor 05:28:51 INFO - Cleaning up... 05:28:51 INFO - Return code: 0 05:28:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:28:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:51 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 0x7ffd54250f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe66790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe63930>, '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 0xe64830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe64cc0>, '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': '31acecf42b6a79ec49471d4a000001bb-1476361709.635707-20032881', '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 05:28:51 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 05:28:51 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 05:28:51 INFO - Using env: {'DISPLAY': ':0', 05:28:51 INFO - 'HOME': '/home/cltbld', 05:28:51 INFO - 'LANG': 'en_US.UTF-8', 05:28:51 INFO - 'LANGUAGE': 'en_US:en', 05:28:51 INFO - 'LOGNAME': 'cltbld', 05:28:51 INFO - 'MAIL': '/var/mail/cltbld', 05:28:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:51 INFO - 'MOZ_NO_REMOTE': '1', 05:28:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:28:51 INFO - 'NO_EM_RESTART': '1', 05:28:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:28:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:51 INFO - 'PWD': '/builds/slave/test', 05:28:51 INFO - 'SHELL': '/bin/bash', 05:28:51 INFO - 'SHLVL': '1', 05:28:51 INFO - 'TERM': 'linux', 05:28:51 INFO - 'TMOUT': '86400', 05:28:51 INFO - 'USER': 'cltbld', 05:28:51 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1476361709.635707-20032881', 05:28:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:51 INFO - '_': '/tools/buildbot/bin/python'} 05:28:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:52 INFO - Downloading/unpacking jsonschema==2.5.1 05:28:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:28:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:28:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:28:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:28:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:54 INFO - Downloading functools32-3.2.3-2.tar.gz 05:28:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:28:54 INFO - warning: no files found matching '*.txt' 05:28:54 INFO - no previously-included directories found matching 'build' 05:28:54 INFO - no previously-included directories found matching 'dist' 05:28:54 INFO - no previously-included directories found matching '.git*' 05:28:54 INFO - Installing collected packages: jsonschema, functools32 05:28:54 INFO - Running setup.py install for functools32 05:28:54 INFO - warning: no files found matching '*.txt' 05:28:54 INFO - no previously-included directories found matching 'build' 05:28:54 INFO - no previously-included directories found matching 'dist' 05:28:54 INFO - no previously-included directories found matching '.git*' 05:28:54 INFO - Successfully installed jsonschema functools32 05:28:54 INFO - Cleaning up... 05:28:54 INFO - Return code: 0 05:28:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:28:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:54 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 0x7ffd54250f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe66790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe63930>, '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 0xe64830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe64cc0>, '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': '31acecf42b6a79ec49471d4a000001bb-1476361709.635707-20032881', '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 05:28:54 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 05:28:54 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 05:28:54 INFO - Using env: {'DISPLAY': ':0', 05:28:54 INFO - 'HOME': '/home/cltbld', 05:28:54 INFO - 'LANG': 'en_US.UTF-8', 05:28:54 INFO - 'LANGUAGE': 'en_US:en', 05:28:54 INFO - 'LOGNAME': 'cltbld', 05:28:54 INFO - 'MAIL': '/var/mail/cltbld', 05:28:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:54 INFO - 'MOZ_NO_REMOTE': '1', 05:28:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:28:54 INFO - 'NO_EM_RESTART': '1', 05:28:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:28:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:54 INFO - 'PWD': '/builds/slave/test', 05:28:54 INFO - 'SHELL': '/bin/bash', 05:28:54 INFO - 'SHLVL': '1', 05:28:54 INFO - 'TERM': 'linux', 05:28:54 INFO - 'TMOUT': '86400', 05:28:54 INFO - 'USER': 'cltbld', 05:28:54 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1476361709.635707-20032881', 05:28:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:54 INFO - '_': '/tools/buildbot/bin/python'} 05:28:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:28:54 INFO - Cleaning up... 05:28:54 INFO - Return code: 0 05:28:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:28:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:54 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 0x7ffd54250f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe66790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe63930>, '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 0xe64830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe64cc0>, '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': '31acecf42b6a79ec49471d4a000001bb-1476361709.635707-20032881', '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 05:28:54 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 05:28:54 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 05:28:54 INFO - Using env: {'DISPLAY': ':0', 05:28:54 INFO - 'HOME': '/home/cltbld', 05:28:54 INFO - 'LANG': 'en_US.UTF-8', 05:28:54 INFO - 'LANGUAGE': 'en_US:en', 05:28:54 INFO - 'LOGNAME': 'cltbld', 05:28:54 INFO - 'MAIL': '/var/mail/cltbld', 05:28:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:54 INFO - 'MOZ_NO_REMOTE': '1', 05:28:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:28:54 INFO - 'NO_EM_RESTART': '1', 05:28:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:28:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:54 INFO - 'PWD': '/builds/slave/test', 05:28:54 INFO - 'SHELL': '/bin/bash', 05:28:54 INFO - 'SHLVL': '1', 05:28:54 INFO - 'TERM': 'linux', 05:28:54 INFO - 'TMOUT': '86400', 05:28:54 INFO - 'USER': 'cltbld', 05:28:54 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1476361709.635707-20032881', 05:28:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:54 INFO - '_': '/tools/buildbot/bin/python'} 05:28:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:54 INFO - Downloading/unpacking blobuploader==1.2.4 05:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:28:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:56 INFO - Downloading blobuploader-1.2.4.tar.gz 05:28:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:28:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:28:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:28:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:28:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:28:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:28:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:57 INFO - Downloading docopt-0.6.1.tar.gz 05:28:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:28:57 INFO - Installing collected packages: blobuploader, requests, docopt 05:28:57 INFO - Running setup.py install for blobuploader 05:28:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:28:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:28:57 INFO - Running setup.py install for requests 05:28:58 INFO - Running setup.py install for docopt 05:28:58 INFO - Successfully installed blobuploader requests docopt 05:28:58 INFO - Cleaning up... 05:28:58 INFO - Return code: 0 05:28:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:28:58 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')]} 05:28:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:58 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')]} 05:28:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:58 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 0x7ffd54250f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe66790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe63930>, '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 0xe64830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe64cc0>, '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': '31acecf42b6a79ec49471d4a000001bb-1476361709.635707-20032881', '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 05:28:58 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 05:28:58 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 05:28:58 INFO - Using env: {'DISPLAY': ':0', 05:28:58 INFO - 'HOME': '/home/cltbld', 05:28:58 INFO - 'LANG': 'en_US.UTF-8', 05:28:58 INFO - 'LANGUAGE': 'en_US:en', 05:28:58 INFO - 'LOGNAME': 'cltbld', 05:28:58 INFO - 'MAIL': '/var/mail/cltbld', 05:28:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:58 INFO - 'MOZ_NO_REMOTE': '1', 05:28:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:28:58 INFO - 'NO_EM_RESTART': '1', 05:28:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:28:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:58 INFO - 'PWD': '/builds/slave/test', 05:28:58 INFO - 'SHELL': '/bin/bash', 05:28:58 INFO - 'SHLVL': '1', 05:28:58 INFO - 'TERM': 'linux', 05:28:58 INFO - 'TMOUT': '86400', 05:28:58 INFO - 'USER': 'cltbld', 05:28:58 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1476361709.635707-20032881', 05:28:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:58 INFO - '_': '/tools/buildbot/bin/python'} 05:28:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:28:58 INFO - Running setup.py (path:/tmp/pip-lF29tc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:28:58 INFO - Running setup.py (path:/tmp/pip-5p7ard-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:28:58 INFO - Running setup.py (path:/tmp/pip-jwGqYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:28:58 INFO - Running setup.py (path:/tmp/pip-gJtXcp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:28:58 INFO - Running setup.py (path:/tmp/pip-ZVonJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:28:58 INFO - Running setup.py (path:/tmp/pip-kOgXse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:28:58 INFO - Running setup.py (path:/tmp/pip-eHtiyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:28:58 INFO - Running setup.py (path:/tmp/pip-YrBKt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:28:59 INFO - Running setup.py (path:/tmp/pip-YAqCgF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:28:59 INFO - Running setup.py (path:/tmp/pip-NPF76k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:28:59 INFO - Running setup.py (path:/tmp/pip-rMzfmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:28:59 INFO - Running setup.py (path:/tmp/pip-6WxWsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:28:59 INFO - Running setup.py (path:/tmp/pip-4T5omH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:28:59 INFO - Running setup.py (path:/tmp/pip-IGlh5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:28:59 INFO - Running setup.py (path:/tmp/pip-LNE_KI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:28:59 INFO - Running setup.py (path:/tmp/pip-3LFGU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:28:59 INFO - Running setup.py (path:/tmp/pip-MDNLQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:28:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:28:59 INFO - Running setup.py install for manifestparser 05:28:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:28:59 INFO - Running setup.py install for mozcrash 05:28:59 INFO - Running setup.py install for mozdebug 05:28:59 INFO - Running setup.py install for mozdevice 05:29:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:29:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:29:00 INFO - Running setup.py install for mozfile 05:29:00 INFO - Running setup.py install for mozhttpd 05:29:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:29:00 INFO - Running setup.py install for mozinfo 05:29:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:29:00 INFO - Running setup.py install for mozInstall 05:29:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:29:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:29:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:29:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:29:00 INFO - Running setup.py install for mozleak 05:29:00 INFO - Running setup.py install for mozlog 05:29:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:29:00 INFO - Running setup.py install for moznetwork 05:29:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:29:00 INFO - Running setup.py install for mozprocess 05:29:00 INFO - Running setup.py install for mozprofile 05:29:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:29:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:29:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:29:01 INFO - Running setup.py install for mozrunner 05:29:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:29:01 INFO - Running setup.py install for mozscreenshot 05:29:01 INFO - Running setup.py install for moztest 05:29:01 INFO - Running setup.py install for mozversion 05:29:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:29:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:29:01 INFO - Cleaning up... 05:29:01 INFO - Return code: 0 05:29:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:29: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')]} 05:29:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29: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')]} 05:29:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:01 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 0x7ffd54250f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe66790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe63930>, '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 0xe64830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe64cc0>, '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': '31acecf42b6a79ec49471d4a000001bb-1476361709.635707-20032881', '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 05:29:01 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 05:29:01 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 05:29:01 INFO - Using env: {'DISPLAY': ':0', 05:29:01 INFO - 'HOME': '/home/cltbld', 05:29:01 INFO - 'LANG': 'en_US.UTF-8', 05:29:01 INFO - 'LANGUAGE': 'en_US:en', 05:29:01 INFO - 'LOGNAME': 'cltbld', 05:29:01 INFO - 'MAIL': '/var/mail/cltbld', 05:29:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:01 INFO - 'MOZ_NO_REMOTE': '1', 05:29:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:01 INFO - 'NO_EM_RESTART': '1', 05:29:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:01 INFO - 'PWD': '/builds/slave/test', 05:29:01 INFO - 'SHELL': '/bin/bash', 05:29:01 INFO - 'SHLVL': '1', 05:29:01 INFO - 'TERM': 'linux', 05:29:01 INFO - 'TMOUT': '86400', 05:29:01 INFO - 'USER': 'cltbld', 05:29:01 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1476361709.635707-20032881', 05:29:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:01 INFO - '_': '/tools/buildbot/bin/python'} 05:29:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:29:01 INFO - Running setup.py (path:/tmp/pip-HqAOtA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:29:01 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)) 05:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:29:01 INFO - Running setup.py (path:/tmp/pip-id3cfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:29:01 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)) 05:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:29:01 INFO - Running setup.py (path:/tmp/pip-CyoLrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:29:01 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)) 05:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:29:01 INFO - Running setup.py (path:/tmp/pip-mNQnxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:29:02 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)) 05:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:29:02 INFO - Running setup.py (path:/tmp/pip-Q_Ty24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:29:02 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)) 05:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:29:02 INFO - Running setup.py (path:/tmp/pip-ALPODr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:29:02 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)) 05:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:29:02 INFO - Running setup.py (path:/tmp/pip-UBwehv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:29:02 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)) 05:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:29:02 INFO - Running setup.py (path:/tmp/pip-x4RlBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:29:02 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)) 05:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:29:02 INFO - Running setup.py (path:/tmp/pip-SbHWIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:29:02 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)) 05:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:29:02 INFO - Running setup.py (path:/tmp/pip-YZTu6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:29:02 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)) 05:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:29:02 INFO - Running setup.py (path:/tmp/pip-Hq4tqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:29:02 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)) 05:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:29:02 INFO - Running setup.py (path:/tmp/pip-LrKOz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:29:02 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)) 05:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:29:02 INFO - Running setup.py (path:/tmp/pip-CQ4hjY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:29:02 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)) 05:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:29:02 INFO - Running setup.py (path:/tmp/pip-aoITUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:29:02 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)) 05:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:29:02 INFO - Running setup.py (path:/tmp/pip-Vpr04A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:29:02 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)) 05:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:29:02 INFO - Running setup.py (path:/tmp/pip-YiGDGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:29:02 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)) 05:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:29:02 INFO - Running setup.py (path:/tmp/pip-KQWbRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:29:02 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)) 05:29:02 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)) 05:29:02 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)) 05:29:02 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)) 05:29:02 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)) 05:29:02 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)) 05:29:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:29:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:04 INFO - Downloading blessings-1.6.tar.gz 05:29:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:29:04 INFO - Installing collected packages: blessings 05:29:04 INFO - Running setup.py install for blessings 05:29:05 INFO - Successfully installed blessings 05:29:05 INFO - Cleaning up... 05:29:05 INFO - Return code: 0 05:29:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:29:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:29:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:29:05 INFO - Reading from file tmpfile_stdout 05:29:05 INFO - Current package versions: 05:29:05 INFO - argparse == 1.2.1 05:29:05 INFO - blessings == 1.6 05:29:05 INFO - blobuploader == 1.2.4 05:29:05 INFO - docopt == 0.6.1 05:29:05 INFO - functools32 == 3.2.3-2 05:29:05 INFO - jsonschema == 2.5.1 05:29:05 INFO - manifestparser == 1.1 05:29:05 INFO - mozInstall == 1.12 05:29:05 INFO - mozcrash == 0.17 05:29:05 INFO - mozdebug == 0.1 05:29:05 INFO - mozdevice == 0.48 05:29:05 INFO - mozfile == 1.2 05:29:05 INFO - mozhttpd == 0.7 05:29:05 INFO - mozinfo == 0.9 05:29:05 INFO - mozleak == 0.1 05:29:05 INFO - mozlog == 3.4 05:29:05 INFO - moznetwork == 0.27 05:29:05 INFO - mozprocess == 0.23 05:29:05 INFO - mozprofile == 0.28 05:29:05 INFO - mozrunner == 6.12 05:29:05 INFO - mozscreenshot == 0.1 05:29:05 INFO - mozsystemmonitor == 0.3 05:29:05 INFO - moztest == 0.7 05:29:05 INFO - mozversion == 1.4 05:29:05 INFO - psutil == 3.1.1 05:29:05 INFO - requests == 1.2.3 05:29:05 INFO - wsgiref == 0.1.2 05:29:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:29:05 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')]} 05:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:05 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')]} 05:29:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:05 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 0x7ffd54250f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe66790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe63930>, '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 0xe64830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe64cc0>, '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': '31acecf42b6a79ec49471d4a000001bb-1476361709.635707-20032881', '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 05:29:05 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 05:29:05 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 05:29:05 INFO - Using env: {'DISPLAY': ':0', 05:29:05 INFO - 'HOME': '/home/cltbld', 05:29:05 INFO - 'LANG': 'en_US.UTF-8', 05:29:05 INFO - 'LANGUAGE': 'en_US:en', 05:29:05 INFO - 'LOGNAME': 'cltbld', 05:29:05 INFO - 'MAIL': '/var/mail/cltbld', 05:29:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:05 INFO - 'MOZ_NO_REMOTE': '1', 05:29:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:05 INFO - 'NO_EM_RESTART': '1', 05:29:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:05 INFO - 'PWD': '/builds/slave/test', 05:29:05 INFO - 'SHELL': '/bin/bash', 05:29:05 INFO - 'SHLVL': '1', 05:29:05 INFO - 'TERM': 'linux', 05:29:05 INFO - 'TMOUT': '86400', 05:29:05 INFO - 'USER': 'cltbld', 05:29:05 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1476361709.635707-20032881', 05:29:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:05 INFO - '_': '/tools/buildbot/bin/python'} 05:29:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:05 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)) 05:29:05 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)) 05:29:05 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)) 05:29:05 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)) 05:29:05 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)) 05:29:05 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)) 05:29:05 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)) 05:29:05 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)) 05:29:05 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)) 05:29:05 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)) 05:29:05 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)) 05:29:05 INFO - Cleaning up... 05:29:05 INFO - Return code: 0 05:29:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:29:05 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')]} 05:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:05 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')]} 05:29:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:05 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 0x7ffd54250f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe66790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe63930>, '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 0xe64830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe64cc0>, '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': '31acecf42b6a79ec49471d4a000001bb-1476361709.635707-20032881', '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 05:29:05 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 05:29:05 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 05:29:05 INFO - Using env: {'DISPLAY': ':0', 05:29:05 INFO - 'HOME': '/home/cltbld', 05:29:05 INFO - 'LANG': 'en_US.UTF-8', 05:29:05 INFO - 'LANGUAGE': 'en_US:en', 05:29:05 INFO - 'LOGNAME': 'cltbld', 05:29:05 INFO - 'MAIL': '/var/mail/cltbld', 05:29:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:05 INFO - 'MOZ_NO_REMOTE': '1', 05:29:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:05 INFO - 'NO_EM_RESTART': '1', 05:29:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:05 INFO - 'PWD': '/builds/slave/test', 05:29:05 INFO - 'SHELL': '/bin/bash', 05:29:05 INFO - 'SHLVL': '1', 05:29:05 INFO - 'TERM': 'linux', 05:29:05 INFO - 'TMOUT': '86400', 05:29:05 INFO - 'USER': 'cltbld', 05:29:05 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1476361709.635707-20032881', 05:29:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:05 INFO - '_': '/tools/buildbot/bin/python'} 05:29:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:29:05 INFO - Cleaning up... 05:29:05 INFO - Return code: 0 05:29:05 INFO - Running post-action listener: _resource_record_post_action 05:29:05 INFO - Running post-action listener: _start_resource_monitoring 05:29:05 INFO - Starting resource monitoring. 05:29:05 INFO - [mozharness: 2016-10-13 12:29:05.833702Z] Finished create-virtualenv step (success) 05:29:05 INFO - [mozharness: 2016-10-13 12:29:05.834172Z] Running install step. 05:29:05 INFO - Running pre-action listener: _resource_record_pre_action 05:29:05 INFO - Running main action method: install 05:29:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:29:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:29:06 INFO - Reading from file tmpfile_stdout 05:29:06 INFO - Detecting whether we're running mozinstall >=1.0... 05:29:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:29:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:29:06 INFO - Reading from file tmpfile_stdout 05:29:06 INFO - Output received: 05:29:06 INFO - Usage: mozinstall [options] installer 05:29:06 INFO - Options: 05:29:06 INFO - -h, --help show this help message and exit 05:29:06 INFO - -d DEST, --destination=DEST 05:29:06 INFO - Directory to install application into. [default: 05:29:06 INFO - "/builds/slave/test"] 05:29:06 INFO - --app=APP Application being installed. [default: firefox] 05:29:06 INFO - mkdir: /builds/slave/test/build/application 05:29:06 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'] 05:29:06 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 05:29:23 INFO - Reading from file tmpfile_stdout 05:29:23 INFO - Output received: 05:29:23 INFO - /builds/slave/test/build/application/firefox/firefox 05:29:23 INFO - Running post-action listener: _resource_record_post_action 05:29:23 INFO - [mozharness: 2016-10-13 12:29:23.164953Z] Finished install step (success) 05:29:23 INFO - [mozharness: 2016-10-13 12:29:23.165294Z] Running run-tests step. 05:29:23 INFO - Running pre-action listener: _resource_record_pre_action 05:29:23 INFO - Running main action method: run_tests 05:29:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:29:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:29:23 INFO - Python 2.7.3 05:29:23 INFO - Return code: 0 05:29:23 INFO - grabbing minidump binary from tooltool 05:29:23 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')]} 05:29:23 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 0xe63930>, '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 0xe64830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe64cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:29:23 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 05:29:23 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 05:29:23 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 05:29:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:29:23 INFO - Return code: 0 05:29:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:29:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:29:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:29:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:29:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:29:23 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/1476354614/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 05:29:23 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/1476354614/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --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 05:29:23 INFO - Using env: {'DISPLAY': ':0', 05:29:23 INFO - 'HOME': '/home/cltbld', 05:29:23 INFO - 'LANG': 'en_US.UTF-8', 05:29:23 INFO - 'LANGUAGE': 'en_US:en', 05:29:23 INFO - 'LOGNAME': 'cltbld', 05:29:23 INFO - 'MAIL': '/var/mail/cltbld', 05:29:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:29:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:29:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:23 INFO - 'MOZ_NO_REMOTE': '1', 05:29:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:29:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:23 INFO - 'NO_EM_RESTART': '1', 05:29:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:23 INFO - 'PWD': '/builds/slave/test', 05:29:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:29:23 INFO - 'SHELL': '/bin/bash', 05:29:23 INFO - 'SHLVL': '1', 05:29:23 INFO - 'TERM': 'linux', 05:29:23 INFO - 'TMOUT': '86400', 05:29:23 INFO - 'USER': 'cltbld', 05:29:23 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1476361709.635707-20032881', 05:29:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:23 INFO - '_': '/tools/buildbot/bin/python'} 05:29:23 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/1476354614/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 05:29:23 INFO - mozversion application_buildid: 20161013033014 05:29:23 INFO - mozversion application_changeset: f03e2740d604d339ed553dad62a3fc54c317f8fa 05:29:23 INFO - mozversion application_display_name: Nightly 05:29:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:29:23 INFO - mozversion application_name: Firefox 05:29:23 INFO - mozversion application_remotingname: firefox 05:29:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:29:23 INFO - mozversion application_vendor: Mozilla 05:29:23 INFO - mozversion application_version: 52.0a1 05:29:23 INFO - mozversion platform_buildid: 20161013033014 05:29:23 INFO - mozversion platform_changeset: f03e2740d604d339ed553dad62a3fc54c317f8fa 05:29:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:29:23 INFO - mozversion platform_version: 52.0a1 05:29:23 INFO - using testdate: 1476361763 05:29:23 INFO - actual date: 1476361763 05:29:23 INFO - starting webserver on 'localhost:57847' 05:29:23 INFO - SUITE-START | Running 2 tests 05:29:23 INFO - TEST-START | dromaeo_css 05:29:23 INFO - operating with platform_type : linux_ 05:29:23 INFO - Initialising browser for dromaeo_css test... 05:29:23 INFO - TEST-INFO | started process 23043 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzKryz5/profile http://localhost:57847/getInfo.html) 05:29:27 INFO - PROCESS | 23043 | __metrics Screen width/height:1600/1200 05:29:27 INFO - PROCESS | 23043 | colorDepth:24 05:29:27 INFO - PROCESS | 23043 | Browser inner width/height: 1024/697 05:29:27 INFO - PROCESS | 23043 | __metrics 05:29:28 INFO - PROCESS | 23043 | 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" 05:29:28 INFO - PROCESS | 23043 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:29:28 INFO - PROCESS | 23043 | console.error: PushService: 05:29:28 INFO - PROCESS | 23043 | stateChangeProcessEnqueue: Error transitioning state 05:29:28 INFO - PROCESS | 23043 | UnknownError 05:29:29 INFO - TEST-INFO | 23043: exit 0 05:29:29 INFO - Browser initialized. 05:29:29 INFO - Running cycle 1/1 for dromaeo_css test... 05:29:29 INFO - TEST-INFO | started process 23126 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzKryz5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:29:41 INFO - PROCESS | 23126 | RSS: Main: 173850624 05:29:41 INFO - PROCESS | 23126 | 05:30:33 INFO - PROCESS | 23126 | 1476361833064 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] 05:32:43 INFO - PROCESS | 23126 | Cycle 1(1): loaded http://localhost:57847/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57847/tests/dromaeo/cssquery-ext.html) 05:32:45 INFO - PROCESS | 23126 | RSS: Main: 342732800 05:32:45 INFO - PROCESS | 23126 | 05:35:48 INFO - PROCESS | 23126 | Cycle 1(1): loaded http://localhost:57847/tests/dromaeo/cssquery-ext.html (next: http://localhost:57847/tests/dromaeo/cssquery-jquery.html) 05:35:48 INFO - PROCESS | 23126 | RSS: Main: 288034816 05:35:48 INFO - PROCESS | 23126 | 05:38:50 INFO - PROCESS | 23126 | Cycle 1(1): loaded http://localhost:57847/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57847/tests/dromaeo/cssquery-mootools.html) 05:38:51 INFO - PROCESS | 23126 | RSS: Main: 217505792 05:38:51 INFO - PROCESS | 23126 | 05:41:53 INFO - PROCESS | 23126 | Cycle 1(1): loaded http://localhost:57847/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57847/tests/dromaeo/cssquery-prototype.html) 05:41:53 INFO - PROCESS | 23126 | RSS: Main: 276623360 05:41:53 INFO - PROCESS | 23126 | 05:44:56 INFO - PROCESS | 23126 | Cycle 1(1): loaded http://localhost:57847/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57847/tests/dromaeo/cssquery-yui.html) 05:44:57 INFO - PROCESS | 23126 | RSS: Main: 215330816 05:44:57 INFO - PROCESS | 23126 | 05:47:59 INFO - PROCESS | 23126 | Cycle 1(1): loaded http://localhost:57847/tests/dromaeo/cssquery-yui.html (next: http://localhost:57847/tests/dromaeo/cssquery-dojo.html) 05:47:59 INFO - PROCESS | 23126 | RSS: Main: 308645888 05:47:59 INFO - PROCESS | 23126 | 05:47:59 INFO - PROCESS | 23126 | __start_tp_report 05:47:59 INFO - PROCESS | 23126 | _x_x_mozilla_page_load 05:47:59 INFO - PROCESS | 23126 | _x_x_mozilla_page_load_details 05:47:59 INFO - PROCESS | 23126 | |i|pagename|runs| 05:47:59 INFO - PROCESS | 23126 | |0;dojo.html;2969.331900322427;3022.7732920031003;3023.198852304139;3053.2519532714487;3064.479038563444;5108.055009823176;5157.9742101289485;5161.845144645667;5248.265242865997;5268.973655131724;5150.510701483362;5198.818041368553;5230.816921407752;5234.947650523493;5289.471052894709;4703.318018887259;4728.550787675165;4780.043991201756;4783.880402989936;4821.445533763627;4825.589824864891;4838.371011768465;4882.194437917739;4896.951030489685;4939.283803848458;4670.719756814602;4841.2012018016985;4842.588379987706;4899;4925.950740492603;4696.788644511005;4707.529247075299;4761.904761904742;4770.952290477086;4782.282657601388;4737.526247375269;4760.880977975578;4774.832880849153;4802.087603355351;4813.9037219255415;5173.715445650488;5215.739213039371;5216.113260745645;5222.112240919053;5243.501867322599;5425.6202065855405;5480.123180291134;5482.451754824526;5572.693501857396;5644.463775941279;5570.610057295991;5590.329160500725;5607.495325420691;5672.489475947144;5674.943250567483;5210.687358758487;5222.92165617516;5227.2159176123505;5236.502532259429;5239.266502689627;5549.750261238254;5599.552035837123;5698.458646428583;5700.572457065737;5755.539556835443;5403.486668766461;5418.864528386822;5425.348958125051;5478.945210547923;5481.725913704299;5440.863978400572;5485;5499.587530935116;5584.609077364546;5587.05020146576;5543.057680194376;5553.16702494629;5553.72231388437;5610.18652295423;5611.298587676541;5426.864328391822;5479.178123281539;5507.146392309199;5509.090999985037;5562.9443705563235;4287.2711639021445;4303.892402689958;4306.1172459645695;4306.3325184595815;4358.629516491071;3778.301014312361;3853.325668008087;3859.150986782903;3884.6503814656817;3913.6673382762215;5180.637355385163;5253.658512196695;5257.421683614876;5258.158694608845;5260.368755749335;5483.643563168382;5566.471185237396;5566.721663916788;5569.860753481195;5576.749046292926;5258.342707161605;5266.47335266478;5268.6575372600655;5269.894602107936;5270.130428479258;4583;4583.564561366665;4584.220682483986;4584.289435137559;4585.587297143273;5811.709414529172;5830.154627578977;5852.326982397079;5855.59010869235;5856.560757943172;5634.7464364104535;5635.0702134147405;5635.887282254414;5637.182608521824;5642.576806739593;5765.971170144123;5766.538676905921;5775.595708300379;5846.327672317568;5854.619449735754;5531.502164805187;5534.1975413565615;5534.640248383842;5535.418781027934;5540.335159780852;5488.231647569263;5535.6955367455175;5539.7784088636;5601.439856014366;5624.100143976944;5370.275012873212;5445.972770136124;5461.890762184655;5467.234587157881;5529.834104976857;5482.259894914295;5487.807926722546;5489.149181876815;5517.751701173537;5550.167474878801;5468.343798744176;5479.315085614298;5481.260029896072;5481.671099734029;5482.17767334887;5364.544013758874;5379.193121031876;5417.51242388187;5504.779808807763;5560.110382338807;5262.736863156751;5328.653637513549;5331.733413329241;5370.033393988963;5389.056915039931 05:47:59 INFO - PROCESS | 23126 | |1;ext.html;537.1805694114036;597.0655923479754;606.1180981671669;610.951123910087;632.3802673380085;30824.53763193551;42180.578194218084;43181.13637727247;43353.78323108388;43380.78309608455;44154.77922610391;44471.77764111183;44496.3325550117;44560.77719611397;44560.77719611397;8187.5087494750205;8906.821863562742;9073.591688374006;9078;9082.09179082093;8241.052278987932;10607.204459665518;10846.240763146583;10866.945665271662;11276.154288428359;11021.724456888562;11085.168612354066;11098.780243951202;11108.555657773679;11114.49984750684;8160.183981601852;8381.329493640495;11011.779764404708;11090.445477726082;11092.500837462294;10260.846087308697;10636.20228482859;10638.148948084136;10938.671839844817;10977;41625;42511.57488425107;42522;42523.57476425227;42568;3400.7109395701395;3887.5334959804723;3945.9013524661827;3953.3573625672407;3993.5806740292433;30653.233669158228;31280.843595782102;31430.685693143005;31433.057008289787;31511;4357.629601483878;4456.46522417312;4621.260598304255;4678.719276843366;4684.156851766681;338509;343034;343461;344545;344554;55712.72143639256;55927;56084;56222;56394.43605563974;58283.70858145682;58408;58441.41558584445;58448;58463.415365846646;14654.19401932904;15009.624759381102;15011.774823377658;15023;15025.774613380809;10540.420276884844;10769.62306319275;11332.886671133349;11592.072634189244;11802.52789888412;15161.317740701696;15651.686966260839;15670.843291567166;15673.373065077269;15684;5773.31328641288;6128.63228206309;6217.222847144107;6232.220972378453;6250.593711408835;918.3479729392207;997.8602995580625;1072.989270107289;1075.3655343347461;1112.7699810888855;31874;31905.202369940936;31929.201769955936;32140.517892231634;32504.286878402498;1083.6207327435334;1091.3342860854873;1102.4322473925934;1103.0032266070984;1132.5616467086918;16317.428889988794;16421;16428.260728267258;16496.587585310222;16586;531289;531542;535467;536183;536418;56764.71617641886;56847.43152568504;56888.71555642278;57057.14414283789;57124;1292.8254685617321;1330.755743379943;1331.73365326935;1361.877431031212;1369.9383527741275;29728.054389122695;30705.53941690921;31434.21414464565;31903.840480797448;32133;51344.35212126738;53440.1983970233;53571.732141339045;58960.410395895495;59124.70437647784;436344;438878;439828;440368;441244;24040.51918961576;24748.752512474646;26511.867440662674;27361.726382736713;27783.722162778115;42253.1549369017;45480.54519454763;45996.770016151044;46022.309665354376;46108.769456152506;35618.64381356153;37215.813920930224;37323.626763733104;37603.81198093992;38482.42276365801;36756.264874702894;37253.62746372502;37728.020316241586;38699.6130038696;38715.225695485366;37205.255894882495;37652.246955060196;37729.81135094307;37788.43317350297;37833.432498513095;31061.378772424876;33575.49636755402;33762.493562596086;34173.82913085419;34361.656383435846;26125.869370653785;26403.20790376292;26699.733002669724;27373.863130684218;29416.26459338534 05:47:59 INFO - PROCESS | 23126 | |2;jquery.html;370.2982847503982;390.9882703518895;399.60439165226427;405.5883278472351;418.98114584843677;13149.567330043948;14544.27278636068;16460.176991150438;19390.80609193911;19442.416727498163;17943.910280448614;18832.34086806962;18833.529161770963;19057.428277151706;19124.61750764984;5509.146082357241;5741.138829175616;5788.594798364116;5792.913106303409;5829.883402331972;4545.090981803636;5792.913106303387;5808;5816.854578635525;5839.532837373021;5542.91685624716;5766.682832444214;5771.163181338703;5779.9422005779825;5781.82654520365;5672.631278966875;5714.314282286111;5714.657120572779;5715.228444160069;5758.856028599298;4926.45808961014;5141.460146684582;5148.433672296044;5150.484951504857;5152.149895267276;18607.348742793936;18629.347972821022;18786.718199227023;20687.8965605171;22367.217147399926;2190.7809219078126;2224.510607666311;2255.0979608156704;2830.9009184678644;2851.9144425667264;13818.585442436743;14202.147871127765;14262.3581938813;14440.277986100653;14579.781303280459;1737.5742942978925;1754.2470201560166;1779.3416435918664;1790.1049475262369;1855.935042273514;49219.75390123062;75160.62419687922;83431;83644.58177709133;86090;10306.793864122825;10508.894911050944;10560.577576896992;10777.730556736144;11131.165162612837;15129.243537823066;15150.16674082914;15150.696986060217;15178.392864285304;15178.392864285526;7671.117821450604;7909.920900791033;7948.165442628557;8007.839843203104;8092.150324215872;7429.591372474566;7540.434467414966;7628.122765881883;7770.378369730408;7843.411744119214;6409.583377080568;6470.547061705635;6508.860949333847;6537.967310163419;6667.633280169637;1923.913423895928;1931.884086954787;1934.458351661537;1937;1989.691597802343;855.7005048233069;932.8507438809758;994.7562847102506;1001.1940387987739;1041.9531121099417;17567.297308107532;19178.52053698641;19313.710294345598;19619;20010.199592016157;896.2964073202505;944.15026476172;951.5955718819474;965.5234323959023;1010.9494525273707;10096.536002279776;10949.178811589163;10962.397068161328;10972.396518191576;11035.558577656964;452098;460631;460888;469049;471112;77991.61004194943;78597;79975;84500;88315.55842220748;991.7124034030195;1018.6231094495084;1022.8772547294373;1027.8972102789662;1033.452270296759;16969;17299.65400691954;17786.644267114843;17789.46631601054;17814.376496822548;34310.48534272038;35555.82222088873;43333;43963.56036439595;44318.77840610776;54772;55707.164392534956;56610.43389566051;58121;58727.41272587219;11047.740280146447;11545.48045337945;11732;11744.647660570197;11970.700732481757;12801.871981280441;12899.484020639069;12947.935260323638;13019.869801301866;13302.534411295559;5963.612365196248;8918.821623567623;10018.447140693204;11908.761824763284;11929.880701193224;11117.22179447431;11507.884921150682;11645.59240426581;11670.124740644655;11725;11979.28124312544;11984.520619175135;12015.639530814089;12055.69860753453;12096.576619818265;11833.644990650295;11838.28970261787;11867.109966752701;11945.4027298633;12089.939550302191;11772.470238839102;11904.28574285511;11907.82138267944;11930.582429614922;12149.514019439124 05:47:59 INFO - PROCESS | 23126 | |3;mootools.html;1321.3129172830133;1437.2023526942548;1477.8300495443025;1622.3510595761693;1769.133124768863;7701.383889288857;8608.354373421995;8816.77958051049;8823.514706691129;9018.36871419001;8792.384533082686;8897.065808090154;8902.332325075613;8903.065178156281;8905.688300909453;2117.4388786971463;2123.6708310211866;2126.627840127979;2133.658614621661;2137.551114266006;2051.9589608207825;2074.0252081521735;2103.064136459276;2103.5897999890026;2105.315772373977;2033.2883490778183;2033.857629965903;2033.979660203394;2042.1116814185878;2077.2521892118825;2084.395525297662;2087.12340816858;2089.414963810128;2089.9268525601533;2090.247510896076;2007.5382661987824;2055.14711394771;2090.780468050848;2091.7176181215646;2095.8742475451522;8752.56237188138;8848.51333176675;8870.112988701143;8998.910010899872;9017.729468115967;5086;5221.06020916235;5230.058589453897;5230.267762513251;5234.895302093937;3204.198950262434;3260.9673903261137;3263.3473305339026;3297.604287485517;3306.470964645669;1041.0682439216935;1047.2616805152425;1055.757175849559;1073.7423018475588;1073.8765042020111;12438.875611243953;12452.75094498105;12514.499420023189;12522.749545009048;12532.686682833002;4157.584241575818;4234.449521562239;4263.147370525907;4398.824047038147;4400.4939431965095;9781.804363912683;9808.166305863939;9817.656382026595;9819.656312029045;9823.263255255884;5003.72479513623;5007.874803129951;5009.799608015712;5011.473795251446;5015.749212539431;4144.067584793397;4166.229247589205;4175.54069052404;4667.603253723471;4680.531946805292;3428.297199074184;3679.8344074516176;3707.480952666629;3716.201016781405;3750.306193354238;1108.9722756931142;1136.8181091025397;1149.620625193684;1154.5266440759249;1154.6766905266538;954.5084281594845;974.1232890398697;974.2206235011962;983.2576404814463;993.2885906040268;5875.177475153482;5954.583179177503;5970.194023806817;6013.0980352946535;6050.667213303311;396.6866175721148;399.64032370865874;400.89175922501346;406.3173867901894;408.6975638027838;3846.74996125251;4100.5489396166395;4103.938440923389;4156.709030367845;4169.3120635094865;10053.547590358452;10342.37945723259;10367.740806479747;10429.582816687247;10460.581576736997;10360.844587331196;10362.378257304586;10379.481025948673;10394.844077338847;10405.06354428105;7845.646945887334;7897.605119744105;7906.288434040849;7916.1688022757935;7933.682652693943;5326.786928522815;5453.809116680897;5558.305211848519;5603.075492543685;5647.7176141193595;10137.594496220068;10157.187425005834;10184.592616295562;10195.490225488844;10251.48742562854;8920.668027204158;9947.253955953478;10226.07965283128;10301.484925753532;10354;6914.412274956685;7822.765317040498;7823.061232652118;8014.19858014194;8020.318272946864;8284.46151000183;8323.875141872755;8390.622421991147;8434.24091831738;8521;7542.698292068256;7710.306072453506;7713.575753333621;7718.228177182237;7871.881921771063;7491.887621685788;7552.055993000875;7556.093268807778;7589.241075892367;7641.044869391326;6547;6668.133142691613;6732.932670673231;7021.719131234693;7104.467164962545;4990.72551009698;5068.594512438923;5167;5242.554382877345;5248.3701955765555;4980.427250866197;5031.1573960712085;5101.770420331169;5156.56169225605;5211.426743058185 05:47:59 INFO - PROCESS | 23126 | |4;prototype.html;316.6516831485366;326.1194774109904;327.5021966610751;340.8509348557345;342.8268724294231;5058.570021548173;5065.696058236508;5080.07895460111;5135.075686376451;5163.380394352683;5105.749091472594;5117.592662017947;5119.157103442758;5123.590112790977;5132.409772876121;4126.8761937141935;4126.917461650765;4127.958720412787;4127.979360103195;4138.855140070098;3861.864834730785;3931.41028845674;4005.5794141615147;4028.415879697442;4131.669466442692;3986.3621820508724;4019.4372787809584;4030.838766449353;4036.9394459083137;4047.531006086285;4023.979880100581;4037.1925614876995;4040.656544193747;4045.3527435610454;4049.068714195737;3460.6676429574545;3480.8781692640637;3571.964280357189;3574.6416361782617;3619.149499867529;4975.203967365241;4982.202847544376;4987.902661414483;4991.251312303148;5007.949920500785;4561.931571026437;4583.702059366131;4586.899144205367;4594.65540084495;4601.778754871603;5118.744062796845;5284.260203571464;5294.708791016493;5311.389190243133;5345.786168553253;3917.882463526099;3924.921501569981;3927.9018024549614;3928.1161738608585;3934.1344904121047;5496.587755918282;5518.558515318765;5530.253415788858;5532.225488431583;5541.750621222055;3770.170562476251;3955.485786847749;3990.2219067281603;3998.1204135090816;4000.959990400117;4024.91327341622;4032.6169013943627;4038.2529232092156;4038.5355684096116;4050.5341885683524;4557.632710186931;4566.611837993808;4567.931481027787;4572.382728331632;4585.335126406719;5183.637145399861;5362.624616276901;5364.356277246756;5366.577856867933;5377.516023557899;1373.7527245095778;1389.7359501694646;1390.4160252693894;1394.953784661504;1403.6069900427897;867.7483529776295;890.670451932789;900.9414388064755;902.4179404284331;904.5206040798256;4535.886602834889;4587.518310577341;4600.320882877725;4609.9308510372375;4615.423072115986;5253.973730131325;5266.920281342393;5359.732013399314;5489.615726899158;5539.19681646159;5185.351831021122;5213.791448342024;5214.504622060898;5226.425093239741;5233.869153271199;2788.5839846188255;2891.3928075104045;2900.753435957925;2903.274181454636;2912.6796052434215;5679.858003549944;5682.573806964494;5696.572757043238;5715.742791574389;5727.3699893011735;5524.281843360337;5581.10242517546;5585.804496842591;5596.776128954796;5617.691026993554;5510.9448905511235;5589.469000444951;5666.518345940559;5698.886022279614;5708.4862362387585;5455.890882182413;5475.67145971243;5523.779048838162;5534.612577119563;5544.390117087037;5251.319577735088;5471.753771080391;5489.87457571205;5490.6431081979545;5513.669179849222;5678.346990096192;5697.4931030346515;5720.885582288248;5724.599278050497;5727.6849773262875;4054.9189016220103;4103.4870641169855;4108.876733697994;4121.670266378743;4132.73137246078;5276.9472305278;5414.972925135507;5464.426235245242;5482.698451585201;5488.121900495901;5274.287971123849;5282.603804714585;5307.283516725347;5314.077257508432;5317.335333083364;5313.601479889101;5324.361076670824;5326.310213342393;5338.866528336823;5343.3587969443915;5066.40285397372;5321.09541377959;5329.493698098674;5331;5341.9198712020125;5248.661591294195;5269.341332333458;5269.868253293698;5324.7870085196155;5349.9465005351;4944.332515110558;5077.619178561548;5143.4085080216255;5163.845084647466;5253.50091741284 05:47:59 INFO - PROCESS | 23126 | |5;yui.html;630.4798541203508;644.1979735229637;652.8498445357565;724.8006798130514;746.5893758432862;13294.601161965133;14515.274236288196;14540.418383264656;14567;14575.489857854964;12711.936440317786;12720.745585088293;12744.107912446132;12750.171238869467;12833.743325133491;653.0922018394411;672.2135101930728;778.493978913705;780.8906753054576;794.1780257433558;799.1568894815966;801.5230937592153;802.0215337288498;802.1857814318471;802.2498963469175;840.9621567029468;842.0737189092011;844.2907957315854;844.5270648436895;844.9662013519452;671.1744554198364;679.6160169504215;805.2390490986021;836.38107800228;836.7155167243136;598.6916737879995;615.1050221927086;615.9630422174683;616.6885722710048;616.950643948483;13253.73492530144;13267.86732132676;13282.535111271156;13294.667633309147;13295;11895.405229738564;11976.465895492585;11976.580819671357;12246.510139594406;12571.43999040801;10620.309679870783;11874.643760687193;11961.40192990347;12019.759604807854;12064.095192860483;4223.429836972;4235.237657221699;4261.4460120184485;4373.278409062501;4394.472663280395;62006.68996654988;62745.37254627486;62893;62920;74996;9692.757681057888;9717.9028209717;9801.754956126153;10118.291719579705;10173.491325433846;19540.70688939667;19741.111649975785;19749.506262343268;19752.901235494017;19794.802051979295;7837.09873364559;7888.290053895177;7947.721829735931;8066.052715147605;8085.231902969209;4275.850345237964;4368.737875727466;4417.447819022622;4435.112977404532;4595.356650068993;3498.9475157872653;3602.081469225383;3622.130688634709;3631.128529153037;3632.20091579852;579.826052184343;593.1281016905142;598.4853026397295;614.1371373220633;631.5579094633774;523.8271370447743;545.5608235370565;596.9850753731105;613.8035828534915;620.0791824141147;7959.84080318402;8017.6792928283385;8555.058943516207;8754.649814007369;9111.863322050174;493.68897594515227;562.5555810909418;614.2536817766346;627.7583130494793;629.7795771479946;3784.7918364489665;4108.1783643271465;4342.5874541918465;4435.3125265583885;4495.887602809956;104658.47670761598;118734;122887;124636;125728;102705;105374;106459;109430.45284773526;111095.44452277687;68114;68356;93291.53354233186;94922.6269343272;98040;7960.4825686330205;7994.440389172934;8078.6364613593705;8254.092049874389;8458.957705211435;52236.738816307196;52524.73737631287;52657.210141847136;53872.46127538675;54613.45386546243;71864.64067679628;80212.59893700494;80549;82699;82955;9530.571124299284;9789;9857.704268871945;10332.17342612574;10681.305715128492;10102.343347682377;10403.895961040293;10661.840072399076;10937.890621093688;11788.882111178778;10284.794304114026;10538.89461105379;10728.517216725422;10902.400367979837;11014.50434730423;10422.947885260524;10450;10952.507137178687;11033.337999720043;11388.430578471209;10384.37693738378;10413.166946644098;10880.292780969212;11273.774524509628;11462.426878655868;8090.514569125871;8690.78273043179;8735.213830755263;8796.164364385373;9342.673006444742;8733;9261.398009129385;9280.814383712153;9350.438973661601;9370.531473426438 05:47:59 INFO - PROCESS | 23126 | __end_tp_report 05:47:59 INFO - PROCESS | 23126 | __start_cc_report 05:47:59 INFO - PROCESS | 23126 | _x_x_mozilla_cycle_collect,1590 05:47:59 INFO - PROCESS | 23126 | __end_cc_report 05:47:59 INFO - PROCESS | 23126 | __startTimestamp1476362879884__endTimestamp 05:47:59 INFO - PROCESS | 23126 | 05:47:59 INFO - PROCESS | 23126 | ------- Summary: start ------- 05:47:59 INFO - PROCESS | 23126 | Number of tests: 6 05:47:59 INFO - PROCESS | 23126 | 05:47:59 INFO - PROCESS | 23126 | [#0] dojo.html Cycles:165 Average:5185.54 Median:5389.06 stddev:581.62 (10.8%) stddev-sans-first:556.81 05:47:59 INFO - PROCESS | 23126 | Values: 2969.3 3022.8 3023.2 3053.3 3064.5 5108.1 5158.0 5161.8 5248.3 5269.0 5150.5 5198.8 5230.8 5234.9 5289.5 4703.3 4728.6 4780.0 4783.9 4821.4 4825.6 4838.4 4882.2 4897.0 4939.3 4670.7 4841.2 4842.6 4899.0 4926.0 4696.8 4707.5 4761.9 4771.0 4782.3 4737.5 4760.9 4774.8 4802.1 4813.9 5173.7 5215.7 5216.1 5222.1 5243.5 5425.6 5480.1 5482.5 5572.7 5644.5 5570.6 5590.3 5607.5 5672.5 5674.9 5210.7 5222.9 5227.2 5236.5 5239.3 5549.8 5599.6 5698.5 5700.6 5755.5 5403.5 5418.9 5425.3 5478.9 5481.7 5440.9 5485.0 5499.6 5584.6 5587.1 5543.1 5553.2 5553.7 5610.2 5611.3 5426.9 5479.2 5507.1 5509.1 5562.9 4287.3 4303.9 4306.1 4306.3 4358.6 3778.3 3853.3 3859.2 3884.7 3913.7 5180.6 5253.7 5257.4 5258.2 5260.4 5483.6 5566.5 5566.7 5569.9 5576.7 5258.3 5266.5 5268.7 5269.9 5270.1 4583.0 4583.6 4584.2 4584.3 4585.6 5811.7 5830.2 5852.3 5855.6 5856.6 5634.7 5635.1 5635.9 5637.2 5642.6 5766.0 5766.5 5775.6 5846.3 5854.6 5531.5 5534.2 5534.6 5535.4 5540.3 5488.2 5535.7 5539.8 5601.4 5624.1 5370.3 5446.0 5461.9 5467.2 5529.8 5482.3 5487.8 5489.1 5517.8 5550.2 5468.3 5479.3 5481.3 5481.7 5482.2 5364.5 5379.2 5417.5 5504.8 5560.1 5262.7 5328.7 5331.7 5370.0 5389.1 05:47:59 INFO - PROCESS | 23126 | 05:47:59 INFO - PROCESS | 23126 | [#1] ext.html Cycles:180 Average:59367.21 Median:37234.72 stddev:118249.32 (317.6%) stddev-sans-first:118498.54 05:47:59 INFO - PROCESS | 23126 | Values: 537.2 597.1 606.1 611.0 632.4 30824.5 42180.6 43181.1 43353.8 43380.8 44154.8 44471.8 44496.3 44560.8 44560.8 8187.5 8906.8 9073.6 9078.0 9082.1 8241.1 10607.2 10846.2 10866.9 11276.2 11021.7 11085.2 11098.8 11108.6 11114.5 8160.2 8381.3 11011.8 11090.4 11092.5 10260.8 10636.2 10638.1 10938.7 10977.0 41625.0 42511.6 42522.0 42523.6 42568.0 3400.7 3887.5 3945.9 3953.4 3993.6 30653.2 31280.8 31430.7 31433.1 31511.0 4357.6 4456.5 4621.3 4678.7 4684.2 338509.0 343034.0 343461.0 344545.0 344554.0 55712.7 55927.0 56084.0 56222.0 56394.4 58283.7 58408.0 58441.4 58448.0 58463.4 14654.2 15009.6 15011.8 15023.0 15025.8 10540.4 10769.6 11332.9 11592.1 11802.5 15161.3 15651.7 15670.8 15673.4 15684.0 5773.3 6128.6 6217.2 6232.2 6250.6 918.3 997.9 1073.0 1075.4 1112.8 31874.0 31905.2 31929.2 32140.5 32504.3 1083.6 1091.3 1102.4 1103.0 1132.6 16317.4 16421.0 16428.3 16496.6 16586.0 531289.0 531542.0 535467.0 536183.0 536418.0 56764.7 56847.4 56888.7 57057.1 57124.0 1292.8 1330.8 1331.7 1361.9 1369.9 29728.1 30705.5 31434.2 31903.8 32133.0 51344.4 53440.2 53571.7 58960.4 59124.7 436344.0 438878.0 439828.0 440368.0 441244.0 24040.5 24748.8 26511.9 27361.7 27783.7 42253.2 45480.5 45996.8 46022.3 46108.8 35618.6 37215.8 37323.6 37603.8 38482.4 36756.3 37253.6 37728.0 38699.6 38715.2 37205.3 37652.2 37729.8 37788.4 37833.4 31061.4 33575.5 33762.5 34173.8 34361.7 26125.9 26403.2 26699.7 27373.9 29416.3 05:47:59 INFO - PROCESS | 23126 | 05:47:59 INFO - PROCESS | 23126 | [#2] jquery.html Cycles:180 Average:27810.04 Median:10804.35 stddev:76130.65 (704.6%) stddev-sans-first:76316.33 05:47:59 INFO - PROCESS | 23126 | Values: 370.3 391.0 399.6 405.6 419.0 13149.6 14544.3 16460.2 19390.8 19442.4 17943.9 18832.3 18833.5 19057.4 19124.6 5509.1 5741.1 5788.6 5792.9 5829.9 4545.1 5792.9 5808.0 5816.9 5839.5 5542.9 5766.7 5771.2 5779.9 5781.8 5672.6 5714.3 5714.7 5715.2 5758.9 4926.5 5141.5 5148.4 5150.5 5152.1 18607.3 18629.3 18786.7 20687.9 22367.2 2190.8 2224.5 2255.1 2830.9 2851.9 13818.6 14202.1 14262.4 14440.3 14579.8 1737.6 1754.2 1779.3 1790.1 1855.9 49219.8 75160.6 83431.0 83644.6 86090.0 10306.8 10508.9 10560.6 10777.7 11131.2 15129.2 15150.2 15150.7 15178.4 15178.4 7671.1 7909.9 7948.2 8007.8 8092.2 7429.6 7540.4 7628.1 7770.4 7843.4 6409.6 6470.5 6508.9 6538.0 6667.6 1923.9 1931.9 1934.5 1937.0 1989.7 855.7 932.9 994.8 1001.2 1042.0 17567.3 19178.5 19313.7 19619.0 20010.2 896.3 944.2 951.6 965.5 1010.9 10096.5 10949.2 10962.4 10972.4 11035.6 452098.0 460631.0 460888.0 469049.0 471112.0 77991.6 78597.0 79975.0 84500.0 88315.6 991.7 1018.6 1022.9 1027.9 1033.5 16969.0 17299.7 17786.6 17789.5 17814.4 34310.5 35555.8 43333.0 43963.6 44318.8 54772.0 55707.2 56610.4 58121.0 58727.4 11047.7 11545.5 11732.0 11744.6 11970.7 12801.9 12899.5 12947.9 13019.9 13302.5 5963.6 8918.8 10018.4 11908.8 11929.9 11117.2 11507.9 11645.6 11670.1 11725.0 11979.3 11984.5 12015.6 12055.7 12096.6 11833.6 11838.3 11867.1 11945.4 12089.9 11772.5 11904.3 11907.8 11930.6 12149.5 05:47:59 INFO - PROCESS | 23126 | 05:47:59 INFO - PROCESS | 23126 | [#3] mootools.html Cycles:180 Average:5631.61 Median:4534.05 stddev:3311.24 (73.0%) stddev-sans-first:3304.68 05:47:59 INFO - PROCESS | 23126 | Values: 1321.3 1437.2 1477.8 1622.4 1769.1 7701.4 8608.4 8816.8 8823.5 9018.4 8792.4 8897.1 8902.3 8903.1 8905.7 2117.4 2123.7 2126.6 2133.7 2137.6 2052.0 2074.0 2103.1 2103.6 2105.3 2033.3 2033.9 2034.0 2042.1 2077.3 2084.4 2087.1 2089.4 2089.9 2090.2 2007.5 2055.1 2090.8 2091.7 2095.9 8752.6 8848.5 8870.1 8998.9 9017.7 5086.0 5221.1 5230.1 5230.3 5234.9 3204.2 3261.0 3263.3 3297.6 3306.5 1041.1 1047.3 1055.8 1073.7 1073.9 12438.9 12452.8 12514.5 12522.7 12532.7 4157.6 4234.4 4263.1 4398.8 4400.5 9781.8 9808.2 9817.7 9819.7 9823.3 5003.7 5007.9 5009.8 5011.5 5015.7 4144.1 4166.2 4175.5 4667.6 4680.5 3428.3 3679.8 3707.5 3716.2 3750.3 1109.0 1136.8 1149.6 1154.5 1154.7 954.5 974.1 974.2 983.3 993.3 5875.2 5954.6 5970.2 6013.1 6050.7 396.7 399.6 400.9 406.3 408.7 3846.7 4100.5 4103.9 4156.7 4169.3 10053.5 10342.4 10367.7 10429.6 10460.6 10360.8 10362.4 10379.5 10394.8 10405.1 7845.6 7897.6 7906.3 7916.2 7933.7 5326.8 5453.8 5558.3 5603.1 5647.7 10137.6 10157.2 10184.6 10195.5 10251.5 8920.7 9947.3 10226.1 10301.5 10354.0 6914.4 7822.8 7823.1 8014.2 8020.3 8284.5 8323.9 8390.6 8434.2 8521.0 7542.7 7710.3 7713.6 7718.2 7871.9 7491.9 7552.1 7556.1 7589.2 7641.0 6547.0 6668.1 6732.9 7021.7 7104.5 4990.7 5068.6 5167.0 5242.6 5248.4 4980.4 5031.2 5101.8 5156.6 5211.4 05:47:59 INFO - PROCESS | 23126 | 05:47:59 INFO - PROCESS | 23126 | [#4] prototype.html Cycles:180 Average:4506.27 Median:5128.00 stddev:1307.85 (25.5%) stddev-sans-first:1273.15 05:47:59 INFO - PROCESS | 23126 | Values: 316.7 326.1 327.5 340.9 342.8 5058.6 5065.7 5080.1 5135.1 5163.4 5105.7 5117.6 5119.2 5123.6 5132.4 4126.9 4126.9 4128.0 4128.0 4138.9 3861.9 3931.4 4005.6 4028.4 4131.7 3986.4 4019.4 4030.8 4036.9 4047.5 4024.0 4037.2 4040.7 4045.4 4049.1 3460.7 3480.9 3572.0 3574.6 3619.1 4975.2 4982.2 4987.9 4991.3 5007.9 4561.9 4583.7 4586.9 4594.7 4601.8 5118.7 5284.3 5294.7 5311.4 5345.8 3917.9 3924.9 3927.9 3928.1 3934.1 5496.6 5518.6 5530.3 5532.2 5541.8 3770.2 3955.5 3990.2 3998.1 4001.0 4024.9 4032.6 4038.3 4038.5 4050.5 4557.6 4566.6 4567.9 4572.4 4585.3 5183.6 5362.6 5364.4 5366.6 5377.5 1373.8 1389.7 1390.4 1395.0 1403.6 867.7 890.7 900.9 902.4 904.5 4535.9 4587.5 4600.3 4609.9 4615.4 5254.0 5266.9 5359.7 5489.6 5539.2 5185.4 5213.8 5214.5 5226.4 5233.9 2788.6 2891.4 2900.8 2903.3 2912.7 5679.9 5682.6 5696.6 5715.7 5727.4 5524.3 5581.1 5585.8 5596.8 5617.7 5510.9 5589.5 5666.5 5698.9 5708.5 5455.9 5475.7 5523.8 5534.6 5544.4 5251.3 5471.8 5489.9 5490.6 5513.7 5678.3 5697.5 5720.9 5724.6 5727.7 4054.9 4103.5 4108.9 4121.7 4132.7 5276.9 5415.0 5464.4 5482.7 5488.1 5274.3 5282.6 5307.3 5314.1 5317.3 5313.6 5324.4 5326.3 5338.9 5343.4 5066.4 5321.1 5329.5 5331.0 5341.9 5248.7 5269.3 5269.9 5324.8 5349.9 4944.3 5077.6 5143.4 5163.8 5253.5 05:47:59 INFO - PROCESS | 23126 | 05:47:59 INFO - PROCESS | 23126 | [#5] yui.html Cycles:180 Average:20031.81 Median:27579.51 stddev:31005.27 (112.4%) stddev-sans-first:31058.02 05:47:59 INFO - PROCESS | 23126 | Values: 630.5 644.2 652.8 724.8 746.6 13294.6 14515.3 14540.4 14567.0 14575.5 12711.9 12720.7 12744.1 12750.2 12833.7 653.1 672.2 778.5 780.9 794.2 799.2 801.5 802.0 802.2 802.2 841.0 842.1 844.3 844.5 845.0 671.2 679.6 805.2 836.4 836.7 598.7 615.1 616.0 616.7 617.0 13253.7 13267.9 13282.5 13294.7 13295.0 11895.4 11976.5 11976.6 12246.5 12571.4 10620.3 11874.6 11961.4 12019.8 12064.1 4223.4 4235.2 4261.4 4373.3 4394.5 62006.7 62745.4 62893.0 62920.0 74996.0 9692.8 9717.9 9801.8 10118.3 10173.5 19540.7 19741.1 19749.5 19752.9 19794.8 7837.1 7888.3 7947.7 8066.1 8085.2 4275.9 4368.7 4417.4 4435.1 4595.4 3498.9 3602.1 3622.1 3631.1 3632.2 579.8 593.1 598.5 614.1 631.6 523.8 545.6 597.0 613.8 620.1 7959.8 8017.7 8555.1 8754.6 9111.9 493.7 562.6 614.3 627.8 629.8 3784.8 4108.2 4342.6 4435.3 4495.9 104658.5 118734.0 122887.0 124636.0 125728.0 102705.0 105374.0 106459.0 109430.5 111095.4 68114.0 68356.0 93291.5 94922.6 98040.0 7960.5 7994.4 8078.6 8254.1 8459.0 52236.7 52524.7 52657.2 53872.5 54613.5 71864.6 80212.6 80549.0 82699.0 82955.0 9530.6 9789.0 9857.7 10332.2 10681.3 10102.3 10403.9 10661.8 10937.9 11788.9 10284.8 10538.9 10728.5 10902.4 11014.5 10422.9 10450.0 10952.5 11033.3 11388.4 10384.4 10413.2 10880.3 11273.8 11462.4 8090.5 8690.8 8735.2 8796.2 9342.7 8733.0 9261.4 9280.8 9350.4 9370.5 05:47:59 INFO - PROCESS | 23126 | -------- Summary: end -------- 05:47:59 INFO - PROCESS | 23126 | 05:48:00 INFO - TEST-INFO | 23126: exit 0 05:48:00 INFO - TEST-OK | dromaeo_css | took 1117299ms 05:48:00 INFO - TEST-START | kraken 05:48:00 INFO - operating with platform_type : linux_ 05:48:00 INFO - Initialising browser for kraken test... 05:48:00 INFO - TEST-INFO | started process 23434 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS2w5iH/profile http://localhost:57847/getInfo.html) 05:48:04 INFO - PROCESS | 23434 | __metrics Screen width/height:1600/1200 05:48:04 INFO - PROCESS | 23434 | colorDepth:24 05:48:04 INFO - PROCESS | 23434 | Browser inner width/height: 1024/697 05:48:04 INFO - PROCESS | 23434 | __metrics 05:48:05 INFO - PROCESS | 23434 | 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" 05:48:05 INFO - PROCESS | 23434 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:48:05 INFO - PROCESS | 23434 | console.error: PushService: 05:48:05 INFO - PROCESS | 23434 | stateChangeProcessEnqueue: Error transitioning state 05:48:05 INFO - PROCESS | 23434 | UnknownError 05:48:06 INFO - TEST-INFO | 23434: exit 0 05:48:06 INFO - Browser initialized. 05:48:06 INFO - Running cycle 1/1 for kraken test... 05:48:06 INFO - TEST-INFO | started process 23516 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS2w5iH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:48:18 INFO - PROCESS | 23516 | RSS: Main: 174542848 05:48:18 INFO - PROCESS | 23516 | 05:48:21 INFO - PROCESS | 23516 | Cycle 1(1): loaded http://localhost:57847/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57847/tests/kraken/driver.html?testName=audio-beat-detection) 05:48:22 INFO - PROCESS | 23516 | RSS: Main: 241745920 05:48:22 INFO - PROCESS | 23516 | 05:48:24 INFO - PROCESS | 23516 | Cycle 1(1): loaded http://localhost:57847/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57847/tests/kraken/driver.html?testName=audio-dft) 05:48:25 INFO - PROCESS | 23516 | RSS: Main: 218062848 05:48:25 INFO - PROCESS | 23516 | 05:48:28 INFO - PROCESS | 23516 | Cycle 1(1): loaded http://localhost:57847/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57847/tests/kraken/driver.html?testName=audio-fft) 05:48:29 INFO - PROCESS | 23516 | RSS: Main: 299343872 05:48:29 INFO - PROCESS | 23516 | 05:48:31 INFO - PROCESS | 23516 | Cycle 1(1): loaded http://localhost:57847/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57847/tests/kraken/driver.html?testName=audio-oscillator) 05:48:31 INFO - PROCESS | 23516 | RSS: Main: 211156992 05:48:31 INFO - PROCESS | 23516 | 05:48:34 INFO - PROCESS | 23516 | Cycle 1(1): loaded http://localhost:57847/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57847/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:48:34 INFO - PROCESS | 23516 | RSS: Main: 213712896 05:48:34 INFO - PROCESS | 23516 | 05:48:37 INFO - PROCESS | 23516 | Cycle 1(1): loaded http://localhost:57847/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57847/tests/kraken/driver.html?testName=imaging-darkroom) 05:48:38 INFO - PROCESS | 23516 | RSS: Main: 249532416 05:48:38 INFO - PROCESS | 23516 | 05:48:41 INFO - PROCESS | 23516 | Cycle 1(1): loaded http://localhost:57847/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57847/tests/kraken/driver.html?testName=imaging-desaturate) 05:48:42 INFO - PROCESS | 23516 | RSS: Main: 248557568 05:48:42 INFO - PROCESS | 23516 | 05:48:44 INFO - PROCESS | 23516 | Cycle 1(1): loaded http://localhost:57847/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57847/tests/kraken/driver.html?testName=json-parse-financial) 05:48:45 INFO - PROCESS | 23516 | RSS: Main: 247427072 05:48:45 INFO - PROCESS | 23516 | 05:48:47 INFO - PROCESS | 23516 | Cycle 1(1): loaded http://localhost:57847/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57847/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:48:47 INFO - PROCESS | 23516 | RSS: Main: 210489344 05:48:47 INFO - PROCESS | 23516 | 05:48:49 INFO - PROCESS | 23516 | Cycle 1(1): loaded http://localhost:57847/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57847/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:48:50 INFO - PROCESS | 23516 | RSS: Main: 218230784 05:48:50 INFO - PROCESS | 23516 | 05:48:52 INFO - PROCESS | 23516 | Cycle 1(1): loaded http://localhost:57847/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57847/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:48:52 INFO - PROCESS | 23516 | RSS: Main: 227602432 05:48:52 INFO - PROCESS | 23516 | 05:48:55 INFO - PROCESS | 23516 | Cycle 1(1): loaded http://localhost:57847/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57847/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:48:56 INFO - PROCESS | 23516 | RSS: Main: 236400640 05:48:56 INFO - PROCESS | 23516 | 05:48:58 INFO - PROCESS | 23516 | Cycle 1(1): loaded http://localhost:57847/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57847/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:48:59 INFO - PROCESS | 23516 | RSS: Main: 233046016 05:48:59 INFO - PROCESS | 23516 | 05:49:01 INFO - PROCESS | 23516 | Cycle 1(1): loaded http://localhost:57847/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57847/tests/kraken/driver.html?testName=ai-astar) 05:49:01 INFO - PROCESS | 23516 | RSS: Main: 282931200 05:49:01 INFO - PROCESS | 23516 | 05:49:01 INFO - PROCESS | 23516 | __start_tp_report 05:49:01 INFO - PROCESS | 23516 | _x_x_mozilla_page_load 05:49:01 INFO - PROCESS | 23516 | _x_x_mozilla_page_load_details 05:49:01 INFO - PROCESS | 23516 | |i|pagename|runs| 05:49:01 INFO - PROCESS | 23516 | |0;ai-astar;108;110;111;109;109;110;110;109;111;110 05:49:01 INFO - PROCESS | 23516 | |1;audio-beat-detection;149;123;127;159;129;125;126;120;156;127 05:49:01 INFO - PROCESS | 23516 | |2;audio-dft;161;163;160;164;163;161;161;161;161;165 05:49:01 INFO - PROCESS | 23516 | |3;audio-fft;75;76;75;122;75;76;77;75;120;76 05:49:01 INFO - PROCESS | 23516 | |4;audio-oscillator;83;82;112;83;83;83;113;82;81;117 05:49:01 INFO - PROCESS | 23516 | |5;imaging-gaussian-blur;118;118;117;117;117;118;118;117;116;117 05:49:01 INFO - PROCESS | 23516 | |6;imaging-darkroom;145;146;146;145;147;146;145;146;146;146 05:49:01 INFO - PROCESS | 23516 | |7;imaging-desaturate;95;95;95;96;95;95;96;95;95;95 05:49:01 INFO - PROCESS | 23516 | |8;json-parse-financial;54;52;52;52;53;55;52;52;53;52 05:49:01 INFO - PROCESS | 23516 | |9;json-stringify-tinderbox;61;61;61;61;63;61;61;63;62;62 05:49:01 INFO - PROCESS | 23516 | |10;stanford-crypto-aes;81;82;79;80;87;81;79;87;81;79 05:49:01 INFO - PROCESS | 23516 | |11;stanford-crypto-ccm;131;146;139;129;131;137;129;136;177;143 05:49:01 INFO - PROCESS | 23516 | |12;stanford-crypto-pbkdf2;174;170;170;174;174;175;169;169;171;172 05:49:01 INFO - PROCESS | 23516 | |13;stanford-crypto-sha256-iterative;67;66;68;66;65;67;67;65;66;64 05:49:01 INFO - PROCESS | 23516 | __end_tp_report 05:49:01 INFO - PROCESS | 23516 | __start_cc_report 05:49:01 INFO - PROCESS | 23516 | _x_x_mozilla_cycle_collect,1705 05:49:01 INFO - PROCESS | 23516 | __end_cc_report 05:49:01 INFO - PROCESS | 23516 | __startTimestamp1476362941413__endTimestamp 05:49:01 INFO - PROCESS | 23516 | 05:49:01 INFO - PROCESS | 23516 | ------- Summary: start ------- 05:49:01 INFO - PROCESS | 23516 | Number of tests: 14 05:49:01 INFO - PROCESS | 23516 | 05:49:01 INFO - PROCESS | 23516 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.00 stddev:0.95 (0.9%) stddev-sans-first:0.78 05:49:01 INFO - PROCESS | 23516 | Values: 108.0 110.0 111.0 109.0 109.0 110.0 110.0 109.0 111.0 110.0 05:49:01 INFO - PROCESS | 23516 | 05:49:01 INFO - PROCESS | 23516 | [#1] audio-beat-detection Cycles:10 Average:134.10 Median:128.00 stddev:14.60 (11.4%) stddev-sans-first:14.46 05:49:01 INFO - PROCESS | 23516 | Values: 149.0 123.0 127.0 159.0 129.0 125.0 126.0 120.0 156.0 127.0 05:49:01 INFO - PROCESS | 23516 | 05:49:01 INFO - PROCESS | 23516 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.63 (1.0%) stddev-sans-first:1.69 05:49:01 INFO - PROCESS | 23516 | Values: 161.0 163.0 160.0 164.0 163.0 161.0 161.0 161.0 161.0 165.0 05:49:01 INFO - PROCESS | 23516 | 05:49:01 INFO - PROCESS | 23516 | [#3] audio-fft Cycles:10 Average:84.70 Median:75.50 stddev:19.15 (25.4%) stddev-sans-first:19.99 05:49:01 INFO - PROCESS | 23516 | Values: 75.0 76.0 75.0 122.0 75.0 76.0 77.0 75.0 120.0 76.0 05:49:01 INFO - PROCESS | 23516 | 05:49:01 INFO - PROCESS | 23516 | [#4] audio-oscillator Cycles:10 Average:91.90 Median:82.50 stddev:15.31 (18.6%) stddev-sans-first:15.90 05:49:01 INFO - PROCESS | 23516 | Values: 83.0 82.0 112.0 83.0 83.0 83.0 113.0 82.0 81.0 117.0 05:49:01 INFO - PROCESS | 23516 | 05:49:01 INFO - PROCESS | 23516 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.50 stddev:0.67 (0.6%) stddev-sans-first:0.67 05:49:01 INFO - PROCESS | 23516 | Values: 118.0 118.0 117.0 117.0 117.0 118.0 118.0 117.0 116.0 117.0 05:49:01 INFO - PROCESS | 23516 | 05:49:01 INFO - PROCESS | 23516 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 05:49:01 INFO - PROCESS | 23516 | Values: 145.0 146.0 146.0 145.0 147.0 146.0 145.0 146.0 146.0 146.0 05:49:01 INFO - PROCESS | 23516 | 05:49:01 INFO - PROCESS | 23516 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:49:01 INFO - PROCESS | 23516 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 95.0 95.0 05:49:01 INFO - PROCESS | 23516 | 05:49:01 INFO - PROCESS | 23516 | [#8] json-parse-financial Cycles:10 Average:52.70 Median:52.50 stddev:1.06 (2.0%) stddev-sans-first:1.01 05:49:01 INFO - PROCESS | 23516 | Values: 54.0 52.0 52.0 52.0 53.0 55.0 52.0 52.0 53.0 52.0 05:49:01 INFO - PROCESS | 23516 | 05:49:01 INFO - PROCESS | 23516 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:61.50 stddev:0.84 (1.4%) stddev-sans-first:0.87 05:49:01 INFO - PROCESS | 23516 | Values: 61.0 61.0 61.0 61.0 63.0 61.0 61.0 63.0 62.0 62.0 05:49:01 INFO - PROCESS | 23516 | 05:49:01 INFO - PROCESS | 23516 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:81.00 stddev:3.03 (3.7%) stddev-sans-first:3.20 05:49:01 INFO - PROCESS | 23516 | Values: 81.0 82.0 79.0 80.0 87.0 81.0 79.0 87.0 81.0 79.0 05:49:01 INFO - PROCESS | 23516 | 05:49:01 INFO - PROCESS | 23516 | [#11] stanford-crypto-ccm Cycles:10 Average:139.80 Median:138.00 stddev:14.31 (10.4%) stddev-sans-first:14.82 05:49:01 INFO - PROCESS | 23516 | Values: 131.0 146.0 139.0 129.0 131.0 137.0 129.0 136.0 177.0 143.0 05:49:01 INFO - PROCESS | 23516 | 05:49:01 INFO - PROCESS | 23516 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.80 Median:173.00 stddev:2.30 (1.3%) stddev-sans-first:2.30 05:49:01 INFO - PROCESS | 23516 | Values: 174.0 170.0 170.0 174.0 174.0 175.0 169.0 169.0 171.0 172.0 05:49:01 INFO - PROCESS | 23516 | 05:49:01 INFO - PROCESS | 23516 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.50 stddev:1.20 (1.8%) stddev-sans-first:1.22 05:49:01 INFO - PROCESS | 23516 | Values: 67.0 66.0 68.0 66.0 65.0 67.0 67.0 65.0 66.0 64.0 05:49:01 INFO - PROCESS | 23516 | -------- Summary: end -------- 05:49:01 INFO - PROCESS | 23516 | 05:49:02 INFO - TEST-INFO | 23516: exit 0 05:49:02 INFO - TEST-OK | kraken | took 61883ms 05:49:02 INFO - SUITE-END | took 1179s 05:49:03 INFO - Completed test suite (00:19:39) 05:49:03 INFO - javascript benchmark 05:49:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2969.331900322427, 3022.7732920031003, 3023.198852304139, 3053.2519532714487, 3064.479038563444, 5108.055009823176, 5157.9742101289485, 5161.845144645667, 5248.265242865997, 5268.973655131724, 5150.510701483362, 5198.818041368553, 5230.816921407752, 5234.947650523493, 5289.471052894709, 4703.318018887259, 4728.550787675165, 4780.043991201756, 4783.880402989936, 4821.445533763627, 4825.589824864891, 4838.371011768465, 4882.194437917739, 4896.951030489685, 4939.283803848458, 4670.719756814602, 4841.2012018016985, 4842.588379987706, 4899.0, 4925.950740492603, 4696.788644511005, 4707.529247075299, 4761.904761904742, 4770.952290477086, 4782.282657601388, 4737.526247375269, 4760.880977975578, 4774.832880849153, 4802.087603355351, 4813.9037219255415, 5173.715445650488, 5215.739213039371, 5216.113260745645, 5222.112240919053, 5243.501867322599, 5425.6202065855405, 5480.123180291134, 5482.451754824526, 5572.693501857396, 5644.463775941279, 5570.610057295991, 5590.329160500725, 5607.495325420691, 5672.489475947144, 5674.943250567483, 5210.687358758487, 5222.92165617516, 5227.2159176123505, 5236.502532259429, 5239.266502689627, 5549.750261238254, 5599.552035837123, 5698.458646428583, 5700.572457065737, 5755.539556835443, 5403.486668766461, 5418.864528386822, 5425.348958125051, 5478.945210547923, 5481.725913704299, 5440.863978400572, 5485.0, 5499.587530935116, 5584.609077364546, 5587.05020146576, 5543.057680194376, 5553.16702494629, 5553.72231388437, 5610.18652295423, 5611.298587676541, 5426.864328391822, 5479.178123281539, 5507.146392309199, 5509.090999985037, 5562.9443705563235, 4287.2711639021445, 4303.892402689958, 4306.1172459645695, 4306.3325184595815, 4358.629516491071, 3778.301014312361, 3853.325668008087, 3859.150986782903, 3884.6503814656817, 3913.6673382762215, 5180.637355385163, 5253.658512196695, 5257.421683614876, 5258.158694608845, 5260.368755749335, 5483.643563168382, 5566.471185237396, 5566.721663916788, 5569.860753481195, 5576.749046292926, 5258.342707161605, 5266.47335266478, 5268.6575372600655, 5269.894602107936, 5270.130428479258, 4583.0, 4583.564561366665, 4584.220682483986, 4584.289435137559, 4585.587297143273, 5811.709414529172, 5830.154627578977, 5852.326982397079, 5855.59010869235, 5856.560757943172, 5634.7464364104535, 5635.0702134147405, 5635.887282254414, 5637.182608521824, 5642.576806739593, 5765.971170144123, 5766.538676905921, 5775.595708300379, 5846.327672317568, 5854.619449735754, 5531.502164805187, 5534.1975413565615, 5534.640248383842, 5535.418781027934, 5540.335159780852, 5488.231647569263, 5535.6955367455175, 5539.7784088636, 5601.439856014366, 5624.100143976944, 5370.275012873212, 5445.972770136124, 5461.890762184655, 5467.234587157881, 5529.834104976857, 5482.259894914295, 5487.807926722546, 5489.149181876815, 5517.751701173537, 5550.167474878801, 5468.343798744176, 5479.315085614298, 5481.260029896072, 5481.671099734029, 5482.17767334887, 5364.544013758874, 5379.193121031876, 5417.51242388187, 5504.779808807763, 5560.110382338807, 5262.736863156751, 5328.653637513549, 5331.733413329241, 5370.033393988963, 5389.056915039931], "value": 5146.730273383547, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [537.1805694114036, 597.0655923479754, 606.1180981671669, 610.951123910087, 632.3802673380085, 30824.53763193551, 42180.578194218084, 43181.13637727247, 43353.78323108388, 43380.78309608455, 44154.77922610391, 44471.77764111183, 44496.3325550117, 44560.77719611397, 44560.77719611397, 8187.5087494750205, 8906.821863562742, 9073.591688374006, 9078.0, 9082.09179082093, 8241.052278987932, 10607.204459665518, 10846.240763146583, 10866.945665271662, 11276.154288428359, 11021.724456888562, 11085.168612354066, 11098.780243951202, 11108.555657773679, 11114.49984750684, 8160.183981601852, 8381.329493640495, 11011.779764404708, 11090.445477726082, 11092.500837462294, 10260.846087308697, 10636.20228482859, 10638.148948084136, 10938.671839844817, 10977.0, 41625.0, 42511.57488425107, 42522.0, 42523.57476425227, 42568.0, 3400.7109395701395, 3887.5334959804723, 3945.9013524661827, 3953.3573625672407, 3993.5806740292433, 30653.233669158228, 31280.843595782102, 31430.685693143005, 31433.057008289787, 31511.0, 4357.629601483878, 4456.46522417312, 4621.260598304255, 4678.719276843366, 4684.156851766681, 338509.0, 343034.0, 343461.0, 344545.0, 344554.0, 55712.72143639256, 55927.0, 56084.0, 56222.0, 56394.43605563974, 58283.70858145682, 58408.0, 58441.41558584445, 58448.0, 58463.415365846646, 14654.19401932904, 15009.624759381102, 15011.774823377658, 15023.0, 15025.774613380809, 10540.420276884844, 10769.62306319275, 11332.886671133349, 11592.072634189244, 11802.52789888412, 15161.317740701696, 15651.686966260839, 15670.843291567166, 15673.373065077269, 15684.0, 5773.31328641288, 6128.63228206309, 6217.222847144107, 6232.220972378453, 6250.593711408835, 918.3479729392207, 997.8602995580625, 1072.989270107289, 1075.3655343347461, 1112.7699810888855, 31874.0, 31905.202369940936, 31929.201769955936, 32140.517892231634, 32504.286878402498, 1083.6207327435334, 1091.3342860854873, 1102.4322473925934, 1103.0032266070984, 1132.5616467086918, 16317.428889988794, 16421.0, 16428.260728267258, 16496.587585310222, 16586.0, 531289.0, 531542.0, 535467.0, 536183.0, 536418.0, 56764.71617641886, 56847.43152568504, 56888.71555642278, 57057.14414283789, 57124.0, 1292.8254685617321, 1330.755743379943, 1331.73365326935, 1361.877431031212, 1369.9383527741275, 29728.054389122695, 30705.53941690921, 31434.21414464565, 31903.840480797448, 32133.0, 51344.35212126738, 53440.1983970233, 53571.732141339045, 58960.410395895495, 59124.70437647784, 436344.0, 438878.0, 439828.0, 440368.0, 441244.0, 24040.51918961576, 24748.752512474646, 26511.867440662674, 27361.726382736713, 27783.722162778115, 42253.1549369017, 45480.54519454763, 45996.770016151044, 46022.309665354376, 46108.769456152506, 35618.64381356153, 37215.813920930224, 37323.626763733104, 37603.81198093992, 38482.42276365801, 36756.264874702894, 37253.62746372502, 37728.020316241586, 38699.6130038696, 38715.225695485366, 37205.255894882495, 37652.246955060196, 37729.81135094307, 37788.43317350297, 37833.432498513095, 31061.378772424876, 33575.49636755402, 33762.493562596086, 34173.82913085419, 34361.656383435846, 26125.869370653785, 26403.20790376292, 26699.733002669724, 27373.863130684218, 29416.26459338534], "value": 19837.28417800481, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.2982847503982, 390.9882703518895, 399.60439165226427, 405.5883278472351, 418.98114584843677, 13149.567330043948, 14544.27278636068, 16460.176991150438, 19390.80609193911, 19442.416727498163, 17943.910280448614, 18832.34086806962, 18833.529161770963, 19057.428277151706, 19124.61750764984, 5509.146082357241, 5741.138829175616, 5788.594798364116, 5792.913106303409, 5829.883402331972, 4545.090981803636, 5792.913106303387, 5808.0, 5816.854578635525, 5839.532837373021, 5542.91685624716, 5766.682832444214, 5771.163181338703, 5779.9422005779825, 5781.82654520365, 5672.631278966875, 5714.314282286111, 5714.657120572779, 5715.228444160069, 5758.856028599298, 4926.45808961014, 5141.460146684582, 5148.433672296044, 5150.484951504857, 5152.149895267276, 18607.348742793936, 18629.347972821022, 18786.718199227023, 20687.8965605171, 22367.217147399926, 2190.7809219078126, 2224.510607666311, 2255.0979608156704, 2830.9009184678644, 2851.9144425667264, 13818.585442436743, 14202.147871127765, 14262.3581938813, 14440.277986100653, 14579.781303280459, 1737.5742942978925, 1754.2470201560166, 1779.3416435918664, 1790.1049475262369, 1855.935042273514, 49219.75390123062, 75160.62419687922, 83431.0, 83644.58177709133, 86090.0, 10306.793864122825, 10508.894911050944, 10560.577576896992, 10777.730556736144, 11131.165162612837, 15129.243537823066, 15150.16674082914, 15150.696986060217, 15178.392864285304, 15178.392864285526, 7671.117821450604, 7909.920900791033, 7948.165442628557, 8007.839843203104, 8092.150324215872, 7429.591372474566, 7540.434467414966, 7628.122765881883, 7770.378369730408, 7843.411744119214, 6409.583377080568, 6470.547061705635, 6508.860949333847, 6537.967310163419, 6667.633280169637, 1923.913423895928, 1931.884086954787, 1934.458351661537, 1937.0, 1989.691597802343, 855.7005048233069, 932.8507438809758, 994.7562847102506, 1001.1940387987739, 1041.9531121099417, 17567.297308107532, 19178.52053698641, 19313.710294345598, 19619.0, 20010.199592016157, 896.2964073202505, 944.15026476172, 951.5955718819474, 965.5234323959023, 1010.9494525273707, 10096.536002279776, 10949.178811589163, 10962.397068161328, 10972.396518191576, 11035.558577656964, 452098.0, 460631.0, 460888.0, 469049.0, 471112.0, 77991.61004194943, 78597.0, 79975.0, 84500.0, 88315.55842220748, 991.7124034030195, 1018.6231094495084, 1022.8772547294373, 1027.8972102789662, 1033.452270296759, 16969.0, 17299.65400691954, 17786.644267114843, 17789.46631601054, 17814.376496822548, 34310.48534272038, 35555.82222088873, 43333.0, 43963.56036439595, 44318.77840610776, 54772.0, 55707.164392534956, 56610.43389566051, 58121.0, 58727.41272587219, 11047.740280146447, 11545.48045337945, 11732.0, 11744.647660570197, 11970.700732481757, 12801.871981280441, 12899.484020639069, 12947.935260323638, 13019.869801301866, 13302.534411295559, 5963.612365196248, 8918.821623567623, 10018.447140693204, 11908.761824763284, 11929.880701193224, 11117.22179447431, 11507.884921150682, 11645.59240426581, 11670.124740644655, 11725.0, 11979.28124312544, 11984.520619175135, 12015.639530814089, 12055.69860753453, 12096.576619818265, 11833.644990650295, 11838.28970261787, 11867.109966752701, 11945.4027298633, 12089.939550302191, 11772.470238839102, 11904.28574285511, 11907.82138267944, 11930.582429614922, 12149.514019439124], "value": 9272.668717813523, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1321.3129172830133, 1437.2023526942548, 1477.8300495443025, 1622.3510595761693, 1769.133124768863, 7701.383889288857, 8608.354373421995, 8816.77958051049, 8823.514706691129, 9018.36871419001, 8792.384533082686, 8897.065808090154, 8902.332325075613, 8903.065178156281, 8905.688300909453, 2117.4388786971463, 2123.6708310211866, 2126.627840127979, 2133.658614621661, 2137.551114266006, 2051.9589608207825, 2074.0252081521735, 2103.064136459276, 2103.5897999890026, 2105.315772373977, 2033.2883490778183, 2033.857629965903, 2033.979660203394, 2042.1116814185878, 2077.2521892118825, 2084.395525297662, 2087.12340816858, 2089.414963810128, 2089.9268525601533, 2090.247510896076, 2007.5382661987824, 2055.14711394771, 2090.780468050848, 2091.7176181215646, 2095.8742475451522, 8752.56237188138, 8848.51333176675, 8870.112988701143, 8998.910010899872, 9017.729468115967, 5086.0, 5221.06020916235, 5230.058589453897, 5230.267762513251, 5234.895302093937, 3204.198950262434, 3260.9673903261137, 3263.3473305339026, 3297.604287485517, 3306.470964645669, 1041.0682439216935, 1047.2616805152425, 1055.757175849559, 1073.7423018475588, 1073.8765042020111, 12438.875611243953, 12452.75094498105, 12514.499420023189, 12522.749545009048, 12532.686682833002, 4157.584241575818, 4234.449521562239, 4263.147370525907, 4398.824047038147, 4400.4939431965095, 9781.804363912683, 9808.166305863939, 9817.656382026595, 9819.656312029045, 9823.263255255884, 5003.72479513623, 5007.874803129951, 5009.799608015712, 5011.473795251446, 5015.749212539431, 4144.067584793397, 4166.229247589205, 4175.54069052404, 4667.603253723471, 4680.531946805292, 3428.297199074184, 3679.8344074516176, 3707.480952666629, 3716.201016781405, 3750.306193354238, 1108.9722756931142, 1136.8181091025397, 1149.620625193684, 1154.5266440759249, 1154.6766905266538, 954.5084281594845, 974.1232890398697, 974.2206235011962, 983.2576404814463, 993.2885906040268, 5875.177475153482, 5954.583179177503, 5970.194023806817, 6013.0980352946535, 6050.667213303311, 396.6866175721148, 399.64032370865874, 400.89175922501346, 406.3173867901894, 408.6975638027838, 3846.74996125251, 4100.5489396166395, 4103.938440923389, 4156.709030367845, 4169.3120635094865, 10053.547590358452, 10342.37945723259, 10367.740806479747, 10429.582816687247, 10460.581576736997, 10360.844587331196, 10362.378257304586, 10379.481025948673, 10394.844077338847, 10405.06354428105, 7845.646945887334, 7897.605119744105, 7906.288434040849, 7916.1688022757935, 7933.682652693943, 5326.786928522815, 5453.809116680897, 5558.305211848519, 5603.075492543685, 5647.7176141193595, 10137.594496220068, 10157.187425005834, 10184.592616295562, 10195.490225488844, 10251.48742562854, 8920.668027204158, 9947.253955953478, 10226.07965283128, 10301.484925753532, 10354.0, 6914.412274956685, 7822.765317040498, 7823.061232652118, 8014.19858014194, 8020.318272946864, 8284.46151000183, 8323.875141872755, 8390.622421991147, 8434.24091831738, 8521.0, 7542.698292068256, 7710.306072453506, 7713.575753333621, 7718.228177182237, 7871.881921771063, 7491.887621685788, 7552.055993000875, 7556.093268807778, 7589.241075892367, 7641.044869391326, 6547.0, 6668.133142691613, 6732.932670673231, 7021.719131234693, 7104.467164962545, 4990.72551009698, 5068.594512438923, 5167.0, 5242.554382877345, 5248.3701955765555, 4980.427250866197, 5031.1573960712085, 5101.770420331169, 5156.56169225605, 5211.426743058185], "value": 4362.874967279422, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.6516831485366, 326.1194774109904, 327.5021966610751, 340.8509348557345, 342.8268724294231, 5058.570021548173, 5065.696058236508, 5080.07895460111, 5135.075686376451, 5163.380394352683, 5105.749091472594, 5117.592662017947, 5119.157103442758, 5123.590112790977, 5132.409772876121, 4126.8761937141935, 4126.917461650765, 4127.958720412787, 4127.979360103195, 4138.855140070098, 3861.864834730785, 3931.41028845674, 4005.5794141615147, 4028.415879697442, 4131.669466442692, 3986.3621820508724, 4019.4372787809584, 4030.838766449353, 4036.9394459083137, 4047.531006086285, 4023.979880100581, 4037.1925614876995, 4040.656544193747, 4045.3527435610454, 4049.068714195737, 3460.6676429574545, 3480.8781692640637, 3571.964280357189, 3574.6416361782617, 3619.149499867529, 4975.203967365241, 4982.202847544376, 4987.902661414483, 4991.251312303148, 5007.949920500785, 4561.931571026437, 4583.702059366131, 4586.899144205367, 4594.65540084495, 4601.778754871603, 5118.744062796845, 5284.260203571464, 5294.708791016493, 5311.389190243133, 5345.786168553253, 3917.882463526099, 3924.921501569981, 3927.9018024549614, 3928.1161738608585, 3934.1344904121047, 5496.587755918282, 5518.558515318765, 5530.253415788858, 5532.225488431583, 5541.750621222055, 3770.170562476251, 3955.485786847749, 3990.2219067281603, 3998.1204135090816, 4000.959990400117, 4024.91327341622, 4032.6169013943627, 4038.2529232092156, 4038.5355684096116, 4050.5341885683524, 4557.632710186931, 4566.611837993808, 4567.931481027787, 4572.382728331632, 4585.335126406719, 5183.637145399861, 5362.624616276901, 5364.356277246756, 5366.577856867933, 5377.516023557899, 1373.7527245095778, 1389.7359501694646, 1390.4160252693894, 1394.953784661504, 1403.6069900427897, 867.7483529776295, 890.670451932789, 900.9414388064755, 902.4179404284331, 904.5206040798256, 4535.886602834889, 4587.518310577341, 4600.320882877725, 4609.9308510372375, 4615.423072115986, 5253.973730131325, 5266.920281342393, 5359.732013399314, 5489.615726899158, 5539.19681646159, 5185.351831021122, 5213.791448342024, 5214.504622060898, 5226.425093239741, 5233.869153271199, 2788.5839846188255, 2891.3928075104045, 2900.753435957925, 2903.274181454636, 2912.6796052434215, 5679.858003549944, 5682.573806964494, 5696.572757043238, 5715.742791574389, 5727.3699893011735, 5524.281843360337, 5581.10242517546, 5585.804496842591, 5596.776128954796, 5617.691026993554, 5510.9448905511235, 5589.469000444951, 5666.518345940559, 5698.886022279614, 5708.4862362387585, 5455.890882182413, 5475.67145971243, 5523.779048838162, 5534.612577119563, 5544.390117087037, 5251.319577735088, 5471.753771080391, 5489.87457571205, 5490.6431081979545, 5513.669179849222, 5678.346990096192, 5697.4931030346515, 5720.885582288248, 5724.599278050497, 5727.6849773262875, 4054.9189016220103, 4103.4870641169855, 4108.876733697994, 4121.670266378743, 4132.73137246078, 5276.9472305278, 5414.972925135507, 5464.426235245242, 5482.698451585201, 5488.121900495901, 5274.287971123849, 5282.603804714585, 5307.283516725347, 5314.077257508432, 5317.335333083364, 5313.601479889101, 5324.361076670824, 5326.310213342393, 5338.866528336823, 5343.3587969443915, 5066.40285397372, 5321.09541377959, 5329.493698098674, 5331.0, 5341.9198712020125, 5248.661591294195, 5269.341332333458, 5269.868253293698, 5324.7870085196155, 5349.9465005351, 4944.332515110558, 5077.619178561548, 5143.4085080216255, 5163.845084647466, 5253.50091741284], "value": 4090.812548487275, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [630.4798541203508, 644.1979735229637, 652.8498445357565, 724.8006798130514, 746.5893758432862, 13294.601161965133, 14515.274236288196, 14540.418383264656, 14567.0, 14575.489857854964, 12711.936440317786, 12720.745585088293, 12744.107912446132, 12750.171238869467, 12833.743325133491, 653.0922018394411, 672.2135101930728, 778.493978913705, 780.8906753054576, 794.1780257433558, 799.1568894815966, 801.5230937592153, 802.0215337288498, 802.1857814318471, 802.2498963469175, 840.9621567029468, 842.0737189092011, 844.2907957315854, 844.5270648436895, 844.9662013519452, 671.1744554198364, 679.6160169504215, 805.2390490986021, 836.38107800228, 836.7155167243136, 598.6916737879995, 615.1050221927086, 615.9630422174683, 616.6885722710048, 616.950643948483, 13253.73492530144, 13267.86732132676, 13282.535111271156, 13294.667633309147, 13295.0, 11895.405229738564, 11976.465895492585, 11976.580819671357, 12246.510139594406, 12571.43999040801, 10620.309679870783, 11874.643760687193, 11961.40192990347, 12019.759604807854, 12064.095192860483, 4223.429836972, 4235.237657221699, 4261.4460120184485, 4373.278409062501, 4394.472663280395, 62006.68996654988, 62745.37254627486, 62893.0, 62920.0, 74996.0, 9692.757681057888, 9717.9028209717, 9801.754956126153, 10118.291719579705, 10173.491325433846, 19540.70688939667, 19741.111649975785, 19749.506262343268, 19752.901235494017, 19794.802051979295, 7837.09873364559, 7888.290053895177, 7947.721829735931, 8066.052715147605, 8085.231902969209, 4275.850345237964, 4368.737875727466, 4417.447819022622, 4435.112977404532, 4595.356650068993, 3498.9475157872653, 3602.081469225383, 3622.130688634709, 3631.128529153037, 3632.20091579852, 579.826052184343, 593.1281016905142, 598.4853026397295, 614.1371373220633, 631.5579094633774, 523.8271370447743, 545.5608235370565, 596.9850753731105, 613.8035828534915, 620.0791824141147, 7959.84080318402, 8017.6792928283385, 8555.058943516207, 8754.649814007369, 9111.863322050174, 493.68897594515227, 562.5555810909418, 614.2536817766346, 627.7583130494793, 629.7795771479946, 3784.7918364489665, 4108.1783643271465, 4342.5874541918465, 4435.3125265583885, 4495.887602809956, 104658.47670761598, 118734.0, 122887.0, 124636.0, 125728.0, 102705.0, 105374.0, 106459.0, 109430.45284773526, 111095.44452277687, 68114.0, 68356.0, 93291.53354233186, 94922.6269343272, 98040.0, 7960.4825686330205, 7994.440389172934, 8078.6364613593705, 8254.092049874389, 8458.957705211435, 52236.738816307196, 52524.73737631287, 52657.210141847136, 53872.46127538675, 54613.45386546243, 71864.64067679628, 80212.59893700494, 80549.0, 82699.0, 82955.0, 9530.571124299284, 9789.0, 9857.704268871945, 10332.17342612574, 10681.305715128492, 10102.343347682377, 10403.895961040293, 10661.840072399076, 10937.890621093688, 11788.882111178778, 10284.794304114026, 10538.89461105379, 10728.517216725422, 10902.400367979837, 11014.50434730423, 10422.947885260524, 10450.0, 10952.507137178687, 11033.337999720043, 11388.430578471209, 10384.37693738378, 10413.166946644098, 10880.292780969212, 11273.774524509628, 11462.426878655868, 8090.514569125871, 8690.78273043179, 8735.213830755263, 8796.164364385373, 9342.673006444742, 8733.0, 9261.398009129385, 9280.814383712153, 9350.438973661601, 9370.531473426438], "value": 6839.00824841813, "unit": "score"}], "name": "dromaeo_css", "value": 6979.223903469895, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 110.0, 111.0, 109.0, 109.0, 110.0, 110.0, 109.0, 111.0, 110.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 123.0, 127.0, 159.0, 129.0, 125.0, 126.0, 120.0, 156.0, 127.0], "value": 134.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 160.0, 164.0, 163.0, 161.0, 161.0, 161.0, 161.0, 165.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 122.0, 75.0, 76.0, 77.0, 75.0, 120.0, 76.0], "value": 84.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 112.0, 83.0, 83.0, 83.0, 113.0, 82.0, 81.0, 117.0], "value": 91.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 116.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 145.0, 147.0, 146.0, 145.0, 146.0, 146.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 52.0, 52.0, 53.0, 55.0, 52.0, 52.0, 53.0, 52.0], "value": 52.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 63.0, 61.0, 61.0, 63.0, 62.0, 62.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 79.0, 80.0, 87.0, 81.0, 79.0, 87.0, 81.0, 79.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 146.0, 139.0, 129.0, 131.0, 137.0, 129.0, 136.0, 177.0, 143.0], "value": 139.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 170.0, 170.0, 174.0, 174.0, 175.0, 169.0, 169.0, 171.0, 172.0], "value": 171.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 68.0, 66.0, 65.0, 67.0, 67.0, 65.0, 66.0, 64.0], "value": 66.1, "unit": "score"}], "name": "kraken", "value": 1514.2999999999997, "alertThreshold": 2.0}]} 05:49:03 INFO - Return code: 0 05:49:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:49:03 INFO - # TBPL SUCCESS # 05:49:03 INFO - Running post-action listener: _resource_record_post_action 05:49:03 INFO - [mozharness: 2016-10-13 12:49:03.215010Z] Finished run-tests step (success) 05:49:03 INFO - Running post-run listener: _resource_record_post_run 05:49:03 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 8192; Write bytes: 394076160; Read time: 192; Write time: 303896 05:49:03 INFO - TinderboxPrint: CPU usage
13.0% 05:49:03 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 192 05:49:03 INFO - TinderboxPrint: I/O write bytes / time
394,076,160 / 303,896 05:49:03 INFO - TinderboxPrint: CPU idle
8,306.5 (87.0%) 05:49:03 INFO - TinderboxPrint: CPU user
1,193.7 (12.5%) 05:49:03 INFO - TinderboxPrint: Swap in / out
0 / 0 05:49:03 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103993344; Read time: 0; Write time: 96476 05:49:03 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290078720; Read time: 184; Write time: 207420 05:49:03 INFO - Running post-run listener: _upload_blobber_files 05:49:03 INFO - Blob upload gear active. 05:49:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:49:03 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 05:49:03 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'] 05:49:03 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 05:49:04 INFO - (blobuploader) - INFO - Open directory for files ... 05:49:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:49:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:49:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:49:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:49:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:49:04 INFO - (blobuploader) - INFO - Done attempting. 05:49:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:49:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:49:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:49:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:49:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:49:08 INFO - (blobuploader) - INFO - Done attempting. 05:49:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:49:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:49:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:49:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:49:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:49:08 INFO - (blobuploader) - INFO - Done attempting. 05:49:08 INFO - (blobuploader) - INFO - Iteration through files over. 05:49:08 INFO - Return code: 0 05:49:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:49:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:49:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/98bc377e0300f2264fe7c42789ca8f1d2ae5fbca336839ae5d9a66fe9bb565898ba30e1ab9ceb03086cd14154406de9d937b7ea6c248caefe22afe3ca4c40a0a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eae59db51883f672c1a790031b8ded957e452a71ff580fad854babb4ec6469ad09f1d15742f66436c4f593e72673c9ba9da313ca0d5b3ce4f791d8eb039019e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/00d310434f0dc9626c7edb675bd9d8bcb060ead91eef3bd88d7f270a85e94a5046d10e77545e1bd0708371c375a86c661cb9641880d11526f48029d121f05bf5"} 05:49:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:49:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:49:08 INFO - Contents: 05:49:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/98bc377e0300f2264fe7c42789ca8f1d2ae5fbca336839ae5d9a66fe9bb565898ba30e1ab9ceb03086cd14154406de9d937b7ea6c248caefe22afe3ca4c40a0a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eae59db51883f672c1a790031b8ded957e452a71ff580fad854babb4ec6469ad09f1d15742f66436c4f593e72673c9ba9da313ca0d5b3ce4f791d8eb039019e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/00d310434f0dc9626c7edb675bd9d8bcb060ead91eef3bd88d7f270a85e94a5046d10e77545e1bd0708371c375a86c661cb9641880d11526f48029d121f05bf5"} 05:49:08 INFO - Running post-run listener: copy_logs_to_upload_dir 05:49:08 INFO - Copying logs to upload dir... 05:49:08 INFO - mkdir: /builds/slave/test/build/upload/logs 05:49:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.750070 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-13 05:49:08.488594) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 05:49:08.492078) ========= 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=31acecf42b6a79ec49471d4a000001bb-1476361709.635707-20032881 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/98bc377e0300f2264fe7c42789ca8f1d2ae5fbca336839ae5d9a66fe9bb565898ba30e1ab9ceb03086cd14154406de9d937b7ea6c248caefe22afe3ca4c40a0a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eae59db51883f672c1a790031b8ded957e452a71ff580fad854babb4ec6469ad09f1d15742f66436c4f593e72673c9ba9da313ca0d5b3ce4f791d8eb039019e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/00d310434f0dc9626c7edb675bd9d8bcb060ead91eef3bd88d7f270a85e94a5046d10e77545e1bd0708371c375a86c661cb9641880d11526f48029d121f05bf5"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476354614/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011306 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476354614/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/98bc377e0300f2264fe7c42789ca8f1d2ae5fbca336839ae5d9a66fe9bb565898ba30e1ab9ceb03086cd14154406de9d937b7ea6c248caefe22afe3ca4c40a0a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eae59db51883f672c1a790031b8ded957e452a71ff580fad854babb4ec6469ad09f1d15742f66436c4f593e72673c9ba9da313ca0d5b3ce4f791d8eb039019e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/00d310434f0dc9626c7edb675bd9d8bcb060ead91eef3bd88d7f270a85e94a5046d10e77545e1bd0708371c375a86c661cb9641880d11526f48029d121f05bf5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 05:49:08.517220) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 05:49:08.517531) ========= 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=31acecf42b6a79ec49471d4a000001bb-1476361709.635707-20032881 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 05:49:08.603634) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 05:49:08.603959) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 05:49:08.604244) ========= ========= Total master_lag: 0.17 =========