builder: autoland_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-027 starttime: 1475706108.2 results: success (0) buildid: 20161005123041 builduid: c4cee597daee4492a77f36b52d4192bf revision: 8450da83e7bc128faddb9007b79b0a67e62cdf90 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-05 15:21:48.199070) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-05 15:21:48.199531) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-05 15:21:48.200125) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-05 15:21:48.231304) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 15:21:48.231626) ========= 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=1f5564757af27664ca02d71f000001b0-1475703933.833021-41340357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-05 15:21:48-- 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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.9M=0s 2016-10-05 15:21:49 (46.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.130729 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 15:21:48.383474) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 15:21:48.383780) ========= 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=1f5564757af27664ca02d71f000001b0-1475703933.833021-41340357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019046 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 15:21:48.444709) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-05 15:21:48.445044) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 8450da83e7bc128faddb9007b79b0a67e62cdf90 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 8450da83e7bc128faddb9007b79b0a67e62cdf90 --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=1f5564757af27664ca02d71f000001b0-1475703933.833021-41340357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-05 15:21:49,206 truncating revision to first 12 chars 2016-10-05 15:21:49,206 Setting DEBUG logging. 2016-10-05 15:21:49,206 attempt 1/10 2016-10-05 15:21:49,206 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/8450da83e7bc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-05 15:21:50,610 unpacking tar archive at: autoland-8450da83e7bc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.721127 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-05 15:21:50.185681) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-05 15:21:50.185972) ========= script_repo_revision: 8450da83e7bc128faddb9007b79b0a67e62cdf90 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-05 15:21:50.186343) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-05 15:21:50.186606) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-05 15:21:50.196454) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-10-05 15:21:50.196786) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] 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=1f5564757af27664ca02d71f000001b0-1475703933.833021-41340357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:21:51 INFO - MultiFileLogger online at 20161005 15:21:51 in /builds/slave/test 15:21:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 15:21:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:21:51 INFO - {'append_to_log': False, 15:21:51 INFO - 'base_work_dir': '/builds/slave/test', 15:21:51 INFO - 'blob_upload_branch': 'Autoland', 15:21:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:21:51 INFO - 'branch': 'Autoland', 15:21:51 INFO - 'buildbot_json_path': 'buildprops.json', 15:21:51 INFO - 'config_files': ('talos/linux_config.py',), 15:21:51 INFO - 'default_actions': ('clobber', 15:21:51 INFO - 'read-buildbot-config', 15:21:51 INFO - 'download-and-extract', 15:21:51 INFO - 'populate-webroot', 15:21:51 INFO - 'create-virtualenv', 15:21:51 INFO - 'install', 15:21:51 INFO - 'run-tests'), 15:21:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:21:51 INFO - 'download_minidump_stackwalk': True, 15:21:51 INFO - 'download_symbols': 'ondemand', 15:21:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:21:51 INFO - 'tooltool.py': '/tools/tooltool.py', 15:21:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:21:51 INFO - '/tools/misc-python/virtualenv.py')}, 15:21:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:21:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:21:51 INFO - 'installer_path': 'installer.exe', 15:21:51 INFO - 'log_level': 'info', 15:21:51 INFO - 'log_name': 'talos', 15:21:51 INFO - 'log_to_console': True, 15:21:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:21:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:21:51 INFO - 'opt_config_files': (), 15:21:51 INFO - 'pip_index': False, 15:21:51 INFO - 'sps_profile': False, 15:21:51 INFO - 'sps_profile_interval': 0, 15:21:51 INFO - 'suite': 'dromaeojs-e10s', 15:21:51 INFO - 'system_bits': '32', 15:21:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:21:51 INFO - 'title': 'talos-linux64-ix-027', 15:21:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:21:51 INFO - 'use_talos_json': True, 15:21:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:21:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:21:51 INFO - 'work_dir': 'build'} 15:21:51 INFO - [mozharness: 2016-10-05 22:21:51.052147Z] Running clobber step. 15:21:51 INFO - Running pre-action listener: _resource_record_pre_action 15:21:51 INFO - Running main action method: clobber 15:21:51 INFO - rmtree: /builds/slave/test/build 15:21:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:21:52 INFO - Running post-action listener: _resource_record_post_action 15:21:52 INFO - [mozharness: 2016-10-05 22:21:52.042788Z] Finished clobber step (success) 15:21:52 INFO - [mozharness: 2016-10-05 22:21:52.042887Z] Running read-buildbot-config step. 15:21:52 INFO - Running pre-action listener: _resource_record_pre_action 15:21:52 INFO - Running main action method: read_buildbot_config 15:21:52 INFO - Using buildbot properties: 15:21:52 INFO - { 15:21:52 INFO - "project": "", 15:21:52 INFO - "product": "firefox", 15:21:52 INFO - "script_repo_revision": "production", 15:21:52 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 15:21:52 INFO - "repository": "", 15:21:52 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs-e10s", 15:21:52 INFO - "buildid": "20161005123041", 15:21:52 INFO - "pgo_build": "True", 15:21:52 INFO - "basedir": "/builds/slave/test", 15:21:52 INFO - "buildnumber": 285, 15:21:52 INFO - "slavename": "talos-linux64-ix-027", 15:21:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:21:52 INFO - "platform": "ubuntu64_hw", 15:21:52 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 15:21:52 INFO - "branch": "autoland", 15:21:52 INFO - "repo_path": "integration/autoland", 15:21:52 INFO - "revision": "8450da83e7bc128faddb9007b79b0a67e62cdf90", 15:21:52 INFO - "stage_platform": "linux64-pgo", 15:21:52 INFO - "builduid": "c4cee597daee4492a77f36b52d4192bf", 15:21:52 INFO - "slavebuilddir": "test" 15:21:52 INFO - } 15:21:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/Hrysc99USlGEd7SVj3uDpw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 15:21:52 INFO - Running post-action listener: _resource_record_post_action 15:21:52 INFO - [mozharness: 2016-10-05 22:21:52.045294Z] Finished read-buildbot-config step (success) 15:21:52 INFO - [mozharness: 2016-10-05 22:21:52.045381Z] Running download-and-extract step. 15:21:52 INFO - Running pre-action listener: _resource_record_pre_action 15:21:52 INFO - Running main action method: download_and_extract 15:21:52 INFO - mkdir: /builds/slave/test/build/tests 15:21:52 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')]} 15:21:52 INFO - trying https://queue.taskcluster.net/v1/task/Hrysc99USlGEd7SVj3uDpw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:21:52 INFO - Downloading https://queue.taskcluster.net/v1/task/Hrysc99USlGEd7SVj3uDpw/artifacts/public/build/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 15:21:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Hrysc99USlGEd7SVj3uDpw/artifacts/public/build/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 15:21:52 INFO - Downloaded 1361 bytes. 15:21:52 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:21:52 INFO - Using the following test package requirements: 15:21:52 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:21:52 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:21:52 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:21:52 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:21:52 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:21:52 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:21:52 INFO - u'jsshell-linux-x86_64.zip'], 15:21:52 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:21:52 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:21:52 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:21:52 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:21:52 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:21:52 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:21:52 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:21:52 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:21:52 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:21:52 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:21:52 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:21:52 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:21:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Hrysc99USlGEd7SVj3uDpw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:21:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Hrysc99USlGEd7SVj3uDpw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:21:52 INFO - Fetch https://queue.taskcluster.net/v1/task/Hrysc99USlGEd7SVj3uDpw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:21:53 INFO - Http code: 200 15:21:53 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 15:21:53 INFO - x-amz-cf-id: FLyG9l7ZLyXVaCaXnuQTeRK3Eaj7SWAJM7UhPhXMsiYyMBqB_pwYgg== 15:21:53 INFO - x-amz-version-id: ep7PKVAgCzACtm8ma6vcBG51o7qOifss 15:21:53 INFO - Expected file size: 21992666 15:21:53 INFO - Obtained file size: 21992666 15:21:57 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 15:21:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Hrysc99USlGEd7SVj3uDpw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:21:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Hrysc99USlGEd7SVj3uDpw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:21:57 INFO - Fetch https://queue.taskcluster.net/v1/task/Hrysc99USlGEd7SVj3uDpw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:21:58 INFO - Http code: 200 15:21:58 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 15:21:58 INFO - x-amz-cf-id: fl9b8w5bwV1xLXvtJ_-4QoLQcxyl0t3AahbaY8exbssNL6hE0ju1yw== 15:21:58 INFO - x-amz-version-id: ep7PKVAgCzACtm8ma6vcBG51o7qOifss 15:21:58 INFO - Expected file size: 21992666 15:21:58 INFO - Obtained file size: 21992666 15:22:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Hrysc99USlGEd7SVj3uDpw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 15:22:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Hrysc99USlGEd7SVj3uDpw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:22:02 INFO - Fetch https://queue.taskcluster.net/v1/task/Hrysc99USlGEd7SVj3uDpw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 15:22:03 INFO - Http code: 200 15:22:03 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 15:22:03 INFO - x-amz-cf-id: HYiYZCG53D560HplmeWNlhBTszj0REteGNovZ6QZh_3qaPh3w5Dc9w== 15:22:03 INFO - x-amz-version-id: CqI0OsPj7RIOXDRz.mJts91eTU88TiiV 15:22:03 INFO - Expected file size: 14409006 15:22:03 INFO - Obtained file size: 14409006 15:22:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:04 INFO - trying https://queue.taskcluster.net/v1/task/Hrysc99USlGEd7SVj3uDpw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:22:04 INFO - Downloading https://queue.taskcluster.net/v1/task/Hrysc99USlGEd7SVj3uDpw/artifacts/public/build/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 15:22:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Hrysc99USlGEd7SVj3uDpw/artifacts/public/build/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 15:22:05 INFO - Downloaded 59706723 bytes. 15:22:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Hrysc99USlGEd7SVj3uDpw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:22:05 INFO - mkdir: /builds/slave/test/properties 15:22:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:22:05 INFO - Writing to file /builds/slave/test/properties/build_url 15:22:05 INFO - Contents: 15:22:05 INFO - build_url:https://queue.taskcluster.net/v1/task/Hrysc99USlGEd7SVj3uDpw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:22:05 INFO - Running post-action listener: _resource_record_post_action 15:22:05 INFO - Running post-action listener: set_extra_try_arguments 15:22:05 INFO - [mozharness: 2016-10-05 22:22:05.851024Z] Finished download-and-extract step (success) 15:22:05 INFO - [mozharness: 2016-10-05 22:22:05.851250Z] Running populate-webroot step. 15:22:05 INFO - Running pre-action listener: _resource_record_pre_action 15:22:05 INFO - Running main action method: populate_webroot 15:22:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:22:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:22:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:22:05 INFO - '--tppagecycles', 15:22:05 INFO - '7'], 15:22:05 INFO - 'tests': ['tsvgm']}}, 15:22:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:22:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:22:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:22:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:22:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:22:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:22:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:05 INFO - 'talos_options': ['--disable-e10s'], 15:22:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:22:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:22:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:05 INFO - 'talos_options': ['--disable-e10s'], 15:22:05 INFO - 'tests': ['damp', 'tps']}, 15:22:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:05 INFO - 'tests': ['damp', 'tps']}, 15:22:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:22:05 INFO - 'tests': ['dromaeo_dom']}, 15:22:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:22:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:22:05 INFO - 'tests': ['basic_compositor_video']}, 15:22:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:22:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:22:05 INFO - 'tests': ['a11yr', 15:22:05 INFO - 'ts_paint', 15:22:05 INFO - 'tpaint', 15:22:05 INFO - 'sessionrestore', 15:22:05 INFO - 'sessionrestore_no_auto_restore', 15:22:05 INFO - 'tabpaint']}, 15:22:05 INFO - 'other-e10s': {'tests': ['a11yr', 15:22:05 INFO - 'ts_paint', 15:22:05 INFO - 'tpaint', 15:22:05 INFO - 'sessionrestore', 15:22:05 INFO - 'sessionrestore_no_auto_restore', 15:22:05 INFO - 'tabpaint']}, 15:22:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:22:05 INFO - 'ts_paint', 15:22:05 INFO - 'tpaint', 15:22:05 INFO - 'sessionrestore', 15:22:05 INFO - 'sessionrestore_no_auto_restore', 15:22:05 INFO - 'tabpaint']}, 15:22:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:22:05 INFO - 'ts_paint', 15:22:05 INFO - 'tpaint', 15:22:05 INFO - 'sessionrestore', 15:22:05 INFO - 'sessionrestore_no_auto_restore', 15:22:05 INFO - 'tabpaint']}, 15:22:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:22:05 INFO - 'tests': ['a11yr', 15:22:05 INFO - 'ts_paint', 15:22:05 INFO - 'tpaint', 15:22:05 INFO - 'sessionrestore', 15:22:05 INFO - 'sessionrestore_no_auto_restore', 15:22:05 INFO - 'tabpaint']}, 15:22:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:22:05 INFO - 'tests': ['a11yr', 15:22:05 INFO - 'ts_paint', 15:22:05 INFO - 'tpaint', 15:22:05 INFO - 'sessionrestore', 15:22:05 INFO - 'sessionrestore_no_auto_restore', 15:22:05 INFO - 'tabpaint']}, 15:22:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:22:05 INFO - 'tests': ['tsvgx', 15:22:05 INFO - 'tsvgr_opacity', 15:22:05 INFO - 'tart', 15:22:05 INFO - 'tscrollx', 15:22:05 INFO - 'cart']}, 15:22:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:22:05 INFO - 'tsvgr_opacity', 15:22:05 INFO - 'tart', 15:22:05 INFO - 'tscrollx', 15:22:05 INFO - 'cart']}, 15:22:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:05 INFO - 'talos_options': ['--disable-e10s'], 15:22:05 INFO - 'tests': ['tp5o']}, 15:22:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:05 INFO - 'tests': ['tp5o']}, 15:22:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:05 INFO - 'talos_options': ['--disable-e10s', 15:22:05 INFO - '--xperf_path', 15:22:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:22:05 INFO - 'tests': ['tp5n']}, 15:22:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:05 INFO - 'talos_options': ['--xperf_path', 15:22:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:22:05 INFO - 'tests': ['tp5n']}}, 15:22:05 INFO - 'talos.zip': {'path': '', 15:22:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:22:05 INFO - Running post-action listener: _resource_record_post_action 15:22:05 INFO - [mozharness: 2016-10-05 22:22:05.873585Z] Finished populate-webroot step (success) 15:22:05 INFO - [mozharness: 2016-10-05 22:22:05.873678Z] Running create-virtualenv step. 15:22:05 INFO - Running pre-action listener: _resource_record_pre_action 15:22:05 INFO - Running main action method: create_virtualenv 15:22:05 INFO - Creating virtualenv /builds/slave/test/build/venv 15:22:05 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 15:22:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:22:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:22:05 INFO - Using real prefix '/usr' 15:22:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:22:06 INFO - Installing distribute.............................................................................................................................................................................................done. 15:22:08 INFO - Installing pip.................done. 15:22:08 INFO - Return code: 0 15:22:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:22:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:22:08 INFO - Reading from file tmpfile_stdout 15:22:08 INFO - Output received: 15:22:08 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) 15:22:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:22: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')]} 15:22:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22: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')]} 15:22:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:08 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 0x7f70c318df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f37b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1482790>, '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 0x1483690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1483b20>, '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': '1f5564757af27664ca02d71f000001b0-1475703933.833021-41340357', '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 15:22:08 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 15:22:08 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 15:22:08 INFO - Using env: {'DISPLAY': ':0', 15:22:08 INFO - 'HOME': '/home/cltbld', 15:22:08 INFO - 'LANG': 'en_US.UTF-8', 15:22:08 INFO - 'LANGUAGE': 'en_US:en', 15:22:08 INFO - 'LOGNAME': 'cltbld', 15:22:08 INFO - 'MAIL': '/var/mail/cltbld', 15:22:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:08 INFO - 'MOZ_NO_REMOTE': '1', 15:22:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:08 INFO - 'NO_EM_RESTART': '1', 15:22:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:08 INFO - 'PWD': '/builds/slave/test', 15:22:08 INFO - 'SHELL': '/bin/bash', 15:22:08 INFO - 'SHLVL': '1', 15:22:08 INFO - 'TERM': 'linux', 15:22:08 INFO - 'TMOUT': '86400', 15:22:08 INFO - 'USER': 'cltbld', 15:22:08 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475703933.833021-41340357', 15:22:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:08 INFO - '_': '/tools/buildbot/bin/python'} 15:22:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:08 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 15:22:08 INFO - Cleaning up... 15:22:08 INFO - Return code: 0 15:22:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:22: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')]} 15:22:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22: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')]} 15:22:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:08 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 0x7f70c318df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f37b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1482790>, '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 0x1483690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1483b20>, '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': '1f5564757af27664ca02d71f000001b0-1475703933.833021-41340357', '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 15:22:08 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 15:22:08 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 15:22:08 INFO - Using env: {'DISPLAY': ':0', 15:22:08 INFO - 'HOME': '/home/cltbld', 15:22:08 INFO - 'LANG': 'en_US.UTF-8', 15:22:08 INFO - 'LANGUAGE': 'en_US:en', 15:22:08 INFO - 'LOGNAME': 'cltbld', 15:22:08 INFO - 'MAIL': '/var/mail/cltbld', 15:22:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:08 INFO - 'MOZ_NO_REMOTE': '1', 15:22:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:08 INFO - 'NO_EM_RESTART': '1', 15:22:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:08 INFO - 'PWD': '/builds/slave/test', 15:22:08 INFO - 'SHELL': '/bin/bash', 15:22:08 INFO - 'SHLVL': '1', 15:22:08 INFO - 'TERM': 'linux', 15:22:08 INFO - 'TMOUT': '86400', 15:22:08 INFO - 'USER': 'cltbld', 15:22:08 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475703933.833021-41340357', 15:22:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:08 INFO - '_': '/tools/buildbot/bin/python'} 15:22:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:09 INFO - Downloading/unpacking psutil>=3.1.1 15:22:09 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 15:22:09 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 15:22:09 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 15:22:09 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 15:22:09 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 15:22:09 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 15:22:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:22:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:22:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:22:11 INFO - Installing collected packages: psutil 15:22:11 INFO - Running setup.py install for psutil 15:22:11 INFO - building 'psutil._psutil_linux' extension 15:22:11 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 15:22:11 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 15:22:11 INFO - building 'psutil._psutil_posix' extension 15:22:11 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 15:22:11 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 15:22:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:22:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:22:11 INFO - Successfully installed psutil 15:22:11 INFO - Cleaning up... 15:22:11 INFO - Return code: 0 15:22:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:22: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')]} 15:22:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22: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')]} 15:22:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f70c318df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f37b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1482790>, '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 0x1483690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1483b20>, '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': '1f5564757af27664ca02d71f000001b0-1475703933.833021-41340357', '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 15:22: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:22: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 mozsystemmonitor==0.3 15:22:11 INFO - Using env: {'DISPLAY': ':0', 15:22:11 INFO - 'HOME': '/home/cltbld', 15:22:11 INFO - 'LANG': 'en_US.UTF-8', 15:22:11 INFO - 'LANGUAGE': 'en_US:en', 15:22:11 INFO - 'LOGNAME': 'cltbld', 15:22:11 INFO - 'MAIL': '/var/mail/cltbld', 15:22:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:11 INFO - 'MOZ_NO_REMOTE': '1', 15:22:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:11 INFO - 'NO_EM_RESTART': '1', 15:22:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:11 INFO - 'PWD': '/builds/slave/test', 15:22:11 INFO - 'SHELL': '/bin/bash', 15:22:11 INFO - 'SHLVL': '1', 15:22:11 INFO - 'TERM': 'linux', 15:22:11 INFO - 'TMOUT': '86400', 15:22:11 INFO - 'USER': 'cltbld', 15:22:11 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475703933.833021-41340357', 15:22:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:11 INFO - '_': '/tools/buildbot/bin/python'} 15:22:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:22:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:22:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:22:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:22:13 INFO - Installing collected packages: mozsystemmonitor 15:22:13 INFO - Running setup.py install for mozsystemmonitor 15:22:13 INFO - Successfully installed mozsystemmonitor 15:22:13 INFO - Cleaning up... 15:22:13 INFO - Return code: 0 15:22:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:22:13 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')]} 15:22:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:13 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')]} 15:22:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:13 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 0x7f70c318df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f37b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1482790>, '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 0x1483690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1483b20>, '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': '1f5564757af27664ca02d71f000001b0-1475703933.833021-41340357', '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 15:22:13 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 15:22:13 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 15:22:13 INFO - Using env: {'DISPLAY': ':0', 15:22:13 INFO - 'HOME': '/home/cltbld', 15:22:13 INFO - 'LANG': 'en_US.UTF-8', 15:22:13 INFO - 'LANGUAGE': 'en_US:en', 15:22:13 INFO - 'LOGNAME': 'cltbld', 15:22:13 INFO - 'MAIL': '/var/mail/cltbld', 15:22:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:13 INFO - 'MOZ_NO_REMOTE': '1', 15:22:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:13 INFO - 'NO_EM_RESTART': '1', 15:22:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:13 INFO - 'PWD': '/builds/slave/test', 15:22:13 INFO - 'SHELL': '/bin/bash', 15:22:13 INFO - 'SHLVL': '1', 15:22:13 INFO - 'TERM': 'linux', 15:22:13 INFO - 'TMOUT': '86400', 15:22:13 INFO - 'USER': 'cltbld', 15:22:13 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475703933.833021-41340357', 15:22:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:13 INFO - '_': '/tools/buildbot/bin/python'} 15:22:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:14 INFO - Downloading/unpacking jsonschema==2.5.1 15:22:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:22:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:22:16 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 15:22:16 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 15:22:16 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 15:22:16 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 15:22:16 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 15:22:16 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 15:22:16 INFO - Downloading functools32-3.2.3-2.tar.gz 15:22:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:22:16 INFO - warning: no files found matching '*.txt' 15:22:16 INFO - no previously-included directories found matching 'build' 15:22:16 INFO - no previously-included directories found matching 'dist' 15:22:16 INFO - no previously-included directories found matching '.git*' 15:22:16 INFO - Installing collected packages: jsonschema, functools32 15:22:16 INFO - Running setup.py install for functools32 15:22:16 INFO - warning: no files found matching '*.txt' 15:22:16 INFO - no previously-included directories found matching 'build' 15:22:16 INFO - no previously-included directories found matching 'dist' 15:22:16 INFO - no previously-included directories found matching '.git*' 15:22:16 INFO - Successfully installed jsonschema functools32 15:22:16 INFO - Cleaning up... 15:22:16 INFO - Return code: 0 15:22:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:22:16 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')]} 15:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:16 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')]} 15:22:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:16 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 0x7f70c318df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f37b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1482790>, '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 0x1483690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1483b20>, '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': '1f5564757af27664ca02d71f000001b0-1475703933.833021-41340357', '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 15:22:16 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 15:22:16 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 15:22:16 INFO - Using env: {'DISPLAY': ':0', 15:22:16 INFO - 'HOME': '/home/cltbld', 15:22:16 INFO - 'LANG': 'en_US.UTF-8', 15:22:16 INFO - 'LANGUAGE': 'en_US:en', 15:22:16 INFO - 'LOGNAME': 'cltbld', 15:22:16 INFO - 'MAIL': '/var/mail/cltbld', 15:22:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:16 INFO - 'MOZ_NO_REMOTE': '1', 15:22:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:16 INFO - 'NO_EM_RESTART': '1', 15:22:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:16 INFO - 'PWD': '/builds/slave/test', 15:22:16 INFO - 'SHELL': '/bin/bash', 15:22:16 INFO - 'SHLVL': '1', 15:22:16 INFO - 'TERM': 'linux', 15:22:16 INFO - 'TMOUT': '86400', 15:22:16 INFO - 'USER': 'cltbld', 15:22:16 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475703933.833021-41340357', 15:22:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:16 INFO - '_': '/tools/buildbot/bin/python'} 15:22:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:22:16 INFO - Cleaning up... 15:22:16 INFO - Return code: 0 15:22:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:22:16 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')]} 15:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:16 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')]} 15:22:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:16 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 0x7f70c318df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f37b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1482790>, '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 0x1483690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1483b20>, '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': '1f5564757af27664ca02d71f000001b0-1475703933.833021-41340357', '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 15:22:16 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 15:22:16 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 15:22:16 INFO - Using env: {'DISPLAY': ':0', 15:22:16 INFO - 'HOME': '/home/cltbld', 15:22:16 INFO - 'LANG': 'en_US.UTF-8', 15:22:16 INFO - 'LANGUAGE': 'en_US:en', 15:22:16 INFO - 'LOGNAME': 'cltbld', 15:22:16 INFO - 'MAIL': '/var/mail/cltbld', 15:22:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:16 INFO - 'MOZ_NO_REMOTE': '1', 15:22:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:16 INFO - 'NO_EM_RESTART': '1', 15:22:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:16 INFO - 'PWD': '/builds/slave/test', 15:22:16 INFO - 'SHELL': '/bin/bash', 15:22:16 INFO - 'SHLVL': '1', 15:22:16 INFO - 'TERM': 'linux', 15:22:16 INFO - 'TMOUT': '86400', 15:22:16 INFO - 'USER': 'cltbld', 15:22:16 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475703933.833021-41340357', 15:22:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:16 INFO - '_': '/tools/buildbot/bin/python'} 15:22:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:16 INFO - Downloading/unpacking blobuploader==1.2.4 15:22:16 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 15:22:16 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 15:22:16 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 15:22:16 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 15:22:16 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 15:22:16 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 15:22:18 INFO - Downloading blobuploader-1.2.4.tar.gz 15:22:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:22:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:22: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 15:22: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 15:22: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 15:22: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 15:22: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 15:22: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 15:22:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:22:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:22: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 15:22: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 15:22: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 15:22: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 15:22: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 15:22: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 15:22:19 INFO - Downloading docopt-0.6.1.tar.gz 15:22:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:22:19 INFO - Installing collected packages: blobuploader, requests, docopt 15:22:19 INFO - Running setup.py install for blobuploader 15:22:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:22:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:22:19 INFO - Running setup.py install for requests 15:22:20 INFO - Running setup.py install for docopt 15:22:20 INFO - Successfully installed blobuploader requests docopt 15:22:20 INFO - Cleaning up... 15:22:20 INFO - Return code: 0 15:22:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:22: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')]} 15:22:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22: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')]} 15:22:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:20 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 0x7f70c318df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f37b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1482790>, '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 0x1483690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1483b20>, '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': '1f5564757af27664ca02d71f000001b0-1475703933.833021-41340357', '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 15:22:20 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 15:22:20 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 15:22:20 INFO - Using env: {'DISPLAY': ':0', 15:22:20 INFO - 'HOME': '/home/cltbld', 15:22:20 INFO - 'LANG': 'en_US.UTF-8', 15:22:20 INFO - 'LANGUAGE': 'en_US:en', 15:22:20 INFO - 'LOGNAME': 'cltbld', 15:22:20 INFO - 'MAIL': '/var/mail/cltbld', 15:22:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:20 INFO - 'MOZ_NO_REMOTE': '1', 15:22:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:20 INFO - 'NO_EM_RESTART': '1', 15:22:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:20 INFO - 'PWD': '/builds/slave/test', 15:22:20 INFO - 'SHELL': '/bin/bash', 15:22:20 INFO - 'SHLVL': '1', 15:22:20 INFO - 'TERM': 'linux', 15:22:20 INFO - 'TMOUT': '86400', 15:22:20 INFO - 'USER': 'cltbld', 15:22:20 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475703933.833021-41340357', 15:22:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:20 INFO - '_': '/tools/buildbot/bin/python'} 15:22:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:22:20 INFO - Running setup.py (path:/tmp/pip-bJr05i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:22:20 INFO - Running setup.py (path:/tmp/pip-cxjUDk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:22:20 INFO - Running setup.py (path:/tmp/pip-_WO_Ky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:22:20 INFO - Running setup.py (path:/tmp/pip-PAde9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:22:20 INFO - Running setup.py (path:/tmp/pip-LDhzDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:22:21 INFO - Running setup.py (path:/tmp/pip-F4MOud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:22:21 INFO - Running setup.py (path:/tmp/pip-BTT8rN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:22:21 INFO - Running setup.py (path:/tmp/pip-Fih1kz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:22:21 INFO - Running setup.py (path:/tmp/pip-y9eRhz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:22:21 INFO - Running setup.py (path:/tmp/pip-KNq2q3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:22:21 INFO - Running setup.py (path:/tmp/pip-PygAdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:22:21 INFO - Running setup.py (path:/tmp/pip-WI34HV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:22:21 INFO - Running setup.py (path:/tmp/pip-oKRcTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:22:21 INFO - Running setup.py (path:/tmp/pip-0AqzOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:22:21 INFO - Running setup.py (path:/tmp/pip-BalcEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:22:21 INFO - Running setup.py (path:/tmp/pip-tQ5O1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:22:21 INFO - Running setup.py (path:/tmp/pip-uatLSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:22:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:22:21 INFO - Running setup.py install for manifestparser 15:22:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:22:22 INFO - Running setup.py install for mozcrash 15:22:22 INFO - Running setup.py install for mozdebug 15:22:22 INFO - Running setup.py install for mozdevice 15:22:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:22:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:22:22 INFO - Running setup.py install for mozfile 15:22:22 INFO - Running setup.py install for mozhttpd 15:22:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:22:22 INFO - Running setup.py install for mozinfo 15:22:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:22:22 INFO - Running setup.py install for mozInstall 15:22:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:22:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:22:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:22:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:22:22 INFO - Running setup.py install for mozleak 15:22:22 INFO - Running setup.py install for mozlog 15:22:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:22:22 INFO - Running setup.py install for moznetwork 15:22:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:22:23 INFO - Running setup.py install for mozprocess 15:22:23 INFO - Running setup.py install for mozprofile 15:22:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:22:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:22:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:22:23 INFO - Running setup.py install for mozrunner 15:22:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:22:23 INFO - Running setup.py install for mozscreenshot 15:22:23 INFO - Running setup.py install for moztest 15:22:23 INFO - Running setup.py install for mozversion 15:22:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:22:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:22:23 INFO - Cleaning up... 15:22:23 INFO - Return code: 0 15:22:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:22: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')]} 15:22:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22: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')]} 15:22:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:23 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 0x7f70c318df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f37b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1482790>, '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 0x1483690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1483b20>, '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': '1f5564757af27664ca02d71f000001b0-1475703933.833021-41340357', '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 15:22:23 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 15:22:23 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 15:22:23 INFO - Using env: {'DISPLAY': ':0', 15:22:23 INFO - 'HOME': '/home/cltbld', 15:22:23 INFO - 'LANG': 'en_US.UTF-8', 15:22:23 INFO - 'LANGUAGE': 'en_US:en', 15:22:23 INFO - 'LOGNAME': 'cltbld', 15:22:23 INFO - 'MAIL': '/var/mail/cltbld', 15:22:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:23 INFO - 'MOZ_NO_REMOTE': '1', 15:22:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:23 INFO - 'NO_EM_RESTART': '1', 15:22:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:23 INFO - 'PWD': '/builds/slave/test', 15:22:23 INFO - 'SHELL': '/bin/bash', 15:22:23 INFO - 'SHLVL': '1', 15:22:23 INFO - 'TERM': 'linux', 15:22:23 INFO - 'TMOUT': '86400', 15:22:23 INFO - 'USER': 'cltbld', 15:22:23 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475703933.833021-41340357', 15:22:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:23 INFO - '_': '/tools/buildbot/bin/python'} 15:22:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:22:24 INFO - Running setup.py (path:/tmp/pip-mGH2Cp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:22:24 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)) 15:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:22:24 INFO - Running setup.py (path:/tmp/pip-csb0NF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:22:24 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)) 15:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:22:24 INFO - Running setup.py (path:/tmp/pip-GHg7qk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:22:24 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)) 15:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:22:24 INFO - Running setup.py (path:/tmp/pip-J1pzk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:22:24 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)) 15:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:22:24 INFO - Running setup.py (path:/tmp/pip-hY056Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:22:24 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)) 15:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:22:24 INFO - Running setup.py (path:/tmp/pip-t9oUNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:22:24 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)) 15:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:22:24 INFO - Running setup.py (path:/tmp/pip-yv589L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:22:24 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)) 15:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:22:24 INFO - Running setup.py (path:/tmp/pip-OnPp9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:22:24 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)) 15:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:22:24 INFO - Running setup.py (path:/tmp/pip-Utjlhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:22:24 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)) 15:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:22:24 INFO - Running setup.py (path:/tmp/pip-TVzgIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:22:24 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)) 15:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:22:24 INFO - Running setup.py (path:/tmp/pip-BzZhX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:22:24 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)) 15:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:22:24 INFO - Running setup.py (path:/tmp/pip-nuDzgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:22:24 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)) 15:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:22:24 INFO - Running setup.py (path:/tmp/pip-r5kZPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:22:24 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)) 15:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:22:24 INFO - Running setup.py (path:/tmp/pip-mZNvPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:22:24 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)) 15:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:22:24 INFO - Running setup.py (path:/tmp/pip-rpVTp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:22:25 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)) 15:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:22:25 INFO - Running setup.py (path:/tmp/pip-YZyADO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:22:25 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)) 15:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:22:25 INFO - Running setup.py (path:/tmp/pip-UXrvT2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:22:25 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)) 15:22:25 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)) 15:22:25 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)) 15:22:25 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)) 15:22:25 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)) 15:22:25 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)) 15:22:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:22:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:27 INFO - Downloading blessings-1.6.tar.gz 15:22:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:22:27 INFO - Installing collected packages: blessings 15:22:27 INFO - Running setup.py install for blessings 15:22:27 INFO - Successfully installed blessings 15:22:27 INFO - Cleaning up... 15:22:27 INFO - Return code: 0 15:22:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:22:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:22:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:22:27 INFO - Reading from file tmpfile_stdout 15:22:27 INFO - Current package versions: 15:22:27 INFO - argparse == 1.2.1 15:22:27 INFO - blessings == 1.6 15:22:27 INFO - blobuploader == 1.2.4 15:22:27 INFO - docopt == 0.6.1 15:22:27 INFO - functools32 == 3.2.3-2 15:22:27 INFO - jsonschema == 2.5.1 15:22:27 INFO - manifestparser == 1.1 15:22:27 INFO - mozInstall == 1.12 15:22:27 INFO - mozcrash == 0.17 15:22:27 INFO - mozdebug == 0.1 15:22:27 INFO - mozdevice == 0.48 15:22:27 INFO - mozfile == 1.2 15:22:27 INFO - mozhttpd == 0.7 15:22:27 INFO - mozinfo == 0.9 15:22:27 INFO - mozleak == 0.1 15:22:27 INFO - mozlog == 3.4 15:22:27 INFO - moznetwork == 0.27 15:22:27 INFO - mozprocess == 0.23 15:22:27 INFO - mozprofile == 0.28 15:22:27 INFO - mozrunner == 6.12 15:22:27 INFO - mozscreenshot == 0.1 15:22:27 INFO - mozsystemmonitor == 0.3 15:22:27 INFO - moztest == 0.7 15:22:27 INFO - mozversion == 1.4 15:22:27 INFO - psutil == 3.1.1 15:22:27 INFO - requests == 1.2.3 15:22:27 INFO - wsgiref == 0.1.2 15:22:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:22:27 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')]} 15:22:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:27 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')]} 15:22:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:27 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 0x7f70c318df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f37b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1482790>, '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 0x1483690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1483b20>, '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': '1f5564757af27664ca02d71f000001b0-1475703933.833021-41340357', '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 15:22:27 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 15:22:27 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 15:22:27 INFO - Using env: {'DISPLAY': ':0', 15:22:27 INFO - 'HOME': '/home/cltbld', 15:22:27 INFO - 'LANG': 'en_US.UTF-8', 15:22:27 INFO - 'LANGUAGE': 'en_US:en', 15:22:27 INFO - 'LOGNAME': 'cltbld', 15:22:27 INFO - 'MAIL': '/var/mail/cltbld', 15:22:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:27 INFO - 'MOZ_NO_REMOTE': '1', 15:22:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:27 INFO - 'NO_EM_RESTART': '1', 15:22:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:27 INFO - 'PWD': '/builds/slave/test', 15:22:27 INFO - 'SHELL': '/bin/bash', 15:22:27 INFO - 'SHLVL': '1', 15:22:27 INFO - 'TERM': 'linux', 15:22:27 INFO - 'TMOUT': '86400', 15:22:27 INFO - 'USER': 'cltbld', 15:22:27 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475703933.833021-41340357', 15:22:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:27 INFO - '_': '/tools/buildbot/bin/python'} 15:22:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:27 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)) 15:22:27 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)) 15:22:27 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)) 15:22:27 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)) 15:22:27 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)) 15:22:27 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)) 15:22:27 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)) 15:22:27 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)) 15:22:27 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)) 15:22:27 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)) 15:22:27 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)) 15:22:27 INFO - Cleaning up... 15:22:27 INFO - Return code: 0 15:22:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:22:27 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')]} 15:22:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:27 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')]} 15:22:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:27 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 0x7f70c318df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f37b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1482790>, '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 0x1483690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1483b20>, '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': '1f5564757af27664ca02d71f000001b0-1475703933.833021-41340357', '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 15:22:27 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 15:22:27 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 15:22:27 INFO - Using env: {'DISPLAY': ':0', 15:22:27 INFO - 'HOME': '/home/cltbld', 15:22:27 INFO - 'LANG': 'en_US.UTF-8', 15:22:27 INFO - 'LANGUAGE': 'en_US:en', 15:22:27 INFO - 'LOGNAME': 'cltbld', 15:22:27 INFO - 'MAIL': '/var/mail/cltbld', 15:22:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:27 INFO - 'MOZ_NO_REMOTE': '1', 15:22:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:27 INFO - 'NO_EM_RESTART': '1', 15:22:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:27 INFO - 'PWD': '/builds/slave/test', 15:22:27 INFO - 'SHELL': '/bin/bash', 15:22:27 INFO - 'SHLVL': '1', 15:22:27 INFO - 'TERM': 'linux', 15:22:27 INFO - 'TMOUT': '86400', 15:22:27 INFO - 'USER': 'cltbld', 15:22:27 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475703933.833021-41340357', 15:22:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:27 INFO - '_': '/tools/buildbot/bin/python'} 15:22:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:22:27 INFO - Cleaning up... 15:22:28 INFO - Return code: 0 15:22:28 INFO - Running post-action listener: _resource_record_post_action 15:22:28 INFO - Running post-action listener: _start_resource_monitoring 15:22:28 INFO - Starting resource monitoring. 15:22:28 INFO - [mozharness: 2016-10-05 22:22:28.045197Z] Finished create-virtualenv step (success) 15:22:28 INFO - [mozharness: 2016-10-05 22:22:28.045759Z] Running install step. 15:22:28 INFO - Running pre-action listener: _resource_record_pre_action 15:22:28 INFO - Running main action method: install 15:22:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:22:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:22:28 INFO - Reading from file tmpfile_stdout 15:22:28 INFO - Detecting whether we're running mozinstall >=1.0... 15:22:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:22:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:22:28 INFO - Reading from file tmpfile_stdout 15:22:28 INFO - Output received: 15:22:28 INFO - Usage: mozinstall [options] installer 15:22:28 INFO - Options: 15:22:28 INFO - -h, --help show this help message and exit 15:22:28 INFO - -d DEST, --destination=DEST 15:22:28 INFO - Directory to install application into. [default: 15:22:28 INFO - "/builds/slave/test"] 15:22:28 INFO - --app=APP Application being installed. [default: firefox] 15:22:28 INFO - mkdir: /builds/slave/test/build/application 15:22:28 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'] 15:22:28 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 15:22:45 INFO - Reading from file tmpfile_stdout 15:22:45 INFO - Output received: 15:22:45 INFO - /builds/slave/test/build/application/firefox/firefox 15:22:45 INFO - Running post-action listener: _resource_record_post_action 15:22:45 INFO - [mozharness: 2016-10-05 22:22:45.353372Z] Finished install step (success) 15:22:45 INFO - [mozharness: 2016-10-05 22:22:45.353683Z] Running run-tests step. 15:22:45 INFO - Running pre-action listener: _resource_record_pre_action 15:22:45 INFO - Running main action method: run_tests 15:22:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:22:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:22:45 INFO - Python 2.7.3 15:22:45 INFO - Return code: 0 15:22:45 INFO - grabbing minidump binary from tooltool 15:22:45 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')]} 15:22:45 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 0x1482790>, '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 0x1483690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1483b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:22:45 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 15:22:45 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 15:22:45 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 15:22:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:22:45 INFO - Return code: 0 15:22:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:22:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:22:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:22:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:22:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:22:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Hrysc99USlGEd7SVj3uDpw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 15:22:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Hrysc99USlGEd7SVj3uDpw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 15:22:45 INFO - Using env: {'DISPLAY': ':0', 15:22:45 INFO - 'HOME': '/home/cltbld', 15:22:45 INFO - 'LANG': 'en_US.UTF-8', 15:22:45 INFO - 'LANGUAGE': 'en_US:en', 15:22:45 INFO - 'LOGNAME': 'cltbld', 15:22:45 INFO - 'MAIL': '/var/mail/cltbld', 15:22:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:22:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:22:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:45 INFO - 'MOZ_NO_REMOTE': '1', 15:22:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:22:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:45 INFO - 'NO_EM_RESTART': '1', 15:22:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:45 INFO - 'PWD': '/builds/slave/test', 15:22:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:22:45 INFO - 'SHELL': '/bin/bash', 15:22:45 INFO - 'SHLVL': '1', 15:22:45 INFO - 'TERM': 'linux', 15:22:45 INFO - 'TMOUT': '86400', 15:22:45 INFO - 'USER': 'cltbld', 15:22:45 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475703933.833021-41340357', 15:22:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:45 INFO - '_': '/tools/buildbot/bin/python'} 15:22:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Hrysc99USlGEd7SVj3uDpw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 15:22:45 INFO - mozversion application_buildid: 20161005123041 15:22:45 INFO - mozversion application_changeset: 8450da83e7bc128faddb9007b79b0a67e62cdf90 15:22:45 INFO - mozversion application_display_name: Nightly 15:22:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:22:45 INFO - mozversion application_name: Firefox 15:22:45 INFO - mozversion application_remotingname: firefox 15:22:45 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 15:22:45 INFO - mozversion application_vendor: Mozilla 15:22:45 INFO - mozversion application_version: 52.0a1 15:22:45 INFO - mozversion platform_buildid: 20161005123041 15:22:45 INFO - mozversion platform_changeset: 8450da83e7bc128faddb9007b79b0a67e62cdf90 15:22:45 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 15:22:45 INFO - mozversion platform_version: 52.0a1 15:22:45 INFO - using testdate: 1475706165 15:22:45 INFO - actual date: 1475706165 15:22:45 INFO - starting webserver on 'localhost:45607' 15:22:45 INFO - SUITE-START | Running 2 tests 15:22:45 INFO - TEST-START | dromaeo_css 15:22:45 INFO - operating with platform_type : linux_ 15:22:45 INFO - Initialising browser for dromaeo_css test... 15:22:45 INFO - TEST-INFO | started process 29376 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbSezSR/profile http://localhost:45607/getInfo.html) 15:22:50 INFO - PROCESS | 29376 | __metrics Screen width/height:1600/1200 15:22:50 INFO - PROCESS | 29376 | colorDepth:24 15:22:50 INFO - PROCESS | 29376 | Browser inner width/height: 1024/697 15:22:50 INFO - PROCESS | 29376 | __metrics 15:22:50 ERROR - PROCESS | 29376 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 15:22:51 INFO - TEST-INFO | 29376: exit 0 15:22:51 INFO - Browser initialized. 15:22:51 INFO - Running cycle 1/1 for dromaeo_css test... 15:22:51 INFO - TEST-INFO | started process 29497 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbSezSR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:23:03 INFO - PROCESS | 29497 | RSS: Main: 185102336 15:23:03 INFO - PROCESS | 29497 | 15:23:53 INFO - PROCESS | 29497 | 1475706233225 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] 15:26:03 INFO - PROCESS | 29497 | Cycle 1(1): loaded http://localhost:45607/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45607/tests/dromaeo/cssquery-ext.html) 15:26:05 INFO - PROCESS | 29497 | RSS: Main: 202526720 15:26:05 INFO - PROCESS | 29497 | 15:29:07 INFO - PROCESS | 29497 | Cycle 1(1): loaded http://localhost:45607/tests/dromaeo/cssquery-ext.html (next: http://localhost:45607/tests/dromaeo/cssquery-jquery.html) 15:29:08 INFO - PROCESS | 29497 | RSS: Main: 203952128 15:29:08 INFO - PROCESS | 29497 | 15:32:10 INFO - PROCESS | 29497 | Cycle 1(1): loaded http://localhost:45607/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45607/tests/dromaeo/cssquery-mootools.html) 15:32:11 INFO - PROCESS | 29497 | RSS: Main: 205197312 15:32:11 INFO - PROCESS | 29497 | 15:35:12 INFO - PROCESS | 29497 | Cycle 1(1): loaded http://localhost:45607/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45607/tests/dromaeo/cssquery-prototype.html) 15:35:13 INFO - PROCESS | 29497 | RSS: Main: 198455296 15:35:13 INFO - PROCESS | 29497 | 15:38:16 INFO - PROCESS | 29497 | Cycle 1(1): loaded http://localhost:45607/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45607/tests/dromaeo/cssquery-yui.html) 15:38:16 INFO - PROCESS | 29497 | RSS: Main: 201162752 15:38:16 INFO - PROCESS | 29497 | 15:41:19 INFO - PROCESS | 29497 | Cycle 1(1): loaded http://localhost:45607/tests/dromaeo/cssquery-yui.html (next: http://localhost:45607/tests/dromaeo/cssquery-dojo.html) 15:41:19 INFO - PROCESS | 29497 | RSS: Main: 200916992 15:41:19 INFO - PROCESS | 29497 | 15:41:19 INFO - PROCESS | 29497 | __start_tp_report 15:41:19 INFO - PROCESS | 29497 | _x_x_mozilla_page_load 15:41:19 INFO - PROCESS | 29497 | _x_x_mozilla_page_load_details 15:41:19 INFO - PROCESS | 29497 | |i|pagename|runs| 15:41:19 INFO - PROCESS | 29497 | |0;dojo.html;2998.9400211995758;3037.0585118613217;3046.025271912987;3054.6639869614346;3056.954145687815;5105.540501354887;5216.791328346866;5303.7082960437165;5312.150055991042;5356.982173387054;5172.301739265198;5178.430372659014;5231.110711179099;5272.551833094191;5330.973345133269;4714.434267887841;4799.496052914446;4823.493533179018;4848;4877.073356062355;4813.711177329354;4819.566239038486;4868.732219727914;4882.389701287339;4932.235503496964;4699.436067671867;4705.505921878188;4742.50203728607;4821.9873826496305;4862.805487780484;4812.061647978646;4841.104395686774;4846.103470857903;4879.780409881564;4881.243407271843;4771.475137734847;4788.664793464424;4797.232442809169;4818.494058123882;4857.781399837016;5172.612054095958;5229.555487783543;5302.73486325686;5317.521423071903;5377.327834020747;5410.242566040757;5421.593380496479;5437.755301011464;5446;5505.559555235572;5467.781288748485;5470.124780035176;5481.835544933659;5487.42382049883;5515.310586176728;5130.384353877521;5131.974340128276;5134.5378915897745;5184.611154163453;5198.2722418861385;5660;5688.061469857427;5742.310922689304;5746.482816546531;5748.540116790647;5529.751161197756;5532.778688852401;5532.834014979557;5539.113741801292;5541.667499950016;5576.749046292926;5600.943990560124;5605.383407825136;5620.57845661577;5628;5652.7738890443925;5686.914696279559;5692.715364231772;5710.057840456361;5734.05388110957;5676.517496012802;5686.744096515667;5691.0609749391715;5699.059655156852;5703.7148142592705;4297.978510107429;4332.870013899588;4395.780210989437;4407.493138289138;4461;3871.090293780959;3886.3393223151566;3892.591277915835;3904.72666913319;3972.5431575369203;5357.062514060024;5391.7304134793885;5393.352797664305;5410.404855465896;5461.590380721462;5550.611457197957;5711.543076553866;5715.657060576379;5718.056520674042;5723.370429252779;5297.205419187076;5319.707416092075;5335;5419.34967803866;5502.642328248651;4813.687110337887;4819.6867203631655;4838.491958344323;4853.854384368475;4905.533974272438;5821.330546987066;5821.476067153976;5822.505087067647;5826.126081087701;5831.591788574759;5504.53211477029;5550.916736249041;5566.777328906798;5650.85872853182;5654.717264136694;5699.715014249188;5709.20071190042;5709.457601527848;5710.828675139753;5771.769129234784;5412.404635490172;5468.808591699271;5472.5348345391085;5483.095289277225;5507.173923911445;5579.776808927598;5646.7458964347525;5660.433956604306;5700.25896633435;5701.230333904869;5534.446555344433;5537.9169312459535;5540.113581826889;5547.944520554743;5552.167174923632;5369;5404.405515393225;5526.47498487643;5546.694931778629;5576.442355764553;5413.431589683027;5440.782368705208;5443.374011988672;5443.537299329601;5449.591280653887;5456.427075157051;5493.313335833021;5497.285352904097;5511.090670039399;5512.3385193777;5352.223927530564;5352.625316227826;5363.490468405495;5364.061289274439;5364.6512976656395 15:41:19 INFO - PROCESS | 29497 | |1;ext.html;569.7436153730821;576.5416493887358;583.1602492410927;586.3579380578266;595.8599729063671;36820.44769328459;41319.38020929685;41390.37914431286;41435.17129657405;41619.79190104049;41509.58490415095;41850.37224441636;41959.58040419595;41983.16033679325;42043.78978105113;8665.69670061548;8811.030786613468;8825.558722063903;8825.691100811473;8830.602622881954;8699.347548933856;8716;8722.084181160983;8753.168448997336;8786.428882122642;8819.60311785968;8875.423097498675;8920.687775927843;8937.106289371044;8953.776155596097;8834.955825220864;8842.557872106368;8856.070112638208;8878.42290251135;8888;8748.650053997833;8838.160374764388;8844.69043583478;8844.955775221148;8846.955765221197;34887;34889.12777180565;35124.82437587796;35185.47221791675;35224;3385.3737058643983;3463.584369875631;3665.21197942441;3984.8007599619905;4000.219957108365;31007.37985240305;31570.684293157003;31928.521072183936;32272.193195170075;32382.6761732382;4209.5790420957965;4270.487541495009;4322.891927701801;4328.675349348811;4358.2808836541935;324560;325745.9999999976;326067;326667;327045;55837;56119.43880561142;56142;56220.71889640608;56293;59507;59540.70229648824;59696;59722.40277597255;59739.40260597338;13559.118657287245;13646.454141834414;13653.590392288248;13663.38514766838;13669.111507751964;11161.553537858395;11335.489902954221;11397.487113079931;11480.483378247998;11655.41722913851;15841.603959901095;16390.426335078453;16581.25384357707;16620.83379166217;16673.583160420843;5459.454054594509;5521.889562208733;5604.551635869121;5613.410591887875;5637.3235211774845;888.9511076890703;950.3490109275168;994.7910938702809;1033.214756784849;1060.8886066963012;31507.842460788008;31560.210994725316;31757.682423175935;31797.682023179936;32122.678773212436;1050.0916707048348;1068.2308737708838;1102.8070087734775;1116.938568378747;1122.6239209864623;15725.528234152993;16543.420980265633;16572.75140872888;16709.164541773105;16876.662466750597;541192;544909;545875;546991;547382;56432;56700.432995669515;56833;56937.715311424006;56995.99999999917;1285.7685616589104;1304.7194853106437;1322.550332886804;1342.442886202215;1346.6431395680152;29661.847341371795;30903;30977.380452391277;31398;31855.36289274248;49693;49791;50127.49872501374;50202.246966294806;50216.497835022645;477266;478208;479276;482868;483295;40022.799886000386;40140.197196055335;40591;40939.59060409358;41241;45773.77113114413;46671.533284666715;47438.76280618575;47471.287930681756;48064.27903581519;37675.81162094172;38800.835974920796;39669.404958925064;41280.38079428751;41386.379204312565;37350.8132459336;39750.60249397585;40545.1890962185;40617.18765624612;40657.18685626212;39242;40194;40342.79828600838;40715;40834;33641.831790840886;35192.64807351894;37249.441258380604;42525.78737106295;43333.56666433295;29868.70131298746;33312.167195819326;33821.83089084539;34027.65972340344;34474.655253448145 15:41:19 INFO - PROCESS | 29497 | |2;jquery.html;383.84262452394523;384.76260544931205;393.5690418991205;399.38295333709414;414.87761110472405;13996.720065598707;17770;18380.632387352245;19387.127579258933;19428.90285548572;16155.596110097253;16742.24659890305;17080.572985675364;17268.050257235845;17887.552811179696;4935.950640493594;5229.50319719626;5260.8158714445;5281.287026251445;5285.577153827685;5121;5199.804045069636;5207.140821764404;5216.2958000669805;5224.111900976843;5111.872203194913;5297.44376840432;5339.466053394668;5348.572114230852;5354.491323324298;5162.406323272797;5248.448912864133;5254.343207099113;5258.237555554461;5275.525202731734;5089.592832573422;5145.922811157836;5152.819651312224;5156.432792392834;5168.095583272912;22010.779892201193;22699.773002269932;22796.316110516713;23001.009868717127;23105.422364440856;2394.688690470245;2440.133752517866;2601.2586412872242;2691.7846572274366;2918.1391489510434;9927.106560409526;10113.69658910234;10279.331843430227;10336.896631033744;10776.40729759863;1880.6708825955402;1892.706630472279;1901.2490066423686;1913.033917871466;1964.5285131568464;80176.59911700404;81956.59021704854;82424;82470.58764706198;85248.57375713144;10940.56237750497;11030.448477576088;11306.265092769108;11436.885631143748;11933.641990740292;15689.215539222992;15754.9212253938;15757.133357665209;15772.76340854888;15777.132257725705;6975.616341101187;7032.789016329416;7271.236520165412;7398.630068496554;7418.851622967619;6970.233274339818;7104.076470058859;7286.562806231537;7418.072740907387;7543.509671871311;4660.7436590987145;4707.576318131385;4805.519448055236;4820.180569303227;4829.396325459317;1902.7811801642988;2007.6185524750251;2013.848961327877;2045.384146524259;2051.3948385226395;879.5030807593689;967.4823969176457;1019.1846522781893;1021.9693409197736;1055.3404122423485;19486.610267794847;19673.508162296057;19736.30922917691;19809.20763169457;19836;976.1166144639113;978.4227305889559;1009.8636684047707;1029.1869423155772;1054.9367037977745;10293.845592316122;10961.12311015117;11080.722981925355;11102.722431939104;11118.49966751482;337970;343859;432786;435338;436930;96337.51831240799;96405.5179724097;98175.50912245536;100109.99890001153;102454;986.5264672957021;1001.6944831826218;1060.1306928318859;1065.1372388365294;1070.4273213830563;16770;16975.57561060934;17442.82557174412;17680.646387072444;17865;28553.28616784597;30579.694203057683;34496.310073798886;35035.824820876755;36989.630103699696;44911.55088449074;50050.74974625104;54111.45888541064;54156.458435415145;55163.44836551743;7942.364610831004;8188.181181881764;8419.747407577783;8433.19884610961;8603.440776349516;7030.3321184487395;10872.67381978542;11810;11989.580364687194;12537.93731031339;10561.630342938268;10724.249302548747;10899.400532970763;11010;11135.276207046516;10615.840762388725;10718.8928110721;10832.75423326296;11154.721131971766;11204.215704900578;11094.167937404565;11160.274582152135;11195.88804111981;11419.771604568028;11451.454053702977;8149.6332665031405;8188.385871059575;8420.284275836622;8628.52543110135;8710.040240945737;10826.40454774995;10923.945380273048;11007.284526505751;11258.718532036764;11599.88400115988 15:41:19 INFO - PROCESS | 29497 | |3;mootools.html;1427.5003748687961;1459.0734883349073;1578.889477736558;1708.0605666883228;1754.4999675092602;7504.324610785028;7724.1117271513795;8019.879701804471;8633.870491942618;8646.481211127337;7970.402219833507;8221.876671849912;8255.215754503328;8354.665813367457;8403.789905252357;2036.6741321388618;2060.546679730457;2061.9587608247825;2069.544700165961;2079.2099002379073;1997.0813425824065;2027.7262569553143;2099.1708275231276;2166.2959538150085;2180.6728990651372;2032.908519116636;2034.9186032558755;2051.148773259096;2056.064490656755;2058.166442590753;2024.028466336167;2031;2032.4613977296028;2040.5612793249375;2045.6317862784692;1976.4169569976748;2032.3699653107435;2119.2582596091397;2144.2816656419964;2171.5005548723884;8466.915330846674;8475.533845638487;8510;8567.057623661454;8574.871376929352;4696.577308042292;4826.420829500483;4828.975855120737;4830.347903033081;4831.565159135695;3076.9384612307626;3199.3441344524317;3303.96696033039;3304.339132173575;3311.0563489405404;1010.0959641121228;1055.0406110859037;1077.4558847781898;1078.6063086973277;1082.2748758331936;11295.774084518345;11298.943505282503;11310;11395.088392928628;11435.771284574344;3945.151792364655;4192.832286708497;4199.97900010498;4302.118065796504;4319.33050377192;9736.902630973742;9746.902530974741;9752.21982241419;9761.219102471785;9779.119879210904;4992.875178120504;4996.775145118479;5000.349954505964;5007.37407824022;5011.4236862761245;3993.281209382339;4106.568810274938;4407.713498622579;4587.885302867455;4595.172868883633;3703.333399988028;3753.193063491308;3825.407061905409;3864.787436691009;3913.7651740895067;1267.790814515613;1268.7335659511607;1271.110222844013;1272.7263638317806;1297.4485843516468;820.9343252539783;919.9632014719336;940.7130825098411;961.8412961861214;985.8176237396104;5726.255586773693;5795.652260864362;5880.676562789087;5995.310539287951;6025.307089684742;882.2280504558511;954.5465903695689;965.1313817564109;974.1670871404989;1009.8687170667766;3732.5924778517706;3967.603239676067;3969.761814291152;4030.8992275193355;4246.214450326699;9993.700188994342;10347.223958203165;10377;10421.06210441064;10430.791384172426;10177.287589868785;10259.281850270409;10377;10430.843537346946;10453.529591168415;7744.57404842739;7787.338076263581;7842.098158711707;7931.84136317282;7952.324052455606;5576.86057848557;5646.774129034792;5690.004249256281;5691.601587888974;5891.1752354671235;9407.576659050223;9452.43285402878;9496.14534691881;9513.238940884574;9581.473018984023;9120.635174592942;9503;9527.951925288075;9797.412155270422;9818.509074546388;6778.4577233822165;6959.40845028158;7266.273372662691;7515.586642734702;7519.812004699927;7730.536167829948;7920.683172673029;7984.600769961363;8194.67221311141;8206;7236.96381518089;7401.777946661608;7436.367908727819;7443.665035073326;7590.430717696085;7204.279572042754;7234.5659260444545;7380.520266182681;7402.29678180572;7422.591757453176;6601.735930562723;6614.470842332698;6657.633830139195;6667.766628167991;6720.563163394364;4882.6084565898545;5142.53717165442;5145.305383773292;5163.767630456563;5214.97392513035;5008.100022859041;5030.62270329734;5137.6660517066275;5183.688978661293;5201.089809283285 15:41:19 INFO - PROCESS | 29497 | |4;prototype.html;317.1073428299339;328.6795374509853;334.26128256553017;336.36930754834685;338.82719812895425;5268.894622107556;5419.268398766166;5471.398146203915;5521;5562.274485502106;5212.50481204285;5297.814576489824;5342.171963345678;5346.385165705945;5357.464253574641;4226.366045093245;4226.387173859796;4246.80889359978;4270.402143699885;4275.636570891478;4181.205570941526;4194.748315101088;4239.321708526621;4271.551487093857;4288.506821715511;4184.937225941613;4195.748255104688;4198.3282674772045;4205.65419065899;4213.07312391275;4190.434291370657;4198.9370159447635;4212.389203565496;4215.936760948588;4229.450171477688;3764.682361173595;3800.1259710266795;3802.334591446486;3803.9429408558894;3808.485854409647;5080.272707279542;5328.333958255218;5337.653052551611;5344.706041167734;5363.839084827461;4832.806687732486;4866.026794641086;4874.488178741217;4884.633652476078;4902.730349830758;5395.649282796606;5688.374278829326;5689.260396148516;5706.800261990852;5733.16869053989;4026.235015347104;4032.1532478179615;4048.392741088831;4054.4121102440276;4057.310257256244;5910.113482977587;5988.933817832884;6004.879902401927;6008.7896923607905;6025.4333873192845;3869.3228684980018;4185.267578173807;4215.178040282177;4217.472815898012;4226.725262857966;4096.610821971908;4108.815103320358;4111.527174374925;4115;4118.485189351331;4672.906541869143;4683.297505374221;4683.976580117146;4742.976285118552;4768.237082066853;5534.833954981357;5669.546436285087;5699.316082070095;5715.1713001614535;5723.742431590588;1423.2527922840384;1447.6319877715457;1450.4778279819257;1450.5639416977117;1452.2790493265304;895.2211575928983;913.917747402737;922.1930810540777;932.5570354081757;943.4292253186724;4787.3537072495465;4795.184818580849;4848.248521479177;4861.878453038702;4876.951230487721;5085.9147749422555;5086.567641750493;5117.462666420047;5159.58723302135;5204.620775494497;4798.328234047236;4822.239882442953;4826.334914454507;4849.830255941025;5145.279660847485;3068.401661675952;3088.9960762752194;3103.4258662147577;3104.891328803481;3110.315730539278;6006.579539432198;6032.728527216286;6048.879022419527;6049.364816694272;6054.215061071868;5585.184814935081;5939.584229103922;5952.642841429441;5954.642721436728;5984.970075149597;6040.09398590215;6057.729300842895;6083.6045657032155;6098.176746139215;6112.205413296243;5583.715745378667;5850.23946886902;5906.704664766658;5926.703664816656;5929.183637772197;5833.766649333979;5846.678432686073;5851.882962340815;5853.824385268449;5861;6017.669028203491;6104.26748790148;6115.174451448997;6120.663363515049;6124.8775024500155;3948.7433316834313;4176.477940257468;4177.206330797138;4182.247195504839;4195.223883581547;5893.499052580579;5894.970525147347;5904.439078287556;5918.556108291809;5942.168096466585;5644.266245388073;5661.377248502579;5801.970990145022;5817.185594016756;5832.708364581669;5686.317641883001;5692.345380281155;5696.063338464942;5704.3154821421695;5723.882163599495;5714.571407144397;5717.971410142923;5719.256496655575;5757.165211044459;5771.163181338598;5638.984982703153;5655.4344565543115;5663.518600918968;5714.771409143754;5756.165356023437;5502.944970550243;5514.476124768141;5517;5536.667799932017;5550.38945715979 15:41:19 INFO - PROCESS | 29497 | |5;yui.html;735.8896165575163;738.7266711316812;755.9622018899054;821.1747194069959;824.5094168969462;15128.546143615695;15891.443799467006;15912.204389780509;15914.363425462996;15976;13037.543685970993;13146;13181.670458238525;13192.406341714646;13206.141600795941;803.8392321535687;828.4076885027205;831.7504748575434;831.8710599857031;833.0794472108324;806.0850934189708;821.1378053044309;821.6179476543406;822.3749950037984;825.471698113205;852.4118358332762;853.1511146409331;858.3347905373355;858.4205661178711;861.5821326656597;855.5722138930535;856.4647095565272;856.5888373580685;857.6055014693248;858.8196478739441;630.7603110817905;631.9905201421982;632.4908448698795;635.3075148088559;636.2873581588605;14052.648683782885;14111.647208819862;14193.07744996572;14204.147751134966;14208.218547979857;12557.74884502314;12976.35118244084;13454.385473743214;13491.865081349159;13506.932465337708;11022.283551569202;11478.655640330804;11499;11608.6517404478;11614.128940329509;3762.9059273518383;3831.731778775487;3858.151206734514;4023.476947996771;4048.352263637804;74578.25421745822;75221.24778752198;77988;78197.60901195515;78899.81650275308;9600.135987761136;9763.071078676368;9820.901790982141;10045.648402305884;10106.898931010743;20578.27976020832;20579.176832926816;20595.691064634044;20601.793982059986;20664.276750313667;8470.110638383005;8520.233179013794;8697.826043479095;8845.955770221108;8961.193492585568;4415.470143582726;4565.452145742533;4749.786259618326;4764.499727528629;4796.232602783608;3640.7633503822167;3710.5547334320054;3744.9625503744614;3752.81235938202;3766.2090960898518;628.4972022382076;644.4683136412478;650.5446187668556;650.9381608747161;661.2428769059496;558.4861927027144;619.8140557832633;651.3746803069012;718.1669263654136;725.8693435181613;9439.24486041115;9455.810883782424;9455.858162127573;9471.905280947103;10500.264981451224;693.8369781312127;708.7342246657504;713.2225873797586;738.3871386748986;756.1682149635357;4359.9782001090425;4822.758862056883;4868.440129385166;4904.141775189328;4929.3345398371475;72655;91937;92285;95109;109182.45408772906;92880;95406.09187816344;95702;97437;97611.51194243983;51655.48344516582;73803;85000.57499712461;88819;89089.55455222682;9215.400998935047;9446.622135114518;9558.474283914451;9565.321470605959;9570.904290957002;48939.26591101207;49109.75445122751;49952;50583;50594.74702626463;66510.33489665041;69975.65012174906;74372.62813686114;76041.61979190068;76199;12823.422945967268;12932.935335323264;12951.805722913976;12999.285039322927;13022.088453808521;13487.662808429475;13679.788670850989;13961.624774461703;14124.929375353058;14208.431662733376;12741.17182383142;12843.327652491102;13110.147840390344;13304.600861974157;13756.312184390541;12773.489060437478;13115.606531804062;13204.603861883774;13246.344206974129;13894.583162504736;12403.813942790684;12961;13171.473141074634;13481.440802775845;13706.38321275525;10632.89367106319;10805.837912431163;10837.241393102408;10925.945370273097;11191.776164476501;10202.489875506046;11532.538698451968;11659.242149260272;11942.582009629621;12022.939885300517 15:41:19 INFO - PROCESS | 29497 | __end_tp_report 15:41:19 INFO - PROCESS | 29497 | __start_cc_report 15:41:19 INFO - PROCESS | 29497 | _x_x_mozilla_cycle_collect,310 15:41:19 INFO - PROCESS | 29497 | __end_cc_report 15:41:19 INFO - PROCESS | 29497 | __startTimestamp1475707279804__endTimestamp 15:41:19 INFO - PROCESS | 29497 | 15:41:19 INFO - PROCESS | 29497 | ------- Summary: start ------- 15:41:19 INFO - PROCESS | 29497 | Number of tests: 6 15:41:19 INFO - PROCESS | 29497 | 15:41:19 INFO - PROCESS | 29497 | [#0] dojo.html Cycles:165 Average:5224.66 Median:5419.35 stddev:575.58 (10.6%) stddev-sans-first:550.23 15:41:19 INFO - PROCESS | 29497 | Values: 2998.9 3037.1 3046.0 3054.7 3057.0 5105.5 5216.8 5303.7 5312.2 5357.0 5172.3 5178.4 5231.1 5272.6 5331.0 4714.4 4799.5 4823.5 4848.0 4877.1 4813.7 4819.6 4868.7 4882.4 4932.2 4699.4 4705.5 4742.5 4822.0 4862.8 4812.1 4841.1 4846.1 4879.8 4881.2 4771.5 4788.7 4797.2 4818.5 4857.8 5172.6 5229.6 5302.7 5317.5 5377.3 5410.2 5421.6 5437.8 5446.0 5505.6 5467.8 5470.1 5481.8 5487.4 5515.3 5130.4 5132.0 5134.5 5184.6 5198.3 5660.0 5688.1 5742.3 5746.5 5748.5 5529.8 5532.8 5532.8 5539.1 5541.7 5576.7 5600.9 5605.4 5620.6 5628.0 5652.8 5686.9 5692.7 5710.1 5734.1 5676.5 5686.7 5691.1 5699.1 5703.7 4298.0 4332.9 4395.8 4407.5 4461.0 3871.1 3886.3 3892.6 3904.7 3972.5 5357.1 5391.7 5393.4 5410.4 5461.6 5550.6 5711.5 5715.7 5718.1 5723.4 5297.2 5319.7 5335.0 5419.3 5502.6 4813.7 4819.7 4838.5 4853.9 4905.5 5821.3 5821.5 5822.5 5826.1 5831.6 5504.5 5550.9 5566.8 5650.9 5654.7 5699.7 5709.2 5709.5 5710.8 5771.8 5412.4 5468.8 5472.5 5483.1 5507.2 5579.8 5646.7 5660.4 5700.3 5701.2 5534.4 5537.9 5540.1 5547.9 5552.2 5369.0 5404.4 5526.5 5546.7 5576.4 5413.4 5440.8 5443.4 5443.5 5449.6 5456.4 5493.3 5497.3 5511.1 5512.3 5352.2 5352.6 5363.5 5364.1 5364.7 15:41:19 INFO - PROCESS | 29497 | 15:41:19 INFO - PROCESS | 29497 | [#1] ext.html Cycles:180 Average:60683.08 Median:41352.88 stddev:122157.17 (295.4%) stddev-sans-first:122416.48 15:41:19 INFO - PROCESS | 29497 | Values: 569.7 576.5 583.2 586.4 595.9 36820.4 41319.4 41390.4 41435.2 41619.8 41509.6 41850.4 41959.6 41983.2 42043.8 8665.7 8811.0 8825.6 8825.7 8830.6 8699.3 8716.0 8722.1 8753.2 8786.4 8819.6 8875.4 8920.7 8937.1 8953.8 8835.0 8842.6 8856.1 8878.4 8888.0 8748.7 8838.2 8844.7 8845.0 8847.0 34887.0 34889.1 35124.8 35185.5 35224.0 3385.4 3463.6 3665.2 3984.8 4000.2 31007.4 31570.7 31928.5 32272.2 32382.7 4209.6 4270.5 4322.9 4328.7 4358.3 324560.0 325746.0 326067.0 326667.0 327045.0 55837.0 56119.4 56142.0 56220.7 56293.0 59507.0 59540.7 59696.0 59722.4 59739.4 13559.1 13646.5 13653.6 13663.4 13669.1 11161.6 11335.5 11397.5 11480.5 11655.4 15841.6 16390.4 16581.3 16620.8 16673.6 5459.5 5521.9 5604.6 5613.4 5637.3 889.0 950.3 994.8 1033.2 1060.9 31507.8 31560.2 31757.7 31797.7 32122.7 1050.1 1068.2 1102.8 1116.9 1122.6 15725.5 16543.4 16572.8 16709.2 16876.7 541192.0 544909.0 545875.0 546991.0 547382.0 56432.0 56700.4 56833.0 56937.7 56996.0 1285.8 1304.7 1322.6 1342.4 1346.6 29661.8 30903.0 30977.4 31398.0 31855.4 49693.0 49791.0 50127.5 50202.2 50216.5 477266.0 478208.0 479276.0 482868.0 483295.0 40022.8 40140.2 40591.0 40939.6 41241.0 45773.8 46671.5 47438.8 47471.3 48064.3 37675.8 38800.8 39669.4 41280.4 41386.4 37350.8 39750.6 40545.2 40617.2 40657.2 39242.0 40194.0 40342.8 40715.0 40834.0 33641.8 35192.6 37249.4 42525.8 43333.6 29868.7 33312.2 33821.8 34027.7 34474.7 15:41:19 INFO - PROCESS | 29497 | 15:41:19 INFO - PROCESS | 29497 | [#2] jquery.html Cycles:180 Average:25922.92 Median:2417.41 stddev:66776.65 (2762.3%) stddev-sans-first:66936.44 15:41:19 INFO - PROCESS | 29497 | Values: 383.8 384.8 393.6 399.4 414.9 13996.7 17770.0 18380.6 19387.1 19428.9 16155.6 16742.2 17080.6 17268.1 17887.6 4936.0 5229.5 5260.8 5281.3 5285.6 5121.0 5199.8 5207.1 5216.3 5224.1 5111.9 5297.4 5339.5 5348.6 5354.5 5162.4 5248.4 5254.3 5258.2 5275.5 5089.6 5145.9 5152.8 5156.4 5168.1 22010.8 22699.8 22796.3 23001.0 23105.4 2394.7 2440.1 2601.3 2691.8 2918.1 9927.1 10113.7 10279.3 10336.9 10776.4 1880.7 1892.7 1901.2 1913.0 1964.5 80176.6 81956.6 82424.0 82470.6 85248.6 10940.6 11030.4 11306.3 11436.9 11933.6 15689.2 15754.9 15757.1 15772.8 15777.1 6975.6 7032.8 7271.2 7398.6 7418.9 6970.2 7104.1 7286.6 7418.1 7543.5 4660.7 4707.6 4805.5 4820.2 4829.4 1902.8 2007.6 2013.8 2045.4 2051.4 879.5 967.5 1019.2 1022.0 1055.3 19486.6 19673.5 19736.3 19809.2 19836.0 976.1 978.4 1009.9 1029.2 1054.9 10293.8 10961.1 11080.7 11102.7 11118.5 337970.0 343859.0 432786.0 435338.0 436930.0 96337.5 96405.5 98175.5 100110.0 102454.0 986.5 1001.7 1060.1 1065.1 1070.4 16770.0 16975.6 17442.8 17680.6 17865.0 28553.3 30579.7 34496.3 35035.8 36989.6 44911.6 50050.7 54111.5 54156.5 55163.4 7942.4 8188.2 8419.7 8433.2 8603.4 7030.3 10872.7 11810.0 11989.6 12537.9 10561.6 10724.2 10899.4 11010.0 11135.3 10615.8 10718.9 10832.8 11154.7 11204.2 11094.2 11160.3 11195.9 11419.8 11451.5 8149.6 8188.4 8420.3 8628.5 8710.0 10826.4 10923.9 11007.3 11258.7 11599.9 15:41:19 INFO - PROCESS | 29497 | 15:41:19 INFO - PROCESS | 29497 | [#3] mootools.html Cycles:180 Average:5484.65 Median:5009.76 stddev:3110.67 (62.1%) stddev-sans-first:3104.45 15:41:19 INFO - PROCESS | 29497 | Values: 1427.5 1459.1 1578.9 1708.1 1754.5 7504.3 7724.1 8019.9 8633.9 8646.5 7970.4 8221.9 8255.2 8354.7 8403.8 2036.7 2060.5 2062.0 2069.5 2079.2 1997.1 2027.7 2099.2 2166.3 2180.7 2032.9 2034.9 2051.1 2056.1 2058.2 2024.0 2031.0 2032.5 2040.6 2045.6 1976.4 2032.4 2119.3 2144.3 2171.5 8466.9 8475.5 8510.0 8567.1 8574.9 4696.6 4826.4 4829.0 4830.3 4831.6 3076.9 3199.3 3304.0 3304.3 3311.1 1010.1 1055.0 1077.5 1078.6 1082.3 11295.8 11298.9 11310.0 11395.1 11435.8 3945.2 4192.8 4200.0 4302.1 4319.3 9736.9 9746.9 9752.2 9761.2 9779.1 4992.9 4996.8 5000.3 5007.4 5011.4 3993.3 4106.6 4407.7 4587.9 4595.2 3703.3 3753.2 3825.4 3864.8 3913.8 1267.8 1268.7 1271.1 1272.7 1297.4 820.9 920.0 940.7 961.8 985.8 5726.3 5795.7 5880.7 5995.3 6025.3 882.2 954.5 965.1 974.2 1009.9 3732.6 3967.6 3969.8 4030.9 4246.2 9993.7 10347.2 10377.0 10421.1 10430.8 10177.3 10259.3 10377.0 10430.8 10453.5 7744.6 7787.3 7842.1 7931.8 7952.3 5576.9 5646.8 5690.0 5691.6 5891.2 9407.6 9452.4 9496.1 9513.2 9581.5 9120.6 9503.0 9528.0 9797.4 9818.5 6778.5 6959.4 7266.3 7515.6 7519.8 7730.5 7920.7 7984.6 8194.7 8206.0 7237.0 7401.8 7436.4 7443.7 7590.4 7204.3 7234.6 7380.5 7402.3 7422.6 6601.7 6614.5 6657.6 6667.8 6720.6 4882.6 5142.5 5145.3 5163.8 5215.0 5008.1 5030.6 5137.7 5183.7 5201.1 15:41:19 INFO - PROCESS | 29497 | 15:41:19 INFO - PROCESS | 29497 | [#4] prototype.html Cycles:180 Average:4744.27 Median:5339.91 stddev:1405.77 (26.3%) stddev-sans-first:1369.88 15:41:19 INFO - PROCESS | 29497 | Values: 317.1 328.7 334.3 336.4 338.8 5268.9 5419.3 5471.4 5521.0 5562.3 5212.5 5297.8 5342.2 5346.4 5357.5 4226.4 4226.4 4246.8 4270.4 4275.6 4181.2 4194.7 4239.3 4271.6 4288.5 4184.9 4195.7 4198.3 4205.7 4213.1 4190.4 4198.9 4212.4 4215.9 4229.5 3764.7 3800.1 3802.3 3803.9 3808.5 5080.3 5328.3 5337.7 5344.7 5363.8 4832.8 4866.0 4874.5 4884.6 4902.7 5395.6 5688.4 5689.3 5706.8 5733.2 4026.2 4032.2 4048.4 4054.4 4057.3 5910.1 5988.9 6004.9 6008.8 6025.4 3869.3 4185.3 4215.2 4217.5 4226.7 4096.6 4108.8 4111.5 4115.0 4118.5 4672.9 4683.3 4684.0 4743.0 4768.2 5534.8 5669.5 5699.3 5715.2 5723.7 1423.3 1447.6 1450.5 1450.6 1452.3 895.2 913.9 922.2 932.6 943.4 4787.4 4795.2 4848.2 4861.9 4877.0 5085.9 5086.6 5117.5 5159.6 5204.6 4798.3 4822.2 4826.3 4849.8 5145.3 3068.4 3089.0 3103.4 3104.9 3110.3 6006.6 6032.7 6048.9 6049.4 6054.2 5585.2 5939.6 5952.6 5954.6 5985.0 6040.1 6057.7 6083.6 6098.2 6112.2 5583.7 5850.2 5906.7 5926.7 5929.2 5833.8 5846.7 5851.9 5853.8 5861.0 6017.7 6104.3 6115.2 6120.7 6124.9 3948.7 4176.5 4177.2 4182.2 4195.2 5893.5 5895.0 5904.4 5918.6 5942.2 5644.3 5661.4 5802.0 5817.2 5832.7 5686.3 5692.3 5696.1 5704.3 5723.9 5714.6 5718.0 5719.3 5757.2 5771.2 5639.0 5655.4 5663.5 5714.8 5756.2 5502.9 5514.5 5517.0 5536.7 5550.4 15:41:19 INFO - PROCESS | 29497 | 15:41:19 INFO - PROCESS | 29497 | [#5] yui.html Cycles:180 Average:19548.70 Median:27440.67 stddev:27422.35 (99.9%) stddev-sans-first:27462.89 15:41:19 INFO - PROCESS | 29497 | Values: 735.9 738.7 756.0 821.2 824.5 15128.5 15891.4 15912.2 15914.4 15976.0 13037.5 13146.0 13181.7 13192.4 13206.1 803.8 828.4 831.8 831.9 833.1 806.1 821.1 821.6 822.4 825.5 852.4 853.2 858.3 858.4 861.6 855.6 856.5 856.6 857.6 858.8 630.8 632.0 632.5 635.3 636.3 14052.6 14111.6 14193.1 14204.1 14208.2 12557.7 12976.4 13454.4 13491.9 13506.9 11022.3 11478.7 11499.0 11608.7 11614.1 3762.9 3831.7 3858.2 4023.5 4048.4 74578.3 75221.2 77988.0 78197.6 78899.8 9600.1 9763.1 9820.9 10045.6 10106.9 20578.3 20579.2 20595.7 20601.8 20664.3 8470.1 8520.2 8697.8 8846.0 8961.2 4415.5 4565.5 4749.8 4764.5 4796.2 3640.8 3710.6 3745.0 3752.8 3766.2 628.5 644.5 650.5 650.9 661.2 558.5 619.8 651.4 718.2 725.9 9439.2 9455.8 9455.9 9471.9 10500.3 693.8 708.7 713.2 738.4 756.2 4360.0 4822.8 4868.4 4904.1 4929.3 72655.0 91937.0 92285.0 95109.0 109182.5 92880.0 95406.1 95702.0 97437.0 97611.5 51655.5 73803.0 85000.6 88819.0 89089.6 9215.4 9446.6 9558.5 9565.3 9570.9 48939.3 49109.8 49952.0 50583.0 50594.7 66510.3 69975.7 74372.6 76041.6 76199.0 12823.4 12932.9 12951.8 12999.3 13022.1 13487.7 13679.8 13961.6 14124.9 14208.4 12741.2 12843.3 13110.1 13304.6 13756.3 12773.5 13115.6 13204.6 13246.3 13894.6 12403.8 12961.0 13171.5 13481.4 13706.4 10632.9 10805.8 10837.2 10925.9 11191.8 10202.5 11532.5 11659.2 11942.6 12022.9 15:41:19 INFO - PROCESS | 29497 | -------- Summary: end -------- 15:41:19 INFO - PROCESS | 29497 | 15:41:20 INFO - TEST-INFO | 29497: exit 0 15:41:20 INFO - TEST-OK | dromaeo_css | took 1115220ms 15:41:20 INFO - TEST-START | kraken 15:41:20 INFO - operating with platform_type : linux_ 15:41:20 INFO - Initialising browser for kraken test... 15:41:20 INFO - TEST-INFO | started process 29864 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5HHrYP/profile http://localhost:45607/getInfo.html) 15:41:25 INFO - PROCESS | 29864 | __metrics Screen width/height:1600/1200 15:41:25 INFO - PROCESS | 29864 | colorDepth:24 15:41:25 INFO - PROCESS | 29864 | Browser inner width/height: 1024/697 15:41:25 INFO - PROCESS | 29864 | __metrics 15:41:25 ERROR - PROCESS | 29864 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 15:41:26 INFO - TEST-INFO | 29864: exit 0 15:41:26 INFO - Browser initialized. 15:41:26 INFO - Running cycle 1/1 for kraken test... 15:41:26 INFO - TEST-INFO | started process 29986 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5HHrYP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:41:38 INFO - PROCESS | 29986 | RSS: Main: 185196544 15:41:38 INFO - PROCESS | 29986 | 15:41:41 INFO - PROCESS | 29986 | Cycle 1(1): loaded http://localhost:45607/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45607/tests/kraken/driver.html?testName=audio-beat-detection) 15:41:42 INFO - PROCESS | 29986 | RSS: Main: 198914048 15:41:42 INFO - PROCESS | 29986 | 15:41:45 INFO - PROCESS | 29986 | Cycle 1(1): loaded http://localhost:45607/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45607/tests/kraken/driver.html?testName=audio-dft) 15:41:45 INFO - PROCESS | 29986 | RSS: Main: 197115904 15:41:45 INFO - PROCESS | 29986 | 15:41:48 INFO - PROCESS | 29986 | Cycle 1(1): loaded http://localhost:45607/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45607/tests/kraken/driver.html?testName=audio-fft) 15:41:49 INFO - PROCESS | 29986 | RSS: Main: 192573440 15:41:49 INFO - PROCESS | 29986 | 15:41:51 INFO - PROCESS | 29986 | Cycle 1(1): loaded http://localhost:45607/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45607/tests/kraken/driver.html?testName=audio-oscillator) 15:41:51 INFO - PROCESS | 29986 | RSS: Main: 192933888 15:41:51 INFO - PROCESS | 29986 | 15:41:54 INFO - PROCESS | 29986 | Cycle 1(1): loaded http://localhost:45607/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45607/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:41:54 INFO - PROCESS | 29986 | RSS: Main: 193249280 15:41:54 INFO - PROCESS | 29986 | 15:41:57 INFO - PROCESS | 29986 | Cycle 1(1): loaded http://localhost:45607/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45607/tests/kraken/driver.html?testName=imaging-darkroom) 15:41:58 INFO - PROCESS | 29986 | RSS: Main: 194297856 15:41:58 INFO - PROCESS | 29986 | 15:42:01 INFO - PROCESS | 29986 | Cycle 1(1): loaded http://localhost:45607/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45607/tests/kraken/driver.html?testName=imaging-desaturate) 15:42:02 INFO - PROCESS | 29986 | RSS: Main: 191942656 15:42:02 INFO - PROCESS | 29986 | 15:42:05 INFO - PROCESS | 29986 | Cycle 1(1): loaded http://localhost:45607/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45607/tests/kraken/driver.html?testName=json-parse-financial) 15:42:05 INFO - PROCESS | 29986 | RSS: Main: 192925696 15:42:05 INFO - PROCESS | 29986 | 15:42:07 INFO - PROCESS | 29986 | Cycle 1(1): loaded http://localhost:45607/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45607/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:42:08 INFO - PROCESS | 29986 | RSS: Main: 193310720 15:42:08 INFO - PROCESS | 29986 | 15:42:09 INFO - PROCESS | 29986 | Cycle 1(1): loaded http://localhost:45607/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45607/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:42:10 INFO - PROCESS | 29986 | RSS: Main: 193273856 15:42:10 INFO - PROCESS | 29986 | 15:42:12 INFO - PROCESS | 29986 | Cycle 1(1): loaded http://localhost:45607/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45607/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:42:13 INFO - PROCESS | 29986 | RSS: Main: 193761280 15:42:13 INFO - PROCESS | 29986 | 15:42:16 INFO - PROCESS | 29986 | Cycle 1(1): loaded http://localhost:45607/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45607/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:42:16 INFO - PROCESS | 29986 | RSS: Main: 193486848 15:42:16 INFO - PROCESS | 29986 | 15:42:19 INFO - PROCESS | 29986 | Cycle 1(1): loaded http://localhost:45607/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45607/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:42:20 INFO - PROCESS | 29986 | RSS: Main: 193855488 15:42:20 INFO - PROCESS | 29986 | 15:42:21 INFO - PROCESS | 29986 | Cycle 1(1): loaded http://localhost:45607/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45607/tests/kraken/driver.html?testName=ai-astar) 15:42:22 INFO - PROCESS | 29986 | RSS: Main: 195313664 15:42:22 INFO - PROCESS | 29986 | 15:42:22 INFO - PROCESS | 29986 | __start_tp_report 15:42:22 INFO - PROCESS | 29986 | _x_x_mozilla_page_load 15:42:22 INFO - PROCESS | 29986 | _x_x_mozilla_page_load_details 15:42:22 INFO - PROCESS | 29986 | |i|pagename|runs| 15:42:22 INFO - PROCESS | 29986 | |0;ai-astar;106;112;113;113;113;113;113;112;111;113 15:42:22 INFO - PROCESS | 29986 | |1;audio-beat-detection;165;129;126;163;129;132;129;127;166;128 15:42:22 INFO - PROCESS | 29986 | |2;audio-dft;163;165;164;166;170;167;165;164;163;163 15:42:22 INFO - PROCESS | 29986 | |3;audio-fft;77;77;77;102;76;76;77;76;101;76 15:42:22 INFO - PROCESS | 29986 | |4;audio-oscillator;82;83;114;82;83;83;99;83;83;106 15:42:22 INFO - PROCESS | 29986 | |5;imaging-gaussian-blur;118;118;118;119;118;118;118;118;119;117 15:42:22 INFO - PROCESS | 29986 | |6;imaging-darkroom;149;147;147;146;147;149;147;148;147;148 15:42:22 INFO - PROCESS | 29986 | |7;imaging-desaturate;98;96;96;96;95;96;96;96;96;96 15:42:22 INFO - PROCESS | 29986 | |8;json-parse-financial;56;57;55;54;60;54;55;54;54;55 15:42:22 INFO - PROCESS | 29986 | |9;json-stringify-tinderbox;62;62;61;62;62;62;62;61;61;61 15:42:22 INFO - PROCESS | 29986 | |10;stanford-crypto-aes;81;81;86;81;80;82;90;81;80;81 15:42:22 INFO - PROCESS | 29986 | |11;stanford-crypto-ccm;137;144;129;140;134;137;136;152;172;134 15:42:22 INFO - PROCESS | 29986 | |12;stanford-crypto-pbkdf2;167;172;169;169;168;168;174;172;170;172 15:42:22 INFO - PROCESS | 29986 | |13;stanford-crypto-sha256-iterative;68;66;67;68;70;67;67;68;69;67 15:42:22 INFO - PROCESS | 29986 | __end_tp_report 15:42:22 INFO - PROCESS | 29986 | __start_cc_report 15:42:22 INFO - PROCESS | 29986 | _x_x_mozilla_cycle_collect,795 15:42:22 INFO - PROCESS | 29986 | __end_cc_report 15:42:22 INFO - PROCESS | 29986 | __startTimestamp1475707342236__endTimestamp 15:42:22 INFO - PROCESS | 29986 | 15:42:22 INFO - PROCESS | 29986 | ------- Summary: start ------- 15:42:22 INFO - PROCESS | 29986 | Number of tests: 14 15:42:22 INFO - PROCESS | 29986 | 15:42:22 INFO - PROCESS | 29986 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.00 stddev:2.18 (1.9%) stddev-sans-first:0.73 15:42:22 INFO - PROCESS | 29986 | Values: 106.0 112.0 113.0 113.0 113.0 113.0 113.0 112.0 111.0 113.0 15:42:22 INFO - PROCESS | 29986 | 15:42:22 INFO - PROCESS | 29986 | [#1] audio-beat-detection Cycles:10 Average:139.40 Median:130.50 stddev:17.52 (13.4%) stddev-sans-first:15.95 15:42:22 INFO - PROCESS | 29986 | Values: 165.0 129.0 126.0 163.0 129.0 132.0 129.0 127.0 166.0 128.0 15:42:22 INFO - PROCESS | 29986 | 15:42:22 INFO - PROCESS | 29986 | [#2] audio-dft Cycles:10 Average:165.00 Median:165.00 stddev:2.21 (1.3%) stddev-sans-first:2.22 15:42:22 INFO - PROCESS | 29986 | Values: 163.0 165.0 164.0 166.0 170.0 167.0 165.0 164.0 163.0 163.0 15:42:22 INFO - PROCESS | 29986 | 15:42:22 INFO - PROCESS | 29986 | [#3] audio-fft Cycles:10 Average:81.50 Median:76.50 stddev:10.55 (13.8%) stddev-sans-first:11.07 15:42:22 INFO - PROCESS | 29986 | Values: 77.0 77.0 77.0 102.0 76.0 76.0 77.0 76.0 101.0 76.0 15:42:22 INFO - PROCESS | 29986 | 15:42:22 INFO - PROCESS | 29986 | [#4] audio-oscillator Cycles:10 Average:89.80 Median:83.00 stddev:11.95 (14.4%) stddev-sans-first:12.34 15:42:22 INFO - PROCESS | 29986 | Values: 82.0 83.0 114.0 82.0 83.0 83.0 99.0 83.0 83.0 106.0 15:42:22 INFO - PROCESS | 29986 | 15:42:22 INFO - PROCESS | 29986 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 15:42:22 INFO - PROCESS | 29986 | Values: 118.0 118.0 118.0 119.0 118.0 118.0 118.0 118.0 119.0 117.0 15:42:22 INFO - PROCESS | 29986 | 15:42:22 INFO - PROCESS | 29986 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.50 stddev:0.97 (0.7%) stddev-sans-first:0.87 15:42:22 INFO - PROCESS | 29986 | Values: 149.0 147.0 147.0 146.0 147.0 149.0 147.0 148.0 147.0 148.0 15:42:22 INFO - PROCESS | 29986 | 15:42:22 INFO - PROCESS | 29986 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.33 15:42:22 INFO - PROCESS | 29986 | Values: 98.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 15:42:22 INFO - PROCESS | 29986 | 15:42:22 INFO - PROCESS | 29986 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.00 stddev:1.90 (3.4%) stddev-sans-first:2.00 15:42:22 INFO - PROCESS | 29986 | Values: 56.0 57.0 55.0 54.0 60.0 54.0 55.0 54.0 54.0 55.0 15:42:22 INFO - PROCESS | 29986 | 15:42:22 INFO - PROCESS | 29986 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:62.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 15:42:22 INFO - PROCESS | 29986 | Values: 62.0 62.0 61.0 62.0 62.0 62.0 62.0 61.0 61.0 61.0 15:42:22 INFO - PROCESS | 29986 | 15:42:22 INFO - PROCESS | 29986 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:81.00 stddev:3.20 (3.9%) stddev-sans-first:3.36 15:42:22 INFO - PROCESS | 29986 | Values: 81.0 81.0 86.0 81.0 80.0 82.0 90.0 81.0 80.0 81.0 15:42:22 INFO - PROCESS | 29986 | 15:42:22 INFO - PROCESS | 29986 | [#11] stanford-crypto-ccm Cycles:10 Average:141.50 Median:138.50 stddev:12.42 (9.0%) stddev-sans-first:13.07 15:42:22 INFO - PROCESS | 29986 | Values: 137.0 144.0 129.0 140.0 134.0 137.0 136.0 152.0 172.0 134.0 15:42:22 INFO - PROCESS | 29986 | 15:42:22 INFO - PROCESS | 29986 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.10 Median:171.00 stddev:2.28 (1.3%) stddev-sans-first:2.13 15:42:22 INFO - PROCESS | 29986 | Values: 167.0 172.0 169.0 169.0 168.0 168.0 174.0 172.0 170.0 172.0 15:42:22 INFO - PROCESS | 29986 | 15:42:22 INFO - PROCESS | 29986 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:1.16 (1.7%) stddev-sans-first:1.22 15:42:22 INFO - PROCESS | 29986 | Values: 68.0 66.0 67.0 68.0 70.0 67.0 67.0 68.0 69.0 67.0 15:42:22 INFO - PROCESS | 29986 | -------- Summary: end -------- 15:42:22 INFO - PROCESS | 29986 | 15:42:22 INFO - PROCESS | 29986 | 15:42:22 INFO - PROCESS | 29986 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 15:42:22 INFO - PROCESS | 29986 | 15:42:22 INFO - PROCESS | 29986 | 15:42:22 INFO - PROCESS | 29986 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 15:42:22 INFO - PROCESS | 29986 | 15:42:22 INFO - PROCESS | 29986 | 15:42:22 INFO - PROCESS | 29986 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 15:42:22 INFO - PROCESS | 29986 | 15:42:22 INFO - PROCESS | 29986 | 15:42:22 INFO - PROCESS | 29986 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000B,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 15:42:22 INFO - PROCESS | 29986 | 15:42:22 INFO - PROCESS | 29986 | 15:42:22 INFO - PROCESS | 29986 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 15:42:22 INFO - PROCESS | 29986 | 15:42:23 INFO - TEST-INFO | 29986: exit 0 15:42:23 INFO - TEST-OK | kraken | took 62444ms 15:42:23 INFO - SUITE-END | took 1177s 15:42:23 INFO - Completed test suite (00:19:37) 15:42:23 INFO - javascript benchmark 15:42:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7074.6694725411135, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2998.9400211995758, 3037.0585118613217, 3046.025271912987, 3054.6639869614346, 3056.954145687815, 5105.540501354887, 5216.791328346866, 5303.7082960437165, 5312.150055991042, 5356.982173387054, 5172.301739265198, 5178.430372659014, 5231.110711179099, 5272.551833094191, 5330.973345133269, 4714.434267887841, 4799.496052914446, 4823.493533179018, 4848.0, 4877.073356062355, 4813.711177329354, 4819.566239038486, 4868.732219727914, 4882.389701287339, 4932.235503496964, 4699.436067671867, 4705.505921878188, 4742.50203728607, 4821.9873826496305, 4862.805487780484, 4812.061647978646, 4841.104395686774, 4846.103470857903, 4879.780409881564, 4881.243407271843, 4771.475137734847, 4788.664793464424, 4797.232442809169, 4818.494058123882, 4857.781399837016, 5172.612054095958, 5229.555487783543, 5302.73486325686, 5317.521423071903, 5377.327834020747, 5410.242566040757, 5421.593380496479, 5437.755301011464, 5446.0, 5505.559555235572, 5467.781288748485, 5470.124780035176, 5481.835544933659, 5487.42382049883, 5515.310586176728, 5130.384353877521, 5131.974340128276, 5134.5378915897745, 5184.611154163453, 5198.2722418861385, 5660.0, 5688.061469857427, 5742.310922689304, 5746.482816546531, 5748.540116790647, 5529.751161197756, 5532.778688852401, 5532.834014979557, 5539.113741801292, 5541.667499950016, 5576.749046292926, 5600.943990560124, 5605.383407825136, 5620.57845661577, 5628.0, 5652.7738890443925, 5686.914696279559, 5692.715364231772, 5710.057840456361, 5734.05388110957, 5676.517496012802, 5686.744096515667, 5691.0609749391715, 5699.059655156852, 5703.7148142592705, 4297.978510107429, 4332.870013899588, 4395.780210989437, 4407.493138289138, 4461.0, 3871.090293780959, 3886.3393223151566, 3892.591277915835, 3904.72666913319, 3972.5431575369203, 5357.062514060024, 5391.7304134793885, 5393.352797664305, 5410.404855465896, 5461.590380721462, 5550.611457197957, 5711.543076553866, 5715.657060576379, 5718.056520674042, 5723.370429252779, 5297.205419187076, 5319.707416092075, 5335.0, 5419.34967803866, 5502.642328248651, 4813.687110337887, 4819.6867203631655, 4838.491958344323, 4853.854384368475, 4905.533974272438, 5821.330546987066, 5821.476067153976, 5822.505087067647, 5826.126081087701, 5831.591788574759, 5504.53211477029, 5550.916736249041, 5566.777328906798, 5650.85872853182, 5654.717264136694, 5699.715014249188, 5709.20071190042, 5709.457601527848, 5710.828675139753, 5771.769129234784, 5412.404635490172, 5468.808591699271, 5472.5348345391085, 5483.095289277225, 5507.173923911445, 5579.776808927598, 5646.7458964347525, 5660.433956604306, 5700.25896633435, 5701.230333904869, 5534.446555344433, 5537.9169312459535, 5540.113581826889, 5547.944520554743, 5552.167174923632, 5369.0, 5404.405515393225, 5526.47498487643, 5546.694931778629, 5576.442355764553, 5413.431589683027, 5440.782368705208, 5443.374011988672, 5443.537299329601, 5449.591280653887, 5456.427075157051, 5493.313335833021, 5497.285352904097, 5511.090670039399, 5512.3385193777, 5352.223927530564, 5352.625316227826, 5363.490468405495, 5364.061289274439, 5364.6512976656395], "value": 5186.69573774744, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.7436153730821, 576.5416493887358, 583.1602492410927, 586.3579380578266, 595.8599729063671, 36820.44769328459, 41319.38020929685, 41390.37914431286, 41435.17129657405, 41619.79190104049, 41509.58490415095, 41850.37224441636, 41959.58040419595, 41983.16033679325, 42043.78978105113, 8665.69670061548, 8811.030786613468, 8825.558722063903, 8825.691100811473, 8830.602622881954, 8699.347548933856, 8716.0, 8722.084181160983, 8753.168448997336, 8786.428882122642, 8819.60311785968, 8875.423097498675, 8920.687775927843, 8937.106289371044, 8953.776155596097, 8834.955825220864, 8842.557872106368, 8856.070112638208, 8878.42290251135, 8888.0, 8748.650053997833, 8838.160374764388, 8844.69043583478, 8844.955775221148, 8846.955765221197, 34887.0, 34889.12777180565, 35124.82437587796, 35185.47221791675, 35224.0, 3385.3737058643983, 3463.584369875631, 3665.21197942441, 3984.8007599619905, 4000.219957108365, 31007.37985240305, 31570.684293157003, 31928.521072183936, 32272.193195170075, 32382.6761732382, 4209.5790420957965, 4270.487541495009, 4322.891927701801, 4328.675349348811, 4358.2808836541935, 324560.0, 325745.9999999976, 326067.0, 326667.0, 327045.0, 55837.0, 56119.43880561142, 56142.0, 56220.71889640608, 56293.0, 59507.0, 59540.70229648824, 59696.0, 59722.40277597255, 59739.40260597338, 13559.118657287245, 13646.454141834414, 13653.590392288248, 13663.38514766838, 13669.111507751964, 11161.553537858395, 11335.489902954221, 11397.487113079931, 11480.483378247998, 11655.41722913851, 15841.603959901095, 16390.426335078453, 16581.25384357707, 16620.83379166217, 16673.583160420843, 5459.454054594509, 5521.889562208733, 5604.551635869121, 5613.410591887875, 5637.3235211774845, 888.9511076890703, 950.3490109275168, 994.7910938702809, 1033.214756784849, 1060.8886066963012, 31507.842460788008, 31560.210994725316, 31757.682423175935, 31797.682023179936, 32122.678773212436, 1050.0916707048348, 1068.2308737708838, 1102.8070087734775, 1116.938568378747, 1122.6239209864623, 15725.528234152993, 16543.420980265633, 16572.75140872888, 16709.164541773105, 16876.662466750597, 541192.0, 544909.0, 545875.0, 546991.0, 547382.0, 56432.0, 56700.432995669515, 56833.0, 56937.715311424006, 56995.99999999917, 1285.7685616589104, 1304.7194853106437, 1322.550332886804, 1342.442886202215, 1346.6431395680152, 29661.847341371795, 30903.0, 30977.380452391277, 31398.0, 31855.36289274248, 49693.0, 49791.0, 50127.49872501374, 50202.246966294806, 50216.497835022645, 477266.0, 478208.0, 479276.0, 482868.0, 483295.0, 40022.799886000386, 40140.197196055335, 40591.0, 40939.59060409358, 41241.0, 45773.77113114413, 46671.533284666715, 47438.76280618575, 47471.287930681756, 48064.27903581519, 37675.81162094172, 38800.835974920796, 39669.404958925064, 41280.38079428751, 41386.379204312565, 37350.8132459336, 39750.60249397585, 40545.1890962185, 40617.18765624612, 40657.18685626212, 39242.0, 40194.0, 40342.79828600838, 40715.0, 40834.0, 33641.831790840886, 35192.64807351894, 37249.441258380604, 42525.78737106295, 43333.56666433295, 29868.70131298746, 33312.167195819326, 33821.83089084539, 34027.65972340344, 34474.655253448145], "value": 19683.445479906168, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.84262452394523, 384.76260544931205, 393.5690418991205, 399.38295333709414, 414.87761110472405, 13996.720065598707, 17770.0, 18380.632387352245, 19387.127579258933, 19428.90285548572, 16155.596110097253, 16742.24659890305, 17080.572985675364, 17268.050257235845, 17887.552811179696, 4935.950640493594, 5229.50319719626, 5260.8158714445, 5281.287026251445, 5285.577153827685, 5121.0, 5199.804045069636, 5207.140821764404, 5216.2958000669805, 5224.111900976843, 5111.872203194913, 5297.44376840432, 5339.466053394668, 5348.572114230852, 5354.491323324298, 5162.406323272797, 5248.448912864133, 5254.343207099113, 5258.237555554461, 5275.525202731734, 5089.592832573422, 5145.922811157836, 5152.819651312224, 5156.432792392834, 5168.095583272912, 22010.779892201193, 22699.773002269932, 22796.316110516713, 23001.009868717127, 23105.422364440856, 2394.688690470245, 2440.133752517866, 2601.2586412872242, 2691.7846572274366, 2918.1391489510434, 9927.106560409526, 10113.69658910234, 10279.331843430227, 10336.896631033744, 10776.40729759863, 1880.6708825955402, 1892.706630472279, 1901.2490066423686, 1913.033917871466, 1964.5285131568464, 80176.59911700404, 81956.59021704854, 82424.0, 82470.58764706198, 85248.57375713144, 10940.56237750497, 11030.448477576088, 11306.265092769108, 11436.885631143748, 11933.641990740292, 15689.215539222992, 15754.9212253938, 15757.133357665209, 15772.76340854888, 15777.132257725705, 6975.616341101187, 7032.789016329416, 7271.236520165412, 7398.630068496554, 7418.851622967619, 6970.233274339818, 7104.076470058859, 7286.562806231537, 7418.072740907387, 7543.509671871311, 4660.7436590987145, 4707.576318131385, 4805.519448055236, 4820.180569303227, 4829.396325459317, 1902.7811801642988, 2007.6185524750251, 2013.848961327877, 2045.384146524259, 2051.3948385226395, 879.5030807593689, 967.4823969176457, 1019.1846522781893, 1021.9693409197736, 1055.3404122423485, 19486.610267794847, 19673.508162296057, 19736.30922917691, 19809.20763169457, 19836.0, 976.1166144639113, 978.4227305889559, 1009.8636684047707, 1029.1869423155772, 1054.9367037977745, 10293.845592316122, 10961.12311015117, 11080.722981925355, 11102.722431939104, 11118.49966751482, 337970.0, 343859.0, 432786.0, 435338.0, 436930.0, 96337.51831240799, 96405.5179724097, 98175.50912245536, 100109.99890001153, 102454.0, 986.5264672957021, 1001.6944831826218, 1060.1306928318859, 1065.1372388365294, 1070.4273213830563, 16770.0, 16975.57561060934, 17442.82557174412, 17680.646387072444, 17865.0, 28553.28616784597, 30579.694203057683, 34496.310073798886, 35035.824820876755, 36989.630103699696, 44911.55088449074, 50050.74974625104, 54111.45888541064, 54156.458435415145, 55163.44836551743, 7942.364610831004, 8188.181181881764, 8419.747407577783, 8433.19884610961, 8603.440776349516, 7030.3321184487395, 10872.67381978542, 11810.0, 11989.580364687194, 12537.93731031339, 10561.630342938268, 10724.249302548747, 10899.400532970763, 11010.0, 11135.276207046516, 10615.840762388725, 10718.8928110721, 10832.75423326296, 11154.721131971766, 11204.215704900578, 11094.167937404565, 11160.274582152135, 11195.88804111981, 11419.771604568028, 11451.454053702977, 8149.6332665031405, 8188.385871059575, 8420.284275836622, 8628.52543110135, 8710.040240945737, 10826.40454774995, 10923.945380273048, 11007.284526505751, 11258.718532036764, 11599.88400115988], "value": 8836.376467659033, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1427.5003748687961, 1459.0734883349073, 1578.889477736558, 1708.0605666883228, 1754.4999675092602, 7504.324610785028, 7724.1117271513795, 8019.879701804471, 8633.870491942618, 8646.481211127337, 7970.402219833507, 8221.876671849912, 8255.215754503328, 8354.665813367457, 8403.789905252357, 2036.6741321388618, 2060.546679730457, 2061.9587608247825, 2069.544700165961, 2079.2099002379073, 1997.0813425824065, 2027.7262569553143, 2099.1708275231276, 2166.2959538150085, 2180.6728990651372, 2032.908519116636, 2034.9186032558755, 2051.148773259096, 2056.064490656755, 2058.166442590753, 2024.028466336167, 2031.0, 2032.4613977296028, 2040.5612793249375, 2045.6317862784692, 1976.4169569976748, 2032.3699653107435, 2119.2582596091397, 2144.2816656419964, 2171.5005548723884, 8466.915330846674, 8475.533845638487, 8510.0, 8567.057623661454, 8574.871376929352, 4696.577308042292, 4826.420829500483, 4828.975855120737, 4830.347903033081, 4831.565159135695, 3076.9384612307626, 3199.3441344524317, 3303.96696033039, 3304.339132173575, 3311.0563489405404, 1010.0959641121228, 1055.0406110859037, 1077.4558847781898, 1078.6063086973277, 1082.2748758331936, 11295.774084518345, 11298.943505282503, 11310.0, 11395.088392928628, 11435.771284574344, 3945.151792364655, 4192.832286708497, 4199.97900010498, 4302.118065796504, 4319.33050377192, 9736.902630973742, 9746.902530974741, 9752.21982241419, 9761.219102471785, 9779.119879210904, 4992.875178120504, 4996.775145118479, 5000.349954505964, 5007.37407824022, 5011.4236862761245, 3993.281209382339, 4106.568810274938, 4407.713498622579, 4587.885302867455, 4595.172868883633, 3703.333399988028, 3753.193063491308, 3825.407061905409, 3864.787436691009, 3913.7651740895067, 1267.790814515613, 1268.7335659511607, 1271.110222844013, 1272.7263638317806, 1297.4485843516468, 820.9343252539783, 919.9632014719336, 940.7130825098411, 961.8412961861214, 985.8176237396104, 5726.255586773693, 5795.652260864362, 5880.676562789087, 5995.310539287951, 6025.307089684742, 882.2280504558511, 954.5465903695689, 965.1313817564109, 974.1670871404989, 1009.8687170667766, 3732.5924778517706, 3967.603239676067, 3969.761814291152, 4030.8992275193355, 4246.214450326699, 9993.700188994342, 10347.223958203165, 10377.0, 10421.06210441064, 10430.791384172426, 10177.287589868785, 10259.281850270409, 10377.0, 10430.843537346946, 10453.529591168415, 7744.57404842739, 7787.338076263581, 7842.098158711707, 7931.84136317282, 7952.324052455606, 5576.86057848557, 5646.774129034792, 5690.004249256281, 5691.601587888974, 5891.1752354671235, 9407.576659050223, 9452.43285402878, 9496.14534691881, 9513.238940884574, 9581.473018984023, 9120.635174592942, 9503.0, 9527.951925288075, 9797.412155270422, 9818.509074546388, 6778.4577233822165, 6959.40845028158, 7266.273372662691, 7515.586642734702, 7519.812004699927, 7730.536167829948, 7920.683172673029, 7984.600769961363, 8194.67221311141, 8206.0, 7236.96381518089, 7401.777946661608, 7436.367908727819, 7443.665035073326, 7590.430717696085, 7204.279572042754, 7234.5659260444545, 7380.520266182681, 7402.29678180572, 7422.591757453176, 6601.735930562723, 6614.470842332698, 6657.633830139195, 6667.766628167991, 6720.563163394364, 4882.6084565898545, 5142.53717165442, 5145.305383773292, 5163.767630456563, 5214.97392513035, 5008.100022859041, 5030.62270329734, 5137.6660517066275, 5183.688978661293, 5201.089809283285], "value": 4390.29406327458, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.1073428299339, 328.6795374509853, 334.26128256553017, 336.36930754834685, 338.82719812895425, 5268.894622107556, 5419.268398766166, 5471.398146203915, 5521.0, 5562.274485502106, 5212.50481204285, 5297.814576489824, 5342.171963345678, 5346.385165705945, 5357.464253574641, 4226.366045093245, 4226.387173859796, 4246.80889359978, 4270.402143699885, 4275.636570891478, 4181.205570941526, 4194.748315101088, 4239.321708526621, 4271.551487093857, 4288.506821715511, 4184.937225941613, 4195.748255104688, 4198.3282674772045, 4205.65419065899, 4213.07312391275, 4190.434291370657, 4198.9370159447635, 4212.389203565496, 4215.936760948588, 4229.450171477688, 3764.682361173595, 3800.1259710266795, 3802.334591446486, 3803.9429408558894, 3808.485854409647, 5080.272707279542, 5328.333958255218, 5337.653052551611, 5344.706041167734, 5363.839084827461, 4832.806687732486, 4866.026794641086, 4874.488178741217, 4884.633652476078, 4902.730349830758, 5395.649282796606, 5688.374278829326, 5689.260396148516, 5706.800261990852, 5733.16869053989, 4026.235015347104, 4032.1532478179615, 4048.392741088831, 4054.4121102440276, 4057.310257256244, 5910.113482977587, 5988.933817832884, 6004.879902401927, 6008.7896923607905, 6025.4333873192845, 3869.3228684980018, 4185.267578173807, 4215.178040282177, 4217.472815898012, 4226.725262857966, 4096.610821971908, 4108.815103320358, 4111.527174374925, 4115.0, 4118.485189351331, 4672.906541869143, 4683.297505374221, 4683.976580117146, 4742.976285118552, 4768.237082066853, 5534.833954981357, 5669.546436285087, 5699.316082070095, 5715.1713001614535, 5723.742431590588, 1423.2527922840384, 1447.6319877715457, 1450.4778279819257, 1450.5639416977117, 1452.2790493265304, 895.2211575928983, 913.917747402737, 922.1930810540777, 932.5570354081757, 943.4292253186724, 4787.3537072495465, 4795.184818580849, 4848.248521479177, 4861.878453038702, 4876.951230487721, 5085.9147749422555, 5086.567641750493, 5117.462666420047, 5159.58723302135, 5204.620775494497, 4798.328234047236, 4822.239882442953, 4826.334914454507, 4849.830255941025, 5145.279660847485, 3068.401661675952, 3088.9960762752194, 3103.4258662147577, 3104.891328803481, 3110.315730539278, 6006.579539432198, 6032.728527216286, 6048.879022419527, 6049.364816694272, 6054.215061071868, 5585.184814935081, 5939.584229103922, 5952.642841429441, 5954.642721436728, 5984.970075149597, 6040.09398590215, 6057.729300842895, 6083.6045657032155, 6098.176746139215, 6112.205413296243, 5583.715745378667, 5850.23946886902, 5906.704664766658, 5926.703664816656, 5929.183637772197, 5833.766649333979, 5846.678432686073, 5851.882962340815, 5853.824385268449, 5861.0, 6017.669028203491, 6104.26748790148, 6115.174451448997, 6120.663363515049, 6124.8775024500155, 3948.7433316834313, 4176.477940257468, 4177.206330797138, 4182.247195504839, 4195.223883581547, 5893.499052580579, 5894.970525147347, 5904.439078287556, 5918.556108291809, 5942.168096466585, 5644.266245388073, 5661.377248502579, 5801.970990145022, 5817.185594016756, 5832.708364581669, 5686.317641883001, 5692.345380281155, 5696.063338464942, 5704.3154821421695, 5723.882163599495, 5714.571407144397, 5717.971410142923, 5719.256496655575, 5757.165211044459, 5771.163181338598, 5638.984982703153, 5655.4344565543115, 5663.518600918968, 5714.771409143754, 5756.165356023437, 5502.944970550243, 5514.476124768141, 5517.0, 5536.667799932017, 5550.38945715979], "value": 4293.214679093012, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [735.8896165575163, 738.7266711316812, 755.9622018899054, 821.1747194069959, 824.5094168969462, 15128.546143615695, 15891.443799467006, 15912.204389780509, 15914.363425462996, 15976.0, 13037.543685970993, 13146.0, 13181.670458238525, 13192.406341714646, 13206.141600795941, 803.8392321535687, 828.4076885027205, 831.7504748575434, 831.8710599857031, 833.0794472108324, 806.0850934189708, 821.1378053044309, 821.6179476543406, 822.3749950037984, 825.471698113205, 852.4118358332762, 853.1511146409331, 858.3347905373355, 858.4205661178711, 861.5821326656597, 855.5722138930535, 856.4647095565272, 856.5888373580685, 857.6055014693248, 858.8196478739441, 630.7603110817905, 631.9905201421982, 632.4908448698795, 635.3075148088559, 636.2873581588605, 14052.648683782885, 14111.647208819862, 14193.07744996572, 14204.147751134966, 14208.218547979857, 12557.74884502314, 12976.35118244084, 13454.385473743214, 13491.865081349159, 13506.932465337708, 11022.283551569202, 11478.655640330804, 11499.0, 11608.6517404478, 11614.128940329509, 3762.9059273518383, 3831.731778775487, 3858.151206734514, 4023.476947996771, 4048.352263637804, 74578.25421745822, 75221.24778752198, 77988.0, 78197.60901195515, 78899.81650275308, 9600.135987761136, 9763.071078676368, 9820.901790982141, 10045.648402305884, 10106.898931010743, 20578.27976020832, 20579.176832926816, 20595.691064634044, 20601.793982059986, 20664.276750313667, 8470.110638383005, 8520.233179013794, 8697.826043479095, 8845.955770221108, 8961.193492585568, 4415.470143582726, 4565.452145742533, 4749.786259618326, 4764.499727528629, 4796.232602783608, 3640.7633503822167, 3710.5547334320054, 3744.9625503744614, 3752.81235938202, 3766.2090960898518, 628.4972022382076, 644.4683136412478, 650.5446187668556, 650.9381608747161, 661.2428769059496, 558.4861927027144, 619.8140557832633, 651.3746803069012, 718.1669263654136, 725.8693435181613, 9439.24486041115, 9455.810883782424, 9455.858162127573, 9471.905280947103, 10500.264981451224, 693.8369781312127, 708.7342246657504, 713.2225873797586, 738.3871386748986, 756.1682149635357, 4359.9782001090425, 4822.758862056883, 4868.440129385166, 4904.141775189328, 4929.3345398371475, 72655.0, 91937.0, 92285.0, 95109.0, 109182.45408772906, 92880.0, 95406.09187816344, 95702.0, 97437.0, 97611.51194243983, 51655.48344516582, 73803.0, 85000.57499712461, 88819.0, 89089.55455222682, 9215.400998935047, 9446.622135114518, 9558.474283914451, 9565.321470605959, 9570.904290957002, 48939.26591101207, 49109.75445122751, 49952.0, 50583.0, 50594.74702626463, 66510.33489665041, 69975.65012174906, 74372.62813686114, 76041.61979190068, 76199.0, 12823.422945967268, 12932.935335323264, 12951.805722913976, 12999.285039322927, 13022.088453808521, 13487.662808429475, 13679.788670850989, 13961.624774461703, 14124.929375353058, 14208.431662733376, 12741.17182383142, 12843.327652491102, 13110.147840390344, 13304.600861974157, 13756.312184390541, 12773.489060437478, 13115.606531804062, 13204.603861883774, 13246.344206974129, 13894.583162504736, 12403.813942790684, 12961.0, 13171.473141074634, 13481.440802775845, 13706.38321275525, 10632.89367106319, 10805.837912431163, 10837.241393102408, 10925.945370273097, 11191.776164476501, 10202.489875506046, 11532.538698451968, 11659.242149260272, 11942.582009629621, 12022.939885300517], "value": 7373.08117475269, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1527.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 112.0, 113.0, 113.0, 113.0, 113.0, 113.0, 112.0, 111.0, 113.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 129.0, 126.0, 163.0, 129.0, 132.0, 129.0, 127.0, 166.0, 128.0], "value": 139.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 164.0, 166.0, 170.0, 167.0, 165.0, 164.0, 163.0, 163.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 77.0, 102.0, 76.0, 76.0, 77.0, 76.0, 101.0, 76.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 114.0, 82.0, 83.0, 83.0, 99.0, 83.0, 83.0, 106.0], "value": 89.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 119.0, 118.0, 118.0, 118.0, 118.0, 119.0, 117.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 147.0, 146.0, 147.0, 149.0, 147.0, 148.0, 147.0, 148.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 55.0, 54.0, 60.0, 54.0, 55.0, 54.0, 54.0, 55.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 62.0, 62.0, 62.0, 62.0, 61.0, 61.0, 61.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 86.0, 81.0, 80.0, 82.0, 90.0, 81.0, 80.0, 81.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 144.0, 129.0, 140.0, 134.0, 137.0, 136.0, 152.0, 172.0, 134.0], "value": 141.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 172.0, 169.0, 169.0, 168.0, 168.0, 174.0, 172.0, 170.0, 172.0], "value": 170.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 67.0, 68.0, 70.0, 67.0, 67.0, 68.0, 69.0, 67.0], "value": 67.7, "unit": "score"}]}]} 15:42:23 INFO - Return code: 0 15:42:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:42:23 ERROR - # TBPL SUCCESS # 15:42:23 INFO - Running post-action listener: _resource_record_post_action 15:42:23 INFO - [mozharness: 2016-10-05 22:42:23.550863Z] Finished run-tests step (success) 15:42:23 INFO - Running post-run listener: _resource_record_post_run 15:42:23 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 409333760; Read time: 20; Write time: 302520 15:42:23 INFO - TinderboxPrint: CPU usage
13.4% 15:42:23 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 15:42:23 INFO - TinderboxPrint: I/O write bytes / time
409,333,760 / 302,520 15:42:23 INFO - TinderboxPrint: CPU idle
8,250.9 (86.6%) 15:42:23 INFO - TinderboxPrint: CPU user
1,217.1 (12.8%) 15:42:23 INFO - TinderboxPrint: Swap in / out
0 / 0 15:42:23 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103591936; Read time: 0; Write time: 110144 15:42:23 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 288555008; Read time: 0; Write time: 187180 15:42:24 INFO - Running post-run listener: _upload_blobber_files 15:42:24 INFO - Blob upload gear active. 15:42:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:42:24 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 15:42:24 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:42:24 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:42:24 INFO - (blobuploader) - INFO - Open directory for files ... 15:42:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:42:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:42:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:42:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:42:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:42:28 INFO - (blobuploader) - INFO - Done attempting. 15:42:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:42:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:42:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:42:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:42:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:42:28 INFO - (blobuploader) - INFO - Done attempting. 15:42:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:42:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:42:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:42:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:42:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:42:29 INFO - (blobuploader) - INFO - Done attempting. 15:42:29 INFO - (blobuploader) - INFO - Iteration through files over. 15:42:29 INFO - Return code: 0 15:42:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:42:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:42:29 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c241afbabed9ff81284f50c724adb61064d6019b12de513d747d294723ed87f1efd511b1e6524e2fae5acdb1c1071216ee4b47efff3ad4ce0e783c0a74938b8b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d6f4470eaa2c493798d27fedc89d95ed903346c5ae41efca543835f2ba203942787d608a3f4d8de337ec0758ed8dfb508aaf1652ebd1cc7dcceb3f4a9a38a0e1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6b53c665c033f1e34a0ac5d22f32fc2ef1032eeeb89a20719a4fb15cc729bc4b04d0834b2e10f4a3c4c162a61bc0a45a5f41e4f35cdfeb55d81195e12e58bd08"} 15:42:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:42:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:42:29 INFO - Contents: 15:42:29 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c241afbabed9ff81284f50c724adb61064d6019b12de513d747d294723ed87f1efd511b1e6524e2fae5acdb1c1071216ee4b47efff3ad4ce0e783c0a74938b8b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d6f4470eaa2c493798d27fedc89d95ed903346c5ae41efca543835f2ba203942787d608a3f4d8de337ec0758ed8dfb508aaf1652ebd1cc7dcceb3f4a9a38a0e1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6b53c665c033f1e34a0ac5d22f32fc2ef1032eeeb89a20719a4fb15cc729bc4b04d0834b2e10f4a3c4c162a61bc0a45a5f41e4f35cdfeb55d81195e12e58bd08"} 15:42:29 INFO - Running post-run listener: copy_logs_to_upload_dir 15:42:29 INFO - Copying logs to upload dir... 15:42:29 INFO - mkdir: /builds/slave/test/build/upload/logs 15:42:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.816565 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-10-05 15:42:29.038498) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-05 15:42:29.042225) ========= 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=1f5564757af27664ca02d71f000001b0-1475703933.833021-41340357 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/Autoland/sha512/c241afbabed9ff81284f50c724adb61064d6019b12de513d747d294723ed87f1efd511b1e6524e2fae5acdb1c1071216ee4b47efff3ad4ce0e783c0a74938b8b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d6f4470eaa2c493798d27fedc89d95ed903346c5ae41efca543835f2ba203942787d608a3f4d8de337ec0758ed8dfb508aaf1652ebd1cc7dcceb3f4a9a38a0e1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6b53c665c033f1e34a0ac5d22f32fc2ef1032eeeb89a20719a4fb15cc729bc4b04d0834b2e10f4a3c4c162a61bc0a45a5f41e4f35cdfeb55d81195e12e58bd08"} build_url:https://queue.taskcluster.net/v1/task/Hrysc99USlGEd7SVj3uDpw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011343 build_url: 'https://queue.taskcluster.net/v1/task/Hrysc99USlGEd7SVj3uDpw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c241afbabed9ff81284f50c724adb61064d6019b12de513d747d294723ed87f1efd511b1e6524e2fae5acdb1c1071216ee4b47efff3ad4ce0e783c0a74938b8b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d6f4470eaa2c493798d27fedc89d95ed903346c5ae41efca543835f2ba203942787d608a3f4d8de337ec0758ed8dfb508aaf1652ebd1cc7dcceb3f4a9a38a0e1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6b53c665c033f1e34a0ac5d22f32fc2ef1032eeeb89a20719a4fb15cc729bc4b04d0834b2e10f4a3c4c162a61bc0a45a5f41e4f35cdfeb55d81195e12e58bd08"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-05 15:42:29.070303) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 15:42:29.070646) ========= 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=1f5564757af27664ca02d71f000001b0-1475703933.833021-41340357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004441 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 15:42:29.157431) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-05 15:42:29.157771) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-05 15:42:29.158093) ========= ========= Total master_lag: 0.21 =========