builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-041 starttime: 1477099802.01 results: success (0) buildid: 20161021182046 builduid: 2ccae782ced84f1894d654f6e939df59 revision: 5639a9f476d08f300c079117e61697f5026b6367 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-21 18:30:02.011874) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-21 18:30:02.012568) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-21 18:30:02.012995) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-21 18:30:02.030413) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 18:30:02.031049) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1477099801.782252-509620426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-21 18:30:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2016-10-21 18:30:02 (46.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126003 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 18:30:02.174478) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 18:30:02.174937) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1477099801.782252-509620426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013817 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 18:30:02.225051) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-21 18:30:02.225461) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5639a9f476d08f300c079117e61697f5026b6367 --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 5639a9f476d08f300c079117e61697f5026b6367 --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=8c6b6742ce8f6f39ef4ce27d000001f1-1477099801.782252-509620426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-21 18:30:02,804 truncating revision to first 12 chars 2016-10-21 18:30:02,804 Setting DEBUG logging. 2016-10-21 18:30:02,804 attempt 1/10 2016-10-21 18:30:02,804 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5639a9f476d0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-21 18:30:03,962 unpacking tar archive at: fx-team-5639a9f476d0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.533195 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-21 18:30:03.773814) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-21 18:30:03.774285) ========= script_repo_revision: 5639a9f476d08f300c079117e61697f5026b6367 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-21 18:30:03.774855) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-21 18:30:03.775256) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-21 18:30:03.785467) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-10-21 18:30:03.785888) ========= /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=8c6b6742ce8f6f39ef4ce27d000001f1-1477099801.782252-509620426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:30:04 INFO - MultiFileLogger online at 20161021 18:30:04 in /builds/slave/test 18:30:04 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 18:30:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:30:04 INFO - {'append_to_log': False, 18:30:04 INFO - 'base_work_dir': '/builds/slave/test', 18:30:04 INFO - 'blob_upload_branch': 'Fx-Team', 18:30:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:30:04 INFO - 'branch': 'Fx-Team', 18:30:04 INFO - 'buildbot_json_path': 'buildprops.json', 18:30:04 INFO - 'config_files': ('talos/linux_config.py',), 18:30:04 INFO - 'default_actions': ('clobber', 18:30:04 INFO - 'read-buildbot-config', 18:30:04 INFO - 'download-and-extract', 18:30:04 INFO - 'populate-webroot', 18:30:04 INFO - 'create-virtualenv', 18:30:04 INFO - 'install', 18:30:04 INFO - 'run-tests'), 18:30:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:30:04 INFO - 'download_minidump_stackwalk': True, 18:30:04 INFO - 'download_symbols': 'ondemand', 18:30:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:30:04 INFO - 'tooltool.py': '/tools/tooltool.py', 18:30:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:30:04 INFO - '/tools/misc-python/virtualenv.py')}, 18:30:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:30:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:30:04 INFO - 'installer_path': 'installer.exe', 18:30:04 INFO - 'log_level': 'info', 18:30:04 INFO - 'log_name': 'talos', 18:30:04 INFO - 'log_to_console': True, 18:30:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:30:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:30:04 INFO - 'opt_config_files': (), 18:30:04 INFO - 'pip_index': False, 18:30:04 INFO - 'sps_profile': False, 18:30:04 INFO - 'sps_profile_interval': 0, 18:30:04 INFO - 'suite': 'dromaeojs', 18:30:04 INFO - 'system_bits': '32', 18:30:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:30:04 INFO - 'title': 'talos-linux64-ix-041', 18:30:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:30:04 INFO - 'use_talos_json': True, 18:30:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:30:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:30:04 INFO - 'work_dir': 'build'} 18:30:04 INFO - [mozharness: 2016-10-22 01:30:04.466885Z] Running clobber step. 18:30:04 INFO - Running pre-action listener: _resource_record_pre_action 18:30:04 INFO - Running main action method: clobber 18:30:04 INFO - rmtree: /builds/slave/test/build 18:30:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:30:04 INFO - Running post-action listener: _resource_record_post_action 18:30:04 INFO - [mozharness: 2016-10-22 01:30:04.932588Z] Finished clobber step (success) 18:30:04 INFO - [mozharness: 2016-10-22 01:30:04.932688Z] Running read-buildbot-config step. 18:30:04 INFO - Running pre-action listener: _resource_record_pre_action 18:30:04 INFO - Running main action method: read_buildbot_config 18:30:04 INFO - Using buildbot properties: 18:30:04 INFO - { 18:30:04 INFO - "project": "", 18:30:04 INFO - "product": "firefox", 18:30:04 INFO - "script_repo_revision": "production", 18:30:04 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 18:30:04 INFO - "repository": "", 18:30:04 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 18:30:04 INFO - "buildid": "20161021182046", 18:30:04 INFO - "stage_platform": "linux64-pgo", 18:30:04 INFO - "basedir": "/builds/slave/test", 18:30:04 INFO - "buildnumber": 1161, 18:30:04 INFO - "platform": "ubuntu64_hw", 18:30:04 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:30:04 INFO - "slavebuilddir": "test", 18:30:04 INFO - "branch": "fx-team", 18:30:04 INFO - "revision": "5639a9f476d08f300c079117e61697f5026b6367", 18:30:04 INFO - "slavename": "talos-linux64-ix-041", 18:30:04 INFO - "builduid": "2ccae782ced84f1894d654f6e939df59", 18:30:04 INFO - "repo_path": "integration/fx-team" 18:30:04 INFO - } 18:30:04 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477089004/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 18:30:04 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477089004/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 18:30:04 INFO - Running post-action listener: _resource_record_post_action 18:30:04 INFO - [mozharness: 2016-10-22 01:30:04.935037Z] Finished read-buildbot-config step (success) 18:30:04 INFO - [mozharness: 2016-10-22 01:30:04.935123Z] Running download-and-extract step. 18:30:04 INFO - Running pre-action listener: _resource_record_pre_action 18:30:04 INFO - Running main action method: download_and_extract 18:30:04 INFO - mkdir: /builds/slave/test/build/tests 18:30:04 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')]} 18:30:04 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477089004/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:30:04 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477089004/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 18:30:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477089004/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 18:30:04 INFO - Downloaded 1361 bytes. 18:30:04 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:30:04 INFO - Using the following test package requirements: 18:30:04 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:30:04 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:30:04 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:30:04 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:30:04 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:30:04 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:30:04 INFO - u'jsshell-linux-x86_64.zip'], 18:30:04 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:30:04 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:30:04 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:30:04 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:30:04 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:30:04 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:30:04 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:30:04 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:30:04 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:30:04 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:30:04 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:30:04 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:30:04 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/1477089004/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:30:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477089004/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:30:04 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477089004/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:30:05 INFO - Http code: 200 18:30:05 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 18:30:05 INFO - x-amz-cf-id: o80-M8Ma4gwGoEnHP76Bd-NqrYR9t1o2papXrtrVLzwwkXnE3NH6mQ== 18:30:05 INFO - x-amz-replication-status: COMPLETED 18:30:05 INFO - x-amz-version-id: BgnSA.7TClvsTFlqqcaaC8HH3kfBlCgA 18:30:05 INFO - Expected file size: 22032309 18:30:05 INFO - Obtained file size: 22032309 18:30:09 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 18:30:09 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/1477089004/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:30:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477089004/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:30:09 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477089004/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:30:09 INFO - Http code: 200 18:30:09 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 18:30:09 INFO - x-amz-cf-id: LZn_FCTQ-Z1UpLkNWyKPWyQoRbSVzgqnza17tR2aMWzeKKlo2UN1zg== 18:30:09 INFO - x-amz-replication-status: COMPLETED 18:30:09 INFO - x-amz-version-id: BgnSA.7TClvsTFlqqcaaC8HH3kfBlCgA 18:30:09 INFO - Expected file size: 22032309 18:30:09 INFO - Obtained file size: 22032309 18:30:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477089004/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 18:30:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477089004/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:30:14 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477089004/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 18:30:14 INFO - Http code: 200 18:30:14 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 18:30:14 INFO - x-amz-cf-id: jqnVHbnYlDAU-FT8YW_X-mKU1z6761xnBTM1stUtEAokQhZzMfFGjA== 18:30:14 INFO - x-amz-replication-status: COMPLETED 18:30:14 INFO - x-amz-version-id: BRBhb_oLHXnSWJl0Zc2br_GgdWjtmGU7 18:30:14 INFO - Expected file size: 14409028 18:30:14 INFO - Obtained file size: 14409028 18:30:14 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')]} 18:30:14 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477089004/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:30:14 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477089004/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 18:30:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477089004/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 18:30:15 INFO - Downloaded 59339219 bytes. 18:30:15 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477089004/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:30:15 INFO - mkdir: /builds/slave/test/properties 18:30:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:30:15 INFO - Writing to file /builds/slave/test/properties/build_url 18:30:15 INFO - Contents: 18:30:15 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477089004/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:30:15 INFO - Running post-action listener: _resource_record_post_action 18:30:15 INFO - Running post-action listener: set_extra_try_arguments 18:30:15 INFO - [mozharness: 2016-10-22 01:30:15.612398Z] Finished download-and-extract step (success) 18:30:15 INFO - [mozharness: 2016-10-22 01:30:15.612626Z] Running populate-webroot step. 18:30:15 INFO - Running pre-action listener: _resource_record_pre_action 18:30:15 INFO - Running main action method: populate_webroot 18:30:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:30:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:30:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:30:15 INFO - '--tppagecycles', 18:30:15 INFO - '7'], 18:30:15 INFO - 'tests': ['tsvgm']}}, 18:30:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:30:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:30:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:30:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:30:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:30:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:30:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:30:15 INFO - 'talos_options': ['--disable-e10s'], 18:30:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:30:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:30:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:30:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:30:15 INFO - 'talos_options': ['--disable-e10s'], 18:30:15 INFO - 'tests': ['damp', 'tps']}, 18:30:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:30:15 INFO - 'tests': ['damp', 'tps']}, 18:30:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:30:15 INFO - 'tests': ['dromaeo_dom']}, 18:30:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:30:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:30:15 INFO - 'tests': ['basic_compositor_video']}, 18:30:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:30:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:30:15 INFO - 'tests': ['a11yr', 18:30:15 INFO - 'ts_paint', 18:30:15 INFO - 'tpaint', 18:30:15 INFO - 'sessionrestore', 18:30:15 INFO - 'sessionrestore_no_auto_restore', 18:30:15 INFO - 'tabpaint']}, 18:30:15 INFO - 'other-e10s': {'tests': ['a11yr', 18:30:15 INFO - 'ts_paint', 18:30:15 INFO - 'tpaint', 18:30:15 INFO - 'sessionrestore', 18:30:15 INFO - 'sessionrestore_no_auto_restore', 18:30:15 INFO - 'tabpaint']}, 18:30:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:30:15 INFO - 'ts_paint', 18:30:15 INFO - 'tpaint', 18:30:15 INFO - 'sessionrestore', 18:30:15 INFO - 'sessionrestore_no_auto_restore', 18:30:15 INFO - 'tabpaint']}, 18:30:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:30:15 INFO - 'ts_paint', 18:30:15 INFO - 'tpaint', 18:30:15 INFO - 'sessionrestore', 18:30:15 INFO - 'sessionrestore_no_auto_restore', 18:30:15 INFO - 'tabpaint']}, 18:30:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:30:15 INFO - 'tests': ['a11yr', 18:30:15 INFO - 'ts_paint', 18:30:15 INFO - 'tpaint', 18:30:15 INFO - 'sessionrestore', 18:30:15 INFO - 'sessionrestore_no_auto_restore', 18:30:15 INFO - 'tabpaint']}, 18:30:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:30:15 INFO - 'tests': ['a11yr', 18:30:15 INFO - 'ts_paint', 18:30:15 INFO - 'tpaint', 18:30:15 INFO - 'sessionrestore', 18:30:15 INFO - 'sessionrestore_no_auto_restore', 18:30:15 INFO - 'tabpaint']}, 18:30:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:30:15 INFO - 'tests': ['tsvgx', 18:30:15 INFO - 'tsvgr_opacity', 18:30:15 INFO - 'tart', 18:30:15 INFO - 'tscrollx', 18:30:15 INFO - 'cart']}, 18:30:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:30:15 INFO - 'tsvgr_opacity', 18:30:15 INFO - 'tart', 18:30:15 INFO - 'tscrollx', 18:30:15 INFO - 'cart']}, 18:30:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:30:15 INFO - 'talos_options': ['--disable-e10s'], 18:30:15 INFO - 'tests': ['tp5o']}, 18:30:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:30:15 INFO - 'tests': ['tp5o']}, 18:30:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:30:15 INFO - 'talos_options': ['--disable-e10s', 18:30:15 INFO - '--xperf_path', 18:30:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:30:15 INFO - 'tests': ['tp5n']}, 18:30:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:30:15 INFO - 'talos_options': ['--xperf_path', 18:30:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:30:15 INFO - 'tests': ['tp5n']}}, 18:30:15 INFO - 'talos.zip': {'path': '', 18:30:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:30:15 INFO - Running post-action listener: _resource_record_post_action 18:30:15 INFO - [mozharness: 2016-10-22 01:30:15.631414Z] Finished populate-webroot step (success) 18:30:15 INFO - [mozharness: 2016-10-22 01:30:15.631501Z] Running create-virtualenv step. 18:30:15 INFO - Running pre-action listener: _resource_record_pre_action 18:30:15 INFO - Running main action method: create_virtualenv 18:30:15 INFO - Creating virtualenv /builds/slave/test/build/venv 18:30:15 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 18:30:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:30:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:30:15 INFO - Using real prefix '/usr' 18:30:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:30:16 INFO - Installing distribute.............................................................................................................................................................................................done. 18:30:18 INFO - Installing pip.................done. 18:30:18 INFO - Return code: 0 18:30:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:30:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:30:18 INFO - Reading from file tmpfile_stdout 18:30:18 INFO - Output received: 18:30:18 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) 18:30:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:30:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:30:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:30:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:18 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 0x7fc558815f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x263c790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2639930>, '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 0x263a830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263acc0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1477099801.782252-509620426', '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 18:30:18 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 18:30:18 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 18:30:18 INFO - Using env: {'DISPLAY': ':0', 18:30:18 INFO - 'HOME': '/home/cltbld', 18:30:18 INFO - 'LANG': 'en_US.UTF-8', 18:30:18 INFO - 'LANGUAGE': 'en_US:en', 18:30:18 INFO - 'LOGNAME': 'cltbld', 18:30:18 INFO - 'MAIL': '/var/mail/cltbld', 18:30:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:18 INFO - 'MOZ_NO_REMOTE': '1', 18:30:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:18 INFO - 'NO_EM_RESTART': '1', 18:30:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:18 INFO - 'PWD': '/builds/slave/test', 18:30:18 INFO - 'SHELL': '/bin/bash', 18:30:18 INFO - 'SHLVL': '1', 18:30:18 INFO - 'TERM': 'linux', 18:30:18 INFO - 'TMOUT': '86400', 18:30:18 INFO - 'USER': 'cltbld', 18:30:18 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1477099801.782252-509620426', 18:30:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:18 INFO - '_': '/tools/buildbot/bin/python'} 18:30:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:18 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 18:30:18 INFO - Cleaning up... 18:30:18 INFO - Return code: 0 18:30:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:30:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:30:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:30:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:18 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 0x7fc558815f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x263c790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2639930>, '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 0x263a830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263acc0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1477099801.782252-509620426', '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 18:30:18 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 18:30:18 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 18:30:18 INFO - Using env: {'DISPLAY': ':0', 18:30:18 INFO - 'HOME': '/home/cltbld', 18:30:18 INFO - 'LANG': 'en_US.UTF-8', 18:30:18 INFO - 'LANGUAGE': 'en_US:en', 18:30:18 INFO - 'LOGNAME': 'cltbld', 18:30:18 INFO - 'MAIL': '/var/mail/cltbld', 18:30:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:18 INFO - 'MOZ_NO_REMOTE': '1', 18:30:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:18 INFO - 'NO_EM_RESTART': '1', 18:30:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:18 INFO - 'PWD': '/builds/slave/test', 18:30:18 INFO - 'SHELL': '/bin/bash', 18:30:18 INFO - 'SHLVL': '1', 18:30:18 INFO - 'TERM': 'linux', 18:30:18 INFO - 'TMOUT': '86400', 18:30:18 INFO - 'USER': 'cltbld', 18:30:18 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1477099801.782252-509620426', 18:30:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:18 INFO - '_': '/tools/buildbot/bin/python'} 18:30:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:18 INFO - Downloading/unpacking psutil>=3.1.1 18:30:18 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 18:30:18 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 18:30:18 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 18:30:18 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 18:30:18 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 18:30:18 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 18:30:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:30:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:30:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:30:20 INFO - Installing collected packages: psutil 18:30:20 INFO - Running setup.py install for psutil 18:30:20 INFO - building 'psutil._psutil_linux' extension 18:30:20 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 18:30:21 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 18:30:21 INFO - building 'psutil._psutil_posix' extension 18:30:21 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 18:30:21 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 18:30:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:30:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:30:21 INFO - Successfully installed psutil 18:30:21 INFO - Cleaning up... 18:30:21 INFO - Return code: 0 18:30:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:30:21 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')]} 18:30:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:21 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')]} 18:30:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:21 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 0x7fc558815f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x263c790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2639930>, '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 0x263a830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263acc0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1477099801.782252-509620426', '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 18:30:21 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 18:30:21 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 18:30:21 INFO - Using env: {'DISPLAY': ':0', 18:30:21 INFO - 'HOME': '/home/cltbld', 18:30:21 INFO - 'LANG': 'en_US.UTF-8', 18:30:21 INFO - 'LANGUAGE': 'en_US:en', 18:30:21 INFO - 'LOGNAME': 'cltbld', 18:30:21 INFO - 'MAIL': '/var/mail/cltbld', 18:30:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:21 INFO - 'MOZ_NO_REMOTE': '1', 18:30:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:21 INFO - 'NO_EM_RESTART': '1', 18:30:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:21 INFO - 'PWD': '/builds/slave/test', 18:30:21 INFO - 'SHELL': '/bin/bash', 18:30:21 INFO - 'SHLVL': '1', 18:30:21 INFO - 'TERM': 'linux', 18:30:21 INFO - 'TMOUT': '86400', 18:30:21 INFO - 'USER': 'cltbld', 18:30:21 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1477099801.782252-509620426', 18:30:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:21 INFO - '_': '/tools/buildbot/bin/python'} 18:30:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:30:21 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 18:30:21 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 18:30:21 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 18:30:21 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 18:30:21 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 18:30:21 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 18:30:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:30:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:30:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:30:23 INFO - Installing collected packages: mozsystemmonitor 18:30:23 INFO - Running setup.py install for mozsystemmonitor 18:30:23 INFO - Successfully installed mozsystemmonitor 18:30:23 INFO - Cleaning up... 18:30:23 INFO - Return code: 0 18:30:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:30: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')]} 18:30:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30: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')]} 18:30:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:23 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 0x7fc558815f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x263c790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2639930>, '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 0x263a830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263acc0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1477099801.782252-509620426', '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 18:30:23 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 18:30:23 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 18:30:23 INFO - Using env: {'DISPLAY': ':0', 18:30:23 INFO - 'HOME': '/home/cltbld', 18:30:23 INFO - 'LANG': 'en_US.UTF-8', 18:30:23 INFO - 'LANGUAGE': 'en_US:en', 18:30:23 INFO - 'LOGNAME': 'cltbld', 18:30:23 INFO - 'MAIL': '/var/mail/cltbld', 18:30:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:23 INFO - 'MOZ_NO_REMOTE': '1', 18:30:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:23 INFO - 'NO_EM_RESTART': '1', 18:30:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:23 INFO - 'PWD': '/builds/slave/test', 18:30:23 INFO - 'SHELL': '/bin/bash', 18:30:23 INFO - 'SHLVL': '1', 18:30:23 INFO - 'TERM': 'linux', 18:30:23 INFO - 'TMOUT': '86400', 18:30:23 INFO - 'USER': 'cltbld', 18:30:23 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1477099801.782252-509620426', 18:30:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:23 INFO - '_': '/tools/buildbot/bin/python'} 18:30:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:23 INFO - Downloading/unpacking jsonschema==2.5.1 18:30:23 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 18:30:23 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 18:30:23 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 18:30:23 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 18:30:23 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 18:30:23 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 18:30:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:30:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:30:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:26 INFO - Downloading functools32-3.2.3-2.tar.gz 18:30:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:30:26 INFO - warning: no files found matching '*.txt' 18:30:26 INFO - no previously-included directories found matching 'build' 18:30:26 INFO - no previously-included directories found matching 'dist' 18:30:26 INFO - no previously-included directories found matching '.git*' 18:30:26 INFO - Installing collected packages: jsonschema, functools32 18:30:26 INFO - Running setup.py install for functools32 18:30:26 INFO - warning: no files found matching '*.txt' 18:30:26 INFO - no previously-included directories found matching 'build' 18:30:26 INFO - no previously-included directories found matching 'dist' 18:30:26 INFO - no previously-included directories found matching '.git*' 18:30:26 INFO - Successfully installed jsonschema functools32 18:30:26 INFO - Cleaning up... 18:30:26 INFO - Return code: 0 18:30:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:30:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:30:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:30:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:26 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 0x7fc558815f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x263c790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2639930>, '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 0x263a830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263acc0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1477099801.782252-509620426', '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 18:30:26 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 18:30:26 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 18:30:26 INFO - Using env: {'DISPLAY': ':0', 18:30:26 INFO - 'HOME': '/home/cltbld', 18:30:26 INFO - 'LANG': 'en_US.UTF-8', 18:30:26 INFO - 'LANGUAGE': 'en_US:en', 18:30:26 INFO - 'LOGNAME': 'cltbld', 18:30:26 INFO - 'MAIL': '/var/mail/cltbld', 18:30:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:26 INFO - 'MOZ_NO_REMOTE': '1', 18:30:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:26 INFO - 'NO_EM_RESTART': '1', 18:30:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:26 INFO - 'PWD': '/builds/slave/test', 18:30:26 INFO - 'SHELL': '/bin/bash', 18:30:26 INFO - 'SHLVL': '1', 18:30:26 INFO - 'TERM': 'linux', 18:30:26 INFO - 'TMOUT': '86400', 18:30:26 INFO - 'USER': 'cltbld', 18:30:26 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1477099801.782252-509620426', 18:30:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:26 INFO - '_': '/tools/buildbot/bin/python'} 18:30:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:30:26 INFO - Cleaning up... 18:30:26 INFO - Return code: 0 18:30:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:30:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:30:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:30:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:26 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 0x7fc558815f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x263c790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2639930>, '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 0x263a830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263acc0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1477099801.782252-509620426', '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 18:30:26 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 18:30:26 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 18:30:26 INFO - Using env: {'DISPLAY': ':0', 18:30:26 INFO - 'HOME': '/home/cltbld', 18:30:26 INFO - 'LANG': 'en_US.UTF-8', 18:30:26 INFO - 'LANGUAGE': 'en_US:en', 18:30:26 INFO - 'LOGNAME': 'cltbld', 18:30:26 INFO - 'MAIL': '/var/mail/cltbld', 18:30:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:26 INFO - 'MOZ_NO_REMOTE': '1', 18:30:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:26 INFO - 'NO_EM_RESTART': '1', 18:30:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:26 INFO - 'PWD': '/builds/slave/test', 18:30:26 INFO - 'SHELL': '/bin/bash', 18:30:26 INFO - 'SHLVL': '1', 18:30:26 INFO - 'TERM': 'linux', 18:30:26 INFO - 'TMOUT': '86400', 18:30:26 INFO - 'USER': 'cltbld', 18:30:26 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1477099801.782252-509620426', 18:30:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:26 INFO - '_': '/tools/buildbot/bin/python'} 18:30:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:26 INFO - Downloading/unpacking blobuploader==1.2.4 18:30:26 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 18:30:26 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 18:30:26 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 18:30:26 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 18:30:26 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 18:30:26 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 18:30:28 INFO - Downloading blobuploader-1.2.4.tar.gz 18:30:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:30:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:30:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:30:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:30:29 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 18:30:29 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 18:30:29 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 18:30:29 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 18:30:29 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 18:30:29 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 18:30:29 INFO - Downloading docopt-0.6.1.tar.gz 18:30:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:30:29 INFO - Installing collected packages: blobuploader, requests, docopt 18:30:29 INFO - Running setup.py install for blobuploader 18:30:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:30:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:30:29 INFO - Running setup.py install for requests 18:30:29 INFO - Running setup.py install for docopt 18:30:30 INFO - Successfully installed blobuploader requests docopt 18:30:30 INFO - Cleaning up... 18:30:30 INFO - Return code: 0 18:30:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:30:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:30:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:30:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:30 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 0x7fc558815f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x263c790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2639930>, '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 0x263a830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263acc0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1477099801.782252-509620426', '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 18:30:30 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 18:30:30 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 18:30:30 INFO - Using env: {'DISPLAY': ':0', 18:30:30 INFO - 'HOME': '/home/cltbld', 18:30:30 INFO - 'LANG': 'en_US.UTF-8', 18:30:30 INFO - 'LANGUAGE': 'en_US:en', 18:30:30 INFO - 'LOGNAME': 'cltbld', 18:30:30 INFO - 'MAIL': '/var/mail/cltbld', 18:30:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:30 INFO - 'MOZ_NO_REMOTE': '1', 18:30:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:30 INFO - 'NO_EM_RESTART': '1', 18:30:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:30 INFO - 'PWD': '/builds/slave/test', 18:30:30 INFO - 'SHELL': '/bin/bash', 18:30:30 INFO - 'SHLVL': '1', 18:30:30 INFO - 'TERM': 'linux', 18:30:30 INFO - 'TMOUT': '86400', 18:30:30 INFO - 'USER': 'cltbld', 18:30:30 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1477099801.782252-509620426', 18:30:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:30 INFO - '_': '/tools/buildbot/bin/python'} 18:30:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:30:30 INFO - Running setup.py (path:/tmp/pip-ozlXsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:30:30 INFO - Running setup.py (path:/tmp/pip-vCHnIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:30:30 INFO - Running setup.py (path:/tmp/pip-zVDHrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:30:30 INFO - Running setup.py (path:/tmp/pip-fwJGLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:30:30 INFO - Running setup.py (path:/tmp/pip-IKOvhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:30:30 INFO - Running setup.py (path:/tmp/pip-0NiMMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:30:30 INFO - Running setup.py (path:/tmp/pip-S7XUPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:30:30 INFO - Running setup.py (path:/tmp/pip-tbtp48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:30:30 INFO - Running setup.py (path:/tmp/pip-Fs2mCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:30:30 INFO - Running setup.py (path:/tmp/pip-IObKWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:30:31 INFO - Running setup.py (path:/tmp/pip-uDCOiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:30:31 INFO - Running setup.py (path:/tmp/pip-FpsnIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:30:31 INFO - Running setup.py (path:/tmp/pip-XO7QzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:30:31 INFO - Running setup.py (path:/tmp/pip-rU6Osg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:30:31 INFO - Running setup.py (path:/tmp/pip-I0J2b9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:30:31 INFO - Running setup.py (path:/tmp/pip-MSMAra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:30:31 INFO - Running setup.py (path:/tmp/pip-i07umw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:30:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:30:31 INFO - Running setup.py install for manifestparser 18:30:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:30:31 INFO - Running setup.py install for mozcrash 18:30:31 INFO - Running setup.py install for mozdebug 18:30:31 INFO - Running setup.py install for mozdevice 18:30:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:30:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:30:31 INFO - Running setup.py install for mozfile 18:30:32 INFO - Running setup.py install for mozhttpd 18:30:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:30:32 INFO - Running setup.py install for mozinfo 18:30:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:30:32 INFO - Running setup.py install for mozInstall 18:30:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:30:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:30:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:30:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:30:32 INFO - Running setup.py install for mozleak 18:30:32 INFO - Running setup.py install for mozlog 18:30:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:30:32 INFO - Running setup.py install for moznetwork 18:30:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:30:32 INFO - Running setup.py install for mozprocess 18:30:32 INFO - Running setup.py install for mozprofile 18:30:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:30:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:30:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:30:32 INFO - Running setup.py install for mozrunner 18:30:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:30:33 INFO - Running setup.py install for mozscreenshot 18:30:33 INFO - Running setup.py install for moztest 18:30:33 INFO - Running setup.py install for mozversion 18:30:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:30:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:30:33 INFO - Cleaning up... 18:30:33 INFO - Return code: 0 18:30:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:30:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:30:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:30:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:33 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 0x7fc558815f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x263c790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2639930>, '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 0x263a830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263acc0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1477099801.782252-509620426', '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 18:30:33 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 18:30:33 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 18:30:33 INFO - Using env: {'DISPLAY': ':0', 18:30:33 INFO - 'HOME': '/home/cltbld', 18:30:33 INFO - 'LANG': 'en_US.UTF-8', 18:30:33 INFO - 'LANGUAGE': 'en_US:en', 18:30:33 INFO - 'LOGNAME': 'cltbld', 18:30:33 INFO - 'MAIL': '/var/mail/cltbld', 18:30:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:33 INFO - 'MOZ_NO_REMOTE': '1', 18:30:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:33 INFO - 'NO_EM_RESTART': '1', 18:30:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:33 INFO - 'PWD': '/builds/slave/test', 18:30:33 INFO - 'SHELL': '/bin/bash', 18:30:33 INFO - 'SHLVL': '1', 18:30:33 INFO - 'TERM': 'linux', 18:30:33 INFO - 'TMOUT': '86400', 18:30:33 INFO - 'USER': 'cltbld', 18:30:33 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1477099801.782252-509620426', 18:30:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:33 INFO - '_': '/tools/buildbot/bin/python'} 18:30:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:30:33 INFO - Running setup.py (path:/tmp/pip-FHxQqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:30:33 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)) 18:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:30:33 INFO - Running setup.py (path:/tmp/pip-oveGgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:30:33 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)) 18:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:30:33 INFO - Running setup.py (path:/tmp/pip-4whqJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:30:33 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)) 18:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:30:33 INFO - Running setup.py (path:/tmp/pip-um94V2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:30:33 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)) 18:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:30:33 INFO - Running setup.py (path:/tmp/pip-H0Vomk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:30:33 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)) 18:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:30:33 INFO - Running setup.py (path:/tmp/pip-D1PWBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:30:34 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)) 18:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:30:34 INFO - Running setup.py (path:/tmp/pip-bSHxVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:30:34 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)) 18:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:30:34 INFO - Running setup.py (path:/tmp/pip-bJoWqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:30:34 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)) 18:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:30:34 INFO - Running setup.py (path:/tmp/pip-jMzR7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:30:34 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)) 18:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:30:34 INFO - Running setup.py (path:/tmp/pip-oAyeMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:30:34 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)) 18:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:30:34 INFO - Running setup.py (path:/tmp/pip-LQDVB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:30:34 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)) 18:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:30:34 INFO - Running setup.py (path:/tmp/pip-nD0sZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:30:34 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)) 18:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:30:34 INFO - Running setup.py (path:/tmp/pip-eiZ_oh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:30:34 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)) 18:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:30:34 INFO - Running setup.py (path:/tmp/pip-qIk9uG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:30:34 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)) 18:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:30:34 INFO - Running setup.py (path:/tmp/pip-HBkx5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:30:34 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)) 18:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:30:34 INFO - Running setup.py (path:/tmp/pip-MbJGIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:30:34 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)) 18:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:30:34 INFO - Running setup.py (path:/tmp/pip-pNFpkG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:30:34 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)) 18:30:34 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)) 18:30:34 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)) 18:30:34 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)) 18:30:34 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)) 18:30:34 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)) 18:30:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:30:34 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 18:30:34 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 18:30:34 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 18:30:34 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 18:30:34 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 18:30:34 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 18:30:36 INFO - Downloading blessings-1.6.tar.gz 18:30:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:30:36 INFO - Installing collected packages: blessings 18:30:36 INFO - Running setup.py install for blessings 18:30:36 INFO - Successfully installed blessings 18:30:36 INFO - Cleaning up... 18:30:36 INFO - Return code: 0 18:30:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:30:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:30:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:30:37 INFO - Reading from file tmpfile_stdout 18:30:37 INFO - Current package versions: 18:30:37 INFO - argparse == 1.2.1 18:30:37 INFO - blessings == 1.6 18:30:37 INFO - blobuploader == 1.2.4 18:30:37 INFO - docopt == 0.6.1 18:30:37 INFO - functools32 == 3.2.3-2 18:30:37 INFO - jsonschema == 2.5.1 18:30:37 INFO - manifestparser == 1.1 18:30:37 INFO - mozInstall == 1.12 18:30:37 INFO - mozcrash == 0.17 18:30:37 INFO - mozdebug == 0.1 18:30:37 INFO - mozdevice == 0.48 18:30:37 INFO - mozfile == 1.2 18:30:37 INFO - mozhttpd == 0.7 18:30:37 INFO - mozinfo == 0.9 18:30:37 INFO - mozleak == 0.1 18:30:37 INFO - mozlog == 3.4 18:30:37 INFO - moznetwork == 0.27 18:30:37 INFO - mozprocess == 0.23 18:30:37 INFO - mozprofile == 0.28 18:30:37 INFO - mozrunner == 6.12 18:30:37 INFO - mozscreenshot == 0.1 18:30:37 INFO - mozsystemmonitor == 0.3 18:30:37 INFO - moztest == 0.7 18:30:37 INFO - mozversion == 1.4 18:30:37 INFO - psutil == 3.1.1 18:30:37 INFO - requests == 1.2.3 18:30:37 INFO - wsgiref == 0.1.2 18:30:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:30:37 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')]} 18:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:37 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')]} 18:30:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:37 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 0x7fc558815f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x263c790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2639930>, '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 0x263a830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263acc0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1477099801.782252-509620426', '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 18:30:37 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 18:30:37 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 18:30:37 INFO - Using env: {'DISPLAY': ':0', 18:30:37 INFO - 'HOME': '/home/cltbld', 18:30:37 INFO - 'LANG': 'en_US.UTF-8', 18:30:37 INFO - 'LANGUAGE': 'en_US:en', 18:30:37 INFO - 'LOGNAME': 'cltbld', 18:30:37 INFO - 'MAIL': '/var/mail/cltbld', 18:30:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:37 INFO - 'MOZ_NO_REMOTE': '1', 18:30:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:37 INFO - 'NO_EM_RESTART': '1', 18:30:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:37 INFO - 'PWD': '/builds/slave/test', 18:30:37 INFO - 'SHELL': '/bin/bash', 18:30:37 INFO - 'SHLVL': '1', 18:30:37 INFO - 'TERM': 'linux', 18:30:37 INFO - 'TMOUT': '86400', 18:30:37 INFO - 'USER': 'cltbld', 18:30:37 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1477099801.782252-509620426', 18:30:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:37 INFO - '_': '/tools/buildbot/bin/python'} 18:30:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:37 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)) 18:30:37 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)) 18:30:37 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)) 18:30:37 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)) 18:30:37 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)) 18:30:37 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)) 18:30:37 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)) 18:30:37 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)) 18:30:37 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)) 18:30:37 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)) 18:30:37 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)) 18:30:37 INFO - Cleaning up... 18:30:37 INFO - Return code: 0 18:30:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:30:37 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')]} 18:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:37 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')]} 18:30:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:37 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 0x7fc558815f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x263c790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2639930>, '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 0x263a830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263acc0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1477099801.782252-509620426', '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 18:30:37 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 18:30:37 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 18:30:37 INFO - Using env: {'DISPLAY': ':0', 18:30:37 INFO - 'HOME': '/home/cltbld', 18:30:37 INFO - 'LANG': 'en_US.UTF-8', 18:30:37 INFO - 'LANGUAGE': 'en_US:en', 18:30:37 INFO - 'LOGNAME': 'cltbld', 18:30:37 INFO - 'MAIL': '/var/mail/cltbld', 18:30:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:37 INFO - 'MOZ_NO_REMOTE': '1', 18:30:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:37 INFO - 'NO_EM_RESTART': '1', 18:30:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:37 INFO - 'PWD': '/builds/slave/test', 18:30:37 INFO - 'SHELL': '/bin/bash', 18:30:37 INFO - 'SHLVL': '1', 18:30:37 INFO - 'TERM': 'linux', 18:30:37 INFO - 'TMOUT': '86400', 18:30:37 INFO - 'USER': 'cltbld', 18:30:37 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1477099801.782252-509620426', 18:30:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:37 INFO - '_': '/tools/buildbot/bin/python'} 18:30:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:30:37 INFO - Cleaning up... 18:30:37 INFO - Return code: 0 18:30:37 INFO - Running post-action listener: _resource_record_post_action 18:30:37 INFO - Running post-action listener: _start_resource_monitoring 18:30:37 INFO - Starting resource monitoring. 18:30:37 INFO - [mozharness: 2016-10-22 01:30:37.754097Z] Finished create-virtualenv step (success) 18:30:37 INFO - [mozharness: 2016-10-22 01:30:37.754594Z] Running install step. 18:30:37 INFO - Running pre-action listener: _resource_record_pre_action 18:30:37 INFO - Running main action method: install 18:30:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:30:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:30:37 INFO - Reading from file tmpfile_stdout 18:30:37 INFO - Detecting whether we're running mozinstall >=1.0... 18:30:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:30:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:30:38 INFO - Reading from file tmpfile_stdout 18:30:38 INFO - Output received: 18:30:38 INFO - Usage: mozinstall [options] installer 18:30:38 INFO - Options: 18:30:38 INFO - -h, --help show this help message and exit 18:30:38 INFO - -d DEST, --destination=DEST 18:30:38 INFO - Directory to install application into. [default: 18:30:38 INFO - "/builds/slave/test"] 18:30:38 INFO - --app=APP Application being installed. [default: firefox] 18:30:38 INFO - mkdir: /builds/slave/test/build/application 18:30:38 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'] 18:30:38 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 18:30:54 INFO - Reading from file tmpfile_stdout 18:30:54 INFO - Output received: 18:30:54 INFO - /builds/slave/test/build/application/firefox/firefox 18:30:54 INFO - Running post-action listener: _resource_record_post_action 18:30:54 INFO - [mozharness: 2016-10-22 01:30:54.934315Z] Finished install step (success) 18:30:54 INFO - [mozharness: 2016-10-22 01:30:54.934590Z] Running run-tests step. 18:30:54 INFO - Running pre-action listener: _resource_record_pre_action 18:30:54 INFO - Running main action method: run_tests 18:30:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:30:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:30:54 INFO - Python 2.7.3 18:30:54 INFO - Return code: 0 18:30:54 INFO - grabbing minidump binary from tooltool 18:30: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')]} 18:30:54 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 0x2639930>, '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 0x263a830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263acc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:30:54 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 18:30:54 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 18:30:54 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 18:30:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:30:55 INFO - Return code: 0 18:30:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:30:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:30:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:30:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:30:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:30:55 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/1477089004/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 18:30:55 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/1477089004/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --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 18:30:55 INFO - Using env: {'DISPLAY': ':0', 18:30:55 INFO - 'HOME': '/home/cltbld', 18:30:55 INFO - 'LANG': 'en_US.UTF-8', 18:30:55 INFO - 'LANGUAGE': 'en_US:en', 18:30:55 INFO - 'LOGNAME': 'cltbld', 18:30:55 INFO - 'MAIL': '/var/mail/cltbld', 18:30:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:30:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:30:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:55 INFO - 'MOZ_NO_REMOTE': '1', 18:30:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:30:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:55 INFO - 'NO_EM_RESTART': '1', 18:30:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:55 INFO - 'PWD': '/builds/slave/test', 18:30:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:30:55 INFO - 'SHELL': '/bin/bash', 18:30:55 INFO - 'SHLVL': '1', 18:30:55 INFO - 'TERM': 'linux', 18:30:55 INFO - 'TMOUT': '86400', 18:30:55 INFO - 'USER': 'cltbld', 18:30:55 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1477099801.782252-509620426', 18:30:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:55 INFO - '_': '/tools/buildbot/bin/python'} 18:30:55 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/1477089004/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 18:30:55 INFO - mozversion application_buildid: 20161021153004 18:30:55 INFO - mozversion application_changeset: 5639a9f476d08f300c079117e61697f5026b6367 18:30:55 INFO - mozversion application_display_name: Nightly 18:30:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:30:55 INFO - mozversion application_name: Firefox 18:30:55 INFO - mozversion application_remotingname: firefox 18:30:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:30:55 INFO - mozversion application_vendor: Mozilla 18:30:55 INFO - mozversion application_version: 52.0a1 18:30:55 INFO - mozversion platform_buildid: 20161021153004 18:30:55 INFO - mozversion platform_changeset: 5639a9f476d08f300c079117e61697f5026b6367 18:30:55 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:30:55 INFO - mozversion platform_version: 52.0a1 18:30:55 INFO - using testdate: 1477099855 18:30:55 INFO - actual date: 1477099855 18:30:55 INFO - starting webserver on 'localhost:36955' 18:30:55 INFO - SUITE-START | Running 2 tests 18:30:55 INFO - TEST-START | dromaeo_css 18:30:55 INFO - operating with platform_type : linux_ 18:30:55 INFO - Initialising browser for dromaeo_css test... 18:30:55 INFO - TEST-INFO | started process 28504 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsiYB_U/profile http://localhost:36955/getInfo.html) 18:30:59 INFO - PROCESS | 28504 | __metrics Screen width/height:1600/1200 18:30:59 INFO - PROCESS | 28504 | colorDepth:24 18:30:59 INFO - PROCESS | 28504 | Browser inner width/height: 1024/697 18:30:59 INFO - PROCESS | 28504 | __metrics 18:31:00 INFO - PROCESS | 28504 | 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" 18:31:00 INFO - PROCESS | 28504 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:31:00 INFO - PROCESS | 28504 | console.error: PushService: 18:31:00 INFO - PROCESS | 28504 | stateChangeProcessEnqueue: Error transitioning state 18:31:00 INFO - PROCESS | 28504 | UnknownError 18:31:01 INFO - TEST-INFO | 28504: exit 0 18:31:01 INFO - Browser initialized. 18:31:01 INFO - Running cycle 1/1 for dromaeo_css test... 18:31:01 INFO - TEST-INFO | started process 28590 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsiYB_U/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:31:13 INFO - PROCESS | 28590 | RSS: Main: 171638784 18:31:13 INFO - PROCESS | 28590 | 18:32:05 INFO - PROCESS | 28590 | 1477099925267 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] 18:34:15 INFO - PROCESS | 28590 | Cycle 1(1): loaded http://localhost:36955/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36955/tests/dromaeo/cssquery-ext.html) 18:34:17 INFO - PROCESS | 28590 | RSS: Main: 400764928 18:34:17 INFO - PROCESS | 28590 | 18:37:20 INFO - PROCESS | 28590 | Cycle 1(1): loaded http://localhost:36955/tests/dromaeo/cssquery-ext.html (next: http://localhost:36955/tests/dromaeo/cssquery-jquery.html) 18:37:20 INFO - PROCESS | 28590 | RSS: Main: 283328512 18:37:20 INFO - PROCESS | 28590 | 18:40:22 INFO - PROCESS | 28590 | Cycle 1(1): loaded http://localhost:36955/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36955/tests/dromaeo/cssquery-mootools.html) 18:40:23 INFO - PROCESS | 28590 | RSS: Main: 220700672 18:40:23 INFO - PROCESS | 28590 | 18:43:25 INFO - PROCESS | 28590 | Cycle 1(1): loaded http://localhost:36955/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36955/tests/dromaeo/cssquery-prototype.html) 18:43:25 INFO - PROCESS | 28590 | RSS: Main: 259989504 18:43:25 INFO - PROCESS | 28590 | 18:46:28 INFO - PROCESS | 28590 | Cycle 1(1): loaded http://localhost:36955/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36955/tests/dromaeo/cssquery-yui.html) 18:46:29 INFO - PROCESS | 28590 | RSS: Main: 220848128 18:46:29 INFO - PROCESS | 28590 | 18:49:31 INFO - PROCESS | 28590 | Cycle 1(1): loaded http://localhost:36955/tests/dromaeo/cssquery-yui.html (next: http://localhost:36955/tests/dromaeo/cssquery-dojo.html) 18:49:32 INFO - PROCESS | 28590 | RSS: Main: 311316480 18:49:32 INFO - PROCESS | 28590 | 18:49:32 INFO - PROCESS | 28590 | __start_tp_report 18:49:32 INFO - PROCESS | 28590 | _x_x_mozilla_page_load 18:49:32 INFO - PROCESS | 28590 | _x_x_mozilla_page_load_details 18:49:32 INFO - PROCESS | 28590 | |i|pagename|runs| 18:49:32 INFO - PROCESS | 28590 | |0;dojo.html;3130.2330928922415;3159.3365393267413;3167.271527548664;3191.872325106996;3207.4868021116627;5313.0967735484965;5402.91895621565;5472;5497.202905578693;5530.695811730358;5429.104197807367;5441.619086663935;5536.916946245809;5540.972295138528;5566.415526369734;4956.132676781567;4995.300657907896;5000.224965130411;5053.21675140352;5074.644774865761;5009.674371165863;5103.234514822788;5108;5108.003939231851;5151.0470562945975;4869.683470574401;5036.722980236085;5044.092063428581;5106.897862042757;5168.405633352175;4909.754512274372;4980.651354405193;4994.625403094782;5037.546620804109;5052.393712754456;4985.451600323961;4995.500449955011;5001.674891132065;5009.799608015675;5078.13671675816;5508.091164957777;5534.114541673353;5538.446155384469;5553.4724201200825;5570.192322113311;5672.347680016768;5718.828435146952;5883;5901.970490147522;5975.133605627203;5959.076343166773;5967.641941483482;5971.134185543072;6028.276606807167;6048.667323297261;5511.3937466878615;5524.088525393346;5527.668339899619;5527.861803454865;5532.806351777709;5730.885382292331;5860.208871802337;6022.849428764316;6048.032314829607;6055.939440605625;5685.118806584986;5696.287964004499;5712.257406537124;5762.88474230513;5858.150568167592;5871.119332100219;5872.500837428781;5875.148103524965;5875.647461152259;5876.676782776988;5792.913106303409;5846.6784326862435;5850.151727999416;5853.7365818538265;5856.619319744203;5643.153526970905;5682.204491371212;5687.232223649837;5759.85600359986;5777.768889244468;4430.867073987785;4434.844780432734;4437.844675436344;4438.911221775611;4456.732596044248;3991.7405368650943;3993.4808474898077;3999.6000399960353;4036.1120553478186;4041.2725709372594;5534.335879694382;5534.916976245359;5572.080606699849;5588.413216612278;5615.747291371898;5936.28764548257;5947.316058653224;5952.791652292149;5956.255468066492;5958.523318134538;5386.622936394493;5431.782728690887;5496.450354964471;5598.636088654224;5605.271314729059;5056.823011194664;5137.383513978347;5141.177411614124;5141.871453213625;5149.948500515022;6000.699965001732;6041.063635136561;6048.485878700271;6058.1518587397795;6060.666663333559;5898.439648233411;5898.469137777621;5902.321233058254;5903.7048147593305;5909.468147866713;5849.61977471463;5906.379830117948;5909.556783241188;5982.611130276518;5992;5776.133579963039;5791.218185544897;5837.912431313619;5899.203607512931;5900.321463031634;5888.793892213752;5949.8215053548465;5952.672603006703;5960.8807823844145;6016.398360163948;5797.79707710245;5804.2744656917885;5806.361300256884;5807.274090738658;5811.82564523065;5570.164475328733;5616.129499927518;5625.774969001194;5704.1443783432815;5786.479216870502;5611.607187496836;5624.987502249634;5632.436756324499;5637.379888212211;5645.181448689999;5663.320401551676;5683.829485115453;5701.686407247641;5707.429257074259;5719.513841323368;5587.161925711176;5598.048331783525;5607.719614019365;5648.435156484319;5653.943460565341 18:49:32 INFO - PROCESS | 28590 | |1;ext.html;597.5787070115567;612.9080637904315;625;629.1600713048081;638.7093872288107;31871.203219919484;42221.57778422215;43320.350194747065;43563.346549801776;47135.29297060547;44301;44788;44796;44822.55177448224;44874;8819.382643214962;8962.775930601721;8970.416922900024;8976.596053177622;8986.775330616721;8089.433739638198;8318.41771076025;10393.740156496111;10664.360138391683;10666.466676666174;10812.891871081307;10905.34567925923;10907.072898803612;10907.890921090768;10912.454377281143;10741.087007604363;10807.297525660806;10807.891921080767;10814.513346899408;10824.621138260123;10609.939006099405;10680.732981675443;10685.41230232337;10685.946570267099;10686.732831679192;41742.24319811201;41873.581264187276;41972;41994;42075.36886946698;3349.3971085204653;3390.1016230698638;3499.562554680665;3770.9678385039965;4004.799760012017;30260;30728.846355768303;30832.38335233305;32100.518492222636;32412.837935810407;4308.82764689412;4319.935200971988;4350.8912277193;4498.50516443191;4580.450345958473;314671;315342;315386;315394;316666.5833379163;33237.16907077294;57071.71464142653;57320.41436685055;57334.42665573291;57341.713291433276;33549.16127096842;35806.82096589501;36212.818935905154;36232;36238.09404764849;12695.49218031287;12733.36333183337;12736;12750.872491275153;12756.107072504836;10578.788424231627;10761.085307748772;11516.539338426537;11594.362310072858;11595.594154204562;8045.275925166763;8229.588520573947;8245.422820402515;8359.289460395934;8400.201980811813;3258.1528802511043;3284.2774589590254;3293.374258890803;3314.1880239341517;3317.618473875487;990.2869933647762;1028.9073983341534;1030.891756365571;1046.7752729306728;1094.4691824465128;29855.850720746257;31310.217244569067;31416.37167256642;31642.208944776565;31890.362192756016;1070.0690399352457;1154.463174623804;1166.3701601135292;1171.0748508678219;1176.6293617510457;15732;16398.26207820651;16660.250288737036;16685.91657041707;16884.240209190615;531701;537363;538634;539264;539505;57925.71037144787;58232.41767582355;58486;58512.99999999915;58545.414545854845;1209.2140108929266;1267;1289.3295486347047;1322.8280323558067;1341.4902337111835;27956.720432795413;31477;31944.20139496438;32307.676923231407;32534.34931301408;48943.26585101155;49888.501114989835;49889.25166122583;49890;49914.50085499098;384128;384564;386357;386374;386742;26669.866650666623;27045.59431608567;27569.862150689118;27595.172144835688;28968.565471517522;46286.768566156956;46366;46462.535374647174;46604.30093548667;46818;40205.597944020185;41770.37344439775;42298.7885060585;42501.57498424976;43456.34815477834;38567.42148867713;39621.2075758489;40564;40706;40994.59005410027;39802.40296395614;39817.40273895836;40005.39991900066;40106.79946600365;40140.98590140962;33902;33914.830425847715;35121.82439087788;36049.27901442009;37133.62866371302;27496.862515687295;27591.413116294752;27679.169624911287;27906.720932790413;27975.300617484725 18:49:32 INFO - PROCESS | 28590 | |2;jquery.html;364.08977556109727;369.48272418613954;384.86722080882095;388.4038001667441;413.62153629429076;14014.159150450967;17653.29386824527;18073.1867065982;18183.909080454614;19396;18482.629164232905;19254.422367328967;19256.422307330802;19365.128569214383;19523.80476195241;5632.183333416652;5925.822225333247;5927.1998280232265;5927.436893495111;5931.288245410536;5525.309336332958;5763.423657634224;5767.394423585526;5808.332041815182;5862.149988251701;5753.453421924911;5778.393268706788;5781.306243250795;5782.045962416196;5784.797532086378;5590.748416321276;5772.682502462384;5783.045797443417;5813.157092221646;5813.7383817728305;5172.896542069175;5185.948140518584;5193.402758682762;5203.557697595709;5205.843824685227;21095.894520527454;22181.11275548976;22496.55006899869;22537;22768.54462910749;2309.572729045132;2362.7637236276405;2372.9644055339186;2520.735322791099;2839;13619.931900340534;14450.494232701805;14458.783118253235;14937.402503899832;14990.550283491513;1850.3893715073993;1907.7996810334853;1939.8448124150034;1963.6072785442825;1982.6034793041306;76228.61885690536;77445.22554774437;77695.22304776937;79446.60276698637;79495;8812.647494100293;9366.95316523413;9378.15596596296;9487;10257.07686308221;12950.352482375843;12992.350382480838;13019.934900325627;13027.609171724864;13064.934675326562;7129.928700713031;7167.4266058715175;7272.200057993617;7300.488965772452;7363.48455608113;7019.649017549102;7043.401310888529;7066.611336376549;7178.425725941912;7179.210286868441;3945.2109578084496;3958.426028225891;3977.3636218204947;4012.61880121388;4041.2321658884716;1722.5263052660619;1845.3817970979871;1906.9141888615045;1919.7792253890702;1943.834774044222;835.4611275727243;876.5660997806127;940.2008292951074;967.7967626798311;972.2902281334524;17649.205785739672;19192.424227273204;19227.711584326247;19418.70871936922;19493.954008527475;960.596549449233;975.9512024398751;988.3674448352916;1005.2309982863115;1019.0370100255336;10082.69751907444;10733.51699173539;10772.622958196582;10796.67609971702;10909.34543927367;457785;468117;475421;477190;478844;82337;82386.68445537008;86582.13417865867;87366.56316718376;87743.56128219319;993.6571882700457;1014.3305418423805;1017.1811691588194;1018.1752780248023;1019.5157300282455;16127.75808362852;16499.340026398808;17032.74450883213;17313.22090505905;17423.303067877143;40176.79911600423;40695.79652101839;40745.79627101846;41132.79433602813;41808;51964;52423.73788131188;56842.715786420806;57320;58331.4166858326;7642.465027448247;7886.763397098096;8000.15998320168;8199.631016604148;8395.32837373021;11662.734434358394;12367.814482782946;12602.243865368107;12660.746785064062;12912.16070955385;11423.828642570534;11472.483738231633;11476.13928955315;12150.331731754839;12245.510179592717;10549.419781911762;10593.470326483799;11188;11210.943945280222;11380.317180968837;10985.83521247166;11285.548578056785;11366.54533818671;11649.534018639159;11725.472353744273;7928.929594504899;8092.554909480035;8136.552489613128;8309.542975136426;8751.737447876574;9800.754981125529;11590.536378544764;11645.6506304811;11762.529498820293;11780.87806731234 18:49:32 INFO - PROCESS | 28590 | |3;mootools.html;1299.3568183749046;1462.5612316305105;1465.2966576043498;1640.376656870389;1810.8370246677805;7736;8634.91365086349;8813.779655508615;8969.686060987866;9059.094090590937;8850.77873053174;8909.331800114986;8920.553972301375;8922.95538522308;8931.776705582348;2332.650102484628;2353.011735071266;2357.858528488296;2357.964630530543;2360.752121027293;2282.224043825099;2304.5621331946877;2347.1784875293683;2349.0955981946904;2359.1271229645054;2308.9422764430938;2328.0571368595747;2337.474068334628;2346.577616029114;2348.9412764680933;2276.8064714499287;2299.908003679851;2301.9079236830507;2302.3668491164894;2311.5376924615143;2213.3359992002497;2280.9771902281095;2282.851614645043;2283.4748007958096;2288.4507718147524;8871.512066836322;8908.643654253821;8910.153535414125;8948.910510894873;8961.238294744955;5318.255444237771;5459;5473.726313684339;5483.040467918138;5505.532029777473;3565.6969157621634;3566.821658917044;3628;3641.3263546243766;3655.689266412358;1149.465498543173;1151.8272259161108;1157.814749640062;1159.5447713120066;1161.134954458925;12680;12762.042846786435;12773.616791496177;12783.23300601967;12791;4384.101259241847;4515.164694531522;4583.72497650142;4593.724376537419;4682.2508398656055;10086.899131008742;10095.747606309755;10100.191984641211;10101.292909496411;10101.545430455648;5426.213199086111;5445.101558242845;5447.53695935842;5447.5641948644015;5451.427600102012;4333.656566464406;4395.890102747457;4532.909341813145;4965.354503914468;5110.105731496973;3713.294474049922;3783.3379158647126;3824.3307421201735;3853.1523064925673;3875.244327356195;1039.5218199628105;1084.4306738962107;1087.2497976396262;1094.108301734084;1094.8631421072366;721.570665454054;846.4667259626395;866.8829707989466;903.223228023899;916.1891725822695;6051.848703782441;6096.634201947809;6147.477464415575;6260.812175634738;6262.780802671885;422.25682798275255;429.5189387885526;445.06536273825355;447.0187937477271;448.08143306222763;4180.268453020709;4204.747715137101;4223.68322375823;4246.341817018367;4264.829406823692;11071.010827076805;11342.319460832376;11415.143864210051;11437.771244575228;11448.313101213955;10670.413127278074;11157.442127893735;11318.377489238172;11319.094472442184;11343.829842552368;8220.876686849582;8407.45351552147;8419.242268195892;8423;8443.155684431507;5869.853253668522;5896.292444906639;6061.878762424639;6080.361562035922;6354.142190804182;10196.4391958443;10271.794564108826;10286.382817031003;10332.483375831329;10483.37099774016;10564.947175264075;10668;10692.518836652214;10718.303310284806;10737.838932416176;6896.172459304916;7409.851802963803;7660.502067365604;8137.715179968673;8284.50292982423;8536.957315213383;8748.1251874812;8753.47479151253;8782.121787821166;8785.341099417441;7681.116671582839;7746.767596972099;7884.172161923145;7935.325497332791;8139.1453897339925;7618.504797188165;7723;7767.53394796314;7821.413393995359;7836.216378362118;6868.690908909211;6965.860682786417;6982.406495447944;6983.092198014226;6983.196932352845;5257.947420525898;5294.629375943801;5335.1730481775385;5388.272583201375;5479.369872464717;4875.512448755097;4914.189158788903;4929.309896614549;4958.652894297509;5173.948260517347 18:49:32 INFO - PROCESS | 28590 | |4;prototype.html;332.57928720168974;337.3506000948175;338.55141936933563;339.984700688469;347.7774224496324;5223.190405487156;5318.819284093523;5357.517823395893;5429.8325859940105;5440.564754819615;5161.406438259592;5243.501867322599;5285.814996475124;5322.520973112429;5363.570914326854;4193.266178418779;4235.915281694364;4263.189993901156;4266.402703621496;4278.486581610211;4025.899352516196;4180.24755544002;4213.641840443566;4220.957790422102;4259.339802330644;4156.127213285214;4173;4175.081482073939;4181.205570941512;4193.161367726451;4155.688323375759;4166.000319846476;4169.478815148106;4179.352200408942;4189.49726032875;3656.8171591420587;3671.2657468506404;3673.687736542397;3687.2625474905126;3701.9629803701887;4993.576830603297;5031.4465408805;5094.388673359221;5118.897622047538;5119.923201151985;4710.905781884343;4711.505291944365;4735.715857048588;4743.549362810528;4760.523947605247;5304.496072873071;5407.864803379907;5470.863228419282;5512.834614961557;5521.254630624854;3933.567307596191;3961.564227934925;3994.9201015979806;4008.478897743304;4035.2534781065597;5710.571707121941;5751.166080918243;5752.568557358173;5757.107648314476;5811.360750317504;4105.3020986432375;4110.2396056729;4113.9794301028305;4134.503859536815;4150.688698347636;4079.571644977294;4126.607972242632;4149.6265336119895;4166.229247589205;4170.979145104255;4725.881852953704;4736.621070314435;4766.856994290177;4769.451513075971;4775.95224047762;5581.944180558224;5584.944150558443;5593.272874526286;5602.551795856403;5607.52336051432;1363.6250031241489;1401.4604377314806;1409.7321508913274;1410.5133728863525;1423.181670539444;886.2280166217043;888.7733627924838;901.166126931704;906.4606559097458;911.3711539038043;4699.7780577049525;4706.929396059062;4726.621870250372;4731.384919960383;4744.335792988915;4934.235193545006;4941.45643979162;4949.193544356356;4953.984433191259;4978.32792572998;4448.822047118079;4733.881652958704;4741.198344629088;4750.931040515857;4751.738654373973;2611.7669392668995;2655.5220060389315;2660.4147087641077;2666.9599956000675;2667.199840047978;5047.470015648378;5064.696118232918;5094.7962081516325;5098.719570423662;5155.896882062338;4842.297866809293;4999.975000125049;5045.041442125985;5063.734066483379;5086.313347698014;5119.846404607868;5142.637201141701;5150.150225212873;5151.381834179922;5160.948390516197;4964.602831773377;4977.601791856715;5002.599792016557;5051.974740126276;5078.822241221687;4673.504478566826;4733.290006498915;4898.853034408973;4920;4923.990581930624;5136.382039657496;5144.819931302386;5148.897022059463;5151.922721159111;5162.6902385856965;3725.478433019325;3738;3738.9065273368383;3891.5524714658177;3992.3811809169624;5547.7780888764;5626.409227031267;5665.603407761417;5686.77252909879;5699.401562835843;5543.417941116125;5545.306836645419;5576.4664717203095;5603.411641777718;5619.943800561942;5396.623860915598;5534.91697624544;5544.918740845496;5569.275994120739;5598.552115830806;5485.643433176991;5493.890122197614;5502.669839809624;5520.585956053232;5525.475079867406;5452.291202143854;5589.289194740629;5605.663660180402;5633.605647604629;5643.984082864959;5452.890942181055;5486.1222204447095;5492.670439773627;5505.724713764376;5513.228148059195 18:49:32 INFO - PROCESS | 28590 | |5;yui.html;709.8500429304521;714.903488029116;716.0548076538968;776.9145394006662;819.2831272636444;15012.174330411823;15180.772288415683;15799.684006319867;16194.676106477864;16230.350785968561;16158.596035099099;16204.108774017424;16294;16333.34666613337;16380.64196839648;804.39268352394;837.656560810065;844.2148801614496;844.7423535821572;845.0366582096415;666.1706175811098;670.6680193304321;789.6209819286746;797.5693125712138;800.771780042688;884.2263019857625;886.5257087458211;891.8528442806929;892.3976315986683;892.4556020827323;880.4453194487496;883.6377085394989;884.8186121845071;885.7874110213535;886.3441053620339;510.8952664703727;524.8346770767196;604.2296072507544;609.2506217352636;614.2444792904752;15278.847211527966;15331.616709582238;15333.31000104998;15346.539603811903;15349.155796431192;13291.60125196236;13657.931710341483;13663.521776737865;13897.374618142208;13994.30028498571;12087.153899227058;12363.75272494545;12467;12591.559295424617;12596;4403.185410699031;4407;4442.511323754385;4458.687891847572;4459.397981272552;77449;80543.5972820138;81216.9999999994;81307.61693362934;82235.5888220555;10633.46832658364;10659.786804263871;10689.518971646294;10764.730881728019;10884.129269658408;17803.376881809076;17845.286188552313;17958;17991.73012404815;18020.909895450437;7876.369890408753;7878.684852605831;7889.329407000355;8034.678612855537;8107.351411887035;4485;4663.370444989883;4717.457492388419;4748.002919386968;4751.3348131261655;3525.065857547752;3628.2924829657964;3641.7450778445786;3642.8360723766964;3648.781073135567;605.8969975104154;638.3871483376012;648.9935100649028;664.7208172567533;676.3946268090131;611.4527497889453;649.6751624187906;682.9248782633906;686.5743239191734;688.5524409134002;8799.956000219958;9085.409448385833;9136.406133601295;9137.314701397288;9499.857502137334;530.670983989921;580.2340909998845;587.5622661117495;599.5743022454106;666.9333066693389;4179.623833854967;4360.149770794728;4361.236783562864;4510.21071312519;4577.771111444415;66780;115937.4203128979;120973;121898.3905080469;127773.36113319374;64403.67798161073;98417;101269.49365253127;104019;107686.46156769166;56979;89198.55400722956;92112;93085;96503.0349696508;8732.214100730711;8751.693690720795;8774.078721734126;8828.028916819274;8905.866412003696;48148;48678.026439470304;49123.75438122787;49646.25530617116;50365.49634503608;43825.34261986009;44632.33051504295;61969.01449289918;62879;66611.33388666052;11967.581134660246;12045.819312710491;12120.636380908587;12149.75700486003;12201.450934707782;12312.13815032939;12702.745945081231;12733;12811.807822882478;13042.282674452996;10964;12077.094217933514;12081.275123492618;12336.81494777561;13013.089083764045;10333.323404128516;12011.75976480483;12208.206466579644;12431.129820912449;13157.34213289351;12792.424340904496;12800.231986080866;12877.678058048623;12924.418401172157;13833.308334583431;10376.533056012648;10456;10599.205059620404;10826.350418974887;10927.890721092688;10783.568657253621;10923.563057477611;10966.013058824745;11161.609343672932;11161.832572511257 18:49:32 INFO - PROCESS | 28590 | __end_tp_report 18:49:32 INFO - PROCESS | 28590 | __start_cc_report 18:49:32 INFO - PROCESS | 28590 | _x_x_mozilla_cycle_collect,2265 18:49:32 INFO - PROCESS | 28590 | __end_cc_report 18:49:32 INFO - PROCESS | 28590 | __startTimestamp1477100972226__endTimestamp 18:49:32 INFO - PROCESS | 28590 | 18:49:32 INFO - PROCESS | 28590 | ------- Summary: start ------- 18:49:32 INFO - PROCESS | 28590 | Number of tests: 6 18:49:32 INFO - PROCESS | 28590 | 18:49:32 INFO - PROCESS | 28590 | [#0] dojo.html Cycles:165 Average:5453.44 Median:5625.77 stddev:612.06 (10.9%) stddev-sans-first:586.17 18:49:32 INFO - PROCESS | 28590 | Values: 3130.2 3159.3 3167.3 3191.9 3207.5 5313.1 5402.9 5472.0 5497.2 5530.7 5429.1 5441.6 5536.9 5541.0 5566.4 4956.1 4995.3 5000.2 5053.2 5074.6 5009.7 5103.2 5108.0 5108.0 5151.0 4869.7 5036.7 5044.1 5106.9 5168.4 4909.8 4980.7 4994.6 5037.5 5052.4 4985.5 4995.5 5001.7 5009.8 5078.1 5508.1 5534.1 5538.4 5553.5 5570.2 5672.3 5718.8 5883.0 5902.0 5975.1 5959.1 5967.6 5971.1 6028.3 6048.7 5511.4 5524.1 5527.7 5527.9 5532.8 5730.9 5860.2 6022.8 6048.0 6055.9 5685.1 5696.3 5712.3 5762.9 5858.2 5871.1 5872.5 5875.1 5875.6 5876.7 5792.9 5846.7 5850.2 5853.7 5856.6 5643.2 5682.2 5687.2 5759.9 5777.8 4430.9 4434.8 4437.8 4438.9 4456.7 3991.7 3993.5 3999.6 4036.1 4041.3 5534.3 5534.9 5572.1 5588.4 5615.7 5936.3 5947.3 5952.8 5956.3 5958.5 5386.6 5431.8 5496.5 5598.6 5605.3 5056.8 5137.4 5141.2 5141.9 5149.9 6000.7 6041.1 6048.5 6058.2 6060.7 5898.4 5898.5 5902.3 5903.7 5909.5 5849.6 5906.4 5909.6 5982.6 5992.0 5776.1 5791.2 5837.9 5899.2 5900.3 5888.8 5949.8 5952.7 5960.9 6016.4 5797.8 5804.3 5806.4 5807.3 5811.8 5570.2 5616.1 5625.8 5704.1 5786.5 5611.6 5625.0 5632.4 5637.4 5645.2 5663.3 5683.8 5701.7 5707.4 5719.5 5587.2 5598.0 5607.7 5648.4 5653.9 18:49:32 INFO - PROCESS | 28590 | 18:49:32 INFO - PROCESS | 28590 | [#1] ext.html Cycles:180 Average:56407.79 Median:35464.32 stddev:112356.92 (316.8%) stddev-sans-first:112593.98 18:49:32 INFO - PROCESS | 28590 | Values: 597.6 612.9 625.0 629.2 638.7 31871.2 42221.6 43320.4 43563.3 47135.3 44301.0 44788.0 44796.0 44822.6 44874.0 8819.4 8962.8 8970.4 8976.6 8986.8 8089.4 8318.4 10393.7 10664.4 10666.5 10812.9 10905.3 10907.1 10907.9 10912.5 10741.1 10807.3 10807.9 10814.5 10824.6 10609.9 10680.7 10685.4 10685.9 10686.7 41742.2 41873.6 41972.0 41994.0 42075.4 3349.4 3390.1 3499.6 3771.0 4004.8 30260.0 30728.8 30832.4 32100.5 32412.8 4308.8 4319.9 4350.9 4498.5 4580.5 314671.0 315342.0 315386.0 315394.0 316666.6 33237.2 57071.7 57320.4 57334.4 57341.7 33549.2 35806.8 36212.8 36232.0 36238.1 12695.5 12733.4 12736.0 12750.9 12756.1 10578.8 10761.1 11516.5 11594.4 11595.6 8045.3 8229.6 8245.4 8359.3 8400.2 3258.2 3284.3 3293.4 3314.2 3317.6 990.3 1028.9 1030.9 1046.8 1094.5 29855.9 31310.2 31416.4 31642.2 31890.4 1070.1 1154.5 1166.4 1171.1 1176.6 15732.0 16398.3 16660.3 16685.9 16884.2 531701.0 537363.0 538634.0 539264.0 539505.0 57925.7 58232.4 58486.0 58513.0 58545.4 1209.2 1267.0 1289.3 1322.8 1341.5 27956.7 31477.0 31944.2 32307.7 32534.3 48943.3 49888.5 49889.3 49890.0 49914.5 384128.0 384564.0 386357.0 386374.0 386742.0 26669.9 27045.6 27569.9 27595.2 28968.6 46286.8 46366.0 46462.5 46604.3 46818.0 40205.6 41770.4 42298.8 42501.6 43456.3 38567.4 39621.2 40564.0 40706.0 40994.6 39802.4 39817.4 40005.4 40106.8 40141.0 33902.0 33914.8 35121.8 36049.3 37133.6 27496.9 27591.4 27679.2 27906.7 27975.3 18:49:32 INFO - PROCESS | 28590 | 18:49:32 INFO - PROCESS | 28590 | [#2] jquery.html Cycles:180 Average:27885.45 Median:3951.82 stddev:77671.20 (1965.5%) stddev-sans-first:77861.60 18:49:32 INFO - PROCESS | 28590 | Values: 364.1 369.5 384.9 388.4 413.6 14014.2 17653.3 18073.2 18183.9 19396.0 18482.6 19254.4 19256.4 19365.1 19523.8 5632.2 5925.8 5927.2 5927.4 5931.3 5525.3 5763.4 5767.4 5808.3 5862.1 5753.5 5778.4 5781.3 5782.0 5784.8 5590.7 5772.7 5783.0 5813.2 5813.7 5172.9 5185.9 5193.4 5203.6 5205.8 21095.9 22181.1 22496.6 22537.0 22768.5 2309.6 2362.8 2373.0 2520.7 2839.0 13619.9 14450.5 14458.8 14937.4 14990.6 1850.4 1907.8 1939.8 1963.6 1982.6 76228.6 77445.2 77695.2 79446.6 79495.0 8812.6 9367.0 9378.2 9487.0 10257.1 12950.4 12992.4 13019.9 13027.6 13064.9 7129.9 7167.4 7272.2 7300.5 7363.5 7019.6 7043.4 7066.6 7178.4 7179.2 3945.2 3958.4 3977.4 4012.6 4041.2 1722.5 1845.4 1906.9 1919.8 1943.8 835.5 876.6 940.2 967.8 972.3 17649.2 19192.4 19227.7 19418.7 19494.0 960.6 976.0 988.4 1005.2 1019.0 10082.7 10733.5 10772.6 10796.7 10909.3 457785.0 468117.0 475421.0 477190.0 478844.0 82337.0 82386.7 86582.1 87366.6 87743.6 993.7 1014.3 1017.2 1018.2 1019.5 16127.8 16499.3 17032.7 17313.2 17423.3 40176.8 40695.8 40745.8 41132.8 41808.0 51964.0 52423.7 56842.7 57320.0 58331.4 7642.5 7886.8 8000.2 8199.6 8395.3 11662.7 12367.8 12602.2 12660.7 12912.2 11423.8 11472.5 11476.1 12150.3 12245.5 10549.4 10593.5 11188.0 11210.9 11380.3 10985.8 11285.5 11366.5 11649.5 11725.5 7928.9 8092.6 8136.6 8309.5 8751.7 9800.8 11590.5 11645.7 11762.5 11780.9 18:49:32 INFO - PROCESS | 28590 | 18:49:32 INFO - PROCESS | 28590 | [#3] mootools.html Cycles:180 Average:5864.65 Median:446.04 stddev:3417.91 (766.3%) stddev-sans-first:3410.28 18:49:32 INFO - PROCESS | 28590 | Values: 1299.4 1462.6 1465.3 1640.4 1810.8 7736.0 8634.9 8813.8 8969.7 9059.1 8850.8 8909.3 8920.6 8923.0 8931.8 2332.7 2353.0 2357.9 2358.0 2360.8 2282.2 2304.6 2347.2 2349.1 2359.1 2308.9 2328.1 2337.5 2346.6 2348.9 2276.8 2299.9 2301.9 2302.4 2311.5 2213.3 2281.0 2282.9 2283.5 2288.5 8871.5 8908.6 8910.2 8948.9 8961.2 5318.3 5459.0 5473.7 5483.0 5505.5 3565.7 3566.8 3628.0 3641.3 3655.7 1149.5 1151.8 1157.8 1159.5 1161.1 12680.0 12762.0 12773.6 12783.2 12791.0 4384.1 4515.2 4583.7 4593.7 4682.3 10086.9 10095.7 10100.2 10101.3 10101.5 5426.2 5445.1 5447.5 5447.6 5451.4 4333.7 4395.9 4532.9 4965.4 5110.1 3713.3 3783.3 3824.3 3853.2 3875.2 1039.5 1084.4 1087.2 1094.1 1094.9 721.6 846.5 866.9 903.2 916.2 6051.8 6096.6 6147.5 6260.8 6262.8 422.3 429.5 445.1 447.0 448.1 4180.3 4204.7 4223.7 4246.3 4264.8 11071.0 11342.3 11415.1 11437.8 11448.3 10670.4 11157.4 11318.4 11319.1 11343.8 8220.9 8407.5 8419.2 8423.0 8443.2 5869.9 5896.3 6061.9 6080.4 6354.1 10196.4 10271.8 10286.4 10332.5 10483.4 10564.9 10668.0 10692.5 10718.3 10737.8 6896.2 7409.9 7660.5 8137.7 8284.5 8537.0 8748.1 8753.5 8782.1 8785.3 7681.1 7746.8 7884.2 7935.3 8139.1 7618.5 7723.0 7767.5 7821.4 7836.2 6868.7 6965.9 6982.4 6983.1 6983.2 5257.9 5294.6 5335.2 5388.3 5479.4 4875.5 4914.2 4929.3 4958.7 5173.9 18:49:32 INFO - PROCESS | 28590 | 18:49:32 INFO - PROCESS | 28590 | [#4] prototype.html Cycles:180 Average:4492.32 Median:4971.10 stddev:1291.29 (26.0%) stddev-sans-first:1256.60 18:49:32 INFO - PROCESS | 28590 | Values: 332.6 337.4 338.6 340.0 347.8 5223.2 5318.8 5357.5 5429.8 5440.6 5161.4 5243.5 5285.8 5322.5 5363.6 4193.3 4235.9 4263.2 4266.4 4278.5 4025.9 4180.2 4213.6 4221.0 4259.3 4156.1 4173.0 4175.1 4181.2 4193.2 4155.7 4166.0 4169.5 4179.4 4189.5 3656.8 3671.3 3673.7 3687.3 3702.0 4993.6 5031.4 5094.4 5118.9 5119.9 4710.9 4711.5 4735.7 4743.5 4760.5 5304.5 5407.9 5470.9 5512.8 5521.3 3933.6 3961.6 3994.9 4008.5 4035.3 5710.6 5751.2 5752.6 5757.1 5811.4 4105.3 4110.2 4114.0 4134.5 4150.7 4079.6 4126.6 4149.6 4166.2 4171.0 4725.9 4736.6 4766.9 4769.5 4776.0 5581.9 5584.9 5593.3 5602.6 5607.5 1363.6 1401.5 1409.7 1410.5 1423.2 886.2 888.8 901.2 906.5 911.4 4699.8 4706.9 4726.6 4731.4 4744.3 4934.2 4941.5 4949.2 4954.0 4978.3 4448.8 4733.9 4741.2 4750.9 4751.7 2611.8 2655.5 2660.4 2667.0 2667.2 5047.5 5064.7 5094.8 5098.7 5155.9 4842.3 5000.0 5045.0 5063.7 5086.3 5119.8 5142.6 5150.2 5151.4 5160.9 4964.6 4977.6 5002.6 5052.0 5078.8 4673.5 4733.3 4898.9 4920.0 4924.0 5136.4 5144.8 5148.9 5151.9 5162.7 3725.5 3738.0 3738.9 3891.6 3992.4 5547.8 5626.4 5665.6 5686.8 5699.4 5543.4 5545.3 5576.5 5603.4 5619.9 5396.6 5534.9 5544.9 5569.3 5598.6 5485.6 5493.9 5502.7 5520.6 5525.5 5452.3 5589.3 5605.7 5633.6 5644.0 5452.9 5486.1 5492.7 5505.7 5513.2 18:49:32 INFO - PROCESS | 28590 | 18:49:32 INFO - PROCESS | 28590 | [#5] yui.html Cycles:180 Average:19788.92 Median:24545.86 stddev:29166.03 (118.8%) stddev-sans-first:29212.66 18:49:32 INFO - PROCESS | 28590 | Values: 709.9 714.9 716.1 776.9 819.3 15012.2 15180.8 15799.7 16194.7 16230.4 16158.6 16204.1 16294.0 16333.3 16380.6 804.4 837.7 844.2 844.7 845.0 666.2 670.7 789.6 797.6 800.8 884.2 886.5 891.9 892.4 892.5 880.4 883.6 884.8 885.8 886.3 510.9 524.8 604.2 609.3 614.2 15278.8 15331.6 15333.3 15346.5 15349.2 13291.6 13657.9 13663.5 13897.4 13994.3 12087.2 12363.8 12467.0 12591.6 12596.0 4403.2 4407.0 4442.5 4458.7 4459.4 77449.0 80543.6 81217.0 81307.6 82235.6 10633.5 10659.8 10689.5 10764.7 10884.1 17803.4 17845.3 17958.0 17991.7 18020.9 7876.4 7878.7 7889.3 8034.7 8107.4 4485.0 4663.4 4717.5 4748.0 4751.3 3525.1 3628.3 3641.7 3642.8 3648.8 605.9 638.4 649.0 664.7 676.4 611.5 649.7 682.9 686.6 688.6 8800.0 9085.4 9136.4 9137.3 9499.9 530.7 580.2 587.6 599.6 666.9 4179.6 4360.1 4361.2 4510.2 4577.8 66780.0 115937.4 120973.0 121898.4 127773.4 64403.7 98417.0 101269.5 104019.0 107686.5 56979.0 89198.6 92112.0 93085.0 96503.0 8732.2 8751.7 8774.1 8828.0 8905.9 48148.0 48678.0 49123.8 49646.3 50365.5 43825.3 44632.3 61969.0 62879.0 66611.3 11967.6 12045.8 12120.6 12149.8 12201.5 12312.1 12702.7 12733.0 12811.8 13042.3 10964.0 12077.1 12081.3 12336.8 13013.1 10333.3 12011.8 12208.2 12431.1 13157.3 12792.4 12800.2 12877.7 12924.4 13833.3 10376.5 10456.0 10599.2 10826.4 10927.9 10783.6 10923.6 10966.0 11161.6 11161.8 18:49:32 INFO - PROCESS | 28590 | -------- Summary: end -------- 18:49:32 INFO - PROCESS | 28590 | 18:49:33 INFO - TEST-INFO | 28590: exit 0 18:49:33 INFO - TEST-OK | dromaeo_css | took 1117963ms 18:49:33 INFO - TEST-START | kraken 18:49:33 INFO - operating with platform_type : linux_ 18:49:33 INFO - Initialising browser for kraken test... 18:49:33 INFO - TEST-INFO | started process 28899 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgV0l46/profile http://localhost:36955/getInfo.html) 18:49:37 INFO - PROCESS | 28899 | __metrics Screen width/height:1600/1200 18:49:37 INFO - PROCESS | 28899 | colorDepth:24 18:49:37 INFO - PROCESS | 28899 | Browser inner width/height: 1024/697 18:49:37 INFO - PROCESS | 28899 | __metrics 18:49:37 INFO - PROCESS | 28899 | 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" 18:49:37 INFO - PROCESS | 28899 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:49:38 INFO - PROCESS | 28899 | console.error: PushService: 18:49:38 INFO - PROCESS | 28899 | stateChangeProcessEnqueue: Error transitioning state 18:49:38 INFO - PROCESS | 28899 | UnknownError 18:49:39 INFO - TEST-INFO | 28899: exit 0 18:49:39 INFO - Browser initialized. 18:49:39 INFO - Running cycle 1/1 for kraken test... 18:49:39 INFO - TEST-INFO | started process 28979 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgV0l46/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:49:51 INFO - PROCESS | 28979 | RSS: Main: 171728896 18:49:51 INFO - PROCESS | 28979 | 18:49:53 INFO - PROCESS | 28979 | Cycle 1(1): loaded http://localhost:36955/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36955/tests/kraken/driver.html?testName=audio-beat-detection) 18:49:54 INFO - PROCESS | 28979 | RSS: Main: 228872192 18:49:54 INFO - PROCESS | 28979 | 18:49:57 INFO - PROCESS | 28979 | Cycle 1(1): loaded http://localhost:36955/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36955/tests/kraken/driver.html?testName=audio-dft) 18:49:57 INFO - PROCESS | 28979 | RSS: Main: 215969792 18:49:57 INFO - PROCESS | 28979 | 18:50:01 INFO - PROCESS | 28979 | Cycle 1(1): loaded http://localhost:36955/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36955/tests/kraken/driver.html?testName=audio-fft) 18:50:01 INFO - PROCESS | 28979 | RSS: Main: 297259008 18:50:01 INFO - PROCESS | 28979 | 18:50:03 INFO - PROCESS | 28979 | Cycle 1(1): loaded http://localhost:36955/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36955/tests/kraken/driver.html?testName=audio-oscillator) 18:50:04 INFO - PROCESS | 28979 | RSS: Main: 206278656 18:50:04 INFO - PROCESS | 28979 | 18:50:06 INFO - PROCESS | 28979 | Cycle 1(1): loaded http://localhost:36955/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36955/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:50:07 INFO - PROCESS | 28979 | RSS: Main: 211296256 18:50:07 INFO - PROCESS | 28979 | 18:50:10 INFO - PROCESS | 28979 | Cycle 1(1): loaded http://localhost:36955/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36955/tests/kraken/driver.html?testName=imaging-darkroom) 18:50:10 INFO - PROCESS | 28979 | RSS: Main: 248229888 18:50:10 INFO - PROCESS | 28979 | 18:50:13 INFO - PROCESS | 28979 | Cycle 1(1): loaded http://localhost:36955/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36955/tests/kraken/driver.html?testName=imaging-desaturate) 18:50:14 INFO - PROCESS | 28979 | RSS: Main: 246837248 18:50:14 INFO - PROCESS | 28979 | 18:50:17 INFO - PROCESS | 28979 | Cycle 1(1): loaded http://localhost:36955/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36955/tests/kraken/driver.html?testName=json-parse-financial) 18:50:17 INFO - PROCESS | 28979 | RSS: Main: 246697984 18:50:17 INFO - PROCESS | 28979 | 18:50:19 INFO - PROCESS | 28979 | Cycle 1(1): loaded http://localhost:36955/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36955/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:50:19 INFO - PROCESS | 28979 | RSS: Main: 208773120 18:50:19 INFO - PROCESS | 28979 | 18:50:21 INFO - PROCESS | 28979 | Cycle 1(1): loaded http://localhost:36955/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36955/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:50:22 INFO - PROCESS | 28979 | RSS: Main: 217292800 18:50:22 INFO - PROCESS | 28979 | 18:50:24 INFO - PROCESS | 28979 | Cycle 1(1): loaded http://localhost:36955/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36955/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:50:24 INFO - PROCESS | 28979 | RSS: Main: 226066432 18:50:24 INFO - PROCESS | 28979 | 18:50:27 INFO - PROCESS | 28979 | Cycle 1(1): loaded http://localhost:36955/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36955/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:50:28 INFO - PROCESS | 28979 | RSS: Main: 234409984 18:50:28 INFO - PROCESS | 28979 | 18:50:31 INFO - PROCESS | 28979 | Cycle 1(1): loaded http://localhost:36955/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36955/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:50:31 INFO - PROCESS | 28979 | RSS: Main: 231735296 18:50:31 INFO - PROCESS | 28979 | 18:50:33 INFO - PROCESS | 28979 | Cycle 1(1): loaded http://localhost:36955/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36955/tests/kraken/driver.html?testName=ai-astar) 18:50:33 INFO - PROCESS | 28979 | RSS: Main: 282505216 18:50:33 INFO - PROCESS | 28979 | 18:50:33 INFO - PROCESS | 28979 | __start_tp_report 18:50:33 INFO - PROCESS | 28979 | _x_x_mozilla_page_load 18:50:33 INFO - PROCESS | 28979 | _x_x_mozilla_page_load_details 18:50:33 INFO - PROCESS | 28979 | |i|pagename|runs| 18:50:33 INFO - PROCESS | 28979 | |0;ai-astar;102;111;111;110;110;110;110;109;110;109 18:50:33 INFO - PROCESS | 28979 | |1;audio-beat-detection;145;133;124;163;126;126;122;123;158;127 18:50:33 INFO - PROCESS | 28979 | |2;audio-dft;163;161;160;162;162;161;160;161;162;162 18:50:33 INFO - PROCESS | 28979 | |3;audio-fft;75;83;79;112;78;76;76;77;98;74 18:50:33 INFO - PROCESS | 28979 | |4;audio-oscillator;83;82;116;82;82;82;110;81;81;107 18:50:33 INFO - PROCESS | 28979 | |5;imaging-gaussian-blur;116;116;116;118;116;116;116;117;117;117 18:50:33 INFO - PROCESS | 28979 | |6;imaging-darkroom;145;146;146;145;145;145;145;145;145;146 18:50:33 INFO - PROCESS | 28979 | |7;imaging-desaturate;84;85;84;85;84;85;85;84;84;84 18:50:33 INFO - PROCESS | 28979 | |8;json-parse-financial;53;50;51;51;52;53;51;52;53;52 18:50:33 INFO - PROCESS | 28979 | |9;json-stringify-tinderbox;57;59;59;62;59;59;58;62;58;58 18:50:33 INFO - PROCESS | 28979 | |10;stanford-crypto-aes;80;78;87;81;82;80;79;79;80;80 18:50:33 INFO - PROCESS | 28979 | |11;stanford-crypto-ccm;133;131;129;141;136;138;131;144;169;128 18:50:33 INFO - PROCESS | 28979 | |12;stanford-crypto-pbkdf2;166;172;171;171;166;169;171;171;169;171 18:50:33 INFO - PROCESS | 28979 | |13;stanford-crypto-sha256-iterative;66;66;67;66;65;65;67;67;65;65 18:50:33 INFO - PROCESS | 28979 | __end_tp_report 18:50:33 INFO - PROCESS | 28979 | __start_cc_report 18:50:33 INFO - PROCESS | 28979 | _x_x_mozilla_cycle_collect,1673 18:50:33 INFO - PROCESS | 28979 | __end_cc_report 18:50:33 INFO - PROCESS | 28979 | __startTimestamp1477101033555__endTimestamp 18:50:33 INFO - PROCESS | 28979 | 18:50:33 INFO - PROCESS | 28979 | ------- Summary: start ------- 18:50:33 INFO - PROCESS | 28979 | Number of tests: 14 18:50:33 INFO - PROCESS | 28979 | 18:50:33 INFO - PROCESS | 28979 | [#0] ai-astar Cycles:10 Average:109.20 Median:110.00 stddev:2.62 (2.4%) stddev-sans-first:0.71 18:50:33 INFO - PROCESS | 28979 | Values: 102.0 111.0 111.0 110.0 110.0 110.0 110.0 109.0 110.0 109.0 18:50:33 INFO - PROCESS | 28979 | 18:50:33 INFO - PROCESS | 28979 | [#1] audio-beat-detection Cycles:10 Average:134.70 Median:130.00 stddev:15.19 (11.7%) stddev-sans-first:15.65 18:50:33 INFO - PROCESS | 28979 | Values: 145.0 133.0 124.0 163.0 126.0 126.0 122.0 123.0 158.0 127.0 18:50:33 INFO - PROCESS | 28979 | 18:50:33 INFO - PROCESS | 28979 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:0.83 18:50:33 INFO - PROCESS | 28979 | Values: 163.0 161.0 160.0 162.0 162.0 161.0 160.0 161.0 162.0 162.0 18:50:33 INFO - PROCESS | 28979 | 18:50:33 INFO - PROCESS | 28979 | [#3] audio-fft Cycles:10 Average:82.80 Median:77.50 stddev:12.41 (16.0%) stddev-sans-first:12.84 18:50:33 INFO - PROCESS | 28979 | Values: 75.0 83.0 79.0 112.0 78.0 76.0 76.0 77.0 98.0 74.0 18:50:33 INFO - PROCESS | 28979 | 18:50:33 INFO - PROCESS | 28979 | [#4] audio-oscillator Cycles:10 Average:90.60 Median:82.00 stddev:14.25 (17.4%) stddev-sans-first:14.85 18:50:33 INFO - PROCESS | 28979 | Values: 83.0 82.0 116.0 82.0 82.0 82.0 110.0 81.0 81.0 107.0 18:50:33 INFO - PROCESS | 28979 | 18:50:33 INFO - PROCESS | 28979 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:116.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 18:50:33 INFO - PROCESS | 28979 | Values: 116.0 116.0 116.0 118.0 116.0 116.0 116.0 117.0 117.0 117.0 18:50:33 INFO - PROCESS | 28979 | 18:50:33 INFO - PROCESS | 28979 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 18:50:33 INFO - PROCESS | 28979 | Values: 145.0 146.0 146.0 145.0 145.0 145.0 145.0 145.0 145.0 146.0 18:50:33 INFO - PROCESS | 28979 | 18:50:33 INFO - PROCESS | 28979 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.52 (0.6%) stddev-sans-first:0.53 18:50:33 INFO - PROCESS | 28979 | Values: 84.0 85.0 84.0 85.0 84.0 85.0 85.0 84.0 84.0 84.0 18:50:33 INFO - PROCESS | 28979 | 18:50:33 INFO - PROCESS | 28979 | [#8] json-parse-financial Cycles:10 Average:51.80 Median:52.00 stddev:1.03 (2.0%) stddev-sans-first:1.00 18:50:33 INFO - PROCESS | 28979 | Values: 53.0 50.0 51.0 51.0 52.0 53.0 51.0 52.0 53.0 52.0 18:50:33 INFO - PROCESS | 28979 | 18:50:33 INFO - PROCESS | 28979 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:59.00 stddev:1.66 (2.8%) stddev-sans-first:1.58 18:50:33 INFO - PROCESS | 28979 | Values: 57.0 59.0 59.0 62.0 59.0 59.0 58.0 62.0 58.0 58.0 18:50:33 INFO - PROCESS | 28979 | 18:50:33 INFO - PROCESS | 28979 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:80.00 stddev:2.50 (3.1%) stddev-sans-first:2.65 18:50:33 INFO - PROCESS | 28979 | Values: 80.0 78.0 87.0 81.0 82.0 80.0 79.0 79.0 80.0 80.0 18:50:33 INFO - PROCESS | 28979 | 18:50:33 INFO - PROCESS | 28979 | [#11] stanford-crypto-ccm Cycles:10 Average:138.00 Median:137.00 stddev:12.08 (8.8%) stddev-sans-first:12.68 18:50:33 INFO - PROCESS | 28979 | Values: 133.0 131.0 129.0 141.0 136.0 138.0 131.0 144.0 169.0 128.0 18:50:33 INFO - PROCESS | 28979 | 18:50:33 INFO - PROCESS | 28979 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.70 Median:171.00 stddev:2.16 (1.3%) stddev-sans-first:1.83 18:50:33 INFO - PROCESS | 28979 | Values: 166.0 172.0 171.0 171.0 166.0 169.0 171.0 171.0 169.0 171.0 18:50:33 INFO - PROCESS | 28979 | 18:50:33 INFO - PROCESS | 28979 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 18:50:33 INFO - PROCESS | 28979 | Values: 66.0 66.0 67.0 66.0 65.0 65.0 67.0 67.0 65.0 65.0 18:50:33 INFO - PROCESS | 28979 | -------- Summary: end -------- 18:50:33 INFO - PROCESS | 28979 | 18:50:34 INFO - TEST-INFO | 28979: exit 0 18:50:34 INFO - TEST-OK | kraken | took 61496ms 18:50:34 INFO - SUITE-END | took 1179s 18:50:34 INFO - Completed test suite (00:19:39) 18:50:34 INFO - javascript benchmark 18:50:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3130.2330928922415, 3159.3365393267413, 3167.271527548664, 3191.872325106996, 3207.4868021116627, 5313.0967735484965, 5402.91895621565, 5472.0, 5497.202905578693, 5530.695811730358, 5429.104197807367, 5441.619086663935, 5536.916946245809, 5540.972295138528, 5566.415526369734, 4956.132676781567, 4995.300657907896, 5000.224965130411, 5053.21675140352, 5074.644774865761, 5009.674371165863, 5103.234514822788, 5108.0, 5108.003939231851, 5151.0470562945975, 4869.683470574401, 5036.722980236085, 5044.092063428581, 5106.897862042757, 5168.405633352175, 4909.754512274372, 4980.651354405193, 4994.625403094782, 5037.546620804109, 5052.393712754456, 4985.451600323961, 4995.500449955011, 5001.674891132065, 5009.799608015675, 5078.13671675816, 5508.091164957777, 5534.114541673353, 5538.446155384469, 5553.4724201200825, 5570.192322113311, 5672.347680016768, 5718.828435146952, 5883.0, 5901.970490147522, 5975.133605627203, 5959.076343166773, 5967.641941483482, 5971.134185543072, 6028.276606807167, 6048.667323297261, 5511.3937466878615, 5524.088525393346, 5527.668339899619, 5527.861803454865, 5532.806351777709, 5730.885382292331, 5860.208871802337, 6022.849428764316, 6048.032314829607, 6055.939440605625, 5685.118806584986, 5696.287964004499, 5712.257406537124, 5762.88474230513, 5858.150568167592, 5871.119332100219, 5872.500837428781, 5875.148103524965, 5875.647461152259, 5876.676782776988, 5792.913106303409, 5846.6784326862435, 5850.151727999416, 5853.7365818538265, 5856.619319744203, 5643.153526970905, 5682.204491371212, 5687.232223649837, 5759.85600359986, 5777.768889244468, 4430.867073987785, 4434.844780432734, 4437.844675436344, 4438.911221775611, 4456.732596044248, 3991.7405368650943, 3993.4808474898077, 3999.6000399960353, 4036.1120553478186, 4041.2725709372594, 5534.335879694382, 5534.916976245359, 5572.080606699849, 5588.413216612278, 5615.747291371898, 5936.28764548257, 5947.316058653224, 5952.791652292149, 5956.255468066492, 5958.523318134538, 5386.622936394493, 5431.782728690887, 5496.450354964471, 5598.636088654224, 5605.271314729059, 5056.823011194664, 5137.383513978347, 5141.177411614124, 5141.871453213625, 5149.948500515022, 6000.699965001732, 6041.063635136561, 6048.485878700271, 6058.1518587397795, 6060.666663333559, 5898.439648233411, 5898.469137777621, 5902.321233058254, 5903.7048147593305, 5909.468147866713, 5849.61977471463, 5906.379830117948, 5909.556783241188, 5982.611130276518, 5992.0, 5776.133579963039, 5791.218185544897, 5837.912431313619, 5899.203607512931, 5900.321463031634, 5888.793892213752, 5949.8215053548465, 5952.672603006703, 5960.8807823844145, 6016.398360163948, 5797.79707710245, 5804.2744656917885, 5806.361300256884, 5807.274090738658, 5811.82564523065, 5570.164475328733, 5616.129499927518, 5625.774969001194, 5704.1443783432815, 5786.479216870502, 5611.607187496836, 5624.987502249634, 5632.436756324499, 5637.379888212211, 5645.181448689999, 5663.320401551676, 5683.829485115453, 5701.686407247641, 5707.429257074259, 5719.513841323368, 5587.161925711176, 5598.048331783525, 5607.719614019365, 5648.435156484319, 5653.943460565341], "value": 5412.341148824197, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.5787070115567, 612.9080637904315, 625.0, 629.1600713048081, 638.7093872288107, 31871.203219919484, 42221.57778422215, 43320.350194747065, 43563.346549801776, 47135.29297060547, 44301.0, 44788.0, 44796.0, 44822.55177448224, 44874.0, 8819.382643214962, 8962.775930601721, 8970.416922900024, 8976.596053177622, 8986.775330616721, 8089.433739638198, 8318.41771076025, 10393.740156496111, 10664.360138391683, 10666.466676666174, 10812.891871081307, 10905.34567925923, 10907.072898803612, 10907.890921090768, 10912.454377281143, 10741.087007604363, 10807.297525660806, 10807.891921080767, 10814.513346899408, 10824.621138260123, 10609.939006099405, 10680.732981675443, 10685.41230232337, 10685.946570267099, 10686.732831679192, 41742.24319811201, 41873.581264187276, 41972.0, 41994.0, 42075.36886946698, 3349.3971085204653, 3390.1016230698638, 3499.562554680665, 3770.9678385039965, 4004.799760012017, 30260.0, 30728.846355768303, 30832.38335233305, 32100.518492222636, 32412.837935810407, 4308.82764689412, 4319.935200971988, 4350.8912277193, 4498.50516443191, 4580.450345958473, 314671.0, 315342.0, 315386.0, 315394.0, 316666.5833379163, 33237.16907077294, 57071.71464142653, 57320.41436685055, 57334.42665573291, 57341.713291433276, 33549.16127096842, 35806.82096589501, 36212.818935905154, 36232.0, 36238.09404764849, 12695.49218031287, 12733.36333183337, 12736.0, 12750.872491275153, 12756.107072504836, 10578.788424231627, 10761.085307748772, 11516.539338426537, 11594.362310072858, 11595.594154204562, 8045.275925166763, 8229.588520573947, 8245.422820402515, 8359.289460395934, 8400.201980811813, 3258.1528802511043, 3284.2774589590254, 3293.374258890803, 3314.1880239341517, 3317.618473875487, 990.2869933647762, 1028.9073983341534, 1030.891756365571, 1046.7752729306728, 1094.4691824465128, 29855.850720746257, 31310.217244569067, 31416.37167256642, 31642.208944776565, 31890.362192756016, 1070.0690399352457, 1154.463174623804, 1166.3701601135292, 1171.0748508678219, 1176.6293617510457, 15732.0, 16398.26207820651, 16660.250288737036, 16685.91657041707, 16884.240209190615, 531701.0, 537363.0, 538634.0, 539264.0, 539505.0, 57925.71037144787, 58232.41767582355, 58486.0, 58512.99999999915, 58545.414545854845, 1209.2140108929266, 1267.0, 1289.3295486347047, 1322.8280323558067, 1341.4902337111835, 27956.720432795413, 31477.0, 31944.20139496438, 32307.676923231407, 32534.34931301408, 48943.26585101155, 49888.501114989835, 49889.25166122583, 49890.0, 49914.50085499098, 384128.0, 384564.0, 386357.0, 386374.0, 386742.0, 26669.866650666623, 27045.59431608567, 27569.862150689118, 27595.172144835688, 28968.565471517522, 46286.768566156956, 46366.0, 46462.535374647174, 46604.30093548667, 46818.0, 40205.597944020185, 41770.37344439775, 42298.7885060585, 42501.57498424976, 43456.34815477834, 38567.42148867713, 39621.2075758489, 40564.0, 40706.0, 40994.59005410027, 39802.40296395614, 39817.40273895836, 40005.39991900066, 40106.79946600365, 40140.98590140962, 33902.0, 33914.830425847715, 35121.82439087788, 36049.27901442009, 37133.62866371302, 27496.862515687295, 27591.413116294752, 27679.169624911287, 27906.720932790413, 27975.300617484725], "value": 18803.677744392204, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.08977556109727, 369.48272418613954, 384.86722080882095, 388.4038001667441, 413.62153629429076, 14014.159150450967, 17653.29386824527, 18073.1867065982, 18183.909080454614, 19396.0, 18482.629164232905, 19254.422367328967, 19256.422307330802, 19365.128569214383, 19523.80476195241, 5632.183333416652, 5925.822225333247, 5927.1998280232265, 5927.436893495111, 5931.288245410536, 5525.309336332958, 5763.423657634224, 5767.394423585526, 5808.332041815182, 5862.149988251701, 5753.453421924911, 5778.393268706788, 5781.306243250795, 5782.045962416196, 5784.797532086378, 5590.748416321276, 5772.682502462384, 5783.045797443417, 5813.157092221646, 5813.7383817728305, 5172.896542069175, 5185.948140518584, 5193.402758682762, 5203.557697595709, 5205.843824685227, 21095.894520527454, 22181.11275548976, 22496.55006899869, 22537.0, 22768.54462910749, 2309.572729045132, 2362.7637236276405, 2372.9644055339186, 2520.735322791099, 2839.0, 13619.931900340534, 14450.494232701805, 14458.783118253235, 14937.402503899832, 14990.550283491513, 1850.3893715073993, 1907.7996810334853, 1939.8448124150034, 1963.6072785442825, 1982.6034793041306, 76228.61885690536, 77445.22554774437, 77695.22304776937, 79446.60276698637, 79495.0, 8812.647494100293, 9366.95316523413, 9378.15596596296, 9487.0, 10257.07686308221, 12950.352482375843, 12992.350382480838, 13019.934900325627, 13027.609171724864, 13064.934675326562, 7129.928700713031, 7167.4266058715175, 7272.200057993617, 7300.488965772452, 7363.48455608113, 7019.649017549102, 7043.401310888529, 7066.611336376549, 7178.425725941912, 7179.210286868441, 3945.2109578084496, 3958.426028225891, 3977.3636218204947, 4012.61880121388, 4041.2321658884716, 1722.5263052660619, 1845.3817970979871, 1906.9141888615045, 1919.7792253890702, 1943.834774044222, 835.4611275727243, 876.5660997806127, 940.2008292951074, 967.7967626798311, 972.2902281334524, 17649.205785739672, 19192.424227273204, 19227.711584326247, 19418.70871936922, 19493.954008527475, 960.596549449233, 975.9512024398751, 988.3674448352916, 1005.2309982863115, 1019.0370100255336, 10082.69751907444, 10733.51699173539, 10772.622958196582, 10796.67609971702, 10909.34543927367, 457785.0, 468117.0, 475421.0, 477190.0, 478844.0, 82337.0, 82386.68445537008, 86582.13417865867, 87366.56316718376, 87743.56128219319, 993.6571882700457, 1014.3305418423805, 1017.1811691588194, 1018.1752780248023, 1019.5157300282455, 16127.75808362852, 16499.340026398808, 17032.74450883213, 17313.22090505905, 17423.303067877143, 40176.79911600423, 40695.79652101839, 40745.79627101846, 41132.79433602813, 41808.0, 51964.0, 52423.73788131188, 56842.715786420806, 57320.0, 58331.4166858326, 7642.465027448247, 7886.763397098096, 8000.15998320168, 8199.631016604148, 8395.32837373021, 11662.734434358394, 12367.814482782946, 12602.243865368107, 12660.746785064062, 12912.16070955385, 11423.828642570534, 11472.483738231633, 11476.13928955315, 12150.331731754839, 12245.510179592717, 10549.419781911762, 10593.470326483799, 11188.0, 11210.943945280222, 11380.317180968837, 10985.83521247166, 11285.548578056785, 11366.54533818671, 11649.534018639159, 11725.472353744273, 7928.929594504899, 8092.554909480035, 8136.552489613128, 8309.542975136426, 8751.737447876574, 9800.754981125529, 11590.536378544764, 11645.6506304811, 11762.529498820293, 11780.87806731234], "value": 8926.596365764568, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1299.3568183749046, 1462.5612316305105, 1465.2966576043498, 1640.376656870389, 1810.8370246677805, 7736.0, 8634.91365086349, 8813.779655508615, 8969.686060987866, 9059.094090590937, 8850.77873053174, 8909.331800114986, 8920.553972301375, 8922.95538522308, 8931.776705582348, 2332.650102484628, 2353.011735071266, 2357.858528488296, 2357.964630530543, 2360.752121027293, 2282.224043825099, 2304.5621331946877, 2347.1784875293683, 2349.0955981946904, 2359.1271229645054, 2308.9422764430938, 2328.0571368595747, 2337.474068334628, 2346.577616029114, 2348.9412764680933, 2276.8064714499287, 2299.908003679851, 2301.9079236830507, 2302.3668491164894, 2311.5376924615143, 2213.3359992002497, 2280.9771902281095, 2282.851614645043, 2283.4748007958096, 2288.4507718147524, 8871.512066836322, 8908.643654253821, 8910.153535414125, 8948.910510894873, 8961.238294744955, 5318.255444237771, 5459.0, 5473.726313684339, 5483.040467918138, 5505.532029777473, 3565.6969157621634, 3566.821658917044, 3628.0, 3641.3263546243766, 3655.689266412358, 1149.465498543173, 1151.8272259161108, 1157.814749640062, 1159.5447713120066, 1161.134954458925, 12680.0, 12762.042846786435, 12773.616791496177, 12783.23300601967, 12791.0, 4384.101259241847, 4515.164694531522, 4583.72497650142, 4593.724376537419, 4682.2508398656055, 10086.899131008742, 10095.747606309755, 10100.191984641211, 10101.292909496411, 10101.545430455648, 5426.213199086111, 5445.101558242845, 5447.53695935842, 5447.5641948644015, 5451.427600102012, 4333.656566464406, 4395.890102747457, 4532.909341813145, 4965.354503914468, 5110.105731496973, 3713.294474049922, 3783.3379158647126, 3824.3307421201735, 3853.1523064925673, 3875.244327356195, 1039.5218199628105, 1084.4306738962107, 1087.2497976396262, 1094.108301734084, 1094.8631421072366, 721.570665454054, 846.4667259626395, 866.8829707989466, 903.223228023899, 916.1891725822695, 6051.848703782441, 6096.634201947809, 6147.477464415575, 6260.812175634738, 6262.780802671885, 422.25682798275255, 429.5189387885526, 445.06536273825355, 447.0187937477271, 448.08143306222763, 4180.268453020709, 4204.747715137101, 4223.68322375823, 4246.341817018367, 4264.829406823692, 11071.010827076805, 11342.319460832376, 11415.143864210051, 11437.771244575228, 11448.313101213955, 10670.413127278074, 11157.442127893735, 11318.377489238172, 11319.094472442184, 11343.829842552368, 8220.876686849582, 8407.45351552147, 8419.242268195892, 8423.0, 8443.155684431507, 5869.853253668522, 5896.292444906639, 6061.878762424639, 6080.361562035922, 6354.142190804182, 10196.4391958443, 10271.794564108826, 10286.382817031003, 10332.483375831329, 10483.37099774016, 10564.947175264075, 10668.0, 10692.518836652214, 10718.303310284806, 10737.838932416176, 6896.172459304916, 7409.851802963803, 7660.502067365604, 8137.715179968673, 8284.50292982423, 8536.957315213383, 8748.1251874812, 8753.47479151253, 8782.121787821166, 8785.341099417441, 7681.116671582839, 7746.767596972099, 7884.172161923145, 7935.325497332791, 8139.1453897339925, 7618.504797188165, 7723.0, 7767.53394796314, 7821.413393995359, 7836.216378362118, 6868.690908909211, 6965.860682786417, 6982.406495447944, 6983.092198014226, 6983.196932352845, 5257.947420525898, 5294.629375943801, 5335.1730481775385, 5388.272583201375, 5479.369872464717, 4875.512448755097, 4914.189158788903, 4929.309896614549, 4958.652894297509, 5173.948260517347], "value": 4556.035977053756, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.57928720168974, 337.3506000948175, 338.55141936933563, 339.984700688469, 347.7774224496324, 5223.190405487156, 5318.819284093523, 5357.517823395893, 5429.8325859940105, 5440.564754819615, 5161.406438259592, 5243.501867322599, 5285.814996475124, 5322.520973112429, 5363.570914326854, 4193.266178418779, 4235.915281694364, 4263.189993901156, 4266.402703621496, 4278.486581610211, 4025.899352516196, 4180.24755544002, 4213.641840443566, 4220.957790422102, 4259.339802330644, 4156.127213285214, 4173.0, 4175.081482073939, 4181.205570941512, 4193.161367726451, 4155.688323375759, 4166.000319846476, 4169.478815148106, 4179.352200408942, 4189.49726032875, 3656.8171591420587, 3671.2657468506404, 3673.687736542397, 3687.2625474905126, 3701.9629803701887, 4993.576830603297, 5031.4465408805, 5094.388673359221, 5118.897622047538, 5119.923201151985, 4710.905781884343, 4711.505291944365, 4735.715857048588, 4743.549362810528, 4760.523947605247, 5304.496072873071, 5407.864803379907, 5470.863228419282, 5512.834614961557, 5521.254630624854, 3933.567307596191, 3961.564227934925, 3994.9201015979806, 4008.478897743304, 4035.2534781065597, 5710.571707121941, 5751.166080918243, 5752.568557358173, 5757.107648314476, 5811.360750317504, 4105.3020986432375, 4110.2396056729, 4113.9794301028305, 4134.503859536815, 4150.688698347636, 4079.571644977294, 4126.607972242632, 4149.6265336119895, 4166.229247589205, 4170.979145104255, 4725.881852953704, 4736.621070314435, 4766.856994290177, 4769.451513075971, 4775.95224047762, 5581.944180558224, 5584.944150558443, 5593.272874526286, 5602.551795856403, 5607.52336051432, 1363.6250031241489, 1401.4604377314806, 1409.7321508913274, 1410.5133728863525, 1423.181670539444, 886.2280166217043, 888.7733627924838, 901.166126931704, 906.4606559097458, 911.3711539038043, 4699.7780577049525, 4706.929396059062, 4726.621870250372, 4731.384919960383, 4744.335792988915, 4934.235193545006, 4941.45643979162, 4949.193544356356, 4953.984433191259, 4978.32792572998, 4448.822047118079, 4733.881652958704, 4741.198344629088, 4750.931040515857, 4751.738654373973, 2611.7669392668995, 2655.5220060389315, 2660.4147087641077, 2666.9599956000675, 2667.199840047978, 5047.470015648378, 5064.696118232918, 5094.7962081516325, 5098.719570423662, 5155.896882062338, 4842.297866809293, 4999.975000125049, 5045.041442125985, 5063.734066483379, 5086.313347698014, 5119.846404607868, 5142.637201141701, 5150.150225212873, 5151.381834179922, 5160.948390516197, 4964.602831773377, 4977.601791856715, 5002.599792016557, 5051.974740126276, 5078.822241221687, 4673.504478566826, 4733.290006498915, 4898.853034408973, 4920.0, 4923.990581930624, 5136.382039657496, 5144.819931302386, 5148.897022059463, 5151.922721159111, 5162.6902385856965, 3725.478433019325, 3738.0, 3738.9065273368383, 3891.5524714658177, 3992.3811809169624, 5547.7780888764, 5626.409227031267, 5665.603407761417, 5686.77252909879, 5699.401562835843, 5543.417941116125, 5545.306836645419, 5576.4664717203095, 5603.411641777718, 5619.943800561942, 5396.623860915598, 5534.91697624544, 5544.918740845496, 5569.275994120739, 5598.552115830806, 5485.643433176991, 5493.890122197614, 5502.669839809624, 5520.585956053232, 5525.475079867406, 5452.291202143854, 5589.289194740629, 5605.663660180402, 5633.605647604629, 5643.984082864959, 5452.890942181055, 5486.1222204447095, 5492.670439773627, 5505.724713764376, 5513.228148059195], "value": 4084.2153655651427, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.8500429304521, 714.903488029116, 716.0548076538968, 776.9145394006662, 819.2831272636444, 15012.174330411823, 15180.772288415683, 15799.684006319867, 16194.676106477864, 16230.350785968561, 16158.596035099099, 16204.108774017424, 16294.0, 16333.34666613337, 16380.64196839648, 804.39268352394, 837.656560810065, 844.2148801614496, 844.7423535821572, 845.0366582096415, 666.1706175811098, 670.6680193304321, 789.6209819286746, 797.5693125712138, 800.771780042688, 884.2263019857625, 886.5257087458211, 891.8528442806929, 892.3976315986683, 892.4556020827323, 880.4453194487496, 883.6377085394989, 884.8186121845071, 885.7874110213535, 886.3441053620339, 510.8952664703727, 524.8346770767196, 604.2296072507544, 609.2506217352636, 614.2444792904752, 15278.847211527966, 15331.616709582238, 15333.31000104998, 15346.539603811903, 15349.155796431192, 13291.60125196236, 13657.931710341483, 13663.521776737865, 13897.374618142208, 13994.30028498571, 12087.153899227058, 12363.75272494545, 12467.0, 12591.559295424617, 12596.0, 4403.185410699031, 4407.0, 4442.511323754385, 4458.687891847572, 4459.397981272552, 77449.0, 80543.5972820138, 81216.9999999994, 81307.61693362934, 82235.5888220555, 10633.46832658364, 10659.786804263871, 10689.518971646294, 10764.730881728019, 10884.129269658408, 17803.376881809076, 17845.286188552313, 17958.0, 17991.73012404815, 18020.909895450437, 7876.369890408753, 7878.684852605831, 7889.329407000355, 8034.678612855537, 8107.351411887035, 4485.0, 4663.370444989883, 4717.457492388419, 4748.002919386968, 4751.3348131261655, 3525.065857547752, 3628.2924829657964, 3641.7450778445786, 3642.8360723766964, 3648.781073135567, 605.8969975104154, 638.3871483376012, 648.9935100649028, 664.7208172567533, 676.3946268090131, 611.4527497889453, 649.6751624187906, 682.9248782633906, 686.5743239191734, 688.5524409134002, 8799.956000219958, 9085.409448385833, 9136.406133601295, 9137.314701397288, 9499.857502137334, 530.670983989921, 580.2340909998845, 587.5622661117495, 599.5743022454106, 666.9333066693389, 4179.623833854967, 4360.149770794728, 4361.236783562864, 4510.21071312519, 4577.771111444415, 66780.0, 115937.4203128979, 120973.0, 121898.3905080469, 127773.36113319374, 64403.67798161073, 98417.0, 101269.49365253127, 104019.0, 107686.46156769166, 56979.0, 89198.55400722956, 92112.0, 93085.0, 96503.0349696508, 8732.214100730711, 8751.693690720795, 8774.078721734126, 8828.028916819274, 8905.866412003696, 48148.0, 48678.026439470304, 49123.75438122787, 49646.25530617116, 50365.49634503608, 43825.34261986009, 44632.33051504295, 61969.01449289918, 62879.0, 66611.33388666052, 11967.581134660246, 12045.819312710491, 12120.636380908587, 12149.75700486003, 12201.450934707782, 12312.13815032939, 12702.745945081231, 12733.0, 12811.807822882478, 13042.282674452996, 10964.0, 12077.094217933514, 12081.275123492618, 12336.81494777561, 13013.089083764045, 10333.323404128516, 12011.75976480483, 12208.206466579644, 12431.129820912449, 13157.34213289351, 12792.424340904496, 12800.231986080866, 12877.678058048623, 12924.418401172157, 13833.308334583431, 10376.533056012648, 10456.0, 10599.205059620404, 10826.350418974887, 10927.890721092688, 10783.568657253621, 10923.563057477611, 10966.013058824745, 11161.609343672932, 11161.832572511257], "value": 7261.473587110209, "unit": "score"}], "name": "dromaeo_css", "value": 7049.84720129455, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 111.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 109.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 133.0, 124.0, 163.0, 126.0, 126.0, 122.0, 123.0, 158.0, 127.0], "value": 134.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 160.0, 162.0, 162.0, 161.0, 160.0, 161.0, 162.0, 162.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 83.0, 79.0, 112.0, 78.0, 76.0, 76.0, 77.0, 98.0, 74.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 116.0, 82.0, 82.0, 82.0, 110.0, 81.0, 81.0, 107.0], "value": 90.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 118.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 85.0, 84.0, 85.0, 85.0, 84.0, 84.0, 84.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 50.0, 51.0, 51.0, 52.0, 53.0, 51.0, 52.0, 53.0, 52.0], "value": 51.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 59.0, 59.0, 62.0, 59.0, 59.0, 58.0, 62.0, 58.0, 58.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 87.0, 81.0, 82.0, 80.0, 79.0, 79.0, 80.0, 80.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 131.0, 129.0, 141.0, 136.0, 138.0, 131.0, 144.0, 169.0, 128.0], "value": 138.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 172.0, 171.0, 171.0, 166.0, 169.0, 171.0, 171.0, 169.0, 171.0], "value": 169.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 66.0, 65.0, 65.0, 67.0, 67.0, 65.0, 65.0], "value": 65.9, "unit": "score"}], "name": "kraken", "value": 1490.0, "alertThreshold": 2.0}]} 18:50:34 INFO - Return code: 0 18:50:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:50:34 INFO - # TBPL SUCCESS # 18:50:34 INFO - Running post-action listener: _resource_record_post_action 18:50:34 INFO - [mozharness: 2016-10-22 01:50:34.876778Z] Finished run-tests step (success) 18:50:34 INFO - Running post-run listener: _resource_record_post_run 18:50:34 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 12288; Write bytes: 406773760; Read time: 64; Write time: 317436 18:50:34 INFO - TinderboxPrint: CPU usage
13.1% 18:50:34 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 64 18:50:34 INFO - TinderboxPrint: I/O write bytes / time
406,773,760 / 317,436 18:50:34 INFO - TinderboxPrint: CPU idle
8,298.7 (86.9%) 18:50:34 INFO - TinderboxPrint: CPU user
1,201.2 (12.6%) 18:50:34 INFO - TinderboxPrint: Swap in / out
0 / 0 18:50:34 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 118530048; Read time: 0; Write time: 123520 18:50:34 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 8192; Write bytes: 287883264; Read time: 56; Write time: 193916 18:50:35 INFO - Running post-run listener: _upload_blobber_files 18:50:35 INFO - Blob upload gear active. 18:50:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:50:35 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 18:50:35 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'] 18:50:35 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 18:50:35 INFO - (blobuploader) - INFO - Open directory for files ... 18:50:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:50:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:50:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:50:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:50:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:50:39 INFO - (blobuploader) - INFO - Done attempting. 18:50:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:50:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:50:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:50:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:50:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:50:41 INFO - (blobuploader) - INFO - Done attempting. 18:50:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:50:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:50:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:50:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:50:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:50:42 INFO - (blobuploader) - INFO - Done attempting. 18:50:42 INFO - (blobuploader) - INFO - Iteration through files over. 18:50:42 INFO - Return code: 0 18:50:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:50:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:50:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/828e7430c6eaf4cf1965210b906261cc8fcf136d20f8105ab5a942fd3eeb5e4464fd861aead52e13337fb0a6e17ceb25e2226a4b22af1a81e3cf3ea0528a3f2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ecfafabccef6f5e86996e5abc1cec446506970e8aede44bee7b77f0fa68002196c4e22e6e744e527d18685892cd926ea50c7f14c761bfb9b12f89a8c367654da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/99d506fa12791c76ba5967ca2920b3e57af0ee2aeddc81ca87586732f28bfd3e0d72ac225d3976af0c2548361288ededf6cea6911998ce6d1ce1c412c602a3d0"} 18:50:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:50:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:50:42 INFO - Contents: 18:50:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/828e7430c6eaf4cf1965210b906261cc8fcf136d20f8105ab5a942fd3eeb5e4464fd861aead52e13337fb0a6e17ceb25e2226a4b22af1a81e3cf3ea0528a3f2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ecfafabccef6f5e86996e5abc1cec446506970e8aede44bee7b77f0fa68002196c4e22e6e744e527d18685892cd926ea50c7f14c761bfb9b12f89a8c367654da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/99d506fa12791c76ba5967ca2920b3e57af0ee2aeddc81ca87586732f28bfd3e0d72ac225d3976af0c2548361288ededf6cea6911998ce6d1ce1c412c602a3d0"} 18:50:42 INFO - Running post-run listener: copy_logs_to_upload_dir 18:50:42 INFO - Copying logs to upload dir... 18:50:42 INFO - mkdir: /builds/slave/test/build/upload/logs 18:50:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.360018 ========= master_lag: -0.11 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-10-21 18:50:42.039990) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-21 18:50:42.043988) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1477099801.782252-509620426 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/828e7430c6eaf4cf1965210b906261cc8fcf136d20f8105ab5a942fd3eeb5e4464fd861aead52e13337fb0a6e17ceb25e2226a4b22af1a81e3cf3ea0528a3f2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ecfafabccef6f5e86996e5abc1cec446506970e8aede44bee7b77f0fa68002196c4e22e6e744e527d18685892cd926ea50c7f14c761bfb9b12f89a8c367654da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/99d506fa12791c76ba5967ca2920b3e57af0ee2aeddc81ca87586732f28bfd3e0d72ac225d3976af0c2548361288ededf6cea6911998ce6d1ce1c412c602a3d0"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477089004/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011224 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477089004/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/828e7430c6eaf4cf1965210b906261cc8fcf136d20f8105ab5a942fd3eeb5e4464fd861aead52e13337fb0a6e17ceb25e2226a4b22af1a81e3cf3ea0528a3f2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ecfafabccef6f5e86996e5abc1cec446506970e8aede44bee7b77f0fa68002196c4e22e6e744e527d18685892cd926ea50c7f14c761bfb9b12f89a8c367654da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/99d506fa12791c76ba5967ca2920b3e57af0ee2aeddc81ca87586732f28bfd3e0d72ac225d3976af0c2548361288ededf6cea6911998ce6d1ce1c412c602a3d0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-21 18:50:42.073955) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 18:50:42.074320) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1477099801.782252-509620426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004469 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 18:50:42.157607) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-21 18:50:42.157941) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-21 18:50:42.158260) ========= ========= Total master_lag: 0.06 =========