builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-014 starttime: 1477596536.68 results: success (0) buildid: 20161027122239 builduid: fcbd0ed9bc914c959b66d675c0511d71 revision: 9888f1a23001fde6435e1a9ed7e6d3af8dd988d8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-27 12:28:56.681187) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-27 12:28:56.681676) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-27 12:28:56.681987) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-27 12:28:56.697225) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 12:28:56.697694) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1477596536.140013-1788194419 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-27 12:28:56-- 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% 36.9M=0s 2016-10-27 12:28:57 (36.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.113702 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 12:28:56.829941) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 12:28:56.830733) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1477596536.140013-1788194419 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017992 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 12:28:56.882985) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 12:28:56.883845) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9888f1a23001fde6435e1a9ed7e6d3af8dd988d8 --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 9888f1a23001fde6435e1a9ed7e6d3af8dd988d8 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1477596536.140013-1788194419 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-27 12:28:57,141 truncating revision to first 12 chars 2016-10-27 12:28:57,141 Setting DEBUG logging. 2016-10-27 12:28:57,141 attempt 1/10 2016-10-27 12:28:57,141 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9888f1a23001?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-27 12:28:57,456 unpacking tar archive at: fx-team-9888f1a23001/testing/mozharness/ program finished with exit code 0 elapsedTime=0.657555 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 12:28:57.559104) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-27 12:28:57.559483) ========= script_repo_revision: 9888f1a23001fde6435e1a9ed7e6d3af8dd988d8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-27 12:28:57.559919) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-27 12:28:57.560219) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-27 12:28:57.571275) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-27 12:28:57.571655) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1477596536.140013-1788194419 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:28:57 INFO - MultiFileLogger online at 20161027 12:28:57 in /builds/slave/test 12:28:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 12:28:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:28:57 INFO - {'append_to_log': False, 12:28:57 INFO - 'base_work_dir': '/builds/slave/test', 12:28:57 INFO - 'blob_upload_branch': 'Fx-Team', 12:28:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:28:57 INFO - 'branch': 'Fx-Team', 12:28:57 INFO - 'buildbot_json_path': 'buildprops.json', 12:28:57 INFO - 'config_files': ('talos/linux_config.py',), 12:28:57 INFO - 'default_actions': ('clobber', 12:28:57 INFO - 'read-buildbot-config', 12:28:57 INFO - 'download-and-extract', 12:28:57 INFO - 'populate-webroot', 12:28:57 INFO - 'create-virtualenv', 12:28:57 INFO - 'install', 12:28:57 INFO - 'run-tests'), 12:28:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:28:57 INFO - 'download_minidump_stackwalk': True, 12:28:57 INFO - 'download_symbols': 'ondemand', 12:28:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:28:57 INFO - 'tooltool.py': '/tools/tooltool.py', 12:28:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:28:57 INFO - '/tools/misc-python/virtualenv.py')}, 12:28:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:28:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:28:57 INFO - 'installer_path': 'installer.exe', 12:28:57 INFO - 'log_level': 'info', 12:28:57 INFO - 'log_name': 'talos', 12:28:57 INFO - 'log_to_console': True, 12:28:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:28:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:28:57 INFO - 'opt_config_files': (), 12:28:57 INFO - 'pip_index': False, 12:28:57 INFO - 'sps_profile': False, 12:28:57 INFO - 'sps_profile_interval': 0, 12:28:57 INFO - 'suite': 'dromaeojs-e10s', 12:28:57 INFO - 'system_bits': '32', 12:28:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:28:57 INFO - 'title': 'talos-linux64-ix-014', 12:28:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:28:57 INFO - 'use_talos_json': True, 12:28:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:28:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:28:57 INFO - 'work_dir': 'build'} 12:28:57 INFO - [mozharness: 2016-10-27 19:28:57.921584Z] Running clobber step. 12:28:57 INFO - Running pre-action listener: _resource_record_pre_action 12:28:57 INFO - Running main action method: clobber 12:28:57 INFO - rmtree: /builds/slave/test/build 12:28:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:28:58 INFO - Running post-action listener: _resource_record_post_action 12:28:58 INFO - [mozharness: 2016-10-27 19:28:58.410488Z] Finished clobber step (success) 12:28:58 INFO - [mozharness: 2016-10-27 19:28:58.410618Z] Running read-buildbot-config step. 12:28:58 INFO - Running pre-action listener: _resource_record_pre_action 12:28:58 INFO - Running main action method: read_buildbot_config 12:28:58 INFO - Using buildbot properties: 12:28:58 INFO - { 12:28:58 INFO - "project": "", 12:28:58 INFO - "product": "firefox", 12:28:58 INFO - "script_repo_revision": "production", 12:28:58 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 12:28:58 INFO - "repository": "", 12:28:58 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 12:28:58 INFO - "buildid": "20161027122239", 12:28:58 INFO - "stage_platform": "linux64-pgo", 12:28:58 INFO - "basedir": "/builds/slave/test", 12:28:58 INFO - "buildnumber": 872, 12:28:58 INFO - "platform": "ubuntu64_hw", 12:28:58 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:28:58 INFO - "slavebuilddir": "test", 12:28:58 INFO - "branch": "fx-team", 12:28:58 INFO - "revision": "9888f1a23001fde6435e1a9ed7e6d3af8dd988d8", 12:28:58 INFO - "slavename": "talos-linux64-ix-014", 12:28:58 INFO - "builduid": "fcbd0ed9bc914c959b66d675c0511d71", 12:28:58 INFO - "repo_path": "integration/fx-team" 12:28:58 INFO - } 12:28:58 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477585809/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 12:28:58 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477585809/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 12:28:58 INFO - Running post-action listener: _resource_record_post_action 12:28:58 INFO - [mozharness: 2016-10-27 19:28:58.412991Z] Finished read-buildbot-config step (success) 12:28:58 INFO - [mozharness: 2016-10-27 19:28:58.413080Z] Running download-and-extract step. 12:28:58 INFO - Running pre-action listener: _resource_record_pre_action 12:28:58 INFO - Running main action method: download_and_extract 12:28:58 INFO - mkdir: /builds/slave/test/build/tests 12:28:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:28:58 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477585809/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:28:58 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477585809/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 12:28:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477585809/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 12:28:58 INFO - Downloaded 1361 bytes. 12:28:58 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:28:58 INFO - Using the following test package requirements: 12:28:58 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:28:58 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:28:58 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:28:58 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:28:58 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:28:58 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:28:58 INFO - u'jsshell-linux-x86_64.zip'], 12:28:58 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:28:58 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:28:58 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:28:58 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:28:58 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:28:58 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:28:58 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:28:58 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:28:58 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:28:58 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:28:58 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:28:58 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:28:58 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/1477585809/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:28:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477585809/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:28:58 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477585809/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:28:58 INFO - Http code: 200 12:28:58 INFO - via: 1.1 c0740de9f16cf32ffedfd2f9806b8483.cloudfront.net (CloudFront) 12:28:58 INFO - x-amz-cf-id: 4pQcSPvlZGeUT3ZTSH-V7eGSqI3oy-HDI9spdFeHbXAp1_-2BIMlJw== 12:28:58 INFO - x-amz-replication-status: COMPLETED 12:28:58 INFO - x-amz-version-id: _5aEyNhGvxivC4Ty3jvtkVjUnNpdEVgd 12:28:58 INFO - Expected file size: 21992409 12:28:58 INFO - Obtained file size: 21992409 12:29:02 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 12:29:02 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/1477585809/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:29:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477585809/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:29:02 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477585809/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:29:02 INFO - Http code: 200 12:29:02 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 12:29:02 INFO - x-amz-cf-id: 9yNcF56MDZ11i1-MprJsiknB3P0BMx4HOfKCJlMQBKCIWlTHYF2k4A== 12:29:02 INFO - x-amz-replication-status: COMPLETED 12:29:02 INFO - x-amz-version-id: _5aEyNhGvxivC4Ty3jvtkVjUnNpdEVgd 12:29:03 INFO - Expected file size: 21992409 12:29:03 INFO - Obtained file size: 21992409 12:29:07 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/1477585809/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 12:29:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477585809/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:29:07 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477585809/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 12:29:07 INFO - Http code: 200 12:29:07 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 12:29:07 INFO - x-amz-cf-id: oYtGUAbFbgNH2GlCNdSzg1Yjl4CZv8886k_pI0reeJ5QfzSsiEkbjg== 12:29:07 INFO - x-amz-replication-status: COMPLETED 12:29:07 INFO - x-amz-version-id: NLE.dG4iaRuRV5o0nmCpr1hOOTopU2Vq 12:29:07 INFO - Expected file size: 14409028 12:29:07 INFO - Obtained file size: 14409028 12:29:08 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')]} 12:29:08 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477585809/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:29:08 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477585809/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 12:29:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477585809/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 12:29:08 INFO - Downloaded 59366763 bytes. 12:29:08 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477585809/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:29:08 INFO - mkdir: /builds/slave/test/properties 12:29:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:29:08 INFO - Writing to file /builds/slave/test/properties/build_url 12:29:08 INFO - Contents: 12:29:08 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477585809/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:29:08 INFO - Running post-action listener: _resource_record_post_action 12:29:08 INFO - Running post-action listener: set_extra_try_arguments 12:29:08 INFO - [mozharness: 2016-10-27 19:29:08.962525Z] Finished download-and-extract step (success) 12:29:08 INFO - [mozharness: 2016-10-27 19:29:08.962789Z] Running populate-webroot step. 12:29:08 INFO - Running pre-action listener: _resource_record_pre_action 12:29:08 INFO - Running main action method: populate_webroot 12:29:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:29:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:29:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:29:08 INFO - '--tppagecycles', 12:29:08 INFO - '7'], 12:29:08 INFO - 'tests': ['tsvgm']}}, 12:29:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:29:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:29:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:29:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:29:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:29:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:29:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:29:08 INFO - 'talos_options': ['--disable-e10s'], 12:29:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:29:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:29:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:29:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:29:08 INFO - 'talos_options': ['--disable-e10s'], 12:29:08 INFO - 'tests': ['damp', 'tps']}, 12:29:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:29:08 INFO - 'tests': ['damp', 'tps']}, 12:29:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:29:08 INFO - 'tests': ['dromaeo_dom']}, 12:29:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:29:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:29:08 INFO - 'tests': ['basic_compositor_video']}, 12:29:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:29:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:29:08 INFO - 'tests': ['a11yr', 12:29:08 INFO - 'ts_paint', 12:29:08 INFO - 'tpaint', 12:29:08 INFO - 'sessionrestore', 12:29:08 INFO - 'sessionrestore_no_auto_restore', 12:29:08 INFO - 'tabpaint']}, 12:29:08 INFO - 'other-e10s': {'tests': ['a11yr', 12:29:08 INFO - 'ts_paint', 12:29:08 INFO - 'tpaint', 12:29:08 INFO - 'sessionrestore', 12:29:08 INFO - 'sessionrestore_no_auto_restore', 12:29:08 INFO - 'tabpaint']}, 12:29:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:29:08 INFO - 'ts_paint', 12:29:08 INFO - 'tpaint', 12:29:08 INFO - 'sessionrestore', 12:29:08 INFO - 'sessionrestore_no_auto_restore', 12:29:08 INFO - 'tabpaint']}, 12:29:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:29:08 INFO - 'ts_paint', 12:29:08 INFO - 'tpaint', 12:29:08 INFO - 'sessionrestore', 12:29:08 INFO - 'sessionrestore_no_auto_restore', 12:29:08 INFO - 'tabpaint']}, 12:29:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:29:08 INFO - 'tests': ['a11yr', 12:29:08 INFO - 'ts_paint', 12:29:08 INFO - 'tpaint', 12:29:08 INFO - 'sessionrestore', 12:29:08 INFO - 'sessionrestore_no_auto_restore', 12:29:08 INFO - 'tabpaint']}, 12:29:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:29:08 INFO - 'tests': ['a11yr', 12:29:08 INFO - 'ts_paint', 12:29:08 INFO - 'tpaint', 12:29:08 INFO - 'sessionrestore', 12:29:08 INFO - 'sessionrestore_no_auto_restore', 12:29:08 INFO - 'tabpaint']}, 12:29:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:29:08 INFO - 'tests': ['tsvgx', 12:29:08 INFO - 'tsvgr_opacity', 12:29:08 INFO - 'tart', 12:29:08 INFO - 'tscrollx', 12:29:08 INFO - 'cart']}, 12:29:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:29:08 INFO - 'tsvgr_opacity', 12:29:08 INFO - 'tart', 12:29:08 INFO - 'tscrollx', 12:29:08 INFO - 'cart']}, 12:29:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:29:08 INFO - 'talos_options': ['--disable-e10s'], 12:29:08 INFO - 'tests': ['tp5o']}, 12:29:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:29:08 INFO - 'tests': ['tp5o']}, 12:29:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:29:08 INFO - 'talos_options': ['--disable-e10s', 12:29:08 INFO - '--xperf_path', 12:29:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:29:08 INFO - 'tests': ['tp5n']}, 12:29:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:29:08 INFO - 'talos_options': ['--xperf_path', 12:29:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:29:08 INFO - 'tests': ['tp5n']}}, 12:29:08 INFO - 'talos.zip': {'path': '', 12:29:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:29:08 INFO - Running post-action listener: _resource_record_post_action 12:29:08 INFO - [mozharness: 2016-10-27 19:29:08.981061Z] Finished populate-webroot step (success) 12:29:08 INFO - [mozharness: 2016-10-27 19:29:08.981149Z] Running create-virtualenv step. 12:29:08 INFO - Running pre-action listener: _resource_record_pre_action 12:29:08 INFO - Running main action method: create_virtualenv 12:29:08 INFO - Creating virtualenv /builds/slave/test/build/venv 12:29:08 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 12:29:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:29:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:29:09 INFO - Using real prefix '/usr' 12:29:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:29:09 INFO - Installing distribute.............................................................................................................................................................................................done. 12:29:11 INFO - Installing pip.................done. 12:29:11 INFO - Return code: 0 12:29:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:29:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:29:11 INFO - Reading from file tmpfile_stdout 12:29:11 INFO - Output received: 12:29:11 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) 12:29:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:29:11 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')]} 12:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:29:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:11 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')]} 12:29:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:29:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:11 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 0x7f61fd6f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcef7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7e790>, '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 0xd7f690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7fb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1477596536.140013-1788194419', '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 12:29:11 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 12:29:11 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 12:29:11 INFO - Using env: {'DISPLAY': ':0', 12:29:11 INFO - 'HOME': '/home/cltbld', 12:29:11 INFO - 'LANG': 'en_US.UTF-8', 12:29:11 INFO - 'LANGUAGE': 'en_US:en', 12:29:11 INFO - 'LOGNAME': 'cltbld', 12:29:11 INFO - 'MAIL': '/var/mail/cltbld', 12:29:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:29:11 INFO - 'MOZ_NO_REMOTE': '1', 12:29:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:29:11 INFO - 'NO_EM_RESTART': '1', 12:29:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:29:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:29:11 INFO - 'PWD': '/builds/slave/test', 12:29:11 INFO - 'SHELL': '/bin/bash', 12:29:11 INFO - 'SHLVL': '1', 12:29:11 INFO - 'TERM': 'linux', 12:29:11 INFO - 'TMOUT': '86400', 12:29:11 INFO - 'USER': 'cltbld', 12:29:11 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1477596536.140013-1788194419', 12:29:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:29:11 INFO - '_': '/tools/buildbot/bin/python'} 12:29:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:29:11 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 12:29:11 INFO - Cleaning up... 12:29:11 INFO - Return code: 0 12:29:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:29:11 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')]} 12:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:29:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:11 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')]} 12:29:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:29:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:11 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 0x7f61fd6f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcef7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7e790>, '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 0xd7f690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7fb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1477596536.140013-1788194419', '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 12:29:11 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 12:29:11 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 12:29:11 INFO - Using env: {'DISPLAY': ':0', 12:29:11 INFO - 'HOME': '/home/cltbld', 12:29:11 INFO - 'LANG': 'en_US.UTF-8', 12:29:11 INFO - 'LANGUAGE': 'en_US:en', 12:29:11 INFO - 'LOGNAME': 'cltbld', 12:29:11 INFO - 'MAIL': '/var/mail/cltbld', 12:29:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:29:11 INFO - 'MOZ_NO_REMOTE': '1', 12:29:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:29:11 INFO - 'NO_EM_RESTART': '1', 12:29:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:29:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:29:12 INFO - 'PWD': '/builds/slave/test', 12:29:12 INFO - 'SHELL': '/bin/bash', 12:29:12 INFO - 'SHLVL': '1', 12:29:12 INFO - 'TERM': 'linux', 12:29:12 INFO - 'TMOUT': '86400', 12:29:12 INFO - 'USER': 'cltbld', 12:29:12 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1477596536.140013-1788194419', 12:29:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:29:12 INFO - '_': '/tools/buildbot/bin/python'} 12:29:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:29:12 INFO - Downloading/unpacking psutil>=3.1.1 12:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:29:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:29:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:29:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:29:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:29:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:29:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:29:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:29:14 INFO - Installing collected packages: psutil 12:29:14 INFO - Running setup.py install for psutil 12:29:14 INFO - building 'psutil._psutil_linux' extension 12:29:14 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 12:29:14 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 12:29:14 INFO - building 'psutil._psutil_posix' extension 12:29:14 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 12:29:14 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 12:29:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:29:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:29:14 INFO - Successfully installed psutil 12:29:14 INFO - Cleaning up... 12:29:14 INFO - Return code: 0 12:29:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:29: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')]} 12:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:29:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29: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')]} 12:29:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:29:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:14 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 0x7f61fd6f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcef7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7e790>, '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 0xd7f690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7fb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1477596536.140013-1788194419', '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 12:29:14 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 12:29:14 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 12:29:14 INFO - Using env: {'DISPLAY': ':0', 12:29:14 INFO - 'HOME': '/home/cltbld', 12:29:14 INFO - 'LANG': 'en_US.UTF-8', 12:29:14 INFO - 'LANGUAGE': 'en_US:en', 12:29:14 INFO - 'LOGNAME': 'cltbld', 12:29:14 INFO - 'MAIL': '/var/mail/cltbld', 12:29:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:29:14 INFO - 'MOZ_NO_REMOTE': '1', 12:29:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:29:14 INFO - 'NO_EM_RESTART': '1', 12:29:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:29:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:29:14 INFO - 'PWD': '/builds/slave/test', 12:29:14 INFO - 'SHELL': '/bin/bash', 12:29:14 INFO - 'SHLVL': '1', 12:29:14 INFO - 'TERM': 'linux', 12:29:14 INFO - 'TMOUT': '86400', 12:29:14 INFO - 'USER': 'cltbld', 12:29:14 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1477596536.140013-1788194419', 12:29:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:29:14 INFO - '_': '/tools/buildbot/bin/python'} 12:29:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:29:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:29:15 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 12:29:15 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 12:29:15 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 12:29:15 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 12:29:15 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 12:29:15 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 12:29:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:29:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:29:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:29:17 INFO - Installing collected packages: mozsystemmonitor 12:29:17 INFO - Running setup.py install for mozsystemmonitor 12:29:17 INFO - Successfully installed mozsystemmonitor 12:29:17 INFO - Cleaning up... 12:29:17 INFO - Return code: 0 12:29:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:29:17 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')]} 12:29:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:29:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:17 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')]} 12:29:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:29:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:17 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 0x7f61fd6f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcef7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7e790>, '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 0xd7f690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7fb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1477596536.140013-1788194419', '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 12:29:17 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 12:29:17 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 12:29:17 INFO - Using env: {'DISPLAY': ':0', 12:29:17 INFO - 'HOME': '/home/cltbld', 12:29:17 INFO - 'LANG': 'en_US.UTF-8', 12:29:17 INFO - 'LANGUAGE': 'en_US:en', 12:29:17 INFO - 'LOGNAME': 'cltbld', 12:29:17 INFO - 'MAIL': '/var/mail/cltbld', 12:29:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:29:17 INFO - 'MOZ_NO_REMOTE': '1', 12:29:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:29:17 INFO - 'NO_EM_RESTART': '1', 12:29:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:29:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:29:17 INFO - 'PWD': '/builds/slave/test', 12:29:17 INFO - 'SHELL': '/bin/bash', 12:29:17 INFO - 'SHLVL': '1', 12:29:17 INFO - 'TERM': 'linux', 12:29:17 INFO - 'TMOUT': '86400', 12:29:17 INFO - 'USER': 'cltbld', 12:29:17 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1477596536.140013-1788194419', 12:29:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:29:17 INFO - '_': '/tools/buildbot/bin/python'} 12:29:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:29:17 INFO - Downloading/unpacking jsonschema==2.5.1 12:29:17 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 12:29:17 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 12:29:17 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 12:29:17 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 12:29:17 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 12:29:17 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 12:29:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:29:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:29:19 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 12:29:19 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 12:29:19 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 12:29:19 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 12:29:19 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 12:29:19 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 12:29:19 INFO - Downloading functools32-3.2.3-2.tar.gz 12:29:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:29:19 INFO - warning: no files found matching '*.txt' 12:29:19 INFO - no previously-included directories found matching 'build' 12:29:19 INFO - no previously-included directories found matching 'dist' 12:29:19 INFO - no previously-included directories found matching '.git*' 12:29:19 INFO - Installing collected packages: jsonschema, functools32 12:29:19 INFO - Running setup.py install for functools32 12:29:19 INFO - warning: no files found matching '*.txt' 12:29:19 INFO - no previously-included directories found matching 'build' 12:29:19 INFO - no previously-included directories found matching 'dist' 12:29:19 INFO - no previously-included directories found matching '.git*' 12:29:19 INFO - Successfully installed jsonschema functools32 12:29:19 INFO - Cleaning up... 12:29:19 INFO - Return code: 0 12:29:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:29:19 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')]} 12:29:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:29:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:19 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')]} 12:29:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:29:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:19 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 0x7f61fd6f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcef7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7e790>, '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 0xd7f690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7fb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1477596536.140013-1788194419', '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 12:29:19 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 12:29:19 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 12:29:19 INFO - Using env: {'DISPLAY': ':0', 12:29:19 INFO - 'HOME': '/home/cltbld', 12:29:19 INFO - 'LANG': 'en_US.UTF-8', 12:29:19 INFO - 'LANGUAGE': 'en_US:en', 12:29:19 INFO - 'LOGNAME': 'cltbld', 12:29:19 INFO - 'MAIL': '/var/mail/cltbld', 12:29:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:29:19 INFO - 'MOZ_NO_REMOTE': '1', 12:29:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:29:19 INFO - 'NO_EM_RESTART': '1', 12:29:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:29:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:29:19 INFO - 'PWD': '/builds/slave/test', 12:29:19 INFO - 'SHELL': '/bin/bash', 12:29:19 INFO - 'SHLVL': '1', 12:29:19 INFO - 'TERM': 'linux', 12:29:19 INFO - 'TMOUT': '86400', 12:29:19 INFO - 'USER': 'cltbld', 12:29:19 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1477596536.140013-1788194419', 12:29:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:29:19 INFO - '_': '/tools/buildbot/bin/python'} 12:29:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:29:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:29:20 INFO - Cleaning up... 12:29:20 INFO - Return code: 0 12:29:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:29:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:29:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:29:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:29:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:29:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:20 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 0x7f61fd6f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcef7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7e790>, '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 0xd7f690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7fb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1477596536.140013-1788194419', '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 12:29:20 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 12:29:20 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 12:29:20 INFO - Using env: {'DISPLAY': ':0', 12:29:20 INFO - 'HOME': '/home/cltbld', 12:29:20 INFO - 'LANG': 'en_US.UTF-8', 12:29:20 INFO - 'LANGUAGE': 'en_US:en', 12:29:20 INFO - 'LOGNAME': 'cltbld', 12:29:20 INFO - 'MAIL': '/var/mail/cltbld', 12:29:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:29:20 INFO - 'MOZ_NO_REMOTE': '1', 12:29:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:29:20 INFO - 'NO_EM_RESTART': '1', 12:29:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:29:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:29:20 INFO - 'PWD': '/builds/slave/test', 12:29:20 INFO - 'SHELL': '/bin/bash', 12:29:20 INFO - 'SHLVL': '1', 12:29:20 INFO - 'TERM': 'linux', 12:29:20 INFO - 'TMOUT': '86400', 12:29:20 INFO - 'USER': 'cltbld', 12:29:20 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1477596536.140013-1788194419', 12:29:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:29:20 INFO - '_': '/tools/buildbot/bin/python'} 12:29:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:29:20 INFO - Downloading/unpacking blobuploader==1.2.4 12:29:20 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 12:29:20 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 12:29:20 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 12:29:20 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 12:29:20 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 12:29:20 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 12:29:22 INFO - Downloading blobuploader-1.2.4.tar.gz 12:29:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:29:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:29:22 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 12:29:22 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 12:29:22 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 12:29:22 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 12:29:22 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 12:29:22 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 12:29:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:29:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:29:22 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 12:29:22 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 12:29:22 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 12:29:22 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 12:29:22 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 12:29:22 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 12:29:22 INFO - Downloading docopt-0.6.1.tar.gz 12:29:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:29:22 INFO - Installing collected packages: blobuploader, requests, docopt 12:29:22 INFO - Running setup.py install for blobuploader 12:29:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:29:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:29:23 INFO - Running setup.py install for requests 12:29:23 INFO - Running setup.py install for docopt 12:29:23 INFO - Successfully installed blobuploader requests docopt 12:29:23 INFO - Cleaning up... 12:29:23 INFO - Return code: 0 12:29:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:29:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:29:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:29:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:29:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:29:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:23 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 0x7f61fd6f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcef7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7e790>, '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 0xd7f690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7fb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1477596536.140013-1788194419', '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 12:29:23 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 12:29:23 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 12:29:23 INFO - Using env: {'DISPLAY': ':0', 12:29:23 INFO - 'HOME': '/home/cltbld', 12:29:23 INFO - 'LANG': 'en_US.UTF-8', 12:29:23 INFO - 'LANGUAGE': 'en_US:en', 12:29:23 INFO - 'LOGNAME': 'cltbld', 12:29:23 INFO - 'MAIL': '/var/mail/cltbld', 12:29:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:29:23 INFO - 'MOZ_NO_REMOTE': '1', 12:29:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:29:23 INFO - 'NO_EM_RESTART': '1', 12:29:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:29:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:29:23 INFO - 'PWD': '/builds/slave/test', 12:29:23 INFO - 'SHELL': '/bin/bash', 12:29:23 INFO - 'SHLVL': '1', 12:29:23 INFO - 'TERM': 'linux', 12:29:23 INFO - 'TMOUT': '86400', 12:29:23 INFO - 'USER': 'cltbld', 12:29:23 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1477596536.140013-1788194419', 12:29:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:29:23 INFO - '_': '/tools/buildbot/bin/python'} 12:29:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:29:23 INFO - Running setup.py (path:/tmp/pip-zumMS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:29:23 INFO - Running setup.py (path:/tmp/pip-fUFLi2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:29:23 INFO - Running setup.py (path:/tmp/pip-j9hQHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:29:23 INFO - Running setup.py (path:/tmp/pip-J07CQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:29:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:29:24 INFO - Running setup.py (path:/tmp/pip-Pm_00S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:29:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:29:24 INFO - Running setup.py (path:/tmp/pip-UonoVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:29:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:29:24 INFO - Running setup.py (path:/tmp/pip-V9Fuhv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:29:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:29:24 INFO - Running setup.py (path:/tmp/pip-rMmII5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:29:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:29:24 INFO - Running setup.py (path:/tmp/pip-QemErY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:29:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:29:24 INFO - Running setup.py (path:/tmp/pip-pFZ6jb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:29:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:29:24 INFO - Running setup.py (path:/tmp/pip-WhfwTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:29:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:29:24 INFO - Running setup.py (path:/tmp/pip-3krslF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:29:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:29:24 INFO - Running setup.py (path:/tmp/pip-nIwaWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:29:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:29:24 INFO - Running setup.py (path:/tmp/pip-rBb6Be-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:29:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:29:24 INFO - Running setup.py (path:/tmp/pip-x6mUIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:29:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:29:24 INFO - Running setup.py (path:/tmp/pip-X7yb32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:29:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:29:24 INFO - Running setup.py (path:/tmp/pip-0qVecF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:29:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:29:24 INFO - Running setup.py install for manifestparser 12:29:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:29:25 INFO - Running setup.py install for mozcrash 12:29:25 INFO - Running setup.py install for mozdebug 12:29:25 INFO - Running setup.py install for mozdevice 12:29:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:29:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:29:25 INFO - Running setup.py install for mozfile 12:29:25 INFO - Running setup.py install for mozhttpd 12:29:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:29:25 INFO - Running setup.py install for mozinfo 12:29:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:29:25 INFO - Running setup.py install for mozInstall 12:29:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:29:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:29:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:29:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:29:25 INFO - Running setup.py install for mozleak 12:29:25 INFO - Running setup.py install for mozlog 12:29:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:29:26 INFO - Running setup.py install for moznetwork 12:29:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:29:26 INFO - Running setup.py install for mozprocess 12:29:26 INFO - Running setup.py install for mozprofile 12:29:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:29:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:29:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:29:26 INFO - Running setup.py install for mozrunner 12:29:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:29:26 INFO - Running setup.py install for mozscreenshot 12:29:26 INFO - Running setup.py install for moztest 12:29:26 INFO - Running setup.py install for mozversion 12:29:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:29:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:29:26 INFO - Cleaning up... 12:29:26 INFO - Return code: 0 12:29:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:29: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')]} 12:29:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:29:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29: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')]} 12:29:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:29:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:26 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 0x7f61fd6f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcef7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7e790>, '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 0xd7f690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7fb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1477596536.140013-1788194419', '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 12:29:26 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 12:29:26 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 12:29:26 INFO - Using env: {'DISPLAY': ':0', 12:29:26 INFO - 'HOME': '/home/cltbld', 12:29:26 INFO - 'LANG': 'en_US.UTF-8', 12:29:26 INFO - 'LANGUAGE': 'en_US:en', 12:29:26 INFO - 'LOGNAME': 'cltbld', 12:29:26 INFO - 'MAIL': '/var/mail/cltbld', 12:29:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:29:26 INFO - 'MOZ_NO_REMOTE': '1', 12:29:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:29:26 INFO - 'NO_EM_RESTART': '1', 12:29:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:29:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:29:26 INFO - 'PWD': '/builds/slave/test', 12:29:26 INFO - 'SHELL': '/bin/bash', 12:29:26 INFO - 'SHLVL': '1', 12:29:26 INFO - 'TERM': 'linux', 12:29:26 INFO - 'TMOUT': '86400', 12:29:26 INFO - 'USER': 'cltbld', 12:29:26 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1477596536.140013-1788194419', 12:29:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:29:26 INFO - '_': '/tools/buildbot/bin/python'} 12:29:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:29:27 INFO - Running setup.py (path:/tmp/pip-WHdv_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:29:27 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)) 12:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:29:27 INFO - Running setup.py (path:/tmp/pip-tRAqGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:29:27 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)) 12:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:29:27 INFO - Running setup.py (path:/tmp/pip-TMHIFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:29:27 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)) 12:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:29:27 INFO - Running setup.py (path:/tmp/pip-0UnhKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:29:27 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)) 12:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:29:27 INFO - Running setup.py (path:/tmp/pip-t5Vtts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:29:27 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)) 12:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:29:27 INFO - Running setup.py (path:/tmp/pip-ftW2y2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:29:27 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)) 12:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:29:27 INFO - Running setup.py (path:/tmp/pip-lQ8bMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:29:27 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)) 12:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:29:27 INFO - Running setup.py (path:/tmp/pip-6Ll4lp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:29:27 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)) 12:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:29:27 INFO - Running setup.py (path:/tmp/pip-NoYcTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:29:27 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)) 12:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:29:27 INFO - Running setup.py (path:/tmp/pip-v8yZpX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:29:27 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)) 12:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:29:27 INFO - Running setup.py (path:/tmp/pip-FvZmK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:29:27 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)) 12:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:29:27 INFO - Running setup.py (path:/tmp/pip-LF7Str-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:29:27 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)) 12:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:29:27 INFO - Running setup.py (path:/tmp/pip-ZPZG92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:29:27 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)) 12:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:29:28 INFO - Running setup.py (path:/tmp/pip-7k0k4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:29:28 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)) 12:29:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:29:28 INFO - Running setup.py (path:/tmp/pip-M4en2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:29:28 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)) 12:29:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:29:28 INFO - Running setup.py (path:/tmp/pip-NMXPfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:29:28 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)) 12:29:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:29:28 INFO - Running setup.py (path:/tmp/pip-vNhOm6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:29:28 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)) 12:29:28 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)) 12:29:28 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)) 12:29:28 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)) 12:29:28 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)) 12:29:28 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)) 12:29:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:29: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 12:29: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 12:29: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 12:29: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 12:29: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 12:29: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 12:29:30 INFO - Downloading blessings-1.6.tar.gz 12:29:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:29:30 INFO - Installing collected packages: blessings 12:29:30 INFO - Running setup.py install for blessings 12:29:30 INFO - Successfully installed blessings 12:29:30 INFO - Cleaning up... 12:29:30 INFO - Return code: 0 12:29:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:29:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:29:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:29:30 INFO - Reading from file tmpfile_stdout 12:29:30 INFO - Current package versions: 12:29:30 INFO - argparse == 1.2.1 12:29:30 INFO - blessings == 1.6 12:29:30 INFO - blobuploader == 1.2.4 12:29:30 INFO - docopt == 0.6.1 12:29:30 INFO - functools32 == 3.2.3-2 12:29:30 INFO - jsonschema == 2.5.1 12:29:30 INFO - manifestparser == 1.1 12:29:30 INFO - mozInstall == 1.12 12:29:30 INFO - mozcrash == 0.17 12:29:30 INFO - mozdebug == 0.1 12:29:30 INFO - mozdevice == 0.48 12:29:30 INFO - mozfile == 1.2 12:29:30 INFO - mozhttpd == 0.7 12:29:30 INFO - mozinfo == 0.9 12:29:30 INFO - mozleak == 0.1 12:29:30 INFO - mozlog == 3.4 12:29:30 INFO - moznetwork == 0.27 12:29:30 INFO - mozprocess == 0.23 12:29:30 INFO - mozprofile == 0.28 12:29:30 INFO - mozrunner == 6.12 12:29:30 INFO - mozscreenshot == 0.1 12:29:30 INFO - mozsystemmonitor == 0.3 12:29:30 INFO - moztest == 0.7 12:29:30 INFO - mozversion == 1.4 12:29:30 INFO - psutil == 3.1.1 12:29:30 INFO - requests == 1.2.3 12:29:30 INFO - wsgiref == 0.1.2 12:29:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:29: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')]} 12:29:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:29:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29: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')]} 12:29:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:29:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:30 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 0x7f61fd6f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcef7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7e790>, '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 0xd7f690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7fb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1477596536.140013-1788194419', '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 12:29:30 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 12:29:30 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 12:29:30 INFO - Using env: {'DISPLAY': ':0', 12:29:30 INFO - 'HOME': '/home/cltbld', 12:29:30 INFO - 'LANG': 'en_US.UTF-8', 12:29:30 INFO - 'LANGUAGE': 'en_US:en', 12:29:30 INFO - 'LOGNAME': 'cltbld', 12:29:30 INFO - 'MAIL': '/var/mail/cltbld', 12:29:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:29:30 INFO - 'MOZ_NO_REMOTE': '1', 12:29:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:29:30 INFO - 'NO_EM_RESTART': '1', 12:29:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:29:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:29:30 INFO - 'PWD': '/builds/slave/test', 12:29:30 INFO - 'SHELL': '/bin/bash', 12:29:30 INFO - 'SHLVL': '1', 12:29:30 INFO - 'TERM': 'linux', 12:29:30 INFO - 'TMOUT': '86400', 12:29:30 INFO - 'USER': 'cltbld', 12:29:30 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1477596536.140013-1788194419', 12:29:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:29:30 INFO - '_': '/tools/buildbot/bin/python'} 12:29:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:29:30 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)) 12:29:30 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)) 12:29:30 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)) 12:29:30 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)) 12:29:30 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)) 12:29:30 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)) 12:29:30 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)) 12:29:30 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)) 12:29:30 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)) 12:29:30 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)) 12:29:30 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)) 12:29:30 INFO - Cleaning up... 12:29:30 INFO - Return code: 0 12:29:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:29: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')]} 12:29:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:29:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29: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')]} 12:29:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:29:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f61fd6f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcef7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7e790>, '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 0xd7f690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7fb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1477596536.140013-1788194419', '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 12:29:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:29:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:29:30 INFO - Using env: {'DISPLAY': ':0', 12:29:30 INFO - 'HOME': '/home/cltbld', 12:29:30 INFO - 'LANG': 'en_US.UTF-8', 12:29:30 INFO - 'LANGUAGE': 'en_US:en', 12:29:30 INFO - 'LOGNAME': 'cltbld', 12:29:30 INFO - 'MAIL': '/var/mail/cltbld', 12:29:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:29:30 INFO - 'MOZ_NO_REMOTE': '1', 12:29:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:29:30 INFO - 'NO_EM_RESTART': '1', 12:29:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:29:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:29:30 INFO - 'PWD': '/builds/slave/test', 12:29:30 INFO - 'SHELL': '/bin/bash', 12:29:30 INFO - 'SHLVL': '1', 12:29:30 INFO - 'TERM': 'linux', 12:29:30 INFO - 'TMOUT': '86400', 12:29:30 INFO - 'USER': 'cltbld', 12:29:30 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1477596536.140013-1788194419', 12:29:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:29:30 INFO - '_': '/tools/buildbot/bin/python'} 12:29:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:29:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:29:31 INFO - Cleaning up... 12:29:31 INFO - Return code: 0 12:29:31 INFO - Running post-action listener: _resource_record_post_action 12:29:31 INFO - Running post-action listener: _start_resource_monitoring 12:29:31 INFO - Starting resource monitoring. 12:29:31 INFO - [mozharness: 2016-10-27 19:29:31.186112Z] Finished create-virtualenv step (success) 12:29:31 INFO - [mozharness: 2016-10-27 19:29:31.186656Z] Running install step. 12:29:31 INFO - Running pre-action listener: _resource_record_pre_action 12:29:31 INFO - Running main action method: install 12:29:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:29:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:29:31 INFO - Reading from file tmpfile_stdout 12:29:31 INFO - Detecting whether we're running mozinstall >=1.0... 12:29:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:29:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:29:31 INFO - Reading from file tmpfile_stdout 12:29:31 INFO - Output received: 12:29:31 INFO - Usage: mozinstall [options] installer 12:29:31 INFO - Options: 12:29:31 INFO - -h, --help show this help message and exit 12:29:31 INFO - -d DEST, --destination=DEST 12:29:31 INFO - Directory to install application into. [default: 12:29:31 INFO - "/builds/slave/test"] 12:29:31 INFO - --app=APP Application being installed. [default: firefox] 12:29:31 INFO - mkdir: /builds/slave/test/build/application 12:29:31 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'] 12:29:31 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 12:29:48 INFO - Reading from file tmpfile_stdout 12:29:48 INFO - Output received: 12:29:48 INFO - /builds/slave/test/build/application/firefox/firefox 12:29:48 INFO - Running post-action listener: _resource_record_post_action 12:29:48 INFO - [mozharness: 2016-10-27 19:29:48.351960Z] Finished install step (success) 12:29:48 INFO - [mozharness: 2016-10-27 19:29:48.352233Z] Running run-tests step. 12:29:48 INFO - Running pre-action listener: _resource_record_pre_action 12:29:48 INFO - Running main action method: run_tests 12:29:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:29:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:29:48 INFO - Python 2.7.3 12:29:48 INFO - Return code: 0 12:29:48 INFO - grabbing minidump binary from tooltool 12:29:48 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')]} 12:29:48 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 0xd7e790>, '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 0xd7f690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:29:48 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 12:29:48 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 12:29:48 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 12:29:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:29:48 INFO - Return code: 0 12:29:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:29:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:29:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:29:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:29:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:29:48 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477585809/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 12:29:48 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477585809/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:29:48 INFO - Using env: {'DISPLAY': ':0', 12:29:48 INFO - 'HOME': '/home/cltbld', 12:29:48 INFO - 'LANG': 'en_US.UTF-8', 12:29:48 INFO - 'LANGUAGE': 'en_US:en', 12:29:48 INFO - 'LOGNAME': 'cltbld', 12:29:48 INFO - 'MAIL': '/var/mail/cltbld', 12:29:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:29:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:29:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:29:48 INFO - 'MOZ_NO_REMOTE': '1', 12:29:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:29:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:29:48 INFO - 'NO_EM_RESTART': '1', 12:29:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:29:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:29:48 INFO - 'PWD': '/builds/slave/test', 12:29:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:29:48 INFO - 'SHELL': '/bin/bash', 12:29:48 INFO - 'SHLVL': '1', 12:29:48 INFO - 'TERM': 'linux', 12:29:48 INFO - 'TMOUT': '86400', 12:29:48 INFO - 'USER': 'cltbld', 12:29:48 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1477596536.140013-1788194419', 12:29:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:29:48 INFO - '_': '/tools/buildbot/bin/python'} 12:29:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477585809/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:29:48 INFO - mozversion application_buildid: 20161027093009 12:29:48 INFO - mozversion application_changeset: 9888f1a23001fde6435e1a9ed7e6d3af8dd988d8 12:29:48 INFO - mozversion application_display_name: Nightly 12:29:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:29:48 INFO - mozversion application_name: Firefox 12:29:48 INFO - mozversion application_remotingname: firefox 12:29:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:29:48 INFO - mozversion application_vendor: Mozilla 12:29:48 INFO - mozversion application_version: 52.0a1 12:29:48 INFO - mozversion platform_buildid: 20161027093009 12:29:48 INFO - mozversion platform_changeset: 9888f1a23001fde6435e1a9ed7e6d3af8dd988d8 12:29:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:29:48 INFO - mozversion platform_version: 52.0a1 12:29:48 INFO - using testdate: 1477596588 12:29:48 INFO - actual date: 1477596588 12:29:48 INFO - starting webserver on 'localhost:48362' 12:29:48 INFO - SUITE-START | Running 2 tests 12:29:48 INFO - TEST-START | dromaeo_css 12:29:48 INFO - operating with platform_type : linux_ 12:29:48 INFO - Initialising browser for dromaeo_css test... 12:29:48 INFO - TEST-INFO | started process 29773 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqnoXAo/profile http://localhost:48362/getInfo.html) 12:29:53 INFO - PROCESS | 29773 | __metrics Screen width/height:1600/1200 12:29:53 INFO - PROCESS | 29773 | colorDepth:24 12:29:53 INFO - PROCESS | 29773 | Browser inner width/height: 1024/697 12:29:53 INFO - PROCESS | 29773 | __metrics 12:29:53 ERROR - PROCESS | 29773 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3097: TypeError: this.tabs is undefined 12:29:54 INFO - TEST-INFO | 29773: exit 0 12:29:54 INFO - Browser initialized. 12:29:54 INFO - Running cycle 1/1 for dromaeo_css test... 12:29:54 INFO - TEST-INFO | started process 29896 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqnoXAo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:30:06 INFO - PROCESS | 29896 | RSS: Main: 182878208 12:30:06 INFO - PROCESS | 29896 | 12:30:56 INFO - PROCESS | 29896 | 1477596656178 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] 12:33:07 INFO - PROCESS | 29896 | Cycle 1(1): loaded http://localhost:48362/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48362/tests/dromaeo/cssquery-ext.html) 12:33:09 INFO - PROCESS | 29896 | RSS: Main: 196829184 12:33:09 INFO - PROCESS | 29896 | 12:36:11 INFO - PROCESS | 29896 | Cycle 1(1): loaded http://localhost:48362/tests/dromaeo/cssquery-ext.html (next: http://localhost:48362/tests/dromaeo/cssquery-jquery.html) 12:36:12 INFO - PROCESS | 29896 | RSS: Main: 194453504 12:36:12 INFO - PROCESS | 29896 | 12:39:14 INFO - PROCESS | 29896 | Cycle 1(1): loaded http://localhost:48362/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48362/tests/dromaeo/cssquery-mootools.html) 12:39:15 INFO - PROCESS | 29896 | RSS: Main: 196833280 12:39:15 INFO - PROCESS | 29896 | 12:42:16 INFO - PROCESS | 29896 | Cycle 1(1): loaded http://localhost:48362/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48362/tests/dromaeo/cssquery-prototype.html) 12:42:17 INFO - PROCESS | 29896 | RSS: Main: 193228800 12:42:17 INFO - PROCESS | 29896 | 12:45:20 INFO - PROCESS | 29896 | Cycle 1(1): loaded http://localhost:48362/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48362/tests/dromaeo/cssquery-yui.html) 12:45:20 INFO - PROCESS | 29896 | RSS: Main: 197222400 12:45:20 INFO - PROCESS | 29896 | 12:48:23 INFO - PROCESS | 29896 | Cycle 1(1): loaded http://localhost:48362/tests/dromaeo/cssquery-yui.html (next: http://localhost:48362/tests/dromaeo/cssquery-dojo.html) 12:48:23 INFO - PROCESS | 29896 | RSS: Main: 196198400 12:48:23 INFO - PROCESS | 29896 | 12:48:23 INFO - PROCESS | 29896 | __start_tp_report 12:48:23 INFO - PROCESS | 29896 | _x_x_mozilla_page_load 12:48:23 INFO - PROCESS | 29896 | _x_x_mozilla_page_load_details 12:48:23 INFO - PROCESS | 29896 | |i|pagename|runs| 12:48:23 INFO - PROCESS | 29896 | |0;dojo.html;3084.2289427643086;3105.394448082625;3129.342838004019;3131.8277494737795;3142.764292678049;5297.761600727967;5458.61789674723;5488.039593071217;5506.091494903341;5514.889702205954;5348;5437.429069947658;5508.03609368361;5528.612997090206;5606.859828504289;4894.951050489485;4967.49934703009;4970.726610036447;4975.353204083464;5042.672226305279;4852.17513022787;4970.329005584254;5036.244563315496;5042.168042273039;5097.515736005093;4841.685290456109;4882.048000639877;4937.975310123426;4970.950290497103;4993.425756038066;4888.828890988834;4932.432770231398;4947.431045429786;4953;5022.4726403727445;4871.098846713334;4877.829275975324;4884.7069175849565;4892.143874821892;4972.900541989176;5257.526822585985;5372.435894231127;5419.83740487786;5435.483629055233;5437.157240627709;5530.170474428827;5729.6562206267345;5774.7112644368035;5778.27771528559;5877.177195192677;5815.418458154193;5816.796412125597;5817.38917413674;5822.82531524055;5829.47534721877;5416.160495123262;5442.074847275972;5449.83650490482;5481.75332110056;5490.0941344677685;5819.418058194231;5864.973629614886;5886.264216972879;5887.587868849225;5927.229460170237;5640.125780504029;5664.065429204135;5690.7439165237665;5698.145278208219;5713.5714821388565;5794.623349482355;5808.912866307009;5817.738201780845;5866.266716660418;5877.9118313225335;5602.299712535933;5684.914726279109;5692.48767610917;5784;5784.334801497797;5753.539716822645;5758.88482230353;5773.769049238067;5775.653460792366;5790.739416726257;4410.933835992462;4427.114577084596;4429.025614364899;4475.440569928759;4475.552444755498;3914.921701565953;3918.216356728609;3920.9019774505296;3954.2882281189086;3957.0700885291935;5510.641808282448;5512.503874651301;5518.641288316247;5553.250311208016;5581.609287349846;5769.509591684669;5827.825165245049;5828.59199856006;5836.387179346192;5844.970775146097;5329.173978033411;5383.084875571162;5444.156155795858;5447.945520544744;5468.398476167618;4819;4824.372831531879;4828.830990915301;4830.637702172351;4905.877353066202;5973.850653733692;5995.250593675791;6013.579049466583;6013.729382177812;6018;5772.971135144466;5782.277215348082;5839.211706419749;5856.560757943256;5883.499902508163;5975.55183361241;5990.430909063632;6025.337212906489;6034.577579569388;6096.207493025879;5693.202951586864;5705.657660540215;5757.740901659352;5758.942410575841;5773.9895518284975;5647;5714.485696287354;5719.370869204301;5752.7698892043845;5838.824835254949;5640.605157638925;5647.20939068539;5651.773929042793;5661.433856614306;5661.971690141688;5600.691961942132;5634.183043458757;5647.29408823897;5665.206871037975;5688.345840228261;5516.3380394351325;5543.113101903676;5606.719664016864;5664.235328230801;5673.262475878109;5686.118651609007;5703.62926409782;5721.7425215866215;5736.397678243724;5737.942620573741;5565.833025009256;5612.270404847343;5616.1014237721765;5635.887282254414;5649 12:48:23 INFO - PROCESS | 29896 | |1;ext.html;580.1095318685817;589.0780927847918;592.3247497852449;602.0818252165448;603.8707616756666;37988.81005594975;41240.793796031016;41296.38055429164;41345.58654413455;41370.37944430836;41513.37729934054;41849.58150418495;41939;41995.790021049856;42099.78950105253;8560.400771945966;8729.869051964226;8737.868931965993;8747.562621868881;8777.605007774666;8652.307815374756;8803.691870784523;8821.955890220572;8823.117688231157;8827.514486703229;8763.78090547735;8782.12178782123;8834.293256539462;8864.822703545957;8886.244669203126;8746.693865714733;8802.73591792244;8851.645934162625;8856.955715221415;8869.113088691143;8579.742607721779;8660.48037117775;8660.653573857038;8665.523396213206;8682.913170868274;39535.60464395348;39569.40645890314;40049.19901601952;40166;40409.19181616351;3430.9142271443166;3484.4599087141532;3563.2873425315042;3649.908752281214;4081.9591804081874;31134.221644458845;31275.218119547193;31565;31690.04929852108;32802;4280.514099901873;4460.8438704645505;4467.821287148543;4566.680332376735;4583.931241031387;342612;343401;343607;343609;343711;57551.42448575461;57888.71055644779;57977.71011145002;58096.4190358091;58209.41790582125;60989.08516372258;61528.384716152264;61768.4258939865;61808.38191618026;61936.380636193964;15292.541223763305;15308;15325.080495170325;15360.385584576716;15404.61488462775;12972.545960891324;13031.674208144872;13124.081314308098;13142.211467311801;13152.21086734799;18231.72652410215;18323.816761832477;18361.81638183601;18391.72412413815;18700.438986830417;6871.1864914971675;6932.306769323128;7045.436365090781;7350.7427240046345;7362.705491780269;927.8190752803274;1009.2077718990557;1062.0919114157439;1063.4948399510172;1077.6012875236213;29532.704672953427;30941.845290773403;31021.844890775403;31265.218369540944;31293.8435307822;1066.0390419493274;1114.9163812713916;1127.301073334538;1139.9544018239178;1180.0913296761616;16276.918615407085;16434.096124713255;16443.342266309213;16468;16654.417095401604;532645;539095;540109;541216;544020;54834;55480.44519554834;55606.44393556013;55781.72109139428;55935.44064559384;1330.1287656584952;1346.2393747532612;1375.6354566040006;1395.4766962389308;1396.1762560089596;29520.409591808475;30527.757922325505;31175.817692762197;31459.842700787267;31839.522407163447;47629.761851190524;47838.28242576295;48114.759426204044;48327.75836120937;48377;377848;378801;379646;380929;381514;27079.864600676872;27544.449111018068;27626.171214863585;27741.861290694225;27782.166535003984;41242.38136428016;43468.13063738644;43813.56186438095;45059.32411013903;45968.770156149;38570.228595428496;39153;39339.6231131909;40353.39469907895;40612.3908141384;38593.22813543657;38763.41854872236;38963.415548767356;39472;39641;33307;34521.482177766855;36409.63590364168;38504;39220.60779392169;32419;34614.480782788785;35533.28933421369;35634.64365356313;35676;26664.466710666067;27242.455150896476;27383.178504644893;27543.26499529641;27684 12:48:23 INFO - PROCESS | 29896 | |2;jquery.html;368.14088851300926;381.15604132325495;382.11540284241977;389.4664309895444;401.5021373496863;17204.569885752862;18774.90612546937;18848.246070157213;19078.523036924067;19272.3254686086;16008.679826403464;16175.514734557983;16533.090680012596;16620.83379166208;16624.83375166248;5534.446555344453;5806.274215723035;5806.7096645167785;5812.941870581282;5813.389594092623;5378.381486129106;5577.107662773957;5594.188842617818;5608.551315894719;5616.63491873029;5533.280673512458;5544.695041772701;5565.860853478655;5587.329520457551;5589.888202235953;5416.160495123262;5618.213450116987;5650.971745141289;5667.631603945731;5692.288463942028;5004.174311238641;5076.263941728465;5110.054639891632;5110.540051395392;5114.232865070232;20213.19147234109;21172.788272117235;22035.118595256172;22291.44271393212;22526.66210006851;2318.258157389636;2332.7667233276707;2420.7942324902406;2551.719310875802;2862.270121119122;9765.414075155513;9798;9980.351277166961;10298.227632927485;10656.946715266451;1657.4011277060251;1670.7385923627705;1678.5719641491341;1686.5530634381898;1721.4835549335148;79723.6013819933;80359.5982020092;80975;81897;82252.58873705594;10669.73325666849;10720.946395267974;10794.568217271379;10907.945460272647;11471.197016208785;14767.704645907022;14822.332995015035;14859.2570371481;14883.553493395215;14929.10425374481;7894.763157105296;8001.519908805491;8173.264406203471;8243.546604936786;8339.166083391734;7698.960640313598;7752.186020467882;7828.686852525949;8110.553919534483;8160.795980100426;4068.16602596467;4367.733357326403;4479.328100784843;4660.254359302496;4794.256890182028;1875.3342563390072;1963.5876465942026;1971.2312198242696;1994.2421879685626;2016.102834238779;409.040799325581;916.1067958740175;964.3442459127721;1053.0469924718143;1094.5949998500605;10928.617498387677;11185.440727963569;11315.83026254607;11568.24806387582;11628.592999244986;436.6594056635829;438.3118503948833;440.170279024042;445.9197344478025;451.884769383805;5891.175235467038;6099.3900609938655;6167.629942203482;6279.780207692709;6371.458426033839;407716.61416929035;416434;453521;466086;467964;64569.67715161394;83575;83885.58057209675;83918.32163356699;85009.57495212484;433.62708071058864;438.58991842627245;444.8265176581136;446.9776511174363;449.0345756623221;10955.890441095487;10980;10987.670369888916;11043.668689939315;11262;35697.28605427929;39250.6074939247;39737.2052558953;39823.60176398199;39933.20133597254;45078.54921450875;53060;53859.73070134624;54030;54573.454265456836;7954.522728636301;8123.7156699515235;8133.633986470505;8140.918590814253;8335.374846886387;10483.737906552396;12262.386880655753;12565.434555444845;12859.228446293253;12950.805737914126;10595.311304765166;10730.570777168827;11353.829692554453;11655.242409243372;11738.58914937973;10596.841047384449;10702.09032232269;10856;11035.062019728413;11331.206815522833;10483.895161048293;10532.21008424356;11009.2843965142;11318.773624527299;11707.531698731955;8021.558814265271;8041.517508949481;8058.83882322362;8135.633896474791;8212.753617391489;8347.415680902279;10553.788924221319;10586.841197381891;10735.94025702671;11112 12:48:23 INFO - PROCESS | 29896 | |3;mootools.html;1484.5175318021643;1498.086167437863;1661.9750703739446;1720.2344956494358;1738.7131123364645;6982.546134501266;7178.353948144666;7703.961480192598;8152.796180095501;8197.959010204955;7686.231376862311;7989.36085113191;8002.239787220219;8071.192880711926;8170.509769413839;2198.3734635628807;2238.205437069841;2250.583642026222;2251.5271792923504;2253.0649780341137;2080.708700781892;2125.670521069229;2162.275637661385;2162.91348346066;2165.566886622674;2053.486628342914;2091.6862470629376;2095.7485101787806;2108.8840113793735;2120.639491286477;1986.980130198701;2003.8497112716532;2006.9297574584966;2009.3971808457404;2009.6784514477686;2094.9476263093393;2107.9789202107936;2140.6360918643713;2143.0998980428258;2153.7630860605323;8123.147069557671;8136.186381361876;8193.959030204871;8199.59002049901;8200.794980125485;4879.463259041502;5004.074246264453;5004.924926126111;5017.448080711119;5037.49625037497;3146.889858854952;3347.44767113426;3352.0949343677316;3356.311956049004;3392.4063288924585;991.8908920018793;1026.6765968719828;1030.536258683588;2049.2929939170963;2098.569793192392;11060.391678457681;11105.278156919856;11132.721681957935;11194.328340299526;11221.943890280496;4207.389928460356;4227.070044590185;4335.241332766816;4384.210842048462;4406.867793966187;8830.249428798625;8853.468791872509;8873.73378798637;8894.243989260856;8911.197992180734;5047.167217409086;5047.823326183566;5050.823221187241;5051.545360917535;5059.797608095635;4055.2359723520362;4216.873493795191;4392;4577.3362862384765;4680.180968330528;3553.6091029986683;3596.9640303597153;3647.1976165243605;3694.261147770457;3724.6275372462537;1122.449999500239;1137.9146564007733;1152.222249981276;1163.5694792926672;1163.9804938431814;796.6136423834436;898.955052247385;920.2959735802117;932.5057719408725;955.9235261179089;5327.493888080626;5548.306461692288;5605.32736071674;5667.12159615252;5673.574481913873;937.5687183895349;947.7583216279943;953.50894289441;958.4872093429982;1007.2596641468515;3574.7318951078773;3755.830987605564;3777.433384992218;3847.8460861565222;3851.345271303829;9687.17658998993;9934.602615895283;9971.601135954626;10006.09945104944;10033.247506437046;9878.604855805832;9895.554700038516;9932.80134397308;9933.304668673123;9951.601935922627;6855.725770969205;7070.505064645528;7380.741674041383;7514.211007844207;7524;5244.292020577326;5426.728663566885;5479.6164268500825;5629.774809007594;5661.122526008476;8576.528290944058;8655.17775811297;8778.956105219433;9120.498372589305;9257.259419246579;9279.582418791306;9284.58219380116;9351.953240233755;9357.625694972125;9381.343305968516;6847.554908931103;7071.893921591283;7158.606276654834;7177.712891484282;7189.173245076674;7004.614746189009;7187.101612298463;7191.928080719126;7225.783226503213;7226.349628533457;6499.415052645285;6643.56816806906;6649.335066493312;6662.167229096363;6790.932090679227;6444.387783160592;6499;6535.150430444012;6536.281009088902;6591.406773390226;6230.06549017651;6237.064440333987;6246;6301.936980630135;6303;4665.323528088476;4669.4396672399525;4703.223968045371;4838.903221935471;4908;4695.0375173090115;4697.154512187839;4698.553637404441;4787.976060119677;4895.902081958269 12:48:23 INFO - PROCESS | 29896 | |4;prototype.html;323.88825855079995;330.5488008867895;335.1554083709053;341.846169223849;344.10704222542495;5513.255710479084;5533.3083364579425;5560.972195139028;5605.859853503659;5613.522850557697;5443.639090227443;5453.7818487260565;5515.172724091388;5515.61390702651;5541.473560011803;4064.2277967186287;4191.55988621195;4205.137946720914;4272.230998420283;4304.27828868452;4254.574542545752;4282.550332215119;4283.250431174532;4293;4295.63487103595;4255.1064276501975;4259;4270.957290427087;4292.420523229371;4309.052008558112;4044.6562042226446;4211.97894010531;4251.808668609889;4254.319308910591;4294.806733696991;3740.4015357542935;3741.4574886641285;3743.3074881147077;3750.2499500099816;3761.5298087739034;5343.385510666245;5363.934885069238;5378.489043540857;5390.730463476811;5434.619576629638;4548.363229147922;4792.976035119802;4793.856184314476;4845.903081938377;4886.706797592155;5626.352969408529;5635;5729.197912292282;5775.335836378787;5792.986227410229;4113.691473139496;4115.855945041909;4122.793860306972;4131.772752498611;4145.481814773153;5913.852153696149;5938.248216776018;5957.642541447483;5988.670623115727;5996.610220335708;4062.3297155969526;4088.693347998912;4095.3242714952294;4105.753654780723;4114.855980040684;4165.437665915063;4167.97916010418;4171.374293855946;4175.916481670411;4200.936985945214;4678.883027924329;4816.710997340171;4822.638302127354;4853.942016529564;4859.684120532154;5748.31020277561;5752.913706294409;5761.971190144022;5778.422157784272;5778.971105144447;1433.4805106586844;1448.2686243446992;1448.2975756757965;1452.2375752729902;1454.8254209494717;891.3654268812147;936.8594710793435;949.9715008549755;964.5370222293199;987.5753426026733;5502.284702988586;5509.5675124467925;5601.831945041656;5605.887882242332;5614;5842.766289348463;5893;5910.379410161957;5916.437938395846;5940.4653581177035;5343.225232341289;5423.918641220384;5520.91718624221;5558.360788509292;5561.193626924073;3138.9843050785057;3161.1938955566184;3167.2873603439043;3175.3966746318124;3191.69678880506;5840.641631062156;6148;6169.413905678954;6178.845528861724;6187.566870319124;6015.608985415934;6033.4871535919065;6056;6070.666113363807;6107.786227482017;6194.203680932569;6208.782692605737;6209.130721698965;6211.534134939988;6215.378462153749;5641.294838145232;5890.14592884038;5894.675792831264;5926.318473375444;5995.980683283765;5828.417158284137;5881.705914704162;5934.673592952429;5970.701464926649;5982.756466325128;5935.732892019956;6119.969400152971;6183;6233.815575040909;6243.562950593415;4188.099558594917;4193.496780386373;4199.454070970754;4252.766097864647;4262.95737042638;5969.76120955157;6005.159277701213;6022.789202377896;6025.969870150621;6057.606255593549;5625.437456254342;5716.856628674199;5748.827535173951;5762.884742305214;5887.20522729426;5745.597808153389;5762.913556296743;5801.9709901451915;5804.8970695567705;5808.6224395414165;5452.345718513804;5788.27646544182;5807.94192058074;5854.579792256819;5855.824325270249;5767.423257674199;5767.7981270657;5780.566457515787;5801.0124785736225;5854.795082172103;5687.260656114679;5739.971300143473;5749.223854779551;5788.9131663024245;5797 12:48:23 INFO - PROCESS | 29896 | |5;yui.html;689.7551369263912;741.6514238307996;759.8746206875866;814.9837003259931;843.7806170395695;12177.391130443475;12779.488820447183;12787.232766034032;12804.103712740112;12811.551595694153;13078.869211307883;13100.08299419041;13176.60470185896;13196.208227506333;13210.801837972438;770.3836930455641;787.9566623835686;788.8304014636852;791.7862177212149;793.5595744361876;797.143071198461;799.5122974985254;800.0559339978822;800.0998876264202;800.9639566219505;835.0188528479043;836.3100442135262;836.431226765799;837.3343192162246;838.534613289624;832.2052439919893;832.5213002523543;832.6835802395111;834.6285902773268;835.5237514616671;609.856683679335;613.6287546034674;614.5053232148119;615.9907601385983;617.3147805935408;11859.288442693465;11915.344656043913;11924.284542927453;12003.3398163101;12012.039036877117;10610.425342428249;10907.06954398366;10980.286281391764;11107.222494425394;11364.659060228207;10134.847977280348;10232.232582556338;10316.535755891004;10343.948280258626;10430.269881108325;3654.177809992757;3655.3785856404475;3670.5595328560744;3730.1047748540154;3778.0366006668123;66839.3316066838;67246.32753672499;67724;69035.65482172607;69593.30406695919;8913.420627659181;8987.55062246885;9192.448453092837;9201.769955751026;9401.341906066646;17212.741808872877;17213.913930430517;17218.483445496655;17329.133543322783;17382.21780019902;7214.819629509304;7265.747757423918;7316.780496585111;7471.252874712485;7707.768766937001;4223.852165174204;4262.296721041055;4282.250606143913;4288.699791014661;4377.496587892433;3225.177579717204;3322.684344987222;3328.4341661917533;3335.81653009082;3351.798892066484;525.031317219729;536.1983834167866;549.3901769036366;550.3753240072547;557.8242853501134;655.9278479367266;694.7255833945563;705.8200158959432;708.4226355520235;720.2905138438633;8577.742667719978;9117.31620128493;9192.402493837879;9429.811403771886;9454.24366050728;507.56095976979645;572.2589246925241;638.5115386729155;656.9770058048041;658.940695337422;4126.649234815074;4217.325227963511;4325.545817689161;4409.933850992237;4419.712718673276;87614;91226.54386728157;91675.54162229279;92174.53912730393;93127.53436232776;64240.678796606655;78382.6080869592;78905;79213;80904;69647.65176174087;71220;72063.27936720566;72413;74335;7650.426218033558;8091.716789912325;8429.5785210738;8709.554095853811;8784.341174411817;40560.59439405568;43596.78201608972;44820;44918.550814491435;45232.54767452415;61855.38144618496;62584;63020.05469917863;63056.36943630505;63844.36155638384;12587.93706031464;12590.307533085768;12615.747685046064;12619.432125554189;12861.742765144458;13130.606081817561;13316.201027938354;13494;13758.174509529461;14063.156210627396;12401.565945192237;12450.875491244971;12494.43775030144;13363.866361336652;13649.863501365257;12312;12777.616671499869;13160.473581057033;13250.734985300433;13515.20014264065;12064.276143431422;12206.755864882474;12682.239065656091;12871.806922896352;13172.73654526885;10131.240156988402;10210.795784084425;10390.480475976323;10657.20070994663;10890.727731806452;9038.864417033617;9331.58007889633;10227.846582301123;10503.11164429788;10582.470876455993 12:48:23 INFO - PROCESS | 29896 | __end_tp_report 12:48:23 INFO - PROCESS | 29896 | __start_cc_report 12:48:23 INFO - PROCESS | 29896 | _x_x_mozilla_cycle_collect,335 12:48:23 INFO - PROCESS | 29896 | __end_cc_report 12:48:23 INFO - PROCESS | 29896 | __startTimestamp1477597703939__endTimestamp 12:48:23 INFO - PROCESS | 29896 | 12:48:23 INFO - PROCESS | 29896 | ------- Summary: start ------- 12:48:23 INFO - PROCESS | 29896 | Number of tests: 6 12:48:23 INFO - PROCESS | 29896 | 12:48:23 INFO - PROCESS | 29896 | [#0] dojo.html Cycles:165 Average:5382.47 Median:5612.27 stddev:614.27 (10.9%) stddev-sans-first:589.10 12:48:23 INFO - PROCESS | 29896 | Values: 3084.2 3105.4 3129.3 3131.8 3142.8 5297.8 5458.6 5488.0 5506.1 5514.9 5348.0 5437.4 5508.0 5528.6 5606.9 4895.0 4967.5 4970.7 4975.4 5042.7 4852.2 4970.3 5036.2 5042.2 5097.5 4841.7 4882.0 4938.0 4971.0 4993.4 4888.8 4932.4 4947.4 4953.0 5022.5 4871.1 4877.8 4884.7 4892.1 4972.9 5257.5 5372.4 5419.8 5435.5 5437.2 5530.2 5729.7 5774.7 5778.3 5877.2 5815.4 5816.8 5817.4 5822.8 5829.5 5416.2 5442.1 5449.8 5481.8 5490.1 5819.4 5865.0 5886.3 5887.6 5927.2 5640.1 5664.1 5690.7 5698.1 5713.6 5794.6 5808.9 5817.7 5866.3 5877.9 5602.3 5684.9 5692.5 5784.0 5784.3 5753.5 5758.9 5773.8 5775.7 5790.7 4410.9 4427.1 4429.0 4475.4 4475.6 3914.9 3918.2 3920.9 3954.3 3957.1 5510.6 5512.5 5518.6 5553.3 5581.6 5769.5 5827.8 5828.6 5836.4 5845.0 5329.2 5383.1 5444.2 5447.9 5468.4 4819.0 4824.4 4828.8 4830.6 4905.9 5973.9 5995.3 6013.6 6013.7 6018.0 5773.0 5782.3 5839.2 5856.6 5883.5 5975.6 5990.4 6025.3 6034.6 6096.2 5693.2 5705.7 5757.7 5758.9 5774.0 5647.0 5714.5 5719.4 5752.8 5838.8 5640.6 5647.2 5651.8 5661.4 5662.0 5600.7 5634.2 5647.3 5665.2 5688.3 5516.3 5543.1 5606.7 5664.2 5673.3 5686.1 5703.6 5721.7 5736.4 5737.9 5565.8 5612.3 5616.1 5635.9 5649.0 12:48:23 INFO - PROCESS | 29896 | 12:48:23 INFO - PROCESS | 29896 | [#1] ext.html Cycles:180 Average:57683.91 Median:39503.80 stddev:113888.15 (288.3%) stddev-sans-first:114126.94 12:48:23 INFO - PROCESS | 29896 | Values: 580.1 589.1 592.3 602.1 603.9 37988.8 41240.8 41296.4 41345.6 41370.4 41513.4 41849.6 41939.0 41995.8 42099.8 8560.4 8729.9 8737.9 8747.6 8777.6 8652.3 8803.7 8822.0 8823.1 8827.5 8763.8 8782.1 8834.3 8864.8 8886.2 8746.7 8802.7 8851.6 8857.0 8869.1 8579.7 8660.5 8660.7 8665.5 8682.9 39535.6 39569.4 40049.2 40166.0 40409.2 3430.9 3484.5 3563.3 3649.9 4082.0 31134.2 31275.2 31565.0 31690.0 32802.0 4280.5 4460.8 4467.8 4566.7 4583.9 342612.0 343401.0 343607.0 343609.0 343711.0 57551.4 57888.7 57977.7 58096.4 58209.4 60989.1 61528.4 61768.4 61808.4 61936.4 15292.5 15308.0 15325.1 15360.4 15404.6 12972.5 13031.7 13124.1 13142.2 13152.2 18231.7 18323.8 18361.8 18391.7 18700.4 6871.2 6932.3 7045.4 7350.7 7362.7 927.8 1009.2 1062.1 1063.5 1077.6 29532.7 30941.8 31021.8 31265.2 31293.8 1066.0 1114.9 1127.3 1140.0 1180.1 16276.9 16434.1 16443.3 16468.0 16654.4 532645.0 539095.0 540109.0 541216.0 544020.0 54834.0 55480.4 55606.4 55781.7 55935.4 1330.1 1346.2 1375.6 1395.5 1396.2 29520.4 30527.8 31175.8 31459.8 31839.5 47629.8 47838.3 48114.8 48327.8 48377.0 377848.0 378801.0 379646.0 380929.0 381514.0 27079.9 27544.4 27626.2 27741.9 27782.2 41242.4 43468.1 43813.6 45059.3 45968.8 38570.2 39153.0 39339.6 40353.4 40612.4 38593.2 38763.4 38963.4 39472.0 39641.0 33307.0 34521.5 36409.6 38504.0 39220.6 32419.0 34614.5 35533.3 35634.6 35676.0 26664.5 27242.5 27383.2 27543.3 27684.0 12:48:23 INFO - PROCESS | 29896 | 12:48:23 INFO - PROCESS | 29896 | [#2] jquery.html Cycles:180 Average:26219.31 Median:208421.52 stddev:73186.52 (35.1%) stddev-sans-first:73366.09 12:48:23 INFO - PROCESS | 29896 | Values: 368.1 381.2 382.1 389.5 401.5 17204.6 18774.9 18848.2 19078.5 19272.3 16008.7 16175.5 16533.1 16620.8 16624.8 5534.4 5806.3 5806.7 5812.9 5813.4 5378.4 5577.1 5594.2 5608.6 5616.6 5533.3 5544.7 5565.9 5587.3 5589.9 5416.2 5618.2 5651.0 5667.6 5692.3 5004.2 5076.3 5110.1 5110.5 5114.2 20213.2 21172.8 22035.1 22291.4 22526.7 2318.3 2332.8 2420.8 2551.7 2862.3 9765.4 9798.0 9980.4 10298.2 10656.9 1657.4 1670.7 1678.6 1686.6 1721.5 79723.6 80359.6 80975.0 81897.0 82252.6 10669.7 10720.9 10794.6 10907.9 11471.2 14767.7 14822.3 14859.3 14883.6 14929.1 7894.8 8001.5 8173.3 8243.5 8339.2 7699.0 7752.2 7828.7 8110.6 8160.8 4068.2 4367.7 4479.3 4660.3 4794.3 1875.3 1963.6 1971.2 1994.2 2016.1 409.0 916.1 964.3 1053.0 1094.6 10928.6 11185.4 11315.8 11568.2 11628.6 436.7 438.3 440.2 445.9 451.9 5891.2 6099.4 6167.6 6279.8 6371.5 407716.6 416434.0 453521.0 466086.0 467964.0 64569.7 83575.0 83885.6 83918.3 85009.6 433.6 438.6 444.8 447.0 449.0 10955.9 10980.0 10987.7 11043.7 11262.0 35697.3 39250.6 39737.2 39823.6 39933.2 45078.5 53060.0 53859.7 54030.0 54573.5 7954.5 8123.7 8133.6 8140.9 8335.4 10483.7 12262.4 12565.4 12859.2 12950.8 10595.3 10730.6 11353.8 11655.2 11738.6 10596.8 10702.1 10856.0 11035.1 11331.2 10483.9 10532.2 11009.3 11318.8 11707.5 8021.6 8041.5 8058.8 8135.6 8212.8 8347.4 10553.8 10586.8 10735.9 11112.0 12:48:23 INFO - PROCESS | 29896 | 12:48:23 INFO - PROCESS | 29896 | [#3] mootools.html Cycles:180 Average:5264.56 Median:5055.67 stddev:2901.60 (57.4%) stddev-sans-first:2895.84 12:48:23 INFO - PROCESS | 29896 | Values: 1484.5 1498.1 1662.0 1720.2 1738.7 6982.5 7178.4 7704.0 8152.8 8198.0 7686.2 7989.4 8002.2 8071.2 8170.5 2198.4 2238.2 2250.6 2251.5 2253.1 2080.7 2125.7 2162.3 2162.9 2165.6 2053.5 2091.7 2095.7 2108.9 2120.6 1987.0 2003.8 2006.9 2009.4 2009.7 2094.9 2108.0 2140.6 2143.1 2153.8 8123.1 8136.2 8194.0 8199.6 8200.8 4879.5 5004.1 5004.9 5017.4 5037.5 3146.9 3347.4 3352.1 3356.3 3392.4 991.9 1026.7 1030.5 2049.3 2098.6 11060.4 11105.3 11132.7 11194.3 11221.9 4207.4 4227.1 4335.2 4384.2 4406.9 8830.2 8853.5 8873.7 8894.2 8911.2 5047.2 5047.8 5050.8 5051.5 5059.8 4055.2 4216.9 4392.0 4577.3 4680.2 3553.6 3597.0 3647.2 3694.3 3724.6 1122.4 1137.9 1152.2 1163.6 1164.0 796.6 899.0 920.3 932.5 955.9 5327.5 5548.3 5605.3 5667.1 5673.6 937.6 947.8 953.5 958.5 1007.3 3574.7 3755.8 3777.4 3847.8 3851.3 9687.2 9934.6 9971.6 10006.1 10033.2 9878.6 9895.6 9932.8 9933.3 9951.6 6855.7 7070.5 7380.7 7514.2 7524.0 5244.3 5426.7 5479.6 5629.8 5661.1 8576.5 8655.2 8779.0 9120.5 9257.3 9279.6 9284.6 9352.0 9357.6 9381.3 6847.6 7071.9 7158.6 7177.7 7189.2 7004.6 7187.1 7191.9 7225.8 7226.3 6499.4 6643.6 6649.3 6662.2 6790.9 6444.4 6499.0 6535.2 6536.3 6591.4 6230.1 6237.1 6246.0 6301.9 6303.0 4665.3 4669.4 4703.2 4838.9 4908.0 4695.0 4697.2 4698.6 4788.0 4895.9 12:48:23 INFO - PROCESS | 29896 | 12:48:23 INFO - PROCESS | 29896 | [#4] prototype.html Cycles:180 Average:4855.31 Median:5581.51 stddev:1448.78 (26.0%) stddev-sans-first:1412.36 12:48:23 INFO - PROCESS | 29896 | Values: 323.9 330.5 335.2 341.8 344.1 5513.3 5533.3 5561.0 5605.9 5613.5 5443.6 5453.8 5515.2 5515.6 5541.5 4064.2 4191.6 4205.1 4272.2 4304.3 4254.6 4282.6 4283.3 4293.0 4295.6 4255.1 4259.0 4271.0 4292.4 4309.1 4044.7 4212.0 4251.8 4254.3 4294.8 3740.4 3741.5 3743.3 3750.2 3761.5 5343.4 5363.9 5378.5 5390.7 5434.6 4548.4 4793.0 4793.9 4845.9 4886.7 5626.4 5635.0 5729.2 5775.3 5793.0 4113.7 4115.9 4122.8 4131.8 4145.5 5913.9 5938.2 5957.6 5988.7 5996.6 4062.3 4088.7 4095.3 4105.8 4114.9 4165.4 4168.0 4171.4 4175.9 4200.9 4678.9 4816.7 4822.6 4853.9 4859.7 5748.3 5752.9 5762.0 5778.4 5779.0 1433.5 1448.3 1448.3 1452.2 1454.8 891.4 936.9 950.0 964.5 987.6 5502.3 5509.6 5601.8 5605.9 5614.0 5842.8 5893.0 5910.4 5916.4 5940.5 5343.2 5423.9 5520.9 5558.4 5561.2 3139.0 3161.2 3167.3 3175.4 3191.7 5840.6 6148.0 6169.4 6178.8 6187.6 6015.6 6033.5 6056.0 6070.7 6107.8 6194.2 6208.8 6209.1 6211.5 6215.4 5641.3 5890.1 5894.7 5926.3 5996.0 5828.4 5881.7 5934.7 5970.7 5982.8 5935.7 6120.0 6183.0 6233.8 6243.6 4188.1 4193.5 4199.5 4252.8 4263.0 5969.8 6005.2 6022.8 6026.0 6057.6 5625.4 5716.9 5748.8 5762.9 5887.2 5745.6 5762.9 5802.0 5804.9 5808.6 5452.3 5788.3 5807.9 5854.6 5855.8 5767.4 5767.8 5780.6 5801.0 5854.8 5687.3 5740.0 5749.2 5788.9 5797.0 12:48:23 INFO - PROCESS | 29896 | 12:48:23 INFO - PROCESS | 29896 | [#5] yui.html Cycles:180 Average:17547.80 Median:542.79 stddev:24328.83 (4482.1%) stddev-sans-first:24364.14 12:48:23 INFO - PROCESS | 29896 | Values: 689.8 741.7 759.9 815.0 843.8 12177.4 12779.5 12787.2 12804.1 12811.6 13078.9 13100.1 13176.6 13196.2 13210.8 770.4 788.0 788.8 791.8 793.6 797.1 799.5 800.1 800.1 801.0 835.0 836.3 836.4 837.3 838.5 832.2 832.5 832.7 834.6 835.5 609.9 613.6 614.5 616.0 617.3 11859.3 11915.3 11924.3 12003.3 12012.0 10610.4 10907.1 10980.3 11107.2 11364.7 10134.8 10232.2 10316.5 10343.9 10430.3 3654.2 3655.4 3670.6 3730.1 3778.0 66839.3 67246.3 67724.0 69035.7 69593.3 8913.4 8987.6 9192.4 9201.8 9401.3 17212.7 17213.9 17218.5 17329.1 17382.2 7214.8 7265.7 7316.8 7471.3 7707.8 4223.9 4262.3 4282.3 4288.7 4377.5 3225.2 3322.7 3328.4 3335.8 3351.8 525.0 536.2 549.4 550.4 557.8 655.9 694.7 705.8 708.4 720.3 8577.7 9117.3 9192.4 9429.8 9454.2 507.6 572.3 638.5 657.0 658.9 4126.6 4217.3 4325.5 4409.9 4419.7 87614.0 91226.5 91675.5 92174.5 93127.5 64240.7 78382.6 78905.0 79213.0 80904.0 69647.7 71220.0 72063.3 72413.0 74335.0 7650.4 8091.7 8429.6 8709.6 8784.3 40560.6 43596.8 44820.0 44918.6 45232.5 61855.4 62584.0 63020.1 63056.4 63844.4 12587.9 12590.3 12615.7 12619.4 12861.7 13130.6 13316.2 13494.0 13758.2 14063.2 12401.6 12450.9 12494.4 13363.9 13649.9 12312.0 12777.6 13160.5 13250.7 13515.2 12064.3 12206.8 12682.2 12871.8 13172.7 10131.2 10210.8 10390.5 10657.2 10890.7 9038.9 9331.6 10227.8 10503.1 10582.5 12:48:23 INFO - PROCESS | 29896 | -------- Summary: end -------- 12:48:23 INFO - PROCESS | 29896 | 12:48:25 INFO - TEST-INFO | 29896: exit 0 12:48:25 INFO - TEST-OK | dromaeo_css | took 1116389ms 12:48:25 INFO - TEST-START | kraken 12:48:25 INFO - operating with platform_type : linux_ 12:48:25 INFO - Initialising browser for kraken test... 12:48:25 INFO - TEST-INFO | started process 30259 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7Dd1_0/profile http://localhost:48362/getInfo.html) 12:48:29 INFO - PROCESS | 30259 | __metrics Screen width/height:1600/1200 12:48:29 INFO - PROCESS | 30259 | colorDepth:24 12:48:29 INFO - PROCESS | 30259 | Browser inner width/height: 1024/697 12:48:29 INFO - PROCESS | 30259 | __metrics 12:48:29 ERROR - PROCESS | 30259 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3097: TypeError: this.tabs is undefined 12:48:30 INFO - TEST-INFO | 30259: exit 0 12:48:30 INFO - Browser initialized. 12:48:30 INFO - Running cycle 1/1 for kraken test... 12:48:30 INFO - TEST-INFO | started process 30386 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7Dd1_0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:48:42 INFO - PROCESS | 30386 | RSS: Main: 182415360 12:48:42 INFO - PROCESS | 30386 | 12:48:45 INFO - PROCESS | 30386 | Cycle 1(1): loaded http://localhost:48362/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48362/tests/kraken/driver.html?testName=audio-beat-detection) 12:48:46 INFO - PROCESS | 30386 | RSS: Main: 191602688 12:48:46 INFO - PROCESS | 30386 | 12:48:49 INFO - PROCESS | 30386 | Cycle 1(1): loaded http://localhost:48362/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48362/tests/kraken/driver.html?testName=audio-dft) 12:48:49 INFO - PROCESS | 30386 | RSS: Main: 194322432 12:48:49 INFO - PROCESS | 30386 | 12:48:52 INFO - PROCESS | 30386 | Cycle 1(1): loaded http://localhost:48362/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48362/tests/kraken/driver.html?testName=audio-fft) 12:48:53 INFO - PROCESS | 30386 | RSS: Main: 190824448 12:48:53 INFO - PROCESS | 30386 | 12:48:55 INFO - PROCESS | 30386 | Cycle 1(1): loaded http://localhost:48362/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48362/tests/kraken/driver.html?testName=audio-oscillator) 12:48:56 INFO - PROCESS | 30386 | RSS: Main: 191934464 12:48:56 INFO - PROCESS | 30386 | 12:48:58 INFO - PROCESS | 30386 | Cycle 1(1): loaded http://localhost:48362/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48362/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:48:58 INFO - PROCESS | 30386 | RSS: Main: 192311296 12:48:58 INFO - PROCESS | 30386 | 12:49:02 INFO - PROCESS | 30386 | Cycle 1(1): loaded http://localhost:48362/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48362/tests/kraken/driver.html?testName=imaging-darkroom) 12:49:02 INFO - PROCESS | 30386 | RSS: Main: 192458752 12:49:02 INFO - PROCESS | 30386 | 12:49:06 INFO - PROCESS | 30386 | Cycle 1(1): loaded http://localhost:48362/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48362/tests/kraken/driver.html?testName=imaging-desaturate) 12:49:06 INFO - PROCESS | 30386 | RSS: Main: 192720896 12:49:06 INFO - PROCESS | 30386 | 12:49:09 INFO - PROCESS | 30386 | Cycle 1(1): loaded http://localhost:48362/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48362/tests/kraken/driver.html?testName=json-parse-financial) 12:49:10 INFO - PROCESS | 30386 | RSS: Main: 193007616 12:49:10 INFO - PROCESS | 30386 | 12:49:11 INFO - PROCESS | 30386 | Cycle 1(1): loaded http://localhost:48362/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48362/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:49:12 INFO - PROCESS | 30386 | RSS: Main: 192897024 12:49:12 INFO - PROCESS | 30386 | 12:49:14 INFO - PROCESS | 30386 | Cycle 1(1): loaded http://localhost:48362/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48362/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:49:14 INFO - PROCESS | 30386 | RSS: Main: 192593920 12:49:14 INFO - PROCESS | 30386 | 12:49:16 INFO - PROCESS | 30386 | Cycle 1(1): loaded http://localhost:48362/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48362/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:49:17 INFO - PROCESS | 30386 | RSS: Main: 192516096 12:49:17 INFO - PROCESS | 30386 | 12:49:20 INFO - PROCESS | 30386 | Cycle 1(1): loaded http://localhost:48362/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48362/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:49:20 INFO - PROCESS | 30386 | RSS: Main: 193187840 12:49:20 INFO - PROCESS | 30386 | 12:49:23 INFO - PROCESS | 30386 | Cycle 1(1): loaded http://localhost:48362/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48362/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:49:24 INFO - PROCESS | 30386 | RSS: Main: 193073152 12:49:24 INFO - PROCESS | 30386 | 12:49:26 INFO - PROCESS | 30386 | Cycle 1(1): loaded http://localhost:48362/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48362/tests/kraken/driver.html?testName=ai-astar) 12:49:26 INFO - PROCESS | 30386 | RSS: Main: 194473984 12:49:26 INFO - PROCESS | 30386 | 12:49:26 INFO - PROCESS | 30386 | __start_tp_report 12:49:26 INFO - PROCESS | 30386 | _x_x_mozilla_page_load 12:49:26 INFO - PROCESS | 30386 | _x_x_mozilla_page_load_details 12:49:26 INFO - PROCESS | 30386 | |i|pagename|runs| 12:49:26 INFO - PROCESS | 30386 | |0;ai-astar;106;114;113;113;113;113;113;114;116;114 12:49:26 INFO - PROCESS | 30386 | |1;audio-beat-detection;152;129;126;168;125;126;127;130;159;126 12:49:26 INFO - PROCESS | 30386 | |2;audio-dft;164;163;165;168;167;163;165;164;160;162 12:49:26 INFO - PROCESS | 30386 | |3;audio-fft;76;76;76;102;78;77;76;76;108;77 12:49:26 INFO - PROCESS | 30386 | |4;audio-oscillator;84;83;114;84;83;83;107;84;84;115 12:49:26 INFO - PROCESS | 30386 | |5;imaging-gaussian-blur;118;118;118;118;118;117;118;118;117;118 12:49:26 INFO - PROCESS | 30386 | |6;imaging-darkroom;148;148;147;147;147;148;147;147;146;146 12:49:26 INFO - PROCESS | 30386 | |7;imaging-desaturate;85;85;85;85;85;85;86;86;85;86 12:49:26 INFO - PROCESS | 30386 | |8;json-parse-financial;54;55;54;53;54;56;54;54;54;54 12:49:26 INFO - PROCESS | 30386 | |9;json-stringify-tinderbox;62;65;62;61;65;62;63;63;62;62 12:49:26 INFO - PROCESS | 30386 | |10;stanford-crypto-aes;80;80;79;80;83;81;89;87;80;79 12:49:26 INFO - PROCESS | 30386 | |11;stanford-crypto-ccm;141;154;135;134;138;144;145;135;174;136 12:49:26 INFO - PROCESS | 30386 | |12;stanford-crypto-pbkdf2;171;169;171;167;166;169;169;169;173;170 12:49:26 INFO - PROCESS | 30386 | |13;stanford-crypto-sha256-iterative;66;66;74;67;66;67;66;65;66;66 12:49:26 INFO - PROCESS | 30386 | __end_tp_report 12:49:26 INFO - PROCESS | 30386 | __start_cc_report 12:49:26 INFO - PROCESS | 30386 | _x_x_mozilla_cycle_collect,815 12:49:26 INFO - PROCESS | 30386 | __end_cc_report 12:49:26 INFO - PROCESS | 30386 | __startTimestamp1477597766379__endTimestamp 12:49:26 INFO - PROCESS | 30386 | 12:49:26 INFO - PROCESS | 30386 | ------- Summary: start ------- 12:49:26 INFO - PROCESS | 30386 | Number of tests: 14 12:49:26 INFO - PROCESS | 30386 | 12:49:26 INFO - PROCESS | 30386 | [#0] ai-astar Cycles:10 Average:112.90 Median:113.50 stddev:2.60 (2.3%) stddev-sans-first:1.00 12:49:26 INFO - PROCESS | 30386 | Values: 106.0 114.0 113.0 113.0 113.0 113.0 113.0 114.0 116.0 114.0 12:49:26 INFO - PROCESS | 30386 | 12:49:26 INFO - PROCESS | 30386 | [#1] audio-beat-detection Cycles:10 Average:136.80 Median:129.50 stddev:16.29 (12.6%) stddev-sans-first:16.33 12:49:26 INFO - PROCESS | 30386 | Values: 152.0 129.0 126.0 168.0 125.0 126.0 127.0 130.0 159.0 126.0 12:49:26 INFO - PROCESS | 30386 | 12:49:26 INFO - PROCESS | 30386 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.50 stddev:2.33 (1.4%) stddev-sans-first:2.47 12:49:26 INFO - PROCESS | 30386 | Values: 164.0 163.0 165.0 168.0 167.0 163.0 165.0 164.0 160.0 162.0 12:49:26 INFO - PROCESS | 30386 | 12:49:26 INFO - PROCESS | 30386 | [#3] audio-fft Cycles:10 Average:82.20 Median:76.00 stddev:12.12 (15.9%) stddev-sans-first:12.64 12:49:26 INFO - PROCESS | 30386 | Values: 76.0 76.0 76.0 102.0 78.0 77.0 76.0 76.0 108.0 77.0 12:49:26 INFO - PROCESS | 30386 | 12:49:26 INFO - PROCESS | 30386 | [#4] audio-oscillator Cycles:10 Average:92.10 Median:83.50 stddev:13.89 (16.6%) stddev-sans-first:14.42 12:49:26 INFO - PROCESS | 30386 | Values: 84.0 83.0 114.0 84.0 83.0 83.0 107.0 84.0 84.0 115.0 12:49:26 INFO - PROCESS | 30386 | 12:49:26 INFO - PROCESS | 30386 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 12:49:26 INFO - PROCESS | 30386 | Values: 118.0 118.0 118.0 118.0 118.0 117.0 118.0 118.0 117.0 118.0 12:49:26 INFO - PROCESS | 30386 | 12:49:26 INFO - PROCESS | 30386 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 12:49:26 INFO - PROCESS | 30386 | Values: 148.0 148.0 147.0 147.0 147.0 148.0 147.0 147.0 146.0 146.0 12:49:26 INFO - PROCESS | 30386 | 12:49:26 INFO - PROCESS | 30386 | [#7] imaging-desaturate Cycles:10 Average:85.30 Median:85.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 12:49:26 INFO - PROCESS | 30386 | Values: 85.0 85.0 85.0 85.0 85.0 85.0 86.0 86.0 85.0 86.0 12:49:26 INFO - PROCESS | 30386 | 12:49:26 INFO - PROCESS | 30386 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.00 stddev:0.79 (1.5%) stddev-sans-first:0.83 12:49:26 INFO - PROCESS | 30386 | Values: 54.0 55.0 54.0 53.0 54.0 56.0 54.0 54.0 54.0 54.0 12:49:26 INFO - PROCESS | 30386 | 12:49:26 INFO - PROCESS | 30386 | [#9] json-stringify-tinderbox Cycles:10 Average:62.70 Median:62.50 stddev:1.34 (2.1%) stddev-sans-first:1.39 12:49:26 INFO - PROCESS | 30386 | Values: 62.0 65.0 62.0 61.0 65.0 62.0 63.0 63.0 62.0 62.0 12:49:26 INFO - PROCESS | 30386 | 12:49:26 INFO - PROCESS | 30386 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:80.50 stddev:3.49 (4.3%) stddev-sans-first:3.64 12:49:26 INFO - PROCESS | 30386 | Values: 80.0 80.0 79.0 80.0 83.0 81.0 89.0 87.0 80.0 79.0 12:49:26 INFO - PROCESS | 30386 | 12:49:26 INFO - PROCESS | 30386 | [#11] stanford-crypto-ccm Cycles:10 Average:143.60 Median:142.50 stddev:12.34 (8.7%) stddev-sans-first:13.05 12:49:26 INFO - PROCESS | 30386 | Values: 141.0 154.0 135.0 134.0 138.0 144.0 145.0 135.0 174.0 136.0 12:49:26 INFO - PROCESS | 30386 | 12:49:26 INFO - PROCESS | 30386 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.40 Median:169.50 stddev:2.01 (1.2%) stddev-sans-first:2.05 12:49:26 INFO - PROCESS | 30386 | Values: 171.0 169.0 171.0 167.0 166.0 169.0 169.0 169.0 173.0 170.0 12:49:26 INFO - PROCESS | 30386 | 12:49:26 INFO - PROCESS | 30386 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:66.00 stddev:2.56 (3.9%) stddev-sans-first:2.69 12:49:26 INFO - PROCESS | 30386 | Values: 66.0 66.0 74.0 67.0 66.0 67.0 66.0 65.0 66.0 66.0 12:49:26 INFO - PROCESS | 30386 | -------- Summary: end -------- 12:49:26 INFO - PROCESS | 30386 | 12:49:27 INFO - TEST-INFO | 30386: exit 0 12:49:27 INFO - TEST-OK | kraken | took 62541ms 12:49:27 INFO - SUITE-END | took 1178s 12:49:28 INFO - Completed test suite (00:19:39) 12:49:28 INFO - javascript benchmark 12:49:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6893.864299290124, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3084.2289427643086, 3105.394448082625, 3129.342838004019, 3131.8277494737795, 3142.764292678049, 5297.761600727967, 5458.61789674723, 5488.039593071217, 5506.091494903341, 5514.889702205954, 5348.0, 5437.429069947658, 5508.03609368361, 5528.612997090206, 5606.859828504289, 4894.951050489485, 4967.49934703009, 4970.726610036447, 4975.353204083464, 5042.672226305279, 4852.17513022787, 4970.329005584254, 5036.244563315496, 5042.168042273039, 5097.515736005093, 4841.685290456109, 4882.048000639877, 4937.975310123426, 4970.950290497103, 4993.425756038066, 4888.828890988834, 4932.432770231398, 4947.431045429786, 4953.0, 5022.4726403727445, 4871.098846713334, 4877.829275975324, 4884.7069175849565, 4892.143874821892, 4972.900541989176, 5257.526822585985, 5372.435894231127, 5419.83740487786, 5435.483629055233, 5437.157240627709, 5530.170474428827, 5729.6562206267345, 5774.7112644368035, 5778.27771528559, 5877.177195192677, 5815.418458154193, 5816.796412125597, 5817.38917413674, 5822.82531524055, 5829.47534721877, 5416.160495123262, 5442.074847275972, 5449.83650490482, 5481.75332110056, 5490.0941344677685, 5819.418058194231, 5864.973629614886, 5886.264216972879, 5887.587868849225, 5927.229460170237, 5640.125780504029, 5664.065429204135, 5690.7439165237665, 5698.145278208219, 5713.5714821388565, 5794.623349482355, 5808.912866307009, 5817.738201780845, 5866.266716660418, 5877.9118313225335, 5602.299712535933, 5684.914726279109, 5692.48767610917, 5784.0, 5784.334801497797, 5753.539716822645, 5758.88482230353, 5773.769049238067, 5775.653460792366, 5790.739416726257, 4410.933835992462, 4427.114577084596, 4429.025614364899, 4475.440569928759, 4475.552444755498, 3914.921701565953, 3918.216356728609, 3920.9019774505296, 3954.2882281189086, 3957.0700885291935, 5510.641808282448, 5512.503874651301, 5518.641288316247, 5553.250311208016, 5581.609287349846, 5769.509591684669, 5827.825165245049, 5828.59199856006, 5836.387179346192, 5844.970775146097, 5329.173978033411, 5383.084875571162, 5444.156155795858, 5447.945520544744, 5468.398476167618, 4819.0, 4824.372831531879, 4828.830990915301, 4830.637702172351, 4905.877353066202, 5973.850653733692, 5995.250593675791, 6013.579049466583, 6013.729382177812, 6018.0, 5772.971135144466, 5782.277215348082, 5839.211706419749, 5856.560757943256, 5883.499902508163, 5975.55183361241, 5990.430909063632, 6025.337212906489, 6034.577579569388, 6096.207493025879, 5693.202951586864, 5705.657660540215, 5757.740901659352, 5758.942410575841, 5773.9895518284975, 5647.0, 5714.485696287354, 5719.370869204301, 5752.7698892043845, 5838.824835254949, 5640.605157638925, 5647.20939068539, 5651.773929042793, 5661.433856614306, 5661.971690141688, 5600.691961942132, 5634.183043458757, 5647.29408823897, 5665.206871037975, 5688.345840228261, 5516.3380394351325, 5543.113101903676, 5606.719664016864, 5664.235328230801, 5673.262475878109, 5686.118651609007, 5703.62926409782, 5721.7425215866215, 5736.397678243724, 5737.942620573741, 5565.833025009256, 5612.270404847343, 5616.1014237721765, 5635.887282254414, 5649.0], "value": 5340.592140753212, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.1095318685817, 589.0780927847918, 592.3247497852449, 602.0818252165448, 603.8707616756666, 37988.81005594975, 41240.793796031016, 41296.38055429164, 41345.58654413455, 41370.37944430836, 41513.37729934054, 41849.58150418495, 41939.0, 41995.790021049856, 42099.78950105253, 8560.400771945966, 8729.869051964226, 8737.868931965993, 8747.562621868881, 8777.605007774666, 8652.307815374756, 8803.691870784523, 8821.955890220572, 8823.117688231157, 8827.514486703229, 8763.78090547735, 8782.12178782123, 8834.293256539462, 8864.822703545957, 8886.244669203126, 8746.693865714733, 8802.73591792244, 8851.645934162625, 8856.955715221415, 8869.113088691143, 8579.742607721779, 8660.48037117775, 8660.653573857038, 8665.523396213206, 8682.913170868274, 39535.60464395348, 39569.40645890314, 40049.19901601952, 40166.0, 40409.19181616351, 3430.9142271443166, 3484.4599087141532, 3563.2873425315042, 3649.908752281214, 4081.9591804081874, 31134.221644458845, 31275.218119547193, 31565.0, 31690.04929852108, 32802.0, 4280.514099901873, 4460.8438704645505, 4467.821287148543, 4566.680332376735, 4583.931241031387, 342612.0, 343401.0, 343607.0, 343609.0, 343711.0, 57551.42448575461, 57888.71055644779, 57977.71011145002, 58096.4190358091, 58209.41790582125, 60989.08516372258, 61528.384716152264, 61768.4258939865, 61808.38191618026, 61936.380636193964, 15292.541223763305, 15308.0, 15325.080495170325, 15360.385584576716, 15404.61488462775, 12972.545960891324, 13031.674208144872, 13124.081314308098, 13142.211467311801, 13152.21086734799, 18231.72652410215, 18323.816761832477, 18361.81638183601, 18391.72412413815, 18700.438986830417, 6871.1864914971675, 6932.306769323128, 7045.436365090781, 7350.7427240046345, 7362.705491780269, 927.8190752803274, 1009.2077718990557, 1062.0919114157439, 1063.4948399510172, 1077.6012875236213, 29532.704672953427, 30941.845290773403, 31021.844890775403, 31265.218369540944, 31293.8435307822, 1066.0390419493274, 1114.9163812713916, 1127.301073334538, 1139.9544018239178, 1180.0913296761616, 16276.918615407085, 16434.096124713255, 16443.342266309213, 16468.0, 16654.417095401604, 532645.0, 539095.0, 540109.0, 541216.0, 544020.0, 54834.0, 55480.44519554834, 55606.44393556013, 55781.72109139428, 55935.44064559384, 1330.1287656584952, 1346.2393747532612, 1375.6354566040006, 1395.4766962389308, 1396.1762560089596, 29520.409591808475, 30527.757922325505, 31175.817692762197, 31459.842700787267, 31839.522407163447, 47629.761851190524, 47838.28242576295, 48114.759426204044, 48327.75836120937, 48377.0, 377848.0, 378801.0, 379646.0, 380929.0, 381514.0, 27079.864600676872, 27544.449111018068, 27626.171214863585, 27741.861290694225, 27782.166535003984, 41242.38136428016, 43468.13063738644, 43813.56186438095, 45059.32411013903, 45968.770156149, 38570.228595428496, 39153.0, 39339.6231131909, 40353.39469907895, 40612.3908141384, 38593.22813543657, 38763.41854872236, 38963.415548767356, 39472.0, 39641.0, 33307.0, 34521.482177766855, 36409.63590364168, 38504.0, 39220.60779392169, 32419.0, 34614.480782788785, 35533.28933421369, 35634.64365356313, 35676.0, 26664.466710666067, 27242.455150896476, 27383.178504644893, 27543.26499529641, 27684.0], "value": 19553.833352913414, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.14088851300926, 381.15604132325495, 382.11540284241977, 389.4664309895444, 401.5021373496863, 17204.569885752862, 18774.90612546937, 18848.246070157213, 19078.523036924067, 19272.3254686086, 16008.679826403464, 16175.514734557983, 16533.090680012596, 16620.83379166208, 16624.83375166248, 5534.446555344453, 5806.274215723035, 5806.7096645167785, 5812.941870581282, 5813.389594092623, 5378.381486129106, 5577.107662773957, 5594.188842617818, 5608.551315894719, 5616.63491873029, 5533.280673512458, 5544.695041772701, 5565.860853478655, 5587.329520457551, 5589.888202235953, 5416.160495123262, 5618.213450116987, 5650.971745141289, 5667.631603945731, 5692.288463942028, 5004.174311238641, 5076.263941728465, 5110.054639891632, 5110.540051395392, 5114.232865070232, 20213.19147234109, 21172.788272117235, 22035.118595256172, 22291.44271393212, 22526.66210006851, 2318.258157389636, 2332.7667233276707, 2420.7942324902406, 2551.719310875802, 2862.270121119122, 9765.414075155513, 9798.0, 9980.351277166961, 10298.227632927485, 10656.946715266451, 1657.4011277060251, 1670.7385923627705, 1678.5719641491341, 1686.5530634381898, 1721.4835549335148, 79723.6013819933, 80359.5982020092, 80975.0, 81897.0, 82252.58873705594, 10669.73325666849, 10720.946395267974, 10794.568217271379, 10907.945460272647, 11471.197016208785, 14767.704645907022, 14822.332995015035, 14859.2570371481, 14883.553493395215, 14929.10425374481, 7894.763157105296, 8001.519908805491, 8173.264406203471, 8243.546604936786, 8339.166083391734, 7698.960640313598, 7752.186020467882, 7828.686852525949, 8110.553919534483, 8160.795980100426, 4068.16602596467, 4367.733357326403, 4479.328100784843, 4660.254359302496, 4794.256890182028, 1875.3342563390072, 1963.5876465942026, 1971.2312198242696, 1994.2421879685626, 2016.102834238779, 409.040799325581, 916.1067958740175, 964.3442459127721, 1053.0469924718143, 1094.5949998500605, 10928.617498387677, 11185.440727963569, 11315.83026254607, 11568.24806387582, 11628.592999244986, 436.6594056635829, 438.3118503948833, 440.170279024042, 445.9197344478025, 451.884769383805, 5891.175235467038, 6099.3900609938655, 6167.629942203482, 6279.780207692709, 6371.458426033839, 407716.61416929035, 416434.0, 453521.0, 466086.0, 467964.0, 64569.67715161394, 83575.0, 83885.58057209675, 83918.32163356699, 85009.57495212484, 433.62708071058864, 438.58991842627245, 444.8265176581136, 446.9776511174363, 449.0345756623221, 10955.890441095487, 10980.0, 10987.670369888916, 11043.668689939315, 11262.0, 35697.28605427929, 39250.6074939247, 39737.2052558953, 39823.60176398199, 39933.20133597254, 45078.54921450875, 53060.0, 53859.73070134624, 54030.0, 54573.454265456836, 7954.522728636301, 8123.7156699515235, 8133.633986470505, 8140.918590814253, 8335.374846886387, 10483.737906552396, 12262.386880655753, 12565.434555444845, 12859.228446293253, 12950.805737914126, 10595.311304765166, 10730.570777168827, 11353.829692554453, 11655.242409243372, 11738.58914937973, 10596.841047384449, 10702.09032232269, 10856.0, 11035.062019728413, 11331.206815522833, 10483.895161048293, 10532.21008424356, 11009.2843965142, 11318.773624527299, 11707.531698731955, 8021.558814265271, 8041.517508949481, 8058.83882322362, 8135.633896474791, 8212.753617391489, 8347.415680902279, 10553.788924221319, 10586.841197381891, 10735.94025702671, 11112.0], "value": 8067.5780949812715, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1484.5175318021643, 1498.086167437863, 1661.9750703739446, 1720.2344956494358, 1738.7131123364645, 6982.546134501266, 7178.353948144666, 7703.961480192598, 8152.796180095501, 8197.959010204955, 7686.231376862311, 7989.36085113191, 8002.239787220219, 8071.192880711926, 8170.509769413839, 2198.3734635628807, 2238.205437069841, 2250.583642026222, 2251.5271792923504, 2253.0649780341137, 2080.708700781892, 2125.670521069229, 2162.275637661385, 2162.91348346066, 2165.566886622674, 2053.486628342914, 2091.6862470629376, 2095.7485101787806, 2108.8840113793735, 2120.639491286477, 1986.980130198701, 2003.8497112716532, 2006.9297574584966, 2009.3971808457404, 2009.6784514477686, 2094.9476263093393, 2107.9789202107936, 2140.6360918643713, 2143.0998980428258, 2153.7630860605323, 8123.147069557671, 8136.186381361876, 8193.959030204871, 8199.59002049901, 8200.794980125485, 4879.463259041502, 5004.074246264453, 5004.924926126111, 5017.448080711119, 5037.49625037497, 3146.889858854952, 3347.44767113426, 3352.0949343677316, 3356.311956049004, 3392.4063288924585, 991.8908920018793, 1026.6765968719828, 1030.536258683588, 2049.2929939170963, 2098.569793192392, 11060.391678457681, 11105.278156919856, 11132.721681957935, 11194.328340299526, 11221.943890280496, 4207.389928460356, 4227.070044590185, 4335.241332766816, 4384.210842048462, 4406.867793966187, 8830.249428798625, 8853.468791872509, 8873.73378798637, 8894.243989260856, 8911.197992180734, 5047.167217409086, 5047.823326183566, 5050.823221187241, 5051.545360917535, 5059.797608095635, 4055.2359723520362, 4216.873493795191, 4392.0, 4577.3362862384765, 4680.180968330528, 3553.6091029986683, 3596.9640303597153, 3647.1976165243605, 3694.261147770457, 3724.6275372462537, 1122.449999500239, 1137.9146564007733, 1152.222249981276, 1163.5694792926672, 1163.9804938431814, 796.6136423834436, 898.955052247385, 920.2959735802117, 932.5057719408725, 955.9235261179089, 5327.493888080626, 5548.306461692288, 5605.32736071674, 5667.12159615252, 5673.574481913873, 937.5687183895349, 947.7583216279943, 953.50894289441, 958.4872093429982, 1007.2596641468515, 3574.7318951078773, 3755.830987605564, 3777.433384992218, 3847.8460861565222, 3851.345271303829, 9687.17658998993, 9934.602615895283, 9971.601135954626, 10006.09945104944, 10033.247506437046, 9878.604855805832, 9895.554700038516, 9932.80134397308, 9933.304668673123, 9951.601935922627, 6855.725770969205, 7070.505064645528, 7380.741674041383, 7514.211007844207, 7524.0, 5244.292020577326, 5426.728663566885, 5479.6164268500825, 5629.774809007594, 5661.122526008476, 8576.528290944058, 8655.17775811297, 8778.956105219433, 9120.498372589305, 9257.259419246579, 9279.582418791306, 9284.58219380116, 9351.953240233755, 9357.625694972125, 9381.343305968516, 6847.554908931103, 7071.893921591283, 7158.606276654834, 7177.712891484282, 7189.173245076674, 7004.614746189009, 7187.101612298463, 7191.928080719126, 7225.783226503213, 7226.349628533457, 6499.415052645285, 6643.56816806906, 6649.335066493312, 6662.167229096363, 6790.932090679227, 6444.387783160592, 6499.0, 6535.150430444012, 6536.281009088902, 6591.406773390226, 6230.06549017651, 6237.064440333987, 6246.0, 6301.936980630135, 6303.0, 4665.323528088476, 4669.4396672399525, 4703.223968045371, 4838.903221935471, 4908.0, 4695.0375173090115, 4697.154512187839, 4698.553637404441, 4787.976060119677, 4895.902081958269], "value": 4292.642067632233, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.88825855079995, 330.5488008867895, 335.1554083709053, 341.846169223849, 344.10704222542495, 5513.255710479084, 5533.3083364579425, 5560.972195139028, 5605.859853503659, 5613.522850557697, 5443.639090227443, 5453.7818487260565, 5515.172724091388, 5515.61390702651, 5541.473560011803, 4064.2277967186287, 4191.55988621195, 4205.137946720914, 4272.230998420283, 4304.27828868452, 4254.574542545752, 4282.550332215119, 4283.250431174532, 4293.0, 4295.63487103595, 4255.1064276501975, 4259.0, 4270.957290427087, 4292.420523229371, 4309.052008558112, 4044.6562042226446, 4211.97894010531, 4251.808668609889, 4254.319308910591, 4294.806733696991, 3740.4015357542935, 3741.4574886641285, 3743.3074881147077, 3750.2499500099816, 3761.5298087739034, 5343.385510666245, 5363.934885069238, 5378.489043540857, 5390.730463476811, 5434.619576629638, 4548.363229147922, 4792.976035119802, 4793.856184314476, 4845.903081938377, 4886.706797592155, 5626.352969408529, 5635.0, 5729.197912292282, 5775.335836378787, 5792.986227410229, 4113.691473139496, 4115.855945041909, 4122.793860306972, 4131.772752498611, 4145.481814773153, 5913.852153696149, 5938.248216776018, 5957.642541447483, 5988.670623115727, 5996.610220335708, 4062.3297155969526, 4088.693347998912, 4095.3242714952294, 4105.753654780723, 4114.855980040684, 4165.437665915063, 4167.97916010418, 4171.374293855946, 4175.916481670411, 4200.936985945214, 4678.883027924329, 4816.710997340171, 4822.638302127354, 4853.942016529564, 4859.684120532154, 5748.31020277561, 5752.913706294409, 5761.971190144022, 5778.422157784272, 5778.971105144447, 1433.4805106586844, 1448.2686243446992, 1448.2975756757965, 1452.2375752729902, 1454.8254209494717, 891.3654268812147, 936.8594710793435, 949.9715008549755, 964.5370222293199, 987.5753426026733, 5502.284702988586, 5509.5675124467925, 5601.831945041656, 5605.887882242332, 5614.0, 5842.766289348463, 5893.0, 5910.379410161957, 5916.437938395846, 5940.4653581177035, 5343.225232341289, 5423.918641220384, 5520.91718624221, 5558.360788509292, 5561.193626924073, 3138.9843050785057, 3161.1938955566184, 3167.2873603439043, 3175.3966746318124, 3191.69678880506, 5840.641631062156, 6148.0, 6169.413905678954, 6178.845528861724, 6187.566870319124, 6015.608985415934, 6033.4871535919065, 6056.0, 6070.666113363807, 6107.786227482017, 6194.203680932569, 6208.782692605737, 6209.130721698965, 6211.534134939988, 6215.378462153749, 5641.294838145232, 5890.14592884038, 5894.675792831264, 5926.318473375444, 5995.980683283765, 5828.417158284137, 5881.705914704162, 5934.673592952429, 5970.701464926649, 5982.756466325128, 5935.732892019956, 6119.969400152971, 6183.0, 6233.815575040909, 6243.562950593415, 4188.099558594917, 4193.496780386373, 4199.454070970754, 4252.766097864647, 4262.95737042638, 5969.76120955157, 6005.159277701213, 6022.789202377896, 6025.969870150621, 6057.606255593549, 5625.437456254342, 5716.856628674199, 5748.827535173951, 5762.884742305214, 5887.20522729426, 5745.597808153389, 5762.913556296743, 5801.9709901451915, 5804.8970695567705, 5808.6224395414165, 5452.345718513804, 5788.27646544182, 5807.94192058074, 5854.579792256819, 5855.824325270249, 5767.423257674199, 5767.7981270657, 5780.566457515787, 5801.0124785736225, 5854.795082172103, 5687.260656114679, 5739.971300143473, 5749.223854779551, 5788.9131663024245, 5797.0], "value": 4387.9269943402505, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [689.7551369263912, 741.6514238307996, 759.8746206875866, 814.9837003259931, 843.7806170395695, 12177.391130443475, 12779.488820447183, 12787.232766034032, 12804.103712740112, 12811.551595694153, 13078.869211307883, 13100.08299419041, 13176.60470185896, 13196.208227506333, 13210.801837972438, 770.3836930455641, 787.9566623835686, 788.8304014636852, 791.7862177212149, 793.5595744361876, 797.143071198461, 799.5122974985254, 800.0559339978822, 800.0998876264202, 800.9639566219505, 835.0188528479043, 836.3100442135262, 836.431226765799, 837.3343192162246, 838.534613289624, 832.2052439919893, 832.5213002523543, 832.6835802395111, 834.6285902773268, 835.5237514616671, 609.856683679335, 613.6287546034674, 614.5053232148119, 615.9907601385983, 617.3147805935408, 11859.288442693465, 11915.344656043913, 11924.284542927453, 12003.3398163101, 12012.039036877117, 10610.425342428249, 10907.06954398366, 10980.286281391764, 11107.222494425394, 11364.659060228207, 10134.847977280348, 10232.232582556338, 10316.535755891004, 10343.948280258626, 10430.269881108325, 3654.177809992757, 3655.3785856404475, 3670.5595328560744, 3730.1047748540154, 3778.0366006668123, 66839.3316066838, 67246.32753672499, 67724.0, 69035.65482172607, 69593.30406695919, 8913.420627659181, 8987.55062246885, 9192.448453092837, 9201.769955751026, 9401.341906066646, 17212.741808872877, 17213.913930430517, 17218.483445496655, 17329.133543322783, 17382.21780019902, 7214.819629509304, 7265.747757423918, 7316.780496585111, 7471.252874712485, 7707.768766937001, 4223.852165174204, 4262.296721041055, 4282.250606143913, 4288.699791014661, 4377.496587892433, 3225.177579717204, 3322.684344987222, 3328.4341661917533, 3335.81653009082, 3351.798892066484, 525.031317219729, 536.1983834167866, 549.3901769036366, 550.3753240072547, 557.8242853501134, 655.9278479367266, 694.7255833945563, 705.8200158959432, 708.4226355520235, 720.2905138438633, 8577.742667719978, 9117.31620128493, 9192.402493837879, 9429.811403771886, 9454.24366050728, 507.56095976979645, 572.2589246925241, 638.5115386729155, 656.9770058048041, 658.940695337422, 4126.649234815074, 4217.325227963511, 4325.545817689161, 4409.933850992237, 4419.712718673276, 87614.0, 91226.54386728157, 91675.54162229279, 92174.53912730393, 93127.53436232776, 64240.678796606655, 78382.6080869592, 78905.0, 79213.0, 80904.0, 69647.65176174087, 71220.0, 72063.27936720566, 72413.0, 74335.0, 7650.426218033558, 8091.716789912325, 8429.5785210738, 8709.554095853811, 8784.341174411817, 40560.59439405568, 43596.78201608972, 44820.0, 44918.550814491435, 45232.54767452415, 61855.38144618496, 62584.0, 63020.05469917863, 63056.36943630505, 63844.36155638384, 12587.93706031464, 12590.307533085768, 12615.747685046064, 12619.432125554189, 12861.742765144458, 13130.606081817561, 13316.201027938354, 13494.0, 13758.174509529461, 14063.156210627396, 12401.565945192237, 12450.875491244971, 12494.43775030144, 13363.866361336652, 13649.863501365257, 12312.0, 12777.616671499869, 13160.473581057033, 13250.734985300433, 13515.20014264065, 12064.276143431422, 12206.755864882474, 12682.239065656091, 12871.806922896352, 13172.73654526885, 10131.240156988402, 10210.795784084425, 10390.480475976323, 10657.20070994663, 10890.727731806452, 9038.864417033617, 9331.58007889633, 10227.846582301123, 10503.11164429788, 10582.470876455993], "value": 6763.696145636021, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1516.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 114.0, 113.0, 113.0, 113.0, 113.0, 113.0, 114.0, 116.0, 114.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 129.0, 126.0, 168.0, 125.0, 126.0, 127.0, 130.0, 159.0, 126.0], "value": 136.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 165.0, 168.0, 167.0, 163.0, 165.0, 164.0, 160.0, 162.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 102.0, 78.0, 77.0, 76.0, 76.0, 108.0, 77.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 114.0, 84.0, 83.0, 83.0, 107.0, 84.0, 84.0, 115.0], "value": 92.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 146.0, 146.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 86.0, 86.0, 85.0, 86.0], "value": 85.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 54.0, 53.0, 54.0, 56.0, 54.0, 54.0, 54.0, 54.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 62.0, 61.0, 65.0, 62.0, 63.0, 63.0, 62.0, 62.0], "value": 62.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 79.0, 80.0, 83.0, 81.0, 89.0, 87.0, 80.0, 79.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 154.0, 135.0, 134.0, 138.0, 144.0, 145.0, 135.0, 174.0, 136.0], "value": 143.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 169.0, 171.0, 167.0, 166.0, 169.0, 169.0, 169.0, 173.0, 170.0], "value": 169.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 74.0, 67.0, 66.0, 67.0, 66.0, 65.0, 66.0, 66.0], "value": 66.9, "unit": "score"}]}]} 12:49:28 INFO - Return code: 0 12:49:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:49:28 ERROR - # TBPL SUCCESS # 12:49:28 INFO - Running post-action listener: _resource_record_post_action 12:49:28 INFO - [mozharness: 2016-10-27 19:49:28.202122Z] Finished run-tests step (success) 12:49:28 INFO - Running post-run listener: _resource_record_post_run 12:49:28 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 402366464; Read time: 12; Write time: 272960 12:49:28 INFO - TinderboxPrint: CPU usage
13.4% 12:49:28 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 12:49:28 INFO - TinderboxPrint: I/O write bytes / time
402,366,464 / 272,960 12:49:28 INFO - TinderboxPrint: CPU idle
8,260.4 (86.6%) 12:49:28 INFO - TinderboxPrint: CPU user
1,215.6 (12.7%) 12:49:28 INFO - TinderboxPrint: Swap in / out
0 / 0 12:49:28 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 114454528; Read time: 0; Write time: 96544 12:49:28 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 287444992; Read time: 0; Write time: 176372 12:49:28 INFO - Running post-run listener: _upload_blobber_files 12:49:28 INFO - Blob upload gear active. 12:49:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:49:28 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 12:49:28 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'] 12:49:28 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 12:49:29 INFO - (blobuploader) - INFO - Open directory for files ... 12:49:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:49:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:49:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:49:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:49:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:49:33 INFO - (blobuploader) - INFO - Done attempting. 12:49:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:49:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:49:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:49:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:49:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:49:34 INFO - (blobuploader) - INFO - Done attempting. 12:49:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:49:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:49:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:49:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:49:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:49:34 INFO - (blobuploader) - INFO - Done attempting. 12:49:34 INFO - (blobuploader) - INFO - Iteration through files over. 12:49:34 INFO - Return code: 0 12:49:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:49:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:49:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2832c39847b410cad715480853aac67112274d32d034be370c405eeef45de686a9a9b0083171c3d837a281fb69e45bae46eb38e5051d8d8810258df8d69e5f24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/480dbd23ff32170162558afaba3c72366d6ffdc4fa290607059fd0248690f24a34cc5713283f710219b368978628923489741fd6c215d14ffb13b9e896d9f151", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/105e0b0a5989b23761ab33f40c6ea7f10d3e368911d654c98489a0272a0545bb18a5984c5abfa34aeece55a822a395ad5f5083b88ffdc415f57d5543fba93393"} 12:49:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:49:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:49:35 INFO - Contents: 12:49:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2832c39847b410cad715480853aac67112274d32d034be370c405eeef45de686a9a9b0083171c3d837a281fb69e45bae46eb38e5051d8d8810258df8d69e5f24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/480dbd23ff32170162558afaba3c72366d6ffdc4fa290607059fd0248690f24a34cc5713283f710219b368978628923489741fd6c215d14ffb13b9e896d9f151", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/105e0b0a5989b23761ab33f40c6ea7f10d3e368911d654c98489a0272a0545bb18a5984c5abfa34aeece55a822a395ad5f5083b88ffdc415f57d5543fba93393"} 12:49:35 INFO - Running post-run listener: copy_logs_to_upload_dir 12:49:35 INFO - Copying logs to upload dir... 12:49:35 INFO - mkdir: /builds/slave/test/build/upload/logs 12:49:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.257213 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-27 12:49:34.847511) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-27 12:49:34.850916) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1477596536.140013-1788194419 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2832c39847b410cad715480853aac67112274d32d034be370c405eeef45de686a9a9b0083171c3d837a281fb69e45bae46eb38e5051d8d8810258df8d69e5f24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/480dbd23ff32170162558afaba3c72366d6ffdc4fa290607059fd0248690f24a34cc5713283f710219b368978628923489741fd6c215d14ffb13b9e896d9f151", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/105e0b0a5989b23761ab33f40c6ea7f10d3e368911d654c98489a0272a0545bb18a5984c5abfa34aeece55a822a395ad5f5083b88ffdc415f57d5543fba93393"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477585809/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011484 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477585809/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2832c39847b410cad715480853aac67112274d32d034be370c405eeef45de686a9a9b0083171c3d837a281fb69e45bae46eb38e5051d8d8810258df8d69e5f24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/480dbd23ff32170162558afaba3c72366d6ffdc4fa290607059fd0248690f24a34cc5713283f710219b368978628923489741fd6c215d14ffb13b9e896d9f151", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/105e0b0a5989b23761ab33f40c6ea7f10d3e368911d654c98489a0272a0545bb18a5984c5abfa34aeece55a822a395ad5f5083b88ffdc415f57d5543fba93393"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-27 12:49:34.876953) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 12:49:34.877311) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1477596536.140013-1788194419 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004480 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 12:49:34.961888) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-27 12:49:34.962259) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-27 12:49:34.962664) ========= ========= Total master_lag: 0.18 =========