builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-011 starttime: 1480332768.69 results: success (0) buildid: 20161128004004 builduid: 7d2c7f026e5545e5bf580fbb275befca revision: d8e4710b55d980cb3a63f8bae224595d7ef256a0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-28 03:32:48.693310) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-28 03:32:48.693787) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-28 03:32:48.694174) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-28 03:32:48.709289) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 03:32:48.709685) ========= 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=5cf47e208febbcd81da23b2e0000026f-1480331097.732306-1450121767 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-28 03:32:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2016-11-28 03:32:49 (46.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.086337 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 03:32:48.809982) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 03:32:48.810319) ========= 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=5cf47e208febbcd81da23b2e0000026f-1480331097.732306-1450121767 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015950 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 03:32:48.860579) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 03:32:48.860935) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d8e4710b55d980cb3a63f8bae224595d7ef256a0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d8e4710b55d980cb3a63f8bae224595d7ef256a0 --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=5cf47e208febbcd81da23b2e0000026f-1480331097.732306-1450121767 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-28 03:32:50,063 truncating revision to first 12 chars 2016-11-28 03:32:50,063 Setting DEBUG logging. 2016-11-28 03:32:50,063 attempt 1/10 2016-11-28 03:32:50,063 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d8e4710b55d9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-28 03:32:50,379 unpacking tar archive at: mozilla-aurora-d8e4710b55d9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.658714 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 03:32:49.532581) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-28 03:32:49.532859) ========= script_repo_revision: d8e4710b55d980cb3a63f8bae224595d7ef256a0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-28 03:32:49.533236) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-28 03:32:49.533544) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-28 03:32:49.542081) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-11-28 03:32:49.542410) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=5cf47e208febbcd81da23b2e0000026f-1480331097.732306-1450121767 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:32:50 INFO - MultiFileLogger online at 20161128 03:32:50 in /builds/slave/test 03:32:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:32:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:32:50 INFO - {'append_to_log': False, 03:32:50 INFO - 'base_work_dir': '/builds/slave/test', 03:32:50 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:32:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:32:50 INFO - 'branch': 'Mozilla-Aurora', 03:32:50 INFO - 'buildbot_json_path': 'buildprops.json', 03:32:50 INFO - 'config_files': ('talos/linux_config.py',), 03:32:50 INFO - 'default_actions': ('clobber', 03:32:50 INFO - 'read-buildbot-config', 03:32:50 INFO - 'download-and-extract', 03:32:50 INFO - 'populate-webroot', 03:32:50 INFO - 'create-virtualenv', 03:32:50 INFO - 'install', 03:32:50 INFO - 'run-tests'), 03:32:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:32:50 INFO - 'download_minidump_stackwalk': True, 03:32:50 INFO - 'download_symbols': 'ondemand', 03:32:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:32:50 INFO - 'tooltool.py': '/tools/tooltool.py', 03:32:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:32:50 INFO - '/tools/misc-python/virtualenv.py')}, 03:32:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:32:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:32:50 INFO - 'installer_path': 'installer.exe', 03:32:50 INFO - 'log_level': 'info', 03:32:50 INFO - 'log_name': 'talos', 03:32:50 INFO - 'log_to_console': True, 03:32:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:32:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:32:50 INFO - 'opt_config_files': (), 03:32:50 INFO - 'pip_index': False, 03:32:50 INFO - 'sps_profile': False, 03:32:50 INFO - 'sps_profile_interval': 0, 03:32:50 INFO - 'suite': 'dromaeojs', 03:32:50 INFO - 'system_bits': '32', 03:32:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:32:50 INFO - 'title': 'talos-linux64-ix-011', 03:32:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:32:50 INFO - 'use_talos_json': True, 03:32:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:32:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:32:50 INFO - 'work_dir': 'build'} 03:32:50 INFO - [mozharness: 2016-11-28 11:32:50.837960Z] Running clobber step. 03:32:50 INFO - Running pre-action listener: _resource_record_pre_action 03:32:50 INFO - Running main action method: clobber 03:32:50 INFO - rmtree: /builds/slave/test/build 03:32:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:32:51 INFO - Running post-action listener: _resource_record_post_action 03:32:51 INFO - [mozharness: 2016-11-28 11:32:51.299283Z] Finished clobber step (success) 03:32:51 INFO - [mozharness: 2016-11-28 11:32:51.299382Z] Running read-buildbot-config step. 03:32:51 INFO - Running pre-action listener: _resource_record_pre_action 03:32:51 INFO - Running main action method: read_buildbot_config 03:32:51 INFO - Using buildbot properties: 03:32:51 INFO - { 03:32:51 INFO - "project": "", 03:32:51 INFO - "product": "firefox", 03:32:51 INFO - "script_repo_revision": "production", 03:32:51 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:32:51 INFO - "repository": "", 03:32:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:32:51 INFO - "buildid": "20161128004004", 03:32:51 INFO - "stage_platform": "linux64-pgo", 03:32:51 INFO - "basedir": "/builds/slave/test", 03:32:51 INFO - "nightly_build": "True", 03:32:51 INFO - "buildnumber": 648, 03:32:51 INFO - "slavename": "talos-linux64-ix-011", 03:32:51 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:32:51 INFO - "platform": "ubuntu64_hw", 03:32:51 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:32:51 INFO - "branch": "mozilla-aurora", 03:32:51 INFO - "repo_path": "releases/mozilla-aurora", 03:32:51 INFO - "revision": "d8e4710b55d980cb3a63f8bae224595d7ef256a0", 03:32:51 INFO - "pgo_build": "True", 03:32:51 INFO - "builduid": "7d2c7f026e5545e5bf580fbb275befca", 03:32:51 INFO - "slavebuilddir": "test" 03:32:51 INFO - } 03:32:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/GeRxbj7MR1qvJudTL3AeOA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 03:32:51 INFO - Running post-action listener: _resource_record_post_action 03:32:51 INFO - [mozharness: 2016-11-28 11:32:51.301936Z] Finished read-buildbot-config step (success) 03:32:51 INFO - [mozharness: 2016-11-28 11:32:51.302031Z] Running download-and-extract step. 03:32:51 INFO - Running pre-action listener: _resource_record_pre_action 03:32:51 INFO - Running main action method: download_and_extract 03:32:51 INFO - mkdir: /builds/slave/test/build/tests 03:32:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:32:51 INFO - trying https://queue.taskcluster.net/v1/task/GeRxbj7MR1qvJudTL3AeOA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 03:32:51 INFO - Downloading https://queue.taskcluster.net/v1/task/GeRxbj7MR1qvJudTL3AeOA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 03:32:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GeRxbj7MR1qvJudTL3AeOA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:32:51 INFO - Downloaded 1361 bytes. 03:32:51 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 03:32:51 INFO - Using the following test package requirements: 03:32:51 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 03:32:51 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:32:51 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:32:51 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:32:51 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:32:51 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:32:51 INFO - u'jsshell-linux-x86_64.zip'], 03:32:51 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:32:51 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:32:51 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 03:32:51 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:32:51 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:32:51 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:32:51 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:32:51 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:32:51 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:32:51 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:32:51 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:32:51 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:32:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GeRxbj7MR1qvJudTL3AeOA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 03:32:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GeRxbj7MR1qvJudTL3AeOA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:32:51 INFO - Fetch https://queue.taskcluster.net/v1/task/GeRxbj7MR1qvJudTL3AeOA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 03:32:52 INFO - Http code: 200 03:32:52 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 03:32:52 INFO - x-amz-cf-id: y9X24ngm9l-bkKVaCRBx6zkoQOhEFCJH8BSAr6UnBAz7OY0nLCbFMA== 03:32:52 INFO - x-amz-version-id: 7X_hKWVJhewyLd5y_B0JX8_Qb6DPMmvm 03:32:52 INFO - Expected file size: 21951211 03:32:52 INFO - Obtained file size: 21951211 03:32:56 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:32:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GeRxbj7MR1qvJudTL3AeOA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 03:32:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GeRxbj7MR1qvJudTL3AeOA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:32:56 INFO - Fetch https://queue.taskcluster.net/v1/task/GeRxbj7MR1qvJudTL3AeOA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 03:32:57 INFO - Http code: 200 03:32:57 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 03:32:57 INFO - x-amz-cf-id: Y1fL_Iej7vd-5Ydhp44YK7-PS8aGPgTySBDkh2NjPxyUW9DY4L_z4w== 03:32:57 INFO - x-amz-version-id: 7X_hKWVJhewyLd5y_B0JX8_Qb6DPMmvm 03:32:57 INFO - Expected file size: 21951211 03:32:57 INFO - Obtained file size: 21951211 03:33:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GeRxbj7MR1qvJudTL3AeOA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 03:33:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GeRxbj7MR1qvJudTL3AeOA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:33:01 INFO - Fetch https://queue.taskcluster.net/v1/task/GeRxbj7MR1qvJudTL3AeOA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 03:33:02 INFO - Http code: 200 03:33:02 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 03:33:02 INFO - x-amz-cf-id: SJRQ5e4sYOCv5K3pnkozbjqYLgsPw6N4xRgbwv-u4JFaLnmntKwFdg== 03:33:02 INFO - x-amz-version-id: tQnh4hDze2wcTz3BF2N2oXF8ndzipEzs 03:33:03 INFO - Expected file size: 14409038 03:33:03 INFO - Obtained file size: 14409038 03:33:03 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')]} 03:33:03 INFO - trying https://queue.taskcluster.net/v1/task/GeRxbj7MR1qvJudTL3AeOA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:33:03 INFO - Downloading https://queue.taskcluster.net/v1/task/GeRxbj7MR1qvJudTL3AeOA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:33:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GeRxbj7MR1qvJudTL3AeOA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:33:06 INFO - Downloaded 63956195 bytes. 03:33:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GeRxbj7MR1qvJudTL3AeOA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:33:06 INFO - mkdir: /builds/slave/test/properties 03:33:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:33:06 INFO - Writing to file /builds/slave/test/properties/build_url 03:33:06 INFO - Contents: 03:33:06 INFO - build_url:https://queue.taskcluster.net/v1/task/GeRxbj7MR1qvJudTL3AeOA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:33:07 INFO - Running post-action listener: _resource_record_post_action 03:33:07 INFO - Running post-action listener: set_extra_try_arguments 03:33:07 INFO - [mozharness: 2016-11-28 11:33:07.104881Z] Finished download-and-extract step (success) 03:33:07 INFO - [mozharness: 2016-11-28 11:33:07.105106Z] Running populate-webroot step. 03:33:07 INFO - Running pre-action listener: _resource_record_pre_action 03:33:07 INFO - Running main action method: populate_webroot 03:33:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:33:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:33:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:33:07 INFO - '--tppagecycles', 03:33:07 INFO - '7'], 03:33:07 INFO - 'tests': ['tsvgm']}}, 03:33:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:33:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:33:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:33:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:33:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:33:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:33:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:07 INFO - 'talos_options': ['--disable-e10s'], 03:33:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:33:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:33:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:07 INFO - 'talos_options': ['--disable-e10s'], 03:33:07 INFO - 'tests': ['damp', 'tps']}, 03:33:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:07 INFO - 'tests': ['damp', 'tps']}, 03:33:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:33:07 INFO - 'tests': ['dromaeo_dom']}, 03:33:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:33:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:33:07 INFO - 'tests': ['basic_compositor_video']}, 03:33:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:33:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:33:07 INFO - 'tests': ['a11yr', 03:33:07 INFO - 'ts_paint', 03:33:07 INFO - 'tpaint', 03:33:07 INFO - 'sessionrestore', 03:33:07 INFO - 'sessionrestore_no_auto_restore', 03:33:07 INFO - 'tabpaint']}, 03:33:07 INFO - 'other-e10s': {'tests': ['a11yr', 03:33:07 INFO - 'ts_paint', 03:33:07 INFO - 'tpaint', 03:33:07 INFO - 'sessionrestore', 03:33:07 INFO - 'sessionrestore_no_auto_restore', 03:33:07 INFO - 'tabpaint']}, 03:33:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:33:07 INFO - 'ts_paint', 03:33:07 INFO - 'tpaint', 03:33:07 INFO - 'sessionrestore', 03:33:07 INFO - 'sessionrestore_no_auto_restore', 03:33:07 INFO - 'tabpaint']}, 03:33:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:33:07 INFO - 'ts_paint', 03:33:07 INFO - 'tpaint', 03:33:07 INFO - 'sessionrestore', 03:33:07 INFO - 'sessionrestore_no_auto_restore', 03:33:07 INFO - 'tabpaint']}, 03:33:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:33:07 INFO - 'tests': ['a11yr', 03:33:07 INFO - 'ts_paint', 03:33:07 INFO - 'tpaint', 03:33:07 INFO - 'sessionrestore', 03:33:07 INFO - 'sessionrestore_no_auto_restore', 03:33:07 INFO - 'tabpaint']}, 03:33:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:33:07 INFO - 'tests': ['a11yr', 03:33:07 INFO - 'ts_paint', 03:33:07 INFO - 'tpaint', 03:33:07 INFO - 'sessionrestore', 03:33:07 INFO - 'sessionrestore_no_auto_restore', 03:33:07 INFO - 'tabpaint']}, 03:33:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:33:07 INFO - 'tests': ['tsvgx', 03:33:07 INFO - 'tsvgr_opacity', 03:33:07 INFO - 'tart', 03:33:07 INFO - 'tscrollx', 03:33:07 INFO - 'cart']}, 03:33:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:33:07 INFO - 'tsvgr_opacity', 03:33:07 INFO - 'tart', 03:33:07 INFO - 'tscrollx', 03:33:07 INFO - 'cart']}, 03:33:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:07 INFO - 'talos_options': ['--disable-e10s'], 03:33:07 INFO - 'tests': ['tp5o']}, 03:33:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:07 INFO - 'tests': ['tp5o']}, 03:33:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:07 INFO - 'talos_options': ['--disable-e10s', 03:33:07 INFO - '--xperf_path', 03:33:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:33:07 INFO - 'tests': ['tp5n']}, 03:33:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:07 INFO - 'talos_options': ['--xperf_path', 03:33:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:33:07 INFO - 'tests': ['tp5n']}}, 03:33:07 INFO - 'talos.zip': {'path': '', 03:33:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:33:07 INFO - Running post-action listener: _resource_record_post_action 03:33:07 INFO - [mozharness: 2016-11-28 11:33:07.126485Z] Finished populate-webroot step (success) 03:33:07 INFO - [mozharness: 2016-11-28 11:33:07.126573Z] Running create-virtualenv step. 03:33:07 INFO - Running pre-action listener: _resource_record_pre_action 03:33:07 INFO - Running main action method: create_virtualenv 03:33:07 INFO - Creating virtualenv /builds/slave/test/build/venv 03:33:07 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 03:33:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:33:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:33:07 INFO - Using real prefix '/usr' 03:33:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:33:07 INFO - Installing distribute.............................................................................................................................................................................................done. 03:33:09 INFO - Installing pip.................done. 03:33:09 INFO - Return code: 0 03:33:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:33:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:33:09 INFO - Reading from file tmpfile_stdout 03:33:09 INFO - Output received: 03:33:09 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) 03:33:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:33:09 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')]} 03:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:09 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')]} 03:33:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:09 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 0x7fd841e5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1449ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1446f60>, '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 0x1447d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14481d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1480331097.732306-1450121767', '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 03:33:09 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 03:33:09 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 03:33:09 INFO - Using env: {'DISPLAY': ':0', 03:33:09 INFO - 'HOME': '/home/cltbld', 03:33:09 INFO - 'LANG': 'en_US.UTF-8', 03:33:09 INFO - 'LANGUAGE': 'en_US:en', 03:33:09 INFO - 'LOGNAME': 'cltbld', 03:33:09 INFO - 'MAIL': '/var/mail/cltbld', 03:33:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:09 INFO - 'MOZ_NO_REMOTE': '1', 03:33:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:09 INFO - 'NO_EM_RESTART': '1', 03:33:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:09 INFO - 'PWD': '/builds/slave/test', 03:33:09 INFO - 'SHELL': '/bin/bash', 03:33:09 INFO - 'SHLVL': '1', 03:33:09 INFO - 'TERM': 'linux', 03:33:09 INFO - 'TMOUT': '86400', 03:33:09 INFO - 'USER': 'cltbld', 03:33:09 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480331097.732306-1450121767', 03:33:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:09 INFO - '_': '/tools/buildbot/bin/python'} 03:33:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:10 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 03:33:10 INFO - Cleaning up... 03:33:10 INFO - Return code: 0 03:33:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:33:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:10 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 0x7fd841e5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1449ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1446f60>, '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 0x1447d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14481d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1480331097.732306-1450121767', '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 03:33:10 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 03:33:10 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 03:33:10 INFO - Using env: {'DISPLAY': ':0', 03:33:10 INFO - 'HOME': '/home/cltbld', 03:33:10 INFO - 'LANG': 'en_US.UTF-8', 03:33:10 INFO - 'LANGUAGE': 'en_US:en', 03:33:10 INFO - 'LOGNAME': 'cltbld', 03:33:10 INFO - 'MAIL': '/var/mail/cltbld', 03:33:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:10 INFO - 'MOZ_NO_REMOTE': '1', 03:33:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:10 INFO - 'NO_EM_RESTART': '1', 03:33:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:10 INFO - 'PWD': '/builds/slave/test', 03:33:10 INFO - 'SHELL': '/bin/bash', 03:33:10 INFO - 'SHLVL': '1', 03:33:10 INFO - 'TERM': 'linux', 03:33:10 INFO - 'TMOUT': '86400', 03:33:10 INFO - 'USER': 'cltbld', 03:33:10 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480331097.732306-1450121767', 03:33:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:10 INFO - '_': '/tools/buildbot/bin/python'} 03:33:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:10 INFO - Downloading/unpacking psutil>=3.1.1 03:33:10 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 03:33:10 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 03:33:10 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 03:33:10 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 03:33:10 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 03:33:10 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 03:33:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:33:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:33:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:33:12 INFO - Installing collected packages: psutil 03:33:12 INFO - Running setup.py install for psutil 03:33:12 INFO - building 'psutil._psutil_linux' extension 03:33:12 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 03:33:12 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 03:33:12 INFO - building 'psutil._psutil_posix' extension 03:33:12 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 03:33:12 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 03:33:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:33:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:33:12 INFO - Successfully installed psutil 03:33:12 INFO - Cleaning up... 03:33:12 INFO - Return code: 0 03:33:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:33:12 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')]} 03:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:12 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')]} 03:33:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:12 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 0x7fd841e5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1449ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1446f60>, '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 0x1447d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14481d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1480331097.732306-1450121767', '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 03:33:12 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 03:33:12 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 03:33:12 INFO - Using env: {'DISPLAY': ':0', 03:33:12 INFO - 'HOME': '/home/cltbld', 03:33:12 INFO - 'LANG': 'en_US.UTF-8', 03:33:12 INFO - 'LANGUAGE': 'en_US:en', 03:33:12 INFO - 'LOGNAME': 'cltbld', 03:33:12 INFO - 'MAIL': '/var/mail/cltbld', 03:33:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:12 INFO - 'MOZ_NO_REMOTE': '1', 03:33:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:12 INFO - 'NO_EM_RESTART': '1', 03:33:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:12 INFO - 'PWD': '/builds/slave/test', 03:33:12 INFO - 'SHELL': '/bin/bash', 03:33:12 INFO - 'SHLVL': '1', 03:33:12 INFO - 'TERM': 'linux', 03:33:12 INFO - 'TMOUT': '86400', 03:33:12 INFO - 'USER': 'cltbld', 03:33:12 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480331097.732306-1450121767', 03:33:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:12 INFO - '_': '/tools/buildbot/bin/python'} 03:33:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:33:13 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 03:33:13 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 03:33:13 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 03:33:13 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 03:33:13 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 03:33:13 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 03:33:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:33:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:33:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:33:15 INFO - Installing collected packages: mozsystemmonitor 03:33:15 INFO - Running setup.py install for mozsystemmonitor 03:33:15 INFO - Successfully installed mozsystemmonitor 03:33:15 INFO - Cleaning up... 03:33:15 INFO - Return code: 0 03:33:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:33:15 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')]} 03:33:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:15 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')]} 03:33:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:15 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 0x7fd841e5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1449ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1446f60>, '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 0x1447d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14481d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1480331097.732306-1450121767', '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 03:33:15 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 03:33:15 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 03:33:15 INFO - Using env: {'DISPLAY': ':0', 03:33:15 INFO - 'HOME': '/home/cltbld', 03:33:15 INFO - 'LANG': 'en_US.UTF-8', 03:33:15 INFO - 'LANGUAGE': 'en_US:en', 03:33:15 INFO - 'LOGNAME': 'cltbld', 03:33:15 INFO - 'MAIL': '/var/mail/cltbld', 03:33:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:15 INFO - 'MOZ_NO_REMOTE': '1', 03:33:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:15 INFO - 'NO_EM_RESTART': '1', 03:33:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:15 INFO - 'PWD': '/builds/slave/test', 03:33:15 INFO - 'SHELL': '/bin/bash', 03:33:15 INFO - 'SHLVL': '1', 03:33:15 INFO - 'TERM': 'linux', 03:33:15 INFO - 'TMOUT': '86400', 03:33:15 INFO - 'USER': 'cltbld', 03:33:15 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480331097.732306-1450121767', 03:33:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:15 INFO - '_': '/tools/buildbot/bin/python'} 03:33:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:15 INFO - Downloading/unpacking jsonschema==2.5.1 03:33:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:33:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:17 INFO - Downloading functools32-3.2.3-2.tar.gz 03:33:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:33:17 INFO - warning: no files found matching '*.txt' 03:33:17 INFO - no previously-included directories found matching 'build' 03:33:17 INFO - no previously-included directories found matching 'dist' 03:33:17 INFO - no previously-included directories found matching '.git*' 03:33:17 INFO - Installing collected packages: jsonschema, functools32 03:33:17 INFO - Running setup.py install for functools32 03:33:17 INFO - warning: no files found matching '*.txt' 03:33:17 INFO - no previously-included directories found matching 'build' 03:33:17 INFO - no previously-included directories found matching 'dist' 03:33:17 INFO - no previously-included directories found matching '.git*' 03:33:17 INFO - Successfully installed jsonschema functools32 03:33:17 INFO - Cleaning up... 03:33:17 INFO - Return code: 0 03:33:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:33:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd841e5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1449ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1446f60>, '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 0x1447d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14481d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1480331097.732306-1450121767', '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 03:33:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:33:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:33:17 INFO - Using env: {'DISPLAY': ':0', 03:33:17 INFO - 'HOME': '/home/cltbld', 03:33:17 INFO - 'LANG': 'en_US.UTF-8', 03:33:17 INFO - 'LANGUAGE': 'en_US:en', 03:33:17 INFO - 'LOGNAME': 'cltbld', 03:33:17 INFO - 'MAIL': '/var/mail/cltbld', 03:33:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:17 INFO - 'MOZ_NO_REMOTE': '1', 03:33:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:17 INFO - 'NO_EM_RESTART': '1', 03:33:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:17 INFO - 'PWD': '/builds/slave/test', 03:33:17 INFO - 'SHELL': '/bin/bash', 03:33:17 INFO - 'SHLVL': '1', 03:33:17 INFO - 'TERM': 'linux', 03:33:17 INFO - 'TMOUT': '86400', 03:33:17 INFO - 'USER': 'cltbld', 03:33:18 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480331097.732306-1450121767', 03:33:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:18 INFO - '_': '/tools/buildbot/bin/python'} 03:33:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:33:18 INFO - Cleaning up... 03:33:18 INFO - Return code: 0 03:33:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:33:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd841e5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1449ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1446f60>, '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 0x1447d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14481d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1480331097.732306-1450121767', '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 03:33:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:33:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:33:18 INFO - Using env: {'DISPLAY': ':0', 03:33:18 INFO - 'HOME': '/home/cltbld', 03:33:18 INFO - 'LANG': 'en_US.UTF-8', 03:33:18 INFO - 'LANGUAGE': 'en_US:en', 03:33:18 INFO - 'LOGNAME': 'cltbld', 03:33:18 INFO - 'MAIL': '/var/mail/cltbld', 03:33:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:18 INFO - 'MOZ_NO_REMOTE': '1', 03:33:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:18 INFO - 'NO_EM_RESTART': '1', 03:33:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:18 INFO - 'PWD': '/builds/slave/test', 03:33:18 INFO - 'SHELL': '/bin/bash', 03:33:18 INFO - 'SHLVL': '1', 03:33:18 INFO - 'TERM': 'linux', 03:33:18 INFO - 'TMOUT': '86400', 03:33:18 INFO - 'USER': 'cltbld', 03:33:18 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480331097.732306-1450121767', 03:33:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:18 INFO - '_': '/tools/buildbot/bin/python'} 03:33:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:18 INFO - Downloading/unpacking blobuploader==1.2.4 03:33:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:20 INFO - Downloading blobuploader-1.2.4.tar.gz 03:33:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:33:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:33:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:21 INFO - Downloading docopt-0.6.1.tar.gz 03:33:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:33:21 INFO - Installing collected packages: blobuploader, requests, docopt 03:33:21 INFO - Running setup.py install for blobuploader 03:33:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:33:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:33:21 INFO - Running setup.py install for requests 03:33:21 INFO - Running setup.py install for docopt 03:33:21 INFO - Successfully installed blobuploader requests docopt 03:33:21 INFO - Cleaning up... 03:33:21 INFO - Return code: 0 03:33:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:33:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:21 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 0x7fd841e5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1449ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1446f60>, '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 0x1447d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14481d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1480331097.732306-1450121767', '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 03:33:21 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 03:33:21 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 03:33:21 INFO - Using env: {'DISPLAY': ':0', 03:33:21 INFO - 'HOME': '/home/cltbld', 03:33:21 INFO - 'LANG': 'en_US.UTF-8', 03:33:21 INFO - 'LANGUAGE': 'en_US:en', 03:33:21 INFO - 'LOGNAME': 'cltbld', 03:33:21 INFO - 'MAIL': '/var/mail/cltbld', 03:33:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:21 INFO - 'MOZ_NO_REMOTE': '1', 03:33:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:21 INFO - 'NO_EM_RESTART': '1', 03:33:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:21 INFO - 'PWD': '/builds/slave/test', 03:33:21 INFO - 'SHELL': '/bin/bash', 03:33:21 INFO - 'SHLVL': '1', 03:33:21 INFO - 'TERM': 'linux', 03:33:21 INFO - 'TMOUT': '86400', 03:33:21 INFO - 'USER': 'cltbld', 03:33:21 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480331097.732306-1450121767', 03:33:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:21 INFO - '_': '/tools/buildbot/bin/python'} 03:33:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:33:22 INFO - Running setup.py (path:/tmp/pip-ovJ3Kj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:33:22 INFO - Running setup.py (path:/tmp/pip-NrF77k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:33:22 INFO - Running setup.py (path:/tmp/pip-QIxQjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:33:22 INFO - Running setup.py (path:/tmp/pip-Zn5aj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:33:22 INFO - Running setup.py (path:/tmp/pip-MN7dmf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:33:22 INFO - Running setup.py (path:/tmp/pip-yCXKQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:33:22 INFO - Running setup.py (path:/tmp/pip-SFQBBn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:33:22 INFO - Running setup.py (path:/tmp/pip-AIR0xd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:33:22 INFO - Running setup.py (path:/tmp/pip-ptd9ar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:33:22 INFO - Running setup.py (path:/tmp/pip-KbGufZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:33:22 INFO - Running setup.py (path:/tmp/pip-jR7_Wr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:33:22 INFO - Running setup.py (path:/tmp/pip-Wc3AaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:33:22 INFO - Running setup.py (path:/tmp/pip-NoJDZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:33:22 INFO - Running setup.py (path:/tmp/pip-vw1VqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:33:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:23 INFO - Running setup.py (path:/tmp/pip-z0ocVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:33:23 INFO - Running setup.py (path:/tmp/pip-kxrLlQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:33:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:33:23 INFO - Running setup.py (path:/tmp/pip-AX_oL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:33:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:33:23 INFO - Running setup.py install for manifestparser 03:33:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:33:23 INFO - Running setup.py install for mozcrash 03:33:23 INFO - Running setup.py install for mozdebug 03:33:23 INFO - Running setup.py install for mozdevice 03:33:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:33:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:33:23 INFO - Running setup.py install for mozfile 03:33:23 INFO - Running setup.py install for mozhttpd 03:33:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:33:23 INFO - Running setup.py install for mozinfo 03:33:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:33:23 INFO - Running setup.py install for mozInstall 03:33:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:33:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:33:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:33:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:33:24 INFO - Running setup.py install for mozleak 03:33:24 INFO - Running setup.py install for mozlog 03:33:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:33:24 INFO - Running setup.py install for moznetwork 03:33:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:33:24 INFO - Running setup.py install for mozprocess 03:33:24 INFO - Running setup.py install for mozprofile 03:33:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:33:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:33:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:33:24 INFO - Running setup.py install for mozrunner 03:33:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:33:24 INFO - Running setup.py install for mozscreenshot 03:33:24 INFO - Running setup.py install for moztest 03:33:24 INFO - Running setup.py install for mozversion 03:33:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:33:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:33:25 INFO - Cleaning up... 03:33:25 INFO - Return code: 0 03:33:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:33:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:25 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 0x7fd841e5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1449ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1446f60>, '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 0x1447d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14481d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1480331097.732306-1450121767', '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 03:33:25 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 03:33:25 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 03:33:25 INFO - Using env: {'DISPLAY': ':0', 03:33:25 INFO - 'HOME': '/home/cltbld', 03:33:25 INFO - 'LANG': 'en_US.UTF-8', 03:33:25 INFO - 'LANGUAGE': 'en_US:en', 03:33:25 INFO - 'LOGNAME': 'cltbld', 03:33:25 INFO - 'MAIL': '/var/mail/cltbld', 03:33:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:25 INFO - 'MOZ_NO_REMOTE': '1', 03:33:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:25 INFO - 'NO_EM_RESTART': '1', 03:33:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:25 INFO - 'PWD': '/builds/slave/test', 03:33:25 INFO - 'SHELL': '/bin/bash', 03:33:25 INFO - 'SHLVL': '1', 03:33:25 INFO - 'TERM': 'linux', 03:33:25 INFO - 'TMOUT': '86400', 03:33:25 INFO - 'USER': 'cltbld', 03:33:25 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480331097.732306-1450121767', 03:33:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:25 INFO - '_': '/tools/buildbot/bin/python'} 03:33:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:33:25 INFO - Running setup.py (path:/tmp/pip-0vUsLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:33:25 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)) 03:33:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:33:25 INFO - Running setup.py (path:/tmp/pip-DuS2OT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:33:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 03:33:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:33:25 INFO - Running setup.py (path:/tmp/pip-Ca7xPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:33:25 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)) 03:33:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:33:25 INFO - Running setup.py (path:/tmp/pip-sGRuyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:33:25 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)) 03:33:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:33:25 INFO - Running setup.py (path:/tmp/pip-CS_ABK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:33:25 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)) 03:33:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:33:25 INFO - Running setup.py (path:/tmp/pip-S0NYsV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:33:25 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)) 03:33:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:33:25 INFO - Running setup.py (path:/tmp/pip-zBg2gV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:33:25 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)) 03:33:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:33:25 INFO - Running setup.py (path:/tmp/pip-YwL3T0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:33:25 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)) 03:33:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:33:25 INFO - Running setup.py (path:/tmp/pip-WZP_hj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:33:25 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)) 03:33:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:33:25 INFO - Running setup.py (path:/tmp/pip-89d49z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:33:25 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)) 03:33:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:33:25 INFO - Running setup.py (path:/tmp/pip-fY3M5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:33:26 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)) 03:33:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:33:26 INFO - Running setup.py (path:/tmp/pip-QarMsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:33:26 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)) 03:33:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:33:26 INFO - Running setup.py (path:/tmp/pip-E_OVUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:33:26 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)) 03:33:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:33:26 INFO - Running setup.py (path:/tmp/pip-C7DOUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:33:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 03:33:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:26 INFO - Running setup.py (path:/tmp/pip-Tfk_gB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:26 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)) 03:33:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:33:26 INFO - Running setup.py (path:/tmp/pip-iaOfuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:33:26 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)) 03:33:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:33:26 INFO - Running setup.py (path:/tmp/pip-19Bvhm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:33:26 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)) 03:33:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:33:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:33:26 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)) 03:33:26 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)) 03:33:26 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)) 03:33:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:33:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:28 INFO - Downloading blessings-1.6.tar.gz 03:33:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:33:28 INFO - Installing collected packages: blessings 03:33:28 INFO - Running setup.py install for blessings 03:33:28 INFO - Successfully installed blessings 03:33:28 INFO - Cleaning up... 03:33:28 INFO - Return code: 0 03:33:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:33:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:33:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:33:28 INFO - Reading from file tmpfile_stdout 03:33:28 INFO - Current package versions: 03:33:28 INFO - argparse == 1.2.1 03:33:28 INFO - blessings == 1.6 03:33:28 INFO - blobuploader == 1.2.4 03:33:28 INFO - docopt == 0.6.1 03:33:28 INFO - functools32 == 3.2.3-2 03:33:28 INFO - jsonschema == 2.5.1 03:33:28 INFO - manifestparser == 1.1 03:33:28 INFO - mozInstall == 1.12 03:33:28 INFO - mozcrash == 1.0 03:33:28 INFO - mozdebug == 0.1 03:33:28 INFO - mozdevice == 0.48 03:33:28 INFO - mozfile == 1.2 03:33:28 INFO - mozhttpd == 0.7 03:33:28 INFO - mozinfo == 0.9 03:33:28 INFO - mozleak == 0.1 03:33:28 INFO - mozlog == 3.4 03:33:28 INFO - moznetwork == 0.27 03:33:28 INFO - mozprocess == 0.23 03:33:28 INFO - mozprofile == 0.28 03:33:28 INFO - mozrunner == 6.13 03:33:28 INFO - mozscreenshot == 0.1 03:33:28 INFO - mozsystemmonitor == 0.3 03:33:28 INFO - moztest == 0.7 03:33:28 INFO - mozversion == 1.4 03:33:28 INFO - psutil == 3.1.1 03:33:28 INFO - requests == 1.2.3 03:33:28 INFO - wsgiref == 0.1.2 03:33:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:33:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:28 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 0x7fd841e5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1449ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1446f60>, '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 0x1447d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14481d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1480331097.732306-1450121767', '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 03:33:28 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 03:33:28 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 03:33:28 INFO - Using env: {'DISPLAY': ':0', 03:33:28 INFO - 'HOME': '/home/cltbld', 03:33:28 INFO - 'LANG': 'en_US.UTF-8', 03:33:28 INFO - 'LANGUAGE': 'en_US:en', 03:33:28 INFO - 'LOGNAME': 'cltbld', 03:33:28 INFO - 'MAIL': '/var/mail/cltbld', 03:33:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:28 INFO - 'MOZ_NO_REMOTE': '1', 03:33:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:28 INFO - 'NO_EM_RESTART': '1', 03:33:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:28 INFO - 'PWD': '/builds/slave/test', 03:33:28 INFO - 'SHELL': '/bin/bash', 03:33:28 INFO - 'SHLVL': '1', 03:33:28 INFO - 'TERM': 'linux', 03:33:28 INFO - 'TMOUT': '86400', 03:33:28 INFO - 'USER': 'cltbld', 03:33:28 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480331097.732306-1450121767', 03:33:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:28 INFO - '_': '/tools/buildbot/bin/python'} 03:33:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:29 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)) 03:33:29 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)) 03:33:29 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)) 03:33:29 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)) 03:33:29 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)) 03:33:29 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)) 03:33:29 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)) 03:33:29 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)) 03:33:29 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)) 03:33:29 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)) 03:33:29 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)) 03:33:29 INFO - Cleaning up... 03:33:29 INFO - Return code: 0 03:33:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:33:29 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')]} 03:33:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:29 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')]} 03:33:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:29 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 0x7fd841e5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1449ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1446f60>, '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 0x1447d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14481d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1480331097.732306-1450121767', '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 03:33:29 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 03:33:29 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 03:33:29 INFO - Using env: {'DISPLAY': ':0', 03:33:29 INFO - 'HOME': '/home/cltbld', 03:33:29 INFO - 'LANG': 'en_US.UTF-8', 03:33:29 INFO - 'LANGUAGE': 'en_US:en', 03:33:29 INFO - 'LOGNAME': 'cltbld', 03:33:29 INFO - 'MAIL': '/var/mail/cltbld', 03:33:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:29 INFO - 'MOZ_NO_REMOTE': '1', 03:33:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:29 INFO - 'NO_EM_RESTART': '1', 03:33:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:29 INFO - 'PWD': '/builds/slave/test', 03:33:29 INFO - 'SHELL': '/bin/bash', 03:33:29 INFO - 'SHLVL': '1', 03:33:29 INFO - 'TERM': 'linux', 03:33:29 INFO - 'TMOUT': '86400', 03:33:29 INFO - 'USER': 'cltbld', 03:33:29 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480331097.732306-1450121767', 03:33:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:29 INFO - '_': '/tools/buildbot/bin/python'} 03:33:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:33:29 INFO - Cleaning up... 03:33:29 INFO - Return code: 0 03:33:29 INFO - Running post-action listener: _resource_record_post_action 03:33:29 INFO - Running post-action listener: _start_resource_monitoring 03:33:29 INFO - Starting resource monitoring. 03:33:29 INFO - [mozharness: 2016-11-28 11:33:29.380626Z] Finished create-virtualenv step (success) 03:33:29 INFO - [mozharness: 2016-11-28 11:33:29.381136Z] Running install step. 03:33:29 INFO - Running pre-action listener: _resource_record_pre_action 03:33:29 INFO - Running main action method: install 03:33:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:33:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:33:29 INFO - Reading from file tmpfile_stdout 03:33:29 INFO - Detecting whether we're running mozinstall >=1.0... 03:33:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:33:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:33:29 INFO - Reading from file tmpfile_stdout 03:33:29 INFO - Output received: 03:33:29 INFO - Usage: mozinstall [options] installer 03:33:29 INFO - Options: 03:33:29 INFO - -h, --help show this help message and exit 03:33:29 INFO - -d DEST, --destination=DEST 03:33:29 INFO - Directory to install application into. [default: 03:33:29 INFO - "/builds/slave/test"] 03:33:29 INFO - --app=APP Application being installed. [default: firefox] 03:33:29 INFO - mkdir: /builds/slave/test/build/application 03:33:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:33:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:33:47 INFO - Reading from file tmpfile_stdout 03:33:47 INFO - Output received: 03:33:47 INFO - /builds/slave/test/build/application/firefox/firefox 03:33:47 INFO - Running post-action listener: _resource_record_post_action 03:33:47 INFO - [mozharness: 2016-11-28 11:33:47.060279Z] Finished install step (success) 03:33:47 INFO - [mozharness: 2016-11-28 11:33:47.060522Z] Running run-tests step. 03:33:47 INFO - Running pre-action listener: _resource_record_pre_action 03:33:47 INFO - Running main action method: run_tests 03:33:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:33:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:33:47 INFO - Python 2.7.3 03:33:47 INFO - Return code: 0 03:33:47 INFO - grabbing minidump binary from tooltool 03:33:47 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')]} 03:33:47 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 0x1446f60>, '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 0x1447d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14481d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:33:47 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 03:33:47 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 03:33:47 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 03:33:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:33:47 INFO - Return code: 0 03:33:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:33:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:33:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:33:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:33:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:33:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GeRxbj7MR1qvJudTL3AeOA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:33:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GeRxbj7MR1qvJudTL3AeOA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:33:47 INFO - Using env: {'DISPLAY': ':0', 03:33:47 INFO - 'HOME': '/home/cltbld', 03:33:47 INFO - 'LANG': 'en_US.UTF-8', 03:33:47 INFO - 'LANGUAGE': 'en_US:en', 03:33:47 INFO - 'LOGNAME': 'cltbld', 03:33:47 INFO - 'MAIL': '/var/mail/cltbld', 03:33:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:33:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:33:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:47 INFO - 'MOZ_NO_REMOTE': '1', 03:33:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:33:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:47 INFO - 'NO_EM_RESTART': '1', 03:33:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:47 INFO - 'PWD': '/builds/slave/test', 03:33:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:33:47 INFO - 'SHELL': '/bin/bash', 03:33:47 INFO - 'SHLVL': '1', 03:33:47 INFO - 'TERM': 'linux', 03:33:47 INFO - 'TMOUT': '86400', 03:33:47 INFO - 'USER': 'cltbld', 03:33:47 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480331097.732306-1450121767', 03:33:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:47 INFO - '_': '/tools/buildbot/bin/python'} 03:33:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GeRxbj7MR1qvJudTL3AeOA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:33:47 INFO - mozversion application_buildid: 20161128004004 03:33:47 INFO - mozversion application_changeset: d8e4710b55d980cb3a63f8bae224595d7ef256a0 03:33:47 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:33:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:33:47 INFO - mozversion application_name: Firefox 03:33:47 INFO - mozversion application_remotingname: firefox-dev 03:33:47 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:33:47 INFO - mozversion application_vendor: Mozilla 03:33:47 INFO - mozversion application_version: 52.0a2 03:33:47 INFO - mozversion platform_buildid: 20161128004004 03:33:47 INFO - mozversion platform_changeset: d8e4710b55d980cb3a63f8bae224595d7ef256a0 03:33:47 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:33:47 INFO - mozversion platform_version: 52.0a2 03:33:47 INFO - using testdate: 1480332827 03:33:47 INFO - actual date: 1480332827 03:33:47 INFO - starting webserver on 'localhost:44010' 03:33:47 INFO - SUITE-START | Running 2 tests 03:33:47 INFO - TEST-START | dromaeo_css 03:33:47 INFO - operating with platform_type : linux_ 03:33:47 INFO - Initialising browser for dromaeo_css test... 03:33:47 INFO - TEST-INFO | started process 29641 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCqGVNd/profile http://localhost:44010/getInfo.html) 03:33:52 INFO - PROCESS | 29641 | __metrics Screen width/height:1600/1200 03:33:52 INFO - PROCESS | 29641 | colorDepth:24 03:33:52 INFO - PROCESS | 29641 | Browser inner width/height: 1024/697 03:33:52 INFO - PROCESS | 29641 | __metrics 03:33:53 INFO - PROCESS | 29641 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:33:53 INFO - PROCESS | 29641 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:33:53 INFO - PROCESS | 29641 | console.error: PushService: 03:33:53 INFO - PROCESS | 29641 | stateChangeProcessEnqueue: Error transitioning state 03:33:53 INFO - PROCESS | 29641 | UnknownError 03:33:54 INFO - TEST-INFO | 29641: exit 0 03:33:54 INFO - Browser initialized. 03:33:54 INFO - Running cycle 1/1 for dromaeo_css test... 03:33:54 INFO - TEST-INFO | started process 29734 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCqGVNd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:34:06 INFO - PROCESS | 29734 | RSS: Main: 144306176 03:34:06 INFO - PROCESS | 29734 | 03:34:57 INFO - PROCESS | 29734 | 1480332897693 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] 03:37:08 INFO - PROCESS | 29734 | Cycle 1(1): loaded http://localhost:44010/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44010/tests/dromaeo/cssquery-ext.html) 03:37:09 INFO - PROCESS | 29734 | RSS: Main: 242450432 03:37:09 INFO - PROCESS | 29734 | 03:40:11 INFO - PROCESS | 29734 | Cycle 1(1): loaded http://localhost:44010/tests/dromaeo/cssquery-ext.html (next: http://localhost:44010/tests/dromaeo/cssquery-jquery.html) 03:40:12 INFO - PROCESS | 29734 | RSS: Main: 231223296 03:40:12 INFO - PROCESS | 29734 | 03:43:14 INFO - PROCESS | 29734 | Cycle 1(1): loaded http://localhost:44010/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44010/tests/dromaeo/cssquery-mootools.html) 03:43:14 INFO - PROCESS | 29734 | RSS: Main: 230739968 03:43:14 INFO - PROCESS | 29734 | 03:46:16 INFO - PROCESS | 29734 | Cycle 1(1): loaded http://localhost:44010/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44010/tests/dromaeo/cssquery-prototype.html) 03:46:17 INFO - PROCESS | 29734 | RSS: Main: 215437312 03:46:17 INFO - PROCESS | 29734 | 03:49:20 INFO - PROCESS | 29734 | Cycle 1(1): loaded http://localhost:44010/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44010/tests/dromaeo/cssquery-yui.html) 03:49:20 INFO - PROCESS | 29734 | RSS: Main: 175325184 03:49:20 INFO - PROCESS | 29734 | 03:52:23 INFO - PROCESS | 29734 | Cycle 1(1): loaded http://localhost:44010/tests/dromaeo/cssquery-yui.html (next: http://localhost:44010/tests/dromaeo/cssquery-dojo.html) 03:52:23 INFO - PROCESS | 29734 | RSS: Main: 263860224 03:52:23 INFO - PROCESS | 29734 | 03:52:23 INFO - PROCESS | 29734 | __start_tp_report 03:52:23 INFO - PROCESS | 29734 | _x_x_mozilla_page_load 03:52:23 INFO - PROCESS | 29734 | _x_x_mozilla_page_load_details 03:52:23 INFO - PROCESS | 29734 | |i|pagename|runs| 03:52:23 INFO - PROCESS | 29734 | |0;dojo.html;3138.7802853800235;3165.6042994625673;3182.7135557799807;3197;3223.7582181336406;5454.699991500466;5521.917171242435;5528;5541.168824676291;5549.528290095347;5536.920300541396;5596.720163991805;5598.888022239563;5611.382747897728;5627.634203776752;5033.295338652591;5045.873853153664;5059.645824792247;5122.948770512285;5125.060448791767;4977.875553111183;4983.72589507577;5097.974510127444;5149.304843846089;5153.561947234471;5029.874253143683;5041.243813427978;5048.469910659383;5057.620678449112;5063.949360506403;5079.060373830816;5096.439391666913;5097.9490205097845;5162.92255616166;5181.715005674687;5002.424721157077;5072.112380333427;5107.131787596118;5112.156494178456;5129.487051294878;5375.569954403638;5393.83818485446;5409.215663728776;5413.188021796723;5452.482014208684;5894.97052514739;5899.085641725539;5907;5936.465718085393;5966.97016514919;6037.45662890342;6038.758449662008;6043.637381757108;6048.69756512177;6069.02895536712;5434.429384914606;5448.482394172587;5528.087865502228;5535.806246781424;5569.164625306236;6072.666003369769;6113.052476866093;6114.510839132859;6114.847128821815;6128.2033335666965;5871.853203669943;5872.911906321408;5873.911891321633;5884.558658100574;5884.970575147183;5787.450192231731;5797.4782269595935;5826.504747096545;5830.416958304136;5832.125181222766;5876.118582212703;5877.706114694248;5879.853003674857;5907.940920590739;5915.260592425947;5822.097574875901;5872.11918212263;5874.706264686749;5874.941250587525;5879.559033072451;4504.189245935698;4546.02260513991;4549.636029117729;4564.178447879347;4593.104344652761;4077.306857834116;4092.795360232036;4097.7541347518645;4104.445899803548;4110.403991421227;5664.122061080539;5664.85837854057;5664.97167514168;5665.66006039639;5677.034904066319;5792.0732682771395;5851.561132915049;5909.054551271776;5973.671448070398;5981.0729336952845;5635.6618602883955;5704.686242256633;5713.428657134254;5736.5123964462655;5738.8278351649515;5157.871053223699;5162.354705661793;5173.249878767558;5173.301604283373;5176.597196964826;6057.545684073801;6106.877862442815;6196.81409557723;6252.062190671436;6267.7806276781;5845.532357411312;5864.06175011996;5890.882182356243;5972.5520585955355;6003.5797494174985;6201.937980620317;6206.906896396648;6207.131001659681;6209.782657606962;6214.098955651315;5717.942820571741;5761.740721667451;5847.766089356378;5852.268466441695;5853.297604287342;5879.441453061952;5913.674747888907;5960.403959604005;5965.045592705146;6058.394160583906;5855.7950471734985;5898.174255604305;5898.233229680114;5899.528037757055;5911;5864.882702346014;5867.442592953663;5868.853278667897;5871.823845284648;5873.706314684334;5340.465953404629;5654.095344744986;5655.943440565707;5674.290713660793;5688.914666279927;5836.766529338949;5844.503217226584;5848.093545500455;5849.590528662953;5866.6480011199465;5567.331920169606;5585.469380408855;5691.288588926384;5708.65748055118;5712.571557133148 03:52:23 INFO - PROCESS | 29734 | |1;ext.html;580.2717589425271;614.2015380005993;643.1253495246464;647.4690753582062;653.8953767397218;34784.65215347849;38089.61910380895;38140;45657.77171114148;46338.30492542614;47441;47743.52256477434;47999.52000479994;48030.279545806756;48055.75972120134;8884.555772211395;9065.365424420293;9079.773005674879;9081.318901082412;9082.591283392263;8459.280961118282;8495.277901378391;8638.481691098523;8643.740687779376;8827.16141966512;10739.087177589914;10965.232433729641;10975.012248897598;11195.888041119606;11258.324500529954;10779;10858.837117443245;10871.45642717869;10871.619493317696;10874.130069594414;10752.247342686014;10824.350538967687;10824.51289691958;10828.837567436494;10835.67492975212;43771;44019.779901100286;44113.77943110296;44118.77940610277;44128;3781.4516895050338;3864.594217607139;3931.6658084062888;4233.23801715691;4484.2376795944765;32615.51076733851;33244.3351132976;33389.499157512655;33524.49713254303;35123.824380878184;4384.912301753947;4396.230659634583;4428.180786554498;4455.108978204372;4530.252508336121;355977;358164.6734130658;359611;360126;360267;39088;64691.67654161699;64945.67527162334;64963.35036649573;65061;39265.41101883474;42040;42141.57858421438;42153.57846421497;42221;15984.680306393808;16094.517164485083;16098.597535061717;16099.195040247942;16105.67788644244;12136.75726485483;12140.33228172459;12143.514259429523;12147.210431321935;12156.209846360136;8952.507612081268;9157.221636161;9298.814023719488;9592.808143837085;9593.376430531993;3570.625084366156;3602.603713591503;3602.819859007039;3684.6499582539614;3706.3513885070006;1007.4559737741538;1058.227493929436;1093.3439936038314;1113.9443027848738;1128.5937062657438;33983.32033359319;34283;34691;34753.478697819555;34824;1031.4636389077637;1120.5349779841274;1146.6731981385265;1188.607759439383;1243.6269119264366;15500;17982.190801413966;18134.45596632103;18387;19113.61772764537;579537;581487;584435;585937;587031;57426.425735742945;57480.42519574834;58007;63488.04767928485;65819;1364.501956785786;1400.467822227547;1411.6541447345467;1438.9064710793764;1456.672248744024;33664.831675841466;36323.81838090793;36398.27203455863;36571.63428365682;36577.63422365849;57784;58744;58777.885548011225;58783;58797.70601146967;521106;589766;602735;607305;607734;46067.539324606325;46411.071778563564;46531;48584.271235930784;49904.754286056486;52561.47438525566;53687.73156134194;54316;54506.72746636241;54709;43825.78087109544;45107.54892451165;45117;45321.54678453173;46559.53440465552;44464.55535444734;45906;45908.770456147504;46417;46980.29529556991;45079.7746011281;45431.318530222736;46744.766276168404;46760;46878.76560617175;37788.24423511569;39677;40087.198256034135;40325.79837100796;41070.58929410668;29815;29930.4013919716;30036;30099.398012040074;30604.387912242077 03:52:23 INFO - PROCESS | 29734 | |2;jquery.html;392.6583872031333;429.39669763981595;434.8695391382585;438.28559448099594;442.2343743028116;15689.52931412058;19026.524336891584;19844.40466785995;20989.895050524727;21081.26215582455;20002.199912003503;20248.392548223575;20335.186592536316;20484.795152048475;20538.794612053876;5668.68822214778;5948.107783832438;5951.821445356646;5956.672383018954;5964.433378829004;5567.554595632339;5907.291125064999;5914.970425147868;5932.673702946337;5938.46553810157;5668.886622267572;5902.911456328137;5904.232449781543;5910.822675319747;5911.113333000063;5813.767449302044;5825.708714564276;5857.853553661129;5858.297004359461;5859;5031.77357018935;5089.567386772129;5293.947060529423;5300;5300.946990530084;23590.29229123129;24039.158629447884;24118.155864544657;24215.15246966365;24270.39324016896;2524.3562891462743;2538.3780973661387;2558.859262740567;2595.688517377927;2657.1231493607065;10050.145737612313;10292.176625869912;10458.581656733797;10528.526216320284;14718;1902.1630482587755;1907.637548865711;1932.4202739178331;1958.343954775152;1960.2159136345433;81849.59075204645;82715.58642206811;83204.58397708033;87726;94100;10657.413842238751;11305.434728263554;11565.942170289263;11581.247218930743;11604.6518604442;15571.975643166315;15991.28039238237;16186.352545898033;16206.59483512898;16208.75686864698;8026.515094707498;8196.959015205006;8279.254867061873;8313.33493320533;8319.750407487785;7690.192529784404;8174.550399728072;8179.550124743197;8185.877211841827;8512.319014478826;5036.899262014739;5108.361454818148;5115.87210319745;5241.580673546107;5243.213517972258;2025.615133124731;2070.4202823209525;2096.895155242232;2111.6832475128545;2133.9039743211592;934.6168071090821;1005.5776573839005;1032.87605487342;1041.8124737547314;1046.3146638951498;19890.403287901096;20428.285010024578;20432.387028389174;20503.69244461334;20839.42927141353;989.3816364772017;1011.9797604048025;1037.6835065305004;1063.6330465989222;1065.4353192807823;10428.582856685647;11410.315381077162;11469.139814513777;11530.077593792477;11594.94202528982;400711;402618;404675;521367;537387;103712.48143759233;105305;107880;110098.89901100886;110735.44632276948;506.7972810875679;528.3791544934686;1030.685640879539;1063.5958335832333;1067.4769363012067;10747.193960453154;11734.647960561197;11939.940300298444;11972.555234825873;12603.558875439316;39652.2069558613;40403.797981009906;41783.7910810444;43083;43309;51894.48105518897;61894.69052654708;62268.37731622807;63018;65002;8667.4366166199;8991.235744961752;8992.190702836777;9008.81982360336;9093.226565897465;13042.413091410719;13874.375653095836;13898.58304250874;14240.501582444565;14363.138211707332;11397.259178153394;11688.415579221175;11866.881331186578;11909.285442873455;12522.123451358317;11952.64142075739;12076.577319793765;12081.697957551132;12312.13815032939;12376.195547289397;12254.20347677398;12413.93793031029;12458.632859756617;12468.438920248429;12775.488980440678;9102.908970910206;9133.725988220363;9177.403468774508;9222.95388523053;9299.256059515357;9002.549872506479;11304.773904521699;11939.940300298791;12223.93888030554;12304.876951230373 03:52:23 INFO - PROCESS | 29734 | |3;mootools.html;1426.507854790097;1506.1038681984219;1528.625486755745;1694.6525962177755;1835.504413808271;7380.778576642702;8186.304164146048;8568.400211985163;8584.484930904142;8857.822843543125;8624.353173511996;8692.217700406962;8699.043105258417;8705.260052895495;8707.303415726743;2493.7256901740793;2521.4957008598353;2524.9873750631314;2526.6589010483626;2527.36815796051;2426.3934016495878;2522.608995605684;2524.9747502524924;2526.418923647562;2529.178017144435;2454.398672325283;2458.1150785717127;2472.196536125757;2477.6283557466436;2479.3925488255404;2375.798057165134;2395.149721848745;2417.3110663460916;2422.81828862836;2424.9272521824373;2447.4615584571366;2462.827602067856;2473.245660073677;2488.0296684292957;2488.713797913227;8272.83454330916;8453.154684531559;8510.78723031929;8655.264302534291;8712.825743485158;5442.91835622466;5674.914876276818;5677.659340439587;5678.5741069419955;5680.971595142039;3443.862245510202;3528.1179705073732;3536.45184996326;3579.28414317135;3625.8912232633065;1188.7265928836416;1204.5302332090491;1221.2855479544478;1245.862955074941;1259;12093.334866582334;12128.272303661808;12156.574519891761;12166.209196402206;12200.511979520808;4512.593866551961;4600.493945665974;4775.761211939389;4800.73595952219;4834.8791280218275;9307.813843723088;9313.674021409219;9315.627374905063;9321.161095501437;9327.766805829773;5448.210009548672;5459.563234941195;5460.153676180198;5465.836024919259;5469.753861076261;4343.956560434419;4550.13547425988;4741.502142275081;5096.592272618182;5169.508896654812;3894.883153505399;3982.283189026003;4017.8995525111523;4076.4700588923843;4082.1223436961195;1271.3897329281997;1282.8717128287096;1285.762134005212;1286.292539103508;1296.494367196794;929.1451864284874;965.88892277389;970.0929630795229;970.2916870684298;990.7968866382519;5748.942510574924;5783.971080144656;5803.303603567599;5845.561582881301;5865.178874957509;456.9657275704269;461.6560662306536;490.1862907573411;505.61320589748874;516.3210378352454;4013.8595149169637;4045.332520134145;4065.593440655911;4080.9387859182134;4106.2198182345255;10304.793904121876;10777.191710621735;10781.838272425919;10785.40680262593;10813.56745730162;10696;10717.571297148183;10725.83911241332;10737.51681174349;10737.83893241602;7670.578118203553;8005.759827205193;8266.338692904554;8354.79113022167;8366.916330836613;5980.594560278418;6068.666223357758;6092.360302168208;6093.817185484442;6148.108524263867;9655.758606034624;9746.366486178376;9804.41173529562;9807.313488056054;9913.603455861974;8788;9111.17999380059;9777;9810.117089461983;9902.702918912444;7453.962730186531;7708.383329333752;7715.922840771745;7732.884006740016;7942.642581083981;8610.569471526524;8628.611712473079;8686;8694.130586941508;8699.56502174876;7679.308862202429;7746.651400687096;7760.805979850549;7842.333401660922;7845.725399610987;7419.9258007421395;7489.550626962399;7546.641604511241;7571.46999710037;7692.19231980634;6912.205096413977;6984.301569842975;7028.402585780266;7030.226675065841;7032.789016329519;5072.949270507248;5132.923006154985;5159.303494028258;5177.559907407762;5385.111456609616;4957.504249575014;4961.255811628284;4988.401391833003;5035.345405097461;5150.6137039721425 03:52:23 INFO - PROCESS | 29734 | |4;prototype.html;335.15039375183915;351.9032266126813;354.7995382608825;356.14169850659914;364.5570631682506;5139.717315547643;5263.3683957925105;5314.096603577392;5333.333333333333;5361.249425080487;5035;5151.9042361322745;5190.455002224769;5206.271122042917;5213.921791173136;4180.853670121546;4197.782643033524;4203.915921681564;4215.59951804578;4219.514755803076;3968.702347323948;4155.8753237402925;4187.811548480326;4197.07664313852;4207.72649777765;4124.13393187431;4142.8757137285775;4148;4155.812988415513;4158.168366326731;4149.232392007473;4157.688173387008;4159.523369203949;4170.145120250371;4177.206330797138;3711.2391959648207;3724.6647801697977;3731.402975523903;3739;3747.3629482987685;4966.826161084381;5085.847424577269;5086.720230387327;5128.307678463434;5139.974300128475;4741.241401375798;4769.880752981168;4779.211430114027;4789.904201915977;4809.615230781529;5514.6139770216105;5519.337679478448;5521.944780552183;5529.972350138264;5545.77816887324;3875.3411919973673;4040.8585699500672;4055.3511438169753;4063.5936406359424;4074.286999775057;5685.118806584986;5713;5717.971410142923;5720.170575266563;5724.79963201286;4163.708540402204;4174.227767862955;4174.853880114242;4177.707560470738;4180.623743863067;4003.417795521872;4202.747835129902;4211.873643790691;4235.174141042528;4237.660987121023;4737.2183589708;4747.192977193886;4751.881202969884;4765.618750499952;4766.4995175506765;5519.9448005520235;5524.944750552523;5535.446455354432;5543.334799823966;5545.251391062155;1327.4491086199312;1360.8298962629672;1361.2717196299932;1382.322661895684;1404.0171879684262;974.6890432368454;974.7222041718077;991.1921783746224;996.5067291690515;997.6059456514636;5120.180771076684;5124.539506240778;5137.357830271216;5144.176931690911;5145.614078944094;5308.274810686542;5358.97320513395;5368.973155134199;5374.167004114369;5383.070358638216;4899.461059283476;5130.4356520782685;5147.459516750687;5149.558123725363;5155.432902380735;2825.3360460291815;2844.1751891951517;2846.7010963848497;2851.9714802852122;2862;5585.078462053797;5606.887862242732;5610.326760788732;5625.46558076982;5633.57748168889;5356.5714742821265;5488.4785945335125;5488.725563721798;5501.669899806025;5521.365043020024;5580;5590.664560126405;5595.384507704231;5608.775648973995;5627.127795191752;5220.9738951305;5366.867512015804;5372.677639341652;5375.677459352295;5387.299651045339;5291.3385826771655;5295.4969277918535;5302.549283310962;5315.760790764502;5319.787208511616;5574.9442505574425;5583.69289689071;5610.438956104357;5621.409751975983;5678.744456499385;3939.428782826417;3968.3650615901315;4040.151568170717;4050.460824886642;4053.6488836474186;5357.464253574612;5383.434739352469;5386.7037312946595;5400.7569659364635;5455.318085239345;5439.422567455394;5450.645708028966;5552.69460179694;5555.694436806015;5587.552995760248;5545.861353466195;5549.528290095225;5558.555315574825;5609.298837645294;5622;5270.920936186037;5449.291592093161;5456.2906822114455;5473.644213126134;5479.972600137134;5548.250986116823;5554;5569.860753481195;5573.581981351496;5575.330960284792;5423.376311724044;5428.83713488596;5440.591955603425;5448.700321482198;5462.590305727166 03:52:23 INFO - PROCESS | 29734 | |5;yui.html;821.6507984106753;830.3813658824176;837.4723923927926;858.5192292316301;882.810195807902;14371.856281437196;15518;15672.216389180523;15711.135887526196;15721.292541835617;14186.574402767908;14309.212993285391;14418.783718244234;14438.27808609568;14540;719.62219834587;733.4572416411844;743.4944237918213;854.8162145138809;870.9259712924409;737.1706829816457;835.3150416658343;857.9442336248155;860.5396113079504;866.1901122450497;903.9728808135767;904.4256896870469;904.525124309736;904.8099899021213;905.0949050949051;900.2392977933636;901.1349104859343;901.2699713232303;901.3104974694331;901.3690416708298;550.2131951309626;564.5822091652188;643.5012865029593;653.8921078022169;657.0144782825762;14709.117452952856;14755.26223688822;14801.925990369979;14818.259087045604;14844.554663360117;13850.722985540333;13996.230207338593;14267.714645707028;14280.785788213185;14298.64253393663;12795.949769196424;12967.935160324232;13097.886679632242;13124.606261812065;13313.068085234037;4309.525952145262;4330.155619654169;4350.238708226079;4402.163588918095;4466.955330446686;62942;63304.366956330305;64167.67916160436;64231.67884160596;64755.67622161906;10636.255462117577;10696.090832279187;10721.463926803628;10805.189610779224;10900.781984360268;19165.61668766617;19740.210391584176;19849.801501985083;19868.50328741764;19988.900055499922;8222.547759873265;8354.45696029756;8454.281386082252;8480.957595211985;8640.179182977732;4413.58070983256;4578.908421831545;4583.816647334136;4638.79125439356;4736.64475164364;3618.348697234523;3729.4778730977687;3735.4957080793747;3738.476613274144;3738.953093133927;679.6635665345685;687.5359132585485;690.689189864563;692.3976140757574;710.1549156503744;608.2088250103491;719.6437763307197;799.152897928198;804.1435870797582;806.334773811596;9461.668841590512;9778.364406313567;9872.210223182128;10441.164706823436;10581.100606448537;692.840646651263;712.4834494991194;714.9356557909709;779.9727009554638;782.1591788827034;4615.630749540029;4657.301404789308;4713.269443236304;4755.619550435957;4820.662553621213;86516.56741716251;86538;86617.56691216504;89394.55302723445;90497.54751226334;73479;73785.63107184538;74126.25873741301;79824;81406.59296703478;42213.57786422096;47522.52477475181;62953;64033.359666403674;65158;10026;10304.124149447382;10337.534810933375;10411.843822342822;10460.947695261475;40491.39262911;41435.585644144376;42801.357979629705;46653.066938660355;47035.52964470448;57216;66384.6680766593;67100.6644966772;67851;69868.6506567464;14238.786418203943;14480.637984050483;14549.272536373352;14817.185054822088;14878.702425951637;14943.476978305707;15502.767458488357;16039.438619648256;16309.51071467858;16549.58626034359;14350.425982960565;14757;14785;14899.329530171384;15581.610459738597;14864.777028344368;14869.47956821506;15153.696926061637;15932;15942.760858587362;13702.246376449391;14063.156210627396;15142.54572362831;15180.848191517944;15275.083494990336;11553.422328883355;11799.469023893773;12118.515259389525;12170.513179472722;12648;11478.598249061577;11759.529618815493;12001.63995080149;12013.939930300292;12282.140250182401 03:52:23 INFO - PROCESS | 29734 | __end_tp_report 03:52:23 INFO - PROCESS | 29734 | __start_cc_report 03:52:23 INFO - PROCESS | 29734 | _x_x_mozilla_cycle_collect,1057 03:52:23 INFO - PROCESS | 29734 | __end_cc_report 03:52:23 INFO - PROCESS | 29734 | __startTimestamp1480333943577__endTimestamp 03:52:23 INFO - PROCESS | 29734 | 03:52:23 INFO - PROCESS | 29734 | ------- Summary: start ------- 03:52:23 INFO - PROCESS | 29734 | Number of tests: 6 03:52:23 INFO - PROCESS | 29734 | 03:52:23 INFO - PROCESS | 29734 | [#0] dojo.html Cycles:165 Average:5519.96 Median:5713.43 stddev:624.47 (10.9%) stddev-sans-first:597.80 03:52:23 INFO - PROCESS | 29734 | Values: 3138.8 3165.6 3182.7 3197.0 3223.8 5454.7 5521.9 5528.0 5541.2 5549.5 5536.9 5596.7 5598.9 5611.4 5627.6 5033.3 5045.9 5059.6 5122.9 5125.1 4977.9 4983.7 5098.0 5149.3 5153.6 5029.9 5041.2 5048.5 5057.6 5063.9 5079.1 5096.4 5097.9 5162.9 5181.7 5002.4 5072.1 5107.1 5112.2 5129.5 5375.6 5393.8 5409.2 5413.2 5452.5 5895.0 5899.1 5907.0 5936.5 5967.0 6037.5 6038.8 6043.6 6048.7 6069.0 5434.4 5448.5 5528.1 5535.8 5569.2 6072.7 6113.1 6114.5 6114.8 6128.2 5871.9 5872.9 5873.9 5884.6 5885.0 5787.5 5797.5 5826.5 5830.4 5832.1 5876.1 5877.7 5879.9 5907.9 5915.3 5822.1 5872.1 5874.7 5874.9 5879.6 4504.2 4546.0 4549.6 4564.2 4593.1 4077.3 4092.8 4097.8 4104.4 4110.4 5664.1 5664.9 5665.0 5665.7 5677.0 5792.1 5851.6 5909.1 5973.7 5981.1 5635.7 5704.7 5713.4 5736.5 5738.8 5157.9 5162.4 5173.2 5173.3 5176.6 6057.5 6106.9 6196.8 6252.1 6267.8 5845.5 5864.1 5890.9 5972.6 6003.6 6201.9 6206.9 6207.1 6209.8 6214.1 5717.9 5761.7 5847.8 5852.3 5853.3 5879.4 5913.7 5960.4 5965.0 6058.4 5855.8 5898.2 5898.2 5899.5 5911.0 5864.9 5867.4 5868.9 5871.8 5873.7 5340.5 5654.1 5655.9 5674.3 5688.9 5836.8 5844.5 5848.1 5849.6 5866.6 5567.3 5585.5 5691.3 5708.7 5712.6 03:52:23 INFO - PROCESS | 29734 | 03:52:23 INFO - PROCESS | 29734 | [#1] ext.html Cycles:180 Average:67105.81 Median:42187.29 stddev:138713.57 (328.8%) stddev-sans-first:139012.78 03:52:23 INFO - PROCESS | 29734 | Values: 580.3 614.2 643.1 647.5 653.9 34784.7 38089.6 38140.0 45657.8 46338.3 47441.0 47743.5 47999.5 48030.3 48055.8 8884.6 9065.4 9079.8 9081.3 9082.6 8459.3 8495.3 8638.5 8643.7 8827.2 10739.1 10965.2 10975.0 11195.9 11258.3 10779.0 10858.8 10871.5 10871.6 10874.1 10752.2 10824.4 10824.5 10828.8 10835.7 43771.0 44019.8 44113.8 44118.8 44128.0 3781.5 3864.6 3931.7 4233.2 4484.2 32615.5 33244.3 33389.5 33524.5 35123.8 4384.9 4396.2 4428.2 4455.1 4530.3 355977.0 358164.7 359611.0 360126.0 360267.0 39088.0 64691.7 64945.7 64963.4 65061.0 39265.4 42040.0 42141.6 42153.6 42221.0 15984.7 16094.5 16098.6 16099.2 16105.7 12136.8 12140.3 12143.5 12147.2 12156.2 8952.5 9157.2 9298.8 9592.8 9593.4 3570.6 3602.6 3602.8 3684.6 3706.4 1007.5 1058.2 1093.3 1113.9 1128.6 33983.3 34283.0 34691.0 34753.5 34824.0 1031.5 1120.5 1146.7 1188.6 1243.6 15500.0 17982.2 18134.5 18387.0 19113.6 579537.0 581487.0 584435.0 585937.0 587031.0 57426.4 57480.4 58007.0 63488.0 65819.0 1364.5 1400.5 1411.7 1438.9 1456.7 33664.8 36323.8 36398.3 36571.6 36577.6 57784.0 58744.0 58777.9 58783.0 58797.7 521106.0 589766.0 602735.0 607305.0 607734.0 46067.5 46411.1 46531.0 48584.3 49904.8 52561.5 53687.7 54316.0 54506.7 54709.0 43825.8 45107.5 45117.0 45321.5 46559.5 44464.6 45906.0 45908.8 46417.0 46980.3 45079.8 45431.3 46744.8 46760.0 46878.8 37788.2 39677.0 40087.2 40325.8 41070.6 29815.0 29930.4 30036.0 30099.4 30604.4 03:52:23 INFO - PROCESS | 29734 | 03:52:23 INFO - PROCESS | 29734 | [#2] jquery.html Cycles:180 Average:28751.11 Median:23814.73 stddev:76210.07 (320.0%) stddev-sans-first:76394.12 03:52:23 INFO - PROCESS | 29734 | Values: 392.7 429.4 434.9 438.3 442.2 15689.5 19026.5 19844.4 20989.9 21081.3 20002.2 20248.4 20335.2 20484.8 20538.8 5668.7 5948.1 5951.8 5956.7 5964.4 5567.6 5907.3 5915.0 5932.7 5938.5 5668.9 5902.9 5904.2 5910.8 5911.1 5813.8 5825.7 5857.9 5858.3 5859.0 5031.8 5089.6 5293.9 5300.0 5300.9 23590.3 24039.2 24118.2 24215.2 24270.4 2524.4 2538.4 2558.9 2595.7 2657.1 10050.1 10292.2 10458.6 10528.5 14718.0 1902.2 1907.6 1932.4 1958.3 1960.2 81849.6 82715.6 83204.6 87726.0 94100.0 10657.4 11305.4 11565.9 11581.2 11604.7 15572.0 15991.3 16186.4 16206.6 16208.8 8026.5 8197.0 8279.3 8313.3 8319.8 7690.2 8174.6 8179.6 8185.9 8512.3 5036.9 5108.4 5115.9 5241.6 5243.2 2025.6 2070.4 2096.9 2111.7 2133.9 934.6 1005.6 1032.9 1041.8 1046.3 19890.4 20428.3 20432.4 20503.7 20839.4 989.4 1012.0 1037.7 1063.6 1065.4 10428.6 11410.3 11469.1 11530.1 11594.9 400711.0 402618.0 404675.0 521367.0 537387.0 103712.5 105305.0 107880.0 110098.9 110735.4 506.8 528.4 1030.7 1063.6 1067.5 10747.2 11734.6 11939.9 11972.6 12603.6 39652.2 40403.8 41783.8 43083.0 43309.0 51894.5 61894.7 62268.4 63018.0 65002.0 8667.4 8991.2 8992.2 9008.8 9093.2 13042.4 13874.4 13898.6 14240.5 14363.1 11397.3 11688.4 11866.9 11909.3 12522.1 11952.6 12076.6 12081.7 12312.1 12376.2 12254.2 12413.9 12458.6 12468.4 12775.5 9102.9 9133.7 9177.4 9223.0 9299.3 9002.5 11304.8 11939.9 12223.9 12304.9 03:52:23 INFO - PROCESS | 29734 | 03:52:23 INFO - PROCESS | 29734 | [#3] mootools.html Cycles:180 Average:5741.80 Median:2837.81 stddev:3168.27 (111.6%) stddev-sans-first:3160.56 03:52:23 INFO - PROCESS | 29734 | Values: 1426.5 1506.1 1528.6 1694.7 1835.5 7380.8 8186.3 8568.4 8584.5 8857.8 8624.4 8692.2 8699.0 8705.3 8707.3 2493.7 2521.5 2525.0 2526.7 2527.4 2426.4 2522.6 2525.0 2526.4 2529.2 2454.4 2458.1 2472.2 2477.6 2479.4 2375.8 2395.1 2417.3 2422.8 2424.9 2447.5 2462.8 2473.2 2488.0 2488.7 8272.8 8453.2 8510.8 8655.3 8712.8 5442.9 5674.9 5677.7 5678.6 5681.0 3443.9 3528.1 3536.5 3579.3 3625.9 1188.7 1204.5 1221.3 1245.9 1259.0 12093.3 12128.3 12156.6 12166.2 12200.5 4512.6 4600.5 4775.8 4800.7 4834.9 9307.8 9313.7 9315.6 9321.2 9327.8 5448.2 5459.6 5460.2 5465.8 5469.8 4344.0 4550.1 4741.5 5096.6 5169.5 3894.9 3982.3 4017.9 4076.5 4082.1 1271.4 1282.9 1285.8 1286.3 1296.5 929.1 965.9 970.1 970.3 990.8 5748.9 5784.0 5803.3 5845.6 5865.2 457.0 461.7 490.2 505.6 516.3 4013.9 4045.3 4065.6 4080.9 4106.2 10304.8 10777.2 10781.8 10785.4 10813.6 10696.0 10717.6 10725.8 10737.5 10737.8 7670.6 8005.8 8266.3 8354.8 8366.9 5980.6 6068.7 6092.4 6093.8 6148.1 9655.8 9746.4 9804.4 9807.3 9913.6 8788.0 9111.2 9777.0 9810.1 9902.7 7454.0 7708.4 7715.9 7732.9 7942.6 8610.6 8628.6 8686.0 8694.1 8699.6 7679.3 7746.7 7760.8 7842.3 7845.7 7419.9 7489.6 7546.6 7571.5 7692.2 6912.2 6984.3 7028.4 7030.2 7032.8 5072.9 5132.9 5159.3 5177.6 5385.1 4957.5 4961.3 4988.4 5035.3 5150.6 03:52:23 INFO - PROCESS | 29734 | 03:52:23 INFO - PROCESS | 29734 | [#4] prototype.html Cycles:180 Average:4600.28 Median:5217.45 stddev:1316.10 (25.2%) stddev-sans-first:1280.26 03:52:23 INFO - PROCESS | 29734 | Values: 335.2 351.9 354.8 356.1 364.6 5139.7 5263.4 5314.1 5333.3 5361.2 5035.0 5151.9 5190.5 5206.3 5213.9 4180.9 4197.8 4203.9 4215.6 4219.5 3968.7 4155.9 4187.8 4197.1 4207.7 4124.1 4142.9 4148.0 4155.8 4158.2 4149.2 4157.7 4159.5 4170.1 4177.2 3711.2 3724.7 3731.4 3739.0 3747.4 4966.8 5085.8 5086.7 5128.3 5140.0 4741.2 4769.9 4779.2 4789.9 4809.6 5514.6 5519.3 5521.9 5530.0 5545.8 3875.3 4040.9 4055.4 4063.6 4074.3 5685.1 5713.0 5718.0 5720.2 5724.8 4163.7 4174.2 4174.9 4177.7 4180.6 4003.4 4202.7 4211.9 4235.2 4237.7 4737.2 4747.2 4751.9 4765.6 4766.5 5519.9 5524.9 5535.4 5543.3 5545.3 1327.4 1360.8 1361.3 1382.3 1404.0 974.7 974.7 991.2 996.5 997.6 5120.2 5124.5 5137.4 5144.2 5145.6 5308.3 5359.0 5369.0 5374.2 5383.1 4899.5 5130.4 5147.5 5149.6 5155.4 2825.3 2844.2 2846.7 2852.0 2862.0 5585.1 5606.9 5610.3 5625.5 5633.6 5356.6 5488.5 5488.7 5501.7 5521.4 5580.0 5590.7 5595.4 5608.8 5627.1 5221.0 5366.9 5372.7 5375.7 5387.3 5291.3 5295.5 5302.5 5315.8 5319.8 5574.9 5583.7 5610.4 5621.4 5678.7 3939.4 3968.4 4040.2 4050.5 4053.6 5357.5 5383.4 5386.7 5400.8 5455.3 5439.4 5450.6 5552.7 5555.7 5587.6 5545.9 5549.5 5558.6 5609.3 5622.0 5270.9 5449.3 5456.3 5473.6 5480.0 5548.3 5554.0 5569.9 5573.6 5575.3 5423.4 5428.8 5440.6 5448.7 5462.6 03:52:23 INFO - PROCESS | 29734 | 03:52:23 INFO - PROCESS | 29734 | [#5] yui.html Cycles:180 Average:18023.18 Median:4440.27 stddev:22933.32 (516.5%) stddev-sans-first:22961.28 03:52:23 INFO - PROCESS | 29734 | Values: 821.7 830.4 837.5 858.5 882.8 14371.9 15518.0 15672.2 15711.1 15721.3 14186.6 14309.2 14418.8 14438.3 14540.0 719.6 733.5 743.5 854.8 870.9 737.2 835.3 857.9 860.5 866.2 904.0 904.4 904.5 904.8 905.1 900.2 901.1 901.3 901.3 901.4 550.2 564.6 643.5 653.9 657.0 14709.1 14755.3 14801.9 14818.3 14844.6 13850.7 13996.2 14267.7 14280.8 14298.6 12795.9 12967.9 13097.9 13124.6 13313.1 4309.5 4330.2 4350.2 4402.2 4467.0 62942.0 63304.4 64167.7 64231.7 64755.7 10636.3 10696.1 10721.5 10805.2 10900.8 19165.6 19740.2 19849.8 19868.5 19988.9 8222.5 8354.5 8454.3 8481.0 8640.2 4413.6 4578.9 4583.8 4638.8 4736.6 3618.3 3729.5 3735.5 3738.5 3739.0 679.7 687.5 690.7 692.4 710.2 608.2 719.6 799.2 804.1 806.3 9461.7 9778.4 9872.2 10441.2 10581.1 692.8 712.5 714.9 780.0 782.2 4615.6 4657.3 4713.3 4755.6 4820.7 86516.6 86538.0 86617.6 89394.6 90497.5 73479.0 73785.6 74126.3 79824.0 81406.6 42213.6 47522.5 62953.0 64033.4 65158.0 10026.0 10304.1 10337.5 10411.8 10460.9 40491.4 41435.6 42801.4 46653.1 47035.5 57216.0 66384.7 67100.7 67851.0 69868.7 14238.8 14480.6 14549.3 14817.2 14878.7 14943.5 15502.8 16039.4 16309.5 16549.6 14350.4 14757.0 14785.0 14899.3 15581.6 14864.8 14869.5 15153.7 15932.0 15942.8 13702.2 14063.2 15142.5 15180.8 15275.1 11553.4 11799.5 12118.5 12170.5 12648.0 11478.6 11759.5 12001.6 12013.9 12282.1 03:52:23 INFO - PROCESS | 29734 | -------- Summary: end -------- 03:52:23 INFO - PROCESS | 29734 | 03:52:24 INFO - TEST-INFO | 29734: exit 0 03:52:24 INFO - TEST-OK | dromaeo_css | took 1117037ms 03:52:24 INFO - TEST-START | kraken 03:52:24 INFO - operating with platform_type : linux_ 03:52:24 INFO - Initialising browser for kraken test... 03:52:24 INFO - TEST-INFO | started process 30050 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvsZCqZ/profile http://localhost:44010/getInfo.html) 03:52:29 INFO - PROCESS | 30050 | __metrics Screen width/height:1600/1200 03:52:29 INFO - PROCESS | 30050 | colorDepth:24 03:52:29 INFO - PROCESS | 30050 | Browser inner width/height: 1024/697 03:52:29 INFO - PROCESS | 30050 | __metrics 03:52:30 INFO - PROCESS | 30050 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:52:30 INFO - PROCESS | 30050 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:52:30 INFO - PROCESS | 30050 | console.error: PushService: 03:52:30 INFO - PROCESS | 30050 | stateChangeProcessEnqueue: Error transitioning state 03:52:30 INFO - PROCESS | 30050 | UnknownError 03:52:31 INFO - TEST-INFO | 30050: exit 0 03:52:31 INFO - Browser initialized. 03:52:31 INFO - Running cycle 1/1 for kraken test... 03:52:31 INFO - TEST-INFO | started process 30139 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvsZCqZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:52:43 INFO - PROCESS | 30139 | RSS: Main: 147992576 03:52:43 INFO - PROCESS | 30139 | 03:52:45 INFO - PROCESS | 30139 | Cycle 1(1): loaded http://localhost:44010/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44010/tests/kraken/driver.html?testName=audio-beat-detection) 03:52:46 INFO - PROCESS | 30139 | RSS: Main: 189288448 03:52:46 INFO - PROCESS | 30139 | 03:52:48 INFO - PROCESS | 30139 | Cycle 1(1): loaded http://localhost:44010/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44010/tests/kraken/driver.html?testName=audio-dft) 03:52:49 INFO - PROCESS | 30139 | RSS: Main: 178573312 03:52:49 INFO - PROCESS | 30139 | 03:52:52 INFO - PROCESS | 30139 | Cycle 1(1): loaded http://localhost:44010/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44010/tests/kraken/driver.html?testName=audio-fft) 03:52:52 INFO - PROCESS | 30139 | RSS: Main: 269897728 03:52:52 INFO - PROCESS | 30139 | 03:52:54 INFO - PROCESS | 30139 | Cycle 1(1): loaded http://localhost:44010/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44010/tests/kraken/driver.html?testName=audio-oscillator) 03:52:55 INFO - PROCESS | 30139 | RSS: Main: 176463872 03:52:55 INFO - PROCESS | 30139 | 03:52:57 INFO - PROCESS | 30139 | Cycle 1(1): loaded http://localhost:44010/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44010/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:52:58 INFO - PROCESS | 30139 | RSS: Main: 178573312 03:52:58 INFO - PROCESS | 30139 | 03:53:01 INFO - PROCESS | 30139 | Cycle 1(1): loaded http://localhost:44010/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44010/tests/kraken/driver.html?testName=imaging-darkroom) 03:53:01 INFO - PROCESS | 30139 | RSS: Main: 216932352 03:53:01 INFO - PROCESS | 30139 | 03:53:05 INFO - PROCESS | 30139 | Cycle 1(1): loaded http://localhost:44010/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44010/tests/kraken/driver.html?testName=imaging-desaturate) 03:53:05 INFO - PROCESS | 30139 | RSS: Main: 215949312 03:53:05 INFO - PROCESS | 30139 | 03:53:08 INFO - PROCESS | 30139 | Cycle 1(1): loaded http://localhost:44010/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44010/tests/kraken/driver.html?testName=json-parse-financial) 03:53:08 INFO - PROCESS | 30139 | RSS: Main: 214822912 03:53:08 INFO - PROCESS | 30139 | 03:53:10 INFO - PROCESS | 30139 | Cycle 1(1): loaded http://localhost:44010/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44010/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:53:10 INFO - PROCESS | 30139 | RSS: Main: 177004544 03:53:10 INFO - PROCESS | 30139 | 03:53:12 INFO - PROCESS | 30139 | Cycle 1(1): loaded http://localhost:44010/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44010/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:53:13 INFO - PROCESS | 30139 | RSS: Main: 183828480 03:53:13 INFO - PROCESS | 30139 | 03:53:15 INFO - PROCESS | 30139 | Cycle 1(1): loaded http://localhost:44010/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44010/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:53:15 INFO - PROCESS | 30139 | RSS: Main: 190115840 03:53:15 INFO - PROCESS | 30139 | 03:53:18 INFO - PROCESS | 30139 | Cycle 1(1): loaded http://localhost:44010/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44010/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:53:19 INFO - PROCESS | 30139 | RSS: Main: 192606208 03:53:19 INFO - PROCESS | 30139 | 03:53:21 INFO - PROCESS | 30139 | Cycle 1(1): loaded http://localhost:44010/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44010/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:53:22 INFO - PROCESS | 30139 | RSS: Main: 194301952 03:53:22 INFO - PROCESS | 30139 | 03:53:24 INFO - PROCESS | 30139 | Cycle 1(1): loaded http://localhost:44010/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44010/tests/kraken/driver.html?testName=ai-astar) 03:53:24 INFO - PROCESS | 30139 | RSS: Main: 245149696 03:53:24 INFO - PROCESS | 30139 | 03:53:24 INFO - PROCESS | 30139 | __start_tp_report 03:53:24 INFO - PROCESS | 30139 | _x_x_mozilla_page_load 03:53:24 INFO - PROCESS | 30139 | _x_x_mozilla_page_load_details 03:53:24 INFO - PROCESS | 30139 | |i|pagename|runs| 03:53:24 INFO - PROCESS | 30139 | |0;ai-astar;104;111;113;112;114;112;112;111;112;112 03:53:24 INFO - PROCESS | 30139 | |1;audio-beat-detection;155;126;126;168;126;122;121;126;153;124 03:53:24 INFO - PROCESS | 30139 | |2;audio-dft;161;159;160;161;160;161;160;161;163;163 03:53:24 INFO - PROCESS | 30139 | |3;audio-fft;74;75;75;106;76;76;77;75;98;74 03:53:24 INFO - PROCESS | 30139 | |4;audio-oscillator;82;82;112;83;83;82;99;82;82;109 03:53:24 INFO - PROCESS | 30139 | |5;imaging-gaussian-blur;118;117;117;117;117;117;117;117;116;116 03:53:24 INFO - PROCESS | 30139 | |6;imaging-darkroom;146;146;148;145;145;146;148;147;146;147 03:53:24 INFO - PROCESS | 30139 | |7;imaging-desaturate;84;85;85;84;85;85;84;85;84;84 03:53:24 INFO - PROCESS | 30139 | |8;json-parse-financial;49;50;50;50;48;50;51;50;51;50 03:53:24 INFO - PROCESS | 30139 | |9;json-stringify-tinderbox;59;59;60;59;60;59;59;59;59;59 03:53:24 INFO - PROCESS | 30139 | |10;stanford-crypto-aes;76;75;74;75;75;75;76;75;75;76 03:53:24 INFO - PROCESS | 30139 | |11;stanford-crypto-ccm;127;127;127;133;126;127;133;132;165;139 03:53:24 INFO - PROCESS | 30139 | |12;stanford-crypto-pbkdf2;159;161;154;155;154;162;160;155;151;161 03:53:24 INFO - PROCESS | 30139 | |13;stanford-crypto-sha256-iterative;61;63;65;61;62;61;62;60;66;61 03:53:24 INFO - PROCESS | 30139 | __end_tp_report 03:53:24 INFO - PROCESS | 30139 | __start_cc_report 03:53:24 INFO - PROCESS | 30139 | _x_x_mozilla_cycle_collect,1590 03:53:24 INFO - PROCESS | 30139 | __end_cc_report 03:53:24 INFO - PROCESS | 30139 | __startTimestamp1480334004296__endTimestamp 03:53:24 INFO - PROCESS | 30139 | 03:53:24 INFO - PROCESS | 30139 | ------- Summary: start ------- 03:53:24 INFO - PROCESS | 30139 | Number of tests: 14 03:53:24 INFO - PROCESS | 30139 | 03:53:24 INFO - PROCESS | 30139 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.00 stddev:2.71 (2.4%) stddev-sans-first:0.93 03:53:24 INFO - PROCESS | 30139 | Values: 104.0 111.0 113.0 112.0 114.0 112.0 112.0 111.0 112.0 112.0 03:53:24 INFO - PROCESS | 30139 | 03:53:24 INFO - PROCESS | 30139 | [#1] audio-beat-detection Cycles:10 Average:134.70 Median:126.00 stddev:17.07 (13.5%) stddev-sans-first:16.45 03:53:24 INFO - PROCESS | 30139 | Values: 155.0 126.0 126.0 168.0 126.0 122.0 121.0 126.0 153.0 124.0 03:53:24 INFO - PROCESS | 30139 | 03:53:24 INFO - PROCESS | 30139 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.29 (0.8%) stddev-sans-first:1.36 03:53:24 INFO - PROCESS | 30139 | Values: 161.0 159.0 160.0 161.0 160.0 161.0 160.0 161.0 163.0 163.0 03:53:24 INFO - PROCESS | 30139 | 03:53:24 INFO - PROCESS | 30139 | [#3] audio-fft Cycles:10 Average:80.60 Median:75.50 stddev:11.47 (15.2%) stddev-sans-first:11.92 03:53:24 INFO - PROCESS | 30139 | Values: 74.0 75.0 75.0 106.0 76.0 76.0 77.0 75.0 98.0 74.0 03:53:24 INFO - PROCESS | 30139 | 03:53:24 INFO - PROCESS | 30139 | [#4] audio-oscillator Cycles:10 Average:89.60 Median:82.00 stddev:12.21 (14.9%) stddev-sans-first:12.64 03:53:24 INFO - PROCESS | 30139 | Values: 82.0 82.0 112.0 83.0 83.0 82.0 99.0 82.0 82.0 109.0 03:53:24 INFO - PROCESS | 30139 | 03:53:24 INFO - PROCESS | 30139 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 03:53:24 INFO - PROCESS | 30139 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 03:53:24 INFO - PROCESS | 30139 | 03:53:24 INFO - PROCESS | 30139 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:1.07 (0.7%) stddev-sans-first:1.13 03:53:24 INFO - PROCESS | 30139 | Values: 146.0 146.0 148.0 145.0 145.0 146.0 148.0 147.0 146.0 147.0 03:53:24 INFO - PROCESS | 30139 | 03:53:24 INFO - PROCESS | 30139 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:85.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 03:53:24 INFO - PROCESS | 30139 | Values: 84.0 85.0 85.0 84.0 85.0 85.0 84.0 85.0 84.0 84.0 03:53:24 INFO - PROCESS | 30139 | 03:53:24 INFO - PROCESS | 30139 | [#8] json-parse-financial Cycles:10 Average:49.90 Median:50.00 stddev:0.88 (1.8%) stddev-sans-first:0.87 03:53:24 INFO - PROCESS | 30139 | Values: 49.0 50.0 50.0 50.0 48.0 50.0 51.0 50.0 51.0 50.0 03:53:24 INFO - PROCESS | 30139 | 03:53:24 INFO - PROCESS | 30139 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:59.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 03:53:24 INFO - PROCESS | 30139 | Values: 59.0 59.0 60.0 59.0 60.0 59.0 59.0 59.0 59.0 59.0 03:53:24 INFO - PROCESS | 30139 | 03:53:24 INFO - PROCESS | 30139 | [#10] stanford-crypto-aes Cycles:10 Average:75.20 Median:75.00 stddev:0.63 (0.8%) stddev-sans-first:0.60 03:53:24 INFO - PROCESS | 30139 | Values: 76.0 75.0 74.0 75.0 75.0 75.0 76.0 75.0 75.0 76.0 03:53:24 INFO - PROCESS | 30139 | 03:53:24 INFO - PROCESS | 30139 | [#11] stanford-crypto-ccm Cycles:10 Average:133.60 Median:132.50 stddev:11.79 (8.9%) stddev-sans-first:12.26 03:53:24 INFO - PROCESS | 30139 | Values: 127.0 127.0 127.0 133.0 126.0 127.0 133.0 132.0 165.0 139.0 03:53:24 INFO - PROCESS | 30139 | 03:53:24 INFO - PROCESS | 30139 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.20 Median:159.50 stddev:3.82 (2.4%) stddev-sans-first:4.00 03:53:24 INFO - PROCESS | 30139 | Values: 159.0 161.0 154.0 155.0 154.0 162.0 160.0 155.0 151.0 161.0 03:53:24 INFO - PROCESS | 30139 | 03:53:24 INFO - PROCESS | 30139 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.20 Median:62.00 stddev:1.93 (3.1%) stddev-sans-first:2.00 03:53:24 INFO - PROCESS | 30139 | Values: 61.0 63.0 65.0 61.0 62.0 61.0 62.0 60.0 66.0 61.0 03:53:24 INFO - PROCESS | 30139 | -------- Summary: end -------- 03:53:24 INFO - PROCESS | 30139 | 03:53:25 INFO - TEST-INFO | 30139: exit 0 03:53:25 INFO - TEST-OK | kraken | took 60955ms 03:53:25 INFO - SUITE-END | took 1177s 03:53:25 INFO - Completed test suite (00:19:38) 03:53:25 INFO - javascript benchmark 03:53:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3138.7802853800235, 3165.6042994625673, 3182.7135557799807, 3197.0, 3223.7582181336406, 5454.699991500466, 5521.917171242435, 5528.0, 5541.168824676291, 5549.528290095347, 5536.920300541396, 5596.720163991805, 5598.888022239563, 5611.382747897728, 5627.634203776752, 5033.295338652591, 5045.873853153664, 5059.645824792247, 5122.948770512285, 5125.060448791767, 4977.875553111183, 4983.72589507577, 5097.974510127444, 5149.304843846089, 5153.561947234471, 5029.874253143683, 5041.243813427978, 5048.469910659383, 5057.620678449112, 5063.949360506403, 5079.060373830816, 5096.439391666913, 5097.9490205097845, 5162.92255616166, 5181.715005674687, 5002.424721157077, 5072.112380333427, 5107.131787596118, 5112.156494178456, 5129.487051294878, 5375.569954403638, 5393.83818485446, 5409.215663728776, 5413.188021796723, 5452.482014208684, 5894.97052514739, 5899.085641725539, 5907.0, 5936.465718085393, 5966.97016514919, 6037.45662890342, 6038.758449662008, 6043.637381757108, 6048.69756512177, 6069.02895536712, 5434.429384914606, 5448.482394172587, 5528.087865502228, 5535.806246781424, 5569.164625306236, 6072.666003369769, 6113.052476866093, 6114.510839132859, 6114.847128821815, 6128.2033335666965, 5871.853203669943, 5872.911906321408, 5873.911891321633, 5884.558658100574, 5884.970575147183, 5787.450192231731, 5797.4782269595935, 5826.504747096545, 5830.416958304136, 5832.125181222766, 5876.118582212703, 5877.706114694248, 5879.853003674857, 5907.940920590739, 5915.260592425947, 5822.097574875901, 5872.11918212263, 5874.706264686749, 5874.941250587525, 5879.559033072451, 4504.189245935698, 4546.02260513991, 4549.636029117729, 4564.178447879347, 4593.104344652761, 4077.306857834116, 4092.795360232036, 4097.7541347518645, 4104.445899803548, 4110.403991421227, 5664.122061080539, 5664.85837854057, 5664.97167514168, 5665.66006039639, 5677.034904066319, 5792.0732682771395, 5851.561132915049, 5909.054551271776, 5973.671448070398, 5981.0729336952845, 5635.6618602883955, 5704.686242256633, 5713.428657134254, 5736.5123964462655, 5738.8278351649515, 5157.871053223699, 5162.354705661793, 5173.249878767558, 5173.301604283373, 5176.597196964826, 6057.545684073801, 6106.877862442815, 6196.81409557723, 6252.062190671436, 6267.7806276781, 5845.532357411312, 5864.06175011996, 5890.882182356243, 5972.5520585955355, 6003.5797494174985, 6201.937980620317, 6206.906896396648, 6207.131001659681, 6209.782657606962, 6214.098955651315, 5717.942820571741, 5761.740721667451, 5847.766089356378, 5852.268466441695, 5853.297604287342, 5879.441453061952, 5913.674747888907, 5960.403959604005, 5965.045592705146, 6058.394160583906, 5855.7950471734985, 5898.174255604305, 5898.233229680114, 5899.528037757055, 5911.0, 5864.882702346014, 5867.442592953663, 5868.853278667897, 5871.823845284648, 5873.706314684334, 5340.465953404629, 5654.095344744986, 5655.943440565707, 5674.290713660793, 5688.914666279927, 5836.766529338949, 5844.503217226584, 5848.093545500455, 5849.590528662953, 5866.6480011199465, 5567.331920169606, 5585.469380408855, 5691.288588926384, 5708.65748055118, 5712.571557133148], "value": 5477.683360053686, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.2717589425271, 614.2015380005993, 643.1253495246464, 647.4690753582062, 653.8953767397218, 34784.65215347849, 38089.61910380895, 38140.0, 45657.77171114148, 46338.30492542614, 47441.0, 47743.52256477434, 47999.52000479994, 48030.279545806756, 48055.75972120134, 8884.555772211395, 9065.365424420293, 9079.773005674879, 9081.318901082412, 9082.591283392263, 8459.280961118282, 8495.277901378391, 8638.481691098523, 8643.740687779376, 8827.16141966512, 10739.087177589914, 10965.232433729641, 10975.012248897598, 11195.888041119606, 11258.324500529954, 10779.0, 10858.837117443245, 10871.45642717869, 10871.619493317696, 10874.130069594414, 10752.247342686014, 10824.350538967687, 10824.51289691958, 10828.837567436494, 10835.67492975212, 43771.0, 44019.779901100286, 44113.77943110296, 44118.77940610277, 44128.0, 3781.4516895050338, 3864.594217607139, 3931.6658084062888, 4233.23801715691, 4484.2376795944765, 32615.51076733851, 33244.3351132976, 33389.499157512655, 33524.49713254303, 35123.824380878184, 4384.912301753947, 4396.230659634583, 4428.180786554498, 4455.108978204372, 4530.252508336121, 355977.0, 358164.6734130658, 359611.0, 360126.0, 360267.0, 39088.0, 64691.67654161699, 64945.67527162334, 64963.35036649573, 65061.0, 39265.41101883474, 42040.0, 42141.57858421438, 42153.57846421497, 42221.0, 15984.680306393808, 16094.517164485083, 16098.597535061717, 16099.195040247942, 16105.67788644244, 12136.75726485483, 12140.33228172459, 12143.514259429523, 12147.210431321935, 12156.209846360136, 8952.507612081268, 9157.221636161, 9298.814023719488, 9592.808143837085, 9593.376430531993, 3570.625084366156, 3602.603713591503, 3602.819859007039, 3684.6499582539614, 3706.3513885070006, 1007.4559737741538, 1058.227493929436, 1093.3439936038314, 1113.9443027848738, 1128.5937062657438, 33983.32033359319, 34283.0, 34691.0, 34753.478697819555, 34824.0, 1031.4636389077637, 1120.5349779841274, 1146.6731981385265, 1188.607759439383, 1243.6269119264366, 15500.0, 17982.190801413966, 18134.45596632103, 18387.0, 19113.61772764537, 579537.0, 581487.0, 584435.0, 585937.0, 587031.0, 57426.425735742945, 57480.42519574834, 58007.0, 63488.04767928485, 65819.0, 1364.501956785786, 1400.467822227547, 1411.6541447345467, 1438.9064710793764, 1456.672248744024, 33664.831675841466, 36323.81838090793, 36398.27203455863, 36571.63428365682, 36577.63422365849, 57784.0, 58744.0, 58777.885548011225, 58783.0, 58797.70601146967, 521106.0, 589766.0, 602735.0, 607305.0, 607734.0, 46067.539324606325, 46411.071778563564, 46531.0, 48584.271235930784, 49904.754286056486, 52561.47438525566, 53687.73156134194, 54316.0, 54506.72746636241, 54709.0, 43825.78087109544, 45107.54892451165, 45117.0, 45321.54678453173, 46559.53440465552, 44464.55535444734, 45906.0, 45908.770456147504, 46417.0, 46980.29529556991, 45079.7746011281, 45431.318530222736, 46744.766276168404, 46760.0, 46878.76560617175, 37788.24423511569, 39677.0, 40087.198256034135, 40325.79837100796, 41070.58929410668, 29815.0, 29930.4013919716, 30036.0, 30099.398012040074, 30604.387912242077], "value": 20767.81172930739, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.6583872031333, 429.39669763981595, 434.8695391382585, 438.28559448099594, 442.2343743028116, 15689.52931412058, 19026.524336891584, 19844.40466785995, 20989.895050524727, 21081.26215582455, 20002.199912003503, 20248.392548223575, 20335.186592536316, 20484.795152048475, 20538.794612053876, 5668.68822214778, 5948.107783832438, 5951.821445356646, 5956.672383018954, 5964.433378829004, 5567.554595632339, 5907.291125064999, 5914.970425147868, 5932.673702946337, 5938.46553810157, 5668.886622267572, 5902.911456328137, 5904.232449781543, 5910.822675319747, 5911.113333000063, 5813.767449302044, 5825.708714564276, 5857.853553661129, 5858.297004359461, 5859.0, 5031.77357018935, 5089.567386772129, 5293.947060529423, 5300.0, 5300.946990530084, 23590.29229123129, 24039.158629447884, 24118.155864544657, 24215.15246966365, 24270.39324016896, 2524.3562891462743, 2538.3780973661387, 2558.859262740567, 2595.688517377927, 2657.1231493607065, 10050.145737612313, 10292.176625869912, 10458.581656733797, 10528.526216320284, 14718.0, 1902.1630482587755, 1907.637548865711, 1932.4202739178331, 1958.343954775152, 1960.2159136345433, 81849.59075204645, 82715.58642206811, 83204.58397708033, 87726.0, 94100.0, 10657.413842238751, 11305.434728263554, 11565.942170289263, 11581.247218930743, 11604.6518604442, 15571.975643166315, 15991.28039238237, 16186.352545898033, 16206.59483512898, 16208.75686864698, 8026.515094707498, 8196.959015205006, 8279.254867061873, 8313.33493320533, 8319.750407487785, 7690.192529784404, 8174.550399728072, 8179.550124743197, 8185.877211841827, 8512.319014478826, 5036.899262014739, 5108.361454818148, 5115.87210319745, 5241.580673546107, 5243.213517972258, 2025.615133124731, 2070.4202823209525, 2096.895155242232, 2111.6832475128545, 2133.9039743211592, 934.6168071090821, 1005.5776573839005, 1032.87605487342, 1041.8124737547314, 1046.3146638951498, 19890.403287901096, 20428.285010024578, 20432.387028389174, 20503.69244461334, 20839.42927141353, 989.3816364772017, 1011.9797604048025, 1037.6835065305004, 1063.6330465989222, 1065.4353192807823, 10428.582856685647, 11410.315381077162, 11469.139814513777, 11530.077593792477, 11594.94202528982, 400711.0, 402618.0, 404675.0, 521367.0, 537387.0, 103712.48143759233, 105305.0, 107880.0, 110098.89901100886, 110735.44632276948, 506.7972810875679, 528.3791544934686, 1030.685640879539, 1063.5958335832333, 1067.4769363012067, 10747.193960453154, 11734.647960561197, 11939.940300298444, 11972.555234825873, 12603.558875439316, 39652.2069558613, 40403.797981009906, 41783.7910810444, 43083.0, 43309.0, 51894.48105518897, 61894.69052654708, 62268.37731622807, 63018.0, 65002.0, 8667.4366166199, 8991.235744961752, 8992.190702836777, 9008.81982360336, 9093.226565897465, 13042.413091410719, 13874.375653095836, 13898.58304250874, 14240.501582444565, 14363.138211707332, 11397.259178153394, 11688.415579221175, 11866.881331186578, 11909.285442873455, 12522.123451358317, 11952.64142075739, 12076.577319793765, 12081.697957551132, 12312.13815032939, 12376.195547289397, 12254.20347677398, 12413.93793031029, 12458.632859756617, 12468.438920248429, 12775.488980440678, 9102.908970910206, 9133.725988220363, 9177.403468774508, 9222.95388523053, 9299.256059515357, 9002.549872506479, 11304.773904521699, 11939.940300298791, 12223.93888030554, 12304.876951230373], "value": 9400.452263254576, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1426.507854790097, 1506.1038681984219, 1528.625486755745, 1694.6525962177755, 1835.504413808271, 7380.778576642702, 8186.304164146048, 8568.400211985163, 8584.484930904142, 8857.822843543125, 8624.353173511996, 8692.217700406962, 8699.043105258417, 8705.260052895495, 8707.303415726743, 2493.7256901740793, 2521.4957008598353, 2524.9873750631314, 2526.6589010483626, 2527.36815796051, 2426.3934016495878, 2522.608995605684, 2524.9747502524924, 2526.418923647562, 2529.178017144435, 2454.398672325283, 2458.1150785717127, 2472.196536125757, 2477.6283557466436, 2479.3925488255404, 2375.798057165134, 2395.149721848745, 2417.3110663460916, 2422.81828862836, 2424.9272521824373, 2447.4615584571366, 2462.827602067856, 2473.245660073677, 2488.0296684292957, 2488.713797913227, 8272.83454330916, 8453.154684531559, 8510.78723031929, 8655.264302534291, 8712.825743485158, 5442.91835622466, 5674.914876276818, 5677.659340439587, 5678.5741069419955, 5680.971595142039, 3443.862245510202, 3528.1179705073732, 3536.45184996326, 3579.28414317135, 3625.8912232633065, 1188.7265928836416, 1204.5302332090491, 1221.2855479544478, 1245.862955074941, 1259.0, 12093.334866582334, 12128.272303661808, 12156.574519891761, 12166.209196402206, 12200.511979520808, 4512.593866551961, 4600.493945665974, 4775.761211939389, 4800.73595952219, 4834.8791280218275, 9307.813843723088, 9313.674021409219, 9315.627374905063, 9321.161095501437, 9327.766805829773, 5448.210009548672, 5459.563234941195, 5460.153676180198, 5465.836024919259, 5469.753861076261, 4343.956560434419, 4550.13547425988, 4741.502142275081, 5096.592272618182, 5169.508896654812, 3894.883153505399, 3982.283189026003, 4017.8995525111523, 4076.4700588923843, 4082.1223436961195, 1271.3897329281997, 1282.8717128287096, 1285.762134005212, 1286.292539103508, 1296.494367196794, 929.1451864284874, 965.88892277389, 970.0929630795229, 970.2916870684298, 990.7968866382519, 5748.942510574924, 5783.971080144656, 5803.303603567599, 5845.561582881301, 5865.178874957509, 456.9657275704269, 461.6560662306536, 490.1862907573411, 505.61320589748874, 516.3210378352454, 4013.8595149169637, 4045.332520134145, 4065.593440655911, 4080.9387859182134, 4106.2198182345255, 10304.793904121876, 10777.191710621735, 10781.838272425919, 10785.40680262593, 10813.56745730162, 10696.0, 10717.571297148183, 10725.83911241332, 10737.51681174349, 10737.83893241602, 7670.578118203553, 8005.759827205193, 8266.338692904554, 8354.79113022167, 8366.916330836613, 5980.594560278418, 6068.666223357758, 6092.360302168208, 6093.817185484442, 6148.108524263867, 9655.758606034624, 9746.366486178376, 9804.41173529562, 9807.313488056054, 9913.603455861974, 8788.0, 9111.17999380059, 9777.0, 9810.117089461983, 9902.702918912444, 7453.962730186531, 7708.383329333752, 7715.922840771745, 7732.884006740016, 7942.642581083981, 8610.569471526524, 8628.611712473079, 8686.0, 8694.130586941508, 8699.56502174876, 7679.308862202429, 7746.651400687096, 7760.805979850549, 7842.333401660922, 7845.725399610987, 7419.9258007421395, 7489.550626962399, 7546.641604511241, 7571.46999710037, 7692.19231980634, 6912.205096413977, 6984.301569842975, 7028.402585780266, 7030.226675065841, 7032.789016329519, 5072.949270507248, 5132.923006154985, 5159.303494028258, 5177.559907407762, 5385.111456609616, 4957.504249575014, 4961.255811628284, 4988.401391833003, 5035.345405097461, 5150.6137039721425], "value": 4589.20981692225, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.15039375183915, 351.9032266126813, 354.7995382608825, 356.14169850659914, 364.5570631682506, 5139.717315547643, 5263.3683957925105, 5314.096603577392, 5333.333333333333, 5361.249425080487, 5035.0, 5151.9042361322745, 5190.455002224769, 5206.271122042917, 5213.921791173136, 4180.853670121546, 4197.782643033524, 4203.915921681564, 4215.59951804578, 4219.514755803076, 3968.702347323948, 4155.8753237402925, 4187.811548480326, 4197.07664313852, 4207.72649777765, 4124.13393187431, 4142.8757137285775, 4148.0, 4155.812988415513, 4158.168366326731, 4149.232392007473, 4157.688173387008, 4159.523369203949, 4170.145120250371, 4177.206330797138, 3711.2391959648207, 3724.6647801697977, 3731.402975523903, 3739.0, 3747.3629482987685, 4966.826161084381, 5085.847424577269, 5086.720230387327, 5128.307678463434, 5139.974300128475, 4741.241401375798, 4769.880752981168, 4779.211430114027, 4789.904201915977, 4809.615230781529, 5514.6139770216105, 5519.337679478448, 5521.944780552183, 5529.972350138264, 5545.77816887324, 3875.3411919973673, 4040.8585699500672, 4055.3511438169753, 4063.5936406359424, 4074.286999775057, 5685.118806584986, 5713.0, 5717.971410142923, 5720.170575266563, 5724.79963201286, 4163.708540402204, 4174.227767862955, 4174.853880114242, 4177.707560470738, 4180.623743863067, 4003.417795521872, 4202.747835129902, 4211.873643790691, 4235.174141042528, 4237.660987121023, 4737.2183589708, 4747.192977193886, 4751.881202969884, 4765.618750499952, 4766.4995175506765, 5519.9448005520235, 5524.944750552523, 5535.446455354432, 5543.334799823966, 5545.251391062155, 1327.4491086199312, 1360.8298962629672, 1361.2717196299932, 1382.322661895684, 1404.0171879684262, 974.6890432368454, 974.7222041718077, 991.1921783746224, 996.5067291690515, 997.6059456514636, 5120.180771076684, 5124.539506240778, 5137.357830271216, 5144.176931690911, 5145.614078944094, 5308.274810686542, 5358.97320513395, 5368.973155134199, 5374.167004114369, 5383.070358638216, 4899.461059283476, 5130.4356520782685, 5147.459516750687, 5149.558123725363, 5155.432902380735, 2825.3360460291815, 2844.1751891951517, 2846.7010963848497, 2851.9714802852122, 2862.0, 5585.078462053797, 5606.887862242732, 5610.326760788732, 5625.46558076982, 5633.57748168889, 5356.5714742821265, 5488.4785945335125, 5488.725563721798, 5501.669899806025, 5521.365043020024, 5580.0, 5590.664560126405, 5595.384507704231, 5608.775648973995, 5627.127795191752, 5220.9738951305, 5366.867512015804, 5372.677639341652, 5375.677459352295, 5387.299651045339, 5291.3385826771655, 5295.4969277918535, 5302.549283310962, 5315.760790764502, 5319.787208511616, 5574.9442505574425, 5583.69289689071, 5610.438956104357, 5621.409751975983, 5678.744456499385, 3939.428782826417, 3968.3650615901315, 4040.151568170717, 4050.460824886642, 4053.6488836474186, 5357.464253574612, 5383.434739352469, 5386.7037312946595, 5400.7569659364635, 5455.318085239345, 5439.422567455394, 5450.645708028966, 5552.69460179694, 5555.694436806015, 5587.552995760248, 5545.861353466195, 5549.528290095225, 5558.555315574825, 5609.298837645294, 5622.0, 5270.920936186037, 5449.291592093161, 5456.2906822114455, 5473.644213126134, 5479.972600137134, 5548.250986116823, 5554.0, 5569.860753481195, 5573.581981351496, 5575.330960284792, 5423.376311724044, 5428.83713488596, 5440.591955603425, 5448.700321482198, 5462.590305727166], "value": 4187.831132383327, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [821.6507984106753, 830.3813658824176, 837.4723923927926, 858.5192292316301, 882.810195807902, 14371.856281437196, 15518.0, 15672.216389180523, 15711.135887526196, 15721.292541835617, 14186.574402767908, 14309.212993285391, 14418.783718244234, 14438.27808609568, 14540.0, 719.62219834587, 733.4572416411844, 743.4944237918213, 854.8162145138809, 870.9259712924409, 737.1706829816457, 835.3150416658343, 857.9442336248155, 860.5396113079504, 866.1901122450497, 903.9728808135767, 904.4256896870469, 904.525124309736, 904.8099899021213, 905.0949050949051, 900.2392977933636, 901.1349104859343, 901.2699713232303, 901.3104974694331, 901.3690416708298, 550.2131951309626, 564.5822091652188, 643.5012865029593, 653.8921078022169, 657.0144782825762, 14709.117452952856, 14755.26223688822, 14801.925990369979, 14818.259087045604, 14844.554663360117, 13850.722985540333, 13996.230207338593, 14267.714645707028, 14280.785788213185, 14298.64253393663, 12795.949769196424, 12967.935160324232, 13097.886679632242, 13124.606261812065, 13313.068085234037, 4309.525952145262, 4330.155619654169, 4350.238708226079, 4402.163588918095, 4466.955330446686, 62942.0, 63304.366956330305, 64167.67916160436, 64231.67884160596, 64755.67622161906, 10636.255462117577, 10696.090832279187, 10721.463926803628, 10805.189610779224, 10900.781984360268, 19165.61668766617, 19740.210391584176, 19849.801501985083, 19868.50328741764, 19988.900055499922, 8222.547759873265, 8354.45696029756, 8454.281386082252, 8480.957595211985, 8640.179182977732, 4413.58070983256, 4578.908421831545, 4583.816647334136, 4638.79125439356, 4736.64475164364, 3618.348697234523, 3729.4778730977687, 3735.4957080793747, 3738.476613274144, 3738.953093133927, 679.6635665345685, 687.5359132585485, 690.689189864563, 692.3976140757574, 710.1549156503744, 608.2088250103491, 719.6437763307197, 799.152897928198, 804.1435870797582, 806.334773811596, 9461.668841590512, 9778.364406313567, 9872.210223182128, 10441.164706823436, 10581.100606448537, 692.840646651263, 712.4834494991194, 714.9356557909709, 779.9727009554638, 782.1591788827034, 4615.630749540029, 4657.301404789308, 4713.269443236304, 4755.619550435957, 4820.662553621213, 86516.56741716251, 86538.0, 86617.56691216504, 89394.55302723445, 90497.54751226334, 73479.0, 73785.63107184538, 74126.25873741301, 79824.0, 81406.59296703478, 42213.57786422096, 47522.52477475181, 62953.0, 64033.359666403674, 65158.0, 10026.0, 10304.124149447382, 10337.534810933375, 10411.843822342822, 10460.947695261475, 40491.39262911, 41435.585644144376, 42801.357979629705, 46653.066938660355, 47035.52964470448, 57216.0, 66384.6680766593, 67100.6644966772, 67851.0, 69868.6506567464, 14238.786418203943, 14480.637984050483, 14549.272536373352, 14817.185054822088, 14878.702425951637, 14943.476978305707, 15502.767458488357, 16039.438619648256, 16309.51071467858, 16549.58626034359, 14350.425982960565, 14757.0, 14785.0, 14899.329530171384, 15581.610459738597, 14864.777028344368, 14869.47956821506, 15153.696926061637, 15932.0, 15942.760858587362, 13702.246376449391, 14063.156210627396, 15142.54572362831, 15180.848191517944, 15275.083494990336, 11553.422328883355, 11799.469023893773, 12118.515259389525, 12170.513179472722, 12648.0, 11478.598249061577, 11759.529618815493, 12001.63995080149, 12013.939930300292, 12282.140250182401], "value": 7503.001398045387, "unit": "score"}], "name": "dromaeo_css", "value": 7323.031138062951, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 113.0, 112.0, 114.0, 112.0, 112.0, 111.0, 112.0, 112.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 126.0, 126.0, 168.0, 126.0, 122.0, 121.0, 126.0, 153.0, 124.0], "value": 134.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 160.0, 161.0, 160.0, 161.0, 160.0, 161.0, 163.0, 163.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 106.0, 76.0, 76.0, 77.0, 75.0, 98.0, 74.0], "value": 80.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 112.0, 83.0, 83.0, 82.0, 99.0, 82.0, 82.0, 109.0], "value": 89.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 148.0, 145.0, 145.0, 146.0, 148.0, 147.0, 146.0, 147.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 84.0, 85.0, 85.0, 84.0, 85.0, 84.0, 84.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 50.0, 50.0, 50.0, 48.0, 50.0, 51.0, 50.0, 51.0, 50.0], "value": 49.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 60.0, 59.0, 60.0, 59.0, 59.0, 59.0, 59.0, 59.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 75.0, 75.0, 75.0, 76.0, 75.0, 75.0, 76.0], "value": 75.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 127.0, 127.0, 133.0, 126.0, 127.0, 133.0, 132.0, 165.0, 139.0], "value": 133.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 161.0, 154.0, 155.0, 154.0, 162.0, 160.0, 155.0, 151.0, 161.0], "value": 157.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 65.0, 61.0, 62.0, 61.0, 62.0, 60.0, 66.0, 61.0], "value": 62.2, "unit": "score"}], "name": "kraken", "value": 1462.2, "alertThreshold": 2.0}]} 03:53:25 INFO - Return code: 0 03:53:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:53:25 INFO - # TBPL SUCCESS # 03:53:25 INFO - Running post-action listener: _resource_record_post_action 03:53:25 INFO - [mozharness: 2016-11-28 11:53:25.589637Z] Finished run-tests step (success) 03:53:25 INFO - Running post-run listener: _resource_record_post_run 03:53:25 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 363094016; Read time: 16; Write time: 477512 03:53:25 INFO - TinderboxPrint: CPU usage
13.0% 03:53:25 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 03:53:25 INFO - TinderboxPrint: I/O write bytes / time
363,094,016 / 477,512 03:53:25 INFO - TinderboxPrint: CPU idle
8,301.5 (87.0%) 03:53:25 INFO - TinderboxPrint: CPU user
1,193.1 (12.5%) 03:53:25 INFO - TinderboxPrint: Swap in / out
0 / 0 03:53:25 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 108253184; Read time: 0; Write time: 205332 03:53:25 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 243572736; Read time: 0; Write time: 268348 03:53:26 INFO - Running post-run listener: _upload_blobber_files 03:53:26 INFO - Blob upload gear active. 03:53:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:53:26 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 03:53:26 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:53:26 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:53:26 INFO - (blobuploader) - INFO - Open directory for files ... 03:53:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:53:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:53:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:53:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:53:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:53:27 INFO - (blobuploader) - INFO - Done attempting. 03:53:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:53:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:53:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:53:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:53:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:53:28 INFO - (blobuploader) - INFO - Done attempting. 03:53:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:53:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:53:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:53:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:53:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:53:32 INFO - (blobuploader) - INFO - Done attempting. 03:53:32 INFO - (blobuploader) - INFO - Iteration through files over. 03:53:32 INFO - Return code: 0 03:53:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:53:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:53:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d93c864b8a18022328f0ccaf7c1131729e12d270130259c3a39779828eaee93bf6b587d61585888a6292a6cdbe6b0462643b23d13bb2fb82897c7d36f4ed3426", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9fabd0661dffd07d109b31d2d5cf570047348f63700395c701d299deb7cdf4b30918ec3d3bfb79d9348d4dca83bd4333ef533a1a4f49609019ac3ab8ab12d612", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c836bbc0c9a5f4f3f659b6d55a3a22ec744767442de97b72de4e9a7c64b05a9cb4b2c1ea2ee6fe9bcc9d1506906297a5d0d4bd50b80b57cae785368d1acadbdf"} 03:53:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:53:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:53:32 INFO - Contents: 03:53:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d93c864b8a18022328f0ccaf7c1131729e12d270130259c3a39779828eaee93bf6b587d61585888a6292a6cdbe6b0462643b23d13bb2fb82897c7d36f4ed3426", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9fabd0661dffd07d109b31d2d5cf570047348f63700395c701d299deb7cdf4b30918ec3d3bfb79d9348d4dca83bd4333ef533a1a4f49609019ac3ab8ab12d612", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c836bbc0c9a5f4f3f659b6d55a3a22ec744767442de97b72de4e9a7c64b05a9cb4b2c1ea2ee6fe9bcc9d1506906297a5d0d4bd50b80b57cae785368d1acadbdf"} 03:53:32 INFO - Running post-run listener: copy_logs_to_upload_dir 03:53:32 INFO - Copying logs to upload dir... 03:53:32 INFO - mkdir: /builds/slave/test/build/upload/logs 03:53:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.561207 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-11-28 03:53:31.133575) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-28 03:53:31.140678) ========= 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=5cf47e208febbcd81da23b2e0000026f-1480331097.732306-1450121767 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d93c864b8a18022328f0ccaf7c1131729e12d270130259c3a39779828eaee93bf6b587d61585888a6292a6cdbe6b0462643b23d13bb2fb82897c7d36f4ed3426", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9fabd0661dffd07d109b31d2d5cf570047348f63700395c701d299deb7cdf4b30918ec3d3bfb79d9348d4dca83bd4333ef533a1a4f49609019ac3ab8ab12d612", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c836bbc0c9a5f4f3f659b6d55a3a22ec744767442de97b72de4e9a7c64b05a9cb4b2c1ea2ee6fe9bcc9d1506906297a5d0d4bd50b80b57cae785368d1acadbdf"} build_url:https://queue.taskcluster.net/v1/task/GeRxbj7MR1qvJudTL3AeOA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011716 build_url: 'https://queue.taskcluster.net/v1/task/GeRxbj7MR1qvJudTL3AeOA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d93c864b8a18022328f0ccaf7c1131729e12d270130259c3a39779828eaee93bf6b587d61585888a6292a6cdbe6b0462643b23d13bb2fb82897c7d36f4ed3426", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9fabd0661dffd07d109b31d2d5cf570047348f63700395c701d299deb7cdf4b30918ec3d3bfb79d9348d4dca83bd4333ef533a1a4f49609019ac3ab8ab12d612", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c836bbc0c9a5f4f3f659b6d55a3a22ec744767442de97b72de4e9a7c64b05a9cb4b2c1ea2ee6fe9bcc9d1506906297a5d0d4bd50b80b57cae785368d1acadbdf"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-28 03:53:31.169145) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 03:53:31.169507) ========= 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=5cf47e208febbcd81da23b2e0000026f-1480331097.732306-1450121767 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004534 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 03:53:31.249951) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-28 03:53:31.250258) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-28 03:53:31.250546) ========= ========= Total master_lag: 0.18 =========