builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-056 starttime: 1480002429.17 results: success (0) buildid: 20161124050619 builduid: 8df6fc0f8c944eedad569230d5879ce5 revision: 233a0890b3b35d778b2a50f1d7b064a8bcb82fb1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-24 07:47:09.172790) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-24 07:47:09.173227) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-24 07:47:09.173534) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-24 07:47:09.187898) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 07:47:09.188172) ========= 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=52faae308a556c440401f8e5000001e8-1480000820.898883-1725220654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-24 07:47:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.0M=0s 2016-11-24 07:47:09 (46.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.112389 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 07:47:09.314206) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 07:47:09.314538) ========= 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=52faae308a556c440401f8e5000001e8-1480000820.898883-1725220654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017762 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 07:47:09.364180) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 07:47:09.364568) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 233a0890b3b35d778b2a50f1d7b064a8bcb82fb1 --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 233a0890b3b35d778b2a50f1d7b064a8bcb82fb1 --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=52faae308a556c440401f8e5000001e8-1480000820.898883-1725220654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-24 07:47:09,473 truncating revision to first 12 chars 2016-11-24 07:47:09,473 Setting DEBUG logging. 2016-11-24 07:47:09,473 attempt 1/10 2016-11-24 07:47:09,473 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/233a0890b3b3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-24 07:47:09,777 unpacking tar archive at: mozilla-aurora-233a0890b3b3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.592390 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 07:47:09.970275) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-24 07:47:09.970603) ========= script_repo_revision: 233a0890b3b35d778b2a50f1d7b064a8bcb82fb1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-24 07:47:09.971011) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-24 07:47:09.971316) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-24 07:47:09.980108) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-11-24 07:47:09.980491) ========= /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=52faae308a556c440401f8e5000001e8-1480000820.898883-1725220654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:47:10 INFO - MultiFileLogger online at 20161124 07:47:10 in /builds/slave/test 07:47:10 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 07:47:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:47:10 INFO - {'append_to_log': False, 07:47:10 INFO - 'base_work_dir': '/builds/slave/test', 07:47:10 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:47:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:47:10 INFO - 'branch': 'Mozilla-Aurora', 07:47:10 INFO - 'buildbot_json_path': 'buildprops.json', 07:47:10 INFO - 'config_files': ('talos/linux_config.py',), 07:47:10 INFO - 'default_actions': ('clobber', 07:47:10 INFO - 'read-buildbot-config', 07:47:10 INFO - 'download-and-extract', 07:47:10 INFO - 'populate-webroot', 07:47:10 INFO - 'create-virtualenv', 07:47:10 INFO - 'install', 07:47:10 INFO - 'run-tests'), 07:47:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:47:10 INFO - 'download_minidump_stackwalk': True, 07:47:10 INFO - 'download_symbols': 'ondemand', 07:47:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:47:10 INFO - 'tooltool.py': '/tools/tooltool.py', 07:47:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:47:10 INFO - '/tools/misc-python/virtualenv.py')}, 07:47:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:47:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:47:10 INFO - 'installer_path': 'installer.exe', 07:47:10 INFO - 'log_level': 'info', 07:47:10 INFO - 'log_name': 'talos', 07:47:10 INFO - 'log_to_console': True, 07:47:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:47:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:47:10 INFO - 'opt_config_files': (), 07:47:10 INFO - 'pip_index': False, 07:47:10 INFO - 'sps_profile': False, 07:47:10 INFO - 'sps_profile_interval': 0, 07:47:10 INFO - 'suite': 'dromaeojs', 07:47:10 INFO - 'system_bits': '32', 07:47:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:47:10 INFO - 'title': 'talos-linux64-ix-056', 07:47:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:47:10 INFO - 'use_talos_json': True, 07:47:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:47:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:47:10 INFO - 'work_dir': 'build'} 07:47:10 INFO - [mozharness: 2016-11-24 15:47:10.184736Z] Running clobber step. 07:47:10 INFO - Running pre-action listener: _resource_record_pre_action 07:47:10 INFO - Running main action method: clobber 07:47:10 INFO - rmtree: /builds/slave/test/build 07:47:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:47:10 INFO - Running post-action listener: _resource_record_post_action 07:47:10 INFO - [mozharness: 2016-11-24 15:47:10.637508Z] Finished clobber step (success) 07:47:10 INFO - [mozharness: 2016-11-24 15:47:10.637608Z] Running read-buildbot-config step. 07:47:10 INFO - Running pre-action listener: _resource_record_pre_action 07:47:10 INFO - Running main action method: read_buildbot_config 07:47:10 INFO - Using buildbot properties: 07:47:10 INFO - { 07:47:10 INFO - "project": "", 07:47:10 INFO - "product": "firefox", 07:47:10 INFO - "script_repo_revision": "production", 07:47:10 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 07:47:10 INFO - "repository": "", 07:47:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 07:47:10 INFO - "buildid": "20161124050619", 07:47:10 INFO - "pgo_build": "True", 07:47:10 INFO - "basedir": "/builds/slave/test", 07:47:10 INFO - "buildnumber": 642, 07:47:10 INFO - "slavename": "talos-linux64-ix-056", 07:47:10 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:47:10 INFO - "platform": "ubuntu64_hw", 07:47:10 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 07:47:10 INFO - "branch": "mozilla-aurora", 07:47:10 INFO - "repo_path": "releases/mozilla-aurora", 07:47:10 INFO - "revision": "233a0890b3b35d778b2a50f1d7b064a8bcb82fb1", 07:47:10 INFO - "stage_platform": "linux64-pgo", 07:47:10 INFO - "builduid": "8df6fc0f8c944eedad569230d5879ce5", 07:47:10 INFO - "slavebuilddir": "test" 07:47:10 INFO - } 07:47:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/BwlxZDJ0S0OhizATfKdDbA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 07:47:10 INFO - Running post-action listener: _resource_record_post_action 07:47:10 INFO - [mozharness: 2016-11-24 15:47:10.640052Z] Finished read-buildbot-config step (success) 07:47:10 INFO - [mozharness: 2016-11-24 15:47:10.640152Z] Running download-and-extract step. 07:47:10 INFO - Running pre-action listener: _resource_record_pre_action 07:47:10 INFO - Running main action method: download_and_extract 07:47:10 INFO - mkdir: /builds/slave/test/build/tests 07:47: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')]} 07:47:10 INFO - trying https://queue.taskcluster.net/v1/task/BwlxZDJ0S0OhizATfKdDbA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 07:47:10 INFO - Downloading https://queue.taskcluster.net/v1/task/BwlxZDJ0S0OhizATfKdDbA/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 07:47:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BwlxZDJ0S0OhizATfKdDbA/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 07:47:11 INFO - Downloaded 1361 bytes. 07:47:11 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 07:47:11 INFO - Using the following test package requirements: 07:47:11 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 07:47:11 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 07:47:11 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 07:47:11 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 07:47:11 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 07:47:11 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 07:47:11 INFO - u'jsshell-linux-x86_64.zip'], 07:47:11 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 07:47:11 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 07:47:11 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 07:47:11 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 07:47:11 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 07:47:11 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 07:47:11 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 07:47:11 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 07:47:11 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 07:47:11 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 07:47:11 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 07:47:11 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:47:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BwlxZDJ0S0OhizATfKdDbA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 07:47:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BwlxZDJ0S0OhizATfKdDbA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:47:11 INFO - Fetch https://queue.taskcluster.net/v1/task/BwlxZDJ0S0OhizATfKdDbA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 07:47:12 INFO - Http code: 200 07:47:12 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 07:47:12 INFO - x-amz-cf-id: kdFpMvDoaga9fdmc9j5XN_SUr8yW9jpA3S3O2DQFg9pT96P4Kz6vKA== 07:47:12 INFO - x-amz-version-id: zv1_hX2rm.CZ_f2Pu1s5JWAHQT_6qX5h 07:47:13 INFO - Expected file size: 21949119 07:47:13 INFO - Obtained file size: 21949119 07:47:17 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 07:47:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BwlxZDJ0S0OhizATfKdDbA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 07:47:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BwlxZDJ0S0OhizATfKdDbA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:47:17 INFO - Fetch https://queue.taskcluster.net/v1/task/BwlxZDJ0S0OhizATfKdDbA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 07:47:17 INFO - Http code: 200 07:47:17 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 07:47:17 INFO - x-amz-cf-id: UGWl_ynTqc5PNvMjQZltk1nyL91j8EzSMv6jDqb19ssabSvSKlbXHw== 07:47:17 INFO - x-amz-version-id: zv1_hX2rm.CZ_f2Pu1s5JWAHQT_6qX5h 07:47:18 INFO - Expected file size: 21949119 07:47:18 INFO - Obtained file size: 21949119 07:47:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BwlxZDJ0S0OhizATfKdDbA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 07:47:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BwlxZDJ0S0OhizATfKdDbA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:47:22 INFO - Fetch https://queue.taskcluster.net/v1/task/BwlxZDJ0S0OhizATfKdDbA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 07:47:23 INFO - Http code: 200 07:47:23 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 07:47:23 INFO - x-amz-cf-id: P-kcFeCHz7MQ2BlPoIhXubDYRUssTqPqR4DBRkVYntcBoKJXDtBTYw== 07:47:23 INFO - x-amz-version-id: 3W7clLqKbQJMXOvmImTFOrBcQcVX4fI1 07:47:24 INFO - Expected file size: 14409038 07:47:24 INFO - Obtained file size: 14409038 07:47:24 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')]} 07:47:24 INFO - trying https://queue.taskcluster.net/v1/task/BwlxZDJ0S0OhizATfKdDbA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 07:47:24 INFO - Downloading https://queue.taskcluster.net/v1/task/BwlxZDJ0S0OhizATfKdDbA/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 07:47:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BwlxZDJ0S0OhizATfKdDbA/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 07:47:27 INFO - Downloaded 63973209 bytes. 07:47:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BwlxZDJ0S0OhizATfKdDbA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 07:47:27 INFO - mkdir: /builds/slave/test/properties 07:47:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:47:27 INFO - Writing to file /builds/slave/test/properties/build_url 07:47:27 INFO - Contents: 07:47:27 INFO - build_url:https://queue.taskcluster.net/v1/task/BwlxZDJ0S0OhizATfKdDbA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 07:47:28 INFO - Running post-action listener: _resource_record_post_action 07:47:28 INFO - Running post-action listener: set_extra_try_arguments 07:47:28 INFO - [mozharness: 2016-11-24 15:47:28.670313Z] Finished download-and-extract step (success) 07:47:28 INFO - [mozharness: 2016-11-24 15:47:28.670539Z] Running populate-webroot step. 07:47:28 INFO - Running pre-action listener: _resource_record_pre_action 07:47:28 INFO - Running main action method: populate_webroot 07:47:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:47:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:47:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:47:28 INFO - '--tppagecycles', 07:47:28 INFO - '7'], 07:47:28 INFO - 'tests': ['tsvgm']}}, 07:47:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:47:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:47:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:47:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:47:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:47:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:47:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:28 INFO - 'talos_options': ['--disable-e10s'], 07:47:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:47:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:47:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:28 INFO - 'talos_options': ['--disable-e10s'], 07:47:28 INFO - 'tests': ['damp', 'tps']}, 07:47:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:28 INFO - 'tests': ['damp', 'tps']}, 07:47:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:47:28 INFO - 'tests': ['dromaeo_dom']}, 07:47:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:47:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:47:28 INFO - 'tests': ['basic_compositor_video']}, 07:47:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:47:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:47:28 INFO - 'tests': ['a11yr', 07:47:28 INFO - 'ts_paint', 07:47:28 INFO - 'tpaint', 07:47:28 INFO - 'sessionrestore', 07:47:28 INFO - 'sessionrestore_no_auto_restore', 07:47:28 INFO - 'tabpaint']}, 07:47:28 INFO - 'other-e10s': {'tests': ['a11yr', 07:47:28 INFO - 'ts_paint', 07:47:28 INFO - 'tpaint', 07:47:28 INFO - 'sessionrestore', 07:47:28 INFO - 'sessionrestore_no_auto_restore', 07:47:28 INFO - 'tabpaint']}, 07:47:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:47:28 INFO - 'ts_paint', 07:47:28 INFO - 'tpaint', 07:47:28 INFO - 'sessionrestore', 07:47:28 INFO - 'sessionrestore_no_auto_restore', 07:47:28 INFO - 'tabpaint']}, 07:47:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:47:28 INFO - 'ts_paint', 07:47:28 INFO - 'tpaint', 07:47:28 INFO - 'sessionrestore', 07:47:28 INFO - 'sessionrestore_no_auto_restore', 07:47:28 INFO - 'tabpaint']}, 07:47:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:47:28 INFO - 'tests': ['a11yr', 07:47:28 INFO - 'ts_paint', 07:47:28 INFO - 'tpaint', 07:47:28 INFO - 'sessionrestore', 07:47:28 INFO - 'sessionrestore_no_auto_restore', 07:47:28 INFO - 'tabpaint']}, 07:47:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:47:28 INFO - 'tests': ['a11yr', 07:47:28 INFO - 'ts_paint', 07:47:28 INFO - 'tpaint', 07:47:28 INFO - 'sessionrestore', 07:47:28 INFO - 'sessionrestore_no_auto_restore', 07:47:28 INFO - 'tabpaint']}, 07:47:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:47:28 INFO - 'tests': ['tsvgx', 07:47:28 INFO - 'tsvgr_opacity', 07:47:28 INFO - 'tart', 07:47:28 INFO - 'tscrollx', 07:47:28 INFO - 'cart']}, 07:47:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:47:28 INFO - 'tsvgr_opacity', 07:47:28 INFO - 'tart', 07:47:28 INFO - 'tscrollx', 07:47:28 INFO - 'cart']}, 07:47:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:28 INFO - 'talos_options': ['--disable-e10s'], 07:47:28 INFO - 'tests': ['tp5o']}, 07:47:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:28 INFO - 'tests': ['tp5o']}, 07:47:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:28 INFO - 'talos_options': ['--disable-e10s', 07:47:28 INFO - '--xperf_path', 07:47:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:47:28 INFO - 'tests': ['tp5n']}, 07:47:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:28 INFO - 'talos_options': ['--xperf_path', 07:47:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:47:28 INFO - 'tests': ['tp5n']}}, 07:47:28 INFO - 'talos.zip': {'path': '', 07:47:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:47:28 INFO - Running post-action listener: _resource_record_post_action 07:47:28 INFO - [mozharness: 2016-11-24 15:47:28.692503Z] Finished populate-webroot step (success) 07:47:28 INFO - [mozharness: 2016-11-24 15:47:28.692600Z] Running create-virtualenv step. 07:47:28 INFO - Running pre-action listener: _resource_record_pre_action 07:47:28 INFO - Running main action method: create_virtualenv 07:47:28 INFO - Creating virtualenv /builds/slave/test/build/venv 07:47:28 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 07:47:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:47:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:47:28 INFO - Using real prefix '/usr' 07:47:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:47:29 INFO - Installing distribute.............................................................................................................................................................................................done. 07:47:31 INFO - Installing pip.................done. 07:47:31 INFO - Return code: 0 07:47:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:47:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:47:31 INFO - Reading from file tmpfile_stdout 07:47:31 INFO - Output received: 07:47:31 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) 07:47:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:47:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:31 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 0x7fa7f3f0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b17f60>, '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 0x1b18d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b191d0>, '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': '52faae308a556c440401f8e5000001e8-1480000820.898883-1725220654', '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 07:47:31 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 07:47:31 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 07:47:31 INFO - Using env: {'DISPLAY': ':0', 07:47:31 INFO - 'HOME': '/home/cltbld', 07:47:31 INFO - 'LANG': 'en_US.UTF-8', 07:47:31 INFO - 'LANGUAGE': 'en_US:en', 07:47:31 INFO - 'LOGNAME': 'cltbld', 07:47:31 INFO - 'MAIL': '/var/mail/cltbld', 07:47:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:31 INFO - 'MOZ_NO_REMOTE': '1', 07:47:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:47:31 INFO - 'NO_EM_RESTART': '1', 07:47:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:47:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:31 INFO - 'PWD': '/builds/slave/test', 07:47:31 INFO - 'SHELL': '/bin/bash', 07:47:31 INFO - 'SHLVL': '1', 07:47:31 INFO - 'TERM': 'linux', 07:47:31 INFO - 'TMOUT': '86400', 07:47:31 INFO - 'USER': 'cltbld', 07:47:31 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1480000820.898883-1725220654', 07:47:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:31 INFO - '_': '/tools/buildbot/bin/python'} 07:47:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:31 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 07:47:31 INFO - Cleaning up... 07:47:31 INFO - Return code: 0 07:47:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:47:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:31 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 0x7fa7f3f0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b17f60>, '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 0x1b18d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b191d0>, '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': '52faae308a556c440401f8e5000001e8-1480000820.898883-1725220654', '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 07:47:31 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 07:47:31 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 07:47:31 INFO - Using env: {'DISPLAY': ':0', 07:47:31 INFO - 'HOME': '/home/cltbld', 07:47:31 INFO - 'LANG': 'en_US.UTF-8', 07:47:31 INFO - 'LANGUAGE': 'en_US:en', 07:47:31 INFO - 'LOGNAME': 'cltbld', 07:47:31 INFO - 'MAIL': '/var/mail/cltbld', 07:47:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:31 INFO - 'MOZ_NO_REMOTE': '1', 07:47:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:47:31 INFO - 'NO_EM_RESTART': '1', 07:47:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:47:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:31 INFO - 'PWD': '/builds/slave/test', 07:47:31 INFO - 'SHELL': '/bin/bash', 07:47:31 INFO - 'SHLVL': '1', 07:47:31 INFO - 'TERM': 'linux', 07:47:31 INFO - 'TMOUT': '86400', 07:47:31 INFO - 'USER': 'cltbld', 07:47:31 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1480000820.898883-1725220654', 07:47:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:31 INFO - '_': '/tools/buildbot/bin/python'} 07:47:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:31 INFO - Downloading/unpacking psutil>=3.1.1 07:47:31 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 07:47:31 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 07:47:31 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 07:47:31 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 07:47:31 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 07:47:31 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 07:47:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:47:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:47:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:47:33 INFO - Installing collected packages: psutil 07:47:33 INFO - Running setup.py install for psutil 07:47:34 INFO - building 'psutil._psutil_linux' extension 07:47:34 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 07:47:34 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 07:47:34 INFO - building 'psutil._psutil_posix' extension 07:47:34 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 07:47:34 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 07:47:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:47:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:47:34 INFO - Successfully installed psutil 07:47:34 INFO - Cleaning up... 07:47:34 INFO - Return code: 0 07:47:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:47:34 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')]} 07:47:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:34 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')]} 07:47:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:34 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 0x7fa7f3f0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b17f60>, '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 0x1b18d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b191d0>, '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': '52faae308a556c440401f8e5000001e8-1480000820.898883-1725220654', '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 07:47:34 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 07:47:34 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 07:47:34 INFO - Using env: {'DISPLAY': ':0', 07:47:34 INFO - 'HOME': '/home/cltbld', 07:47:34 INFO - 'LANG': 'en_US.UTF-8', 07:47:34 INFO - 'LANGUAGE': 'en_US:en', 07:47:34 INFO - 'LOGNAME': 'cltbld', 07:47:34 INFO - 'MAIL': '/var/mail/cltbld', 07:47:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:34 INFO - 'MOZ_NO_REMOTE': '1', 07:47:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:47:34 INFO - 'NO_EM_RESTART': '1', 07:47:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:47:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:34 INFO - 'PWD': '/builds/slave/test', 07:47:34 INFO - 'SHELL': '/bin/bash', 07:47:34 INFO - 'SHLVL': '1', 07:47:34 INFO - 'TERM': 'linux', 07:47:34 INFO - 'TMOUT': '86400', 07:47:34 INFO - 'USER': 'cltbld', 07:47:34 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1480000820.898883-1725220654', 07:47:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:34 INFO - '_': '/tools/buildbot/bin/python'} 07:47:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:47:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:47:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:47:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:47:36 INFO - Installing collected packages: mozsystemmonitor 07:47:36 INFO - Running setup.py install for mozsystemmonitor 07:47:36 INFO - Successfully installed mozsystemmonitor 07:47:36 INFO - Cleaning up... 07:47:36 INFO - Return code: 0 07:47:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:47:36 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')]} 07:47:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:36 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')]} 07:47:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:36 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 0x7fa7f3f0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b17f60>, '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 0x1b18d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b191d0>, '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': '52faae308a556c440401f8e5000001e8-1480000820.898883-1725220654', '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 07:47:36 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 07:47:36 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 07:47:36 INFO - Using env: {'DISPLAY': ':0', 07:47:36 INFO - 'HOME': '/home/cltbld', 07:47:36 INFO - 'LANG': 'en_US.UTF-8', 07:47:36 INFO - 'LANGUAGE': 'en_US:en', 07:47:36 INFO - 'LOGNAME': 'cltbld', 07:47:36 INFO - 'MAIL': '/var/mail/cltbld', 07:47:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:36 INFO - 'MOZ_NO_REMOTE': '1', 07:47:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:47:36 INFO - 'NO_EM_RESTART': '1', 07:47:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:47:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:36 INFO - 'PWD': '/builds/slave/test', 07:47:36 INFO - 'SHELL': '/bin/bash', 07:47:36 INFO - 'SHLVL': '1', 07:47:36 INFO - 'TERM': 'linux', 07:47:36 INFO - 'TMOUT': '86400', 07:47:36 INFO - 'USER': 'cltbld', 07:47:36 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1480000820.898883-1725220654', 07:47:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:36 INFO - '_': '/tools/buildbot/bin/python'} 07:47:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:37 INFO - Downloading/unpacking jsonschema==2.5.1 07:47:37 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 07:47:37 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 07:47:37 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 07:47:37 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 07:47:37 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 07:47:37 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 07:47:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:47:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:47:39 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 07:47:39 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 07:47:39 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 07:47:39 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 07:47:39 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 07:47:39 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 07:47:39 INFO - Downloading functools32-3.2.3-2.tar.gz 07:47:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:47:39 INFO - warning: no files found matching '*.txt' 07:47:39 INFO - no previously-included directories found matching 'build' 07:47:39 INFO - no previously-included directories found matching 'dist' 07:47:39 INFO - no previously-included directories found matching '.git*' 07:47:39 INFO - Installing collected packages: jsonschema, functools32 07:47:39 INFO - Running setup.py install for functools32 07:47:39 INFO - warning: no files found matching '*.txt' 07:47:39 INFO - no previously-included directories found matching 'build' 07:47:39 INFO - no previously-included directories found matching 'dist' 07:47:39 INFO - no previously-included directories found matching '.git*' 07:47:39 INFO - Successfully installed jsonschema functools32 07:47:39 INFO - Cleaning up... 07:47:39 INFO - Return code: 0 07:47:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:47:39 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')]} 07:47:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:39 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')]} 07:47:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:39 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 0x7fa7f3f0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b17f60>, '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 0x1b18d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b191d0>, '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': '52faae308a556c440401f8e5000001e8-1480000820.898883-1725220654', '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 07:47:39 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 07:47:39 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 07:47:39 INFO - Using env: {'DISPLAY': ':0', 07:47:39 INFO - 'HOME': '/home/cltbld', 07:47:39 INFO - 'LANG': 'en_US.UTF-8', 07:47:39 INFO - 'LANGUAGE': 'en_US:en', 07:47:39 INFO - 'LOGNAME': 'cltbld', 07:47:39 INFO - 'MAIL': '/var/mail/cltbld', 07:47:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:39 INFO - 'MOZ_NO_REMOTE': '1', 07:47:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:47:39 INFO - 'NO_EM_RESTART': '1', 07:47:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:47:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:39 INFO - 'PWD': '/builds/slave/test', 07:47:39 INFO - 'SHELL': '/bin/bash', 07:47:39 INFO - 'SHLVL': '1', 07:47:39 INFO - 'TERM': 'linux', 07:47:39 INFO - 'TMOUT': '86400', 07:47:39 INFO - 'USER': 'cltbld', 07:47:39 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1480000820.898883-1725220654', 07:47:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:39 INFO - '_': '/tools/buildbot/bin/python'} 07:47:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:47:39 INFO - Cleaning up... 07:47:39 INFO - Return code: 0 07:47:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:47:39 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')]} 07:47:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:39 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')]} 07:47:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:39 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 0x7fa7f3f0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b17f60>, '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 0x1b18d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b191d0>, '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': '52faae308a556c440401f8e5000001e8-1480000820.898883-1725220654', '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 07:47:39 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 07:47:39 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 07:47:39 INFO - Using env: {'DISPLAY': ':0', 07:47:39 INFO - 'HOME': '/home/cltbld', 07:47:39 INFO - 'LANG': 'en_US.UTF-8', 07:47:39 INFO - 'LANGUAGE': 'en_US:en', 07:47:39 INFO - 'LOGNAME': 'cltbld', 07:47:39 INFO - 'MAIL': '/var/mail/cltbld', 07:47:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:39 INFO - 'MOZ_NO_REMOTE': '1', 07:47:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:47:39 INFO - 'NO_EM_RESTART': '1', 07:47:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:47:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:39 INFO - 'PWD': '/builds/slave/test', 07:47:39 INFO - 'SHELL': '/bin/bash', 07:47:39 INFO - 'SHLVL': '1', 07:47:39 INFO - 'TERM': 'linux', 07:47:39 INFO - 'TMOUT': '86400', 07:47:39 INFO - 'USER': 'cltbld', 07:47:39 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1480000820.898883-1725220654', 07:47:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:39 INFO - '_': '/tools/buildbot/bin/python'} 07:47:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:39 INFO - Downloading/unpacking blobuploader==1.2.4 07:47:39 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 07:47:39 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 07:47:39 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 07:47:39 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 07:47:39 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 07:47:39 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 07:47:41 INFO - Downloading blobuploader-1.2.4.tar.gz 07:47:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:47:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:47:41 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 07:47:41 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 07:47:41 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 07:47:41 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 07:47:41 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 07:47:41 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 07:47:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:47:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:47:42 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 07:47:42 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 07:47:42 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 07:47:42 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 07:47:42 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 07:47:42 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 07:47:42 INFO - Downloading docopt-0.6.1.tar.gz 07:47:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:47:42 INFO - Installing collected packages: blobuploader, requests, docopt 07:47:42 INFO - Running setup.py install for blobuploader 07:47:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:47:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:47:42 INFO - Running setup.py install for requests 07:47:43 INFO - Running setup.py install for docopt 07:47:43 INFO - Successfully installed blobuploader requests docopt 07:47:43 INFO - Cleaning up... 07:47:43 INFO - Return code: 0 07:47:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:47:43 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')]} 07:47:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:43 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')]} 07:47:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:43 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 0x7fa7f3f0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b17f60>, '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 0x1b18d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b191d0>, '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': '52faae308a556c440401f8e5000001e8-1480000820.898883-1725220654', '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 07:47:43 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 07:47:43 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 07:47:43 INFO - Using env: {'DISPLAY': ':0', 07:47:43 INFO - 'HOME': '/home/cltbld', 07:47:43 INFO - 'LANG': 'en_US.UTF-8', 07:47:43 INFO - 'LANGUAGE': 'en_US:en', 07:47:43 INFO - 'LOGNAME': 'cltbld', 07:47:43 INFO - 'MAIL': '/var/mail/cltbld', 07:47:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:43 INFO - 'MOZ_NO_REMOTE': '1', 07:47:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:47:43 INFO - 'NO_EM_RESTART': '1', 07:47:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:47:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:43 INFO - 'PWD': '/builds/slave/test', 07:47:43 INFO - 'SHELL': '/bin/bash', 07:47:43 INFO - 'SHLVL': '1', 07:47:43 INFO - 'TERM': 'linux', 07:47:43 INFO - 'TMOUT': '86400', 07:47:43 INFO - 'USER': 'cltbld', 07:47:43 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1480000820.898883-1725220654', 07:47:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:43 INFO - '_': '/tools/buildbot/bin/python'} 07:47:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:47:43 INFO - Running setup.py (path:/tmp/pip-I_g1k5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:47:43 INFO - Running setup.py (path:/tmp/pip-rEKdln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:47:43 INFO - Running setup.py (path:/tmp/pip-CazhXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:47:43 INFO - Running setup.py (path:/tmp/pip-0z5gBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:47:43 INFO - Running setup.py (path:/tmp/pip-c4hcG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:47:43 INFO - Running setup.py (path:/tmp/pip-Fs6FvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:47:44 INFO - Running setup.py (path:/tmp/pip-GbgaD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:47:44 INFO - Running setup.py (path:/tmp/pip-xFvwIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:47:44 INFO - Running setup.py (path:/tmp/pip-kuiSxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:47:44 INFO - Running setup.py (path:/tmp/pip-mseVub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:47:44 INFO - Running setup.py (path:/tmp/pip-wAWSb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:47:44 INFO - Running setup.py (path:/tmp/pip-xhBzEZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:47:44 INFO - Running setup.py (path:/tmp/pip-9n_Q1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:47:44 INFO - Running setup.py (path:/tmp/pip-ruBrqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:47:44 INFO - Running setup.py (path:/tmp/pip-U9hp5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:47:44 INFO - Running setup.py (path:/tmp/pip-ZxmJEr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:47:44 INFO - Running setup.py (path:/tmp/pip-YmpR6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:47:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:47:44 INFO - Running setup.py install for manifestparser 07:47:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:47:44 INFO - Running setup.py install for mozcrash 07:47:44 INFO - Running setup.py install for mozdebug 07:47:45 INFO - Running setup.py install for mozdevice 07:47:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:47:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:47:45 INFO - Running setup.py install for mozfile 07:47:45 INFO - Running setup.py install for mozhttpd 07:47:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:47:45 INFO - Running setup.py install for mozinfo 07:47:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:47:45 INFO - Running setup.py install for mozInstall 07:47:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:47:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:47:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:47:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:47:45 INFO - Running setup.py install for mozleak 07:47:45 INFO - Running setup.py install for mozlog 07:47:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:47:45 INFO - Running setup.py install for moznetwork 07:47:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:47:45 INFO - Running setup.py install for mozprocess 07:47:46 INFO - Running setup.py install for mozprofile 07:47:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:47:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:47:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:47:46 INFO - Running setup.py install for mozrunner 07:47:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:47:46 INFO - Running setup.py install for mozscreenshot 07:47:46 INFO - Running setup.py install for moztest 07:47:46 INFO - Running setup.py install for mozversion 07:47:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:47:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:47:46 INFO - Cleaning up... 07:47:46 INFO - Return code: 0 07:47:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:47:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:46 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 0x7fa7f3f0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b17f60>, '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 0x1b18d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b191d0>, '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': '52faae308a556c440401f8e5000001e8-1480000820.898883-1725220654', '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 07:47:46 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 07:47:46 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 07:47:46 INFO - Using env: {'DISPLAY': ':0', 07:47:46 INFO - 'HOME': '/home/cltbld', 07:47:46 INFO - 'LANG': 'en_US.UTF-8', 07:47:46 INFO - 'LANGUAGE': 'en_US:en', 07:47:46 INFO - 'LOGNAME': 'cltbld', 07:47:46 INFO - 'MAIL': '/var/mail/cltbld', 07:47:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:46 INFO - 'MOZ_NO_REMOTE': '1', 07:47:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:47:46 INFO - 'NO_EM_RESTART': '1', 07:47:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:47:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:46 INFO - 'PWD': '/builds/slave/test', 07:47:46 INFO - 'SHELL': '/bin/bash', 07:47:46 INFO - 'SHLVL': '1', 07:47:46 INFO - 'TERM': 'linux', 07:47:46 INFO - 'TMOUT': '86400', 07:47:46 INFO - 'USER': 'cltbld', 07:47:46 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1480000820.898883-1725220654', 07:47:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:46 INFO - '_': '/tools/buildbot/bin/python'} 07:47:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:47:46 INFO - Running setup.py (path:/tmp/pip-PMAlL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:47:46 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)) 07:47:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:47:46 INFO - Running setup.py (path:/tmp/pip-m6o4NH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:47:46 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)) 07:47:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:47:46 INFO - Running setup.py (path:/tmp/pip-aNQES9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:47:47 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)) 07:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:47:47 INFO - Running setup.py (path:/tmp/pip-IVWZVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:47:47 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)) 07:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:47:47 INFO - Running setup.py (path:/tmp/pip-qbaTOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:47:47 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)) 07:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:47:47 INFO - Running setup.py (path:/tmp/pip-nxw0te-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:47:47 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)) 07:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:47:47 INFO - Running setup.py (path:/tmp/pip-oDZBt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:47:47 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)) 07:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:47:47 INFO - Running setup.py (path:/tmp/pip-JjKYKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:47:47 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)) 07:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:47:47 INFO - Running setup.py (path:/tmp/pip-gobvlX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:47:47 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)) 07:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:47:47 INFO - Running setup.py (path:/tmp/pip-2hrnxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:47:47 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)) 07:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:47:47 INFO - Running setup.py (path:/tmp/pip-afwwbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:47:47 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)) 07:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:47:47 INFO - Running setup.py (path:/tmp/pip-LaloaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:47:47 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)) 07:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:47:47 INFO - Running setup.py (path:/tmp/pip-IjD3lU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:47:47 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)) 07:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:47:47 INFO - Running setup.py (path:/tmp/pip-OcLSem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:47:47 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)) 07:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:47:47 INFO - Running setup.py (path:/tmp/pip-O64Qd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:47:47 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)) 07:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:47:47 INFO - Running setup.py (path:/tmp/pip-XxIPL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:47:47 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)) 07:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:47:47 INFO - Running setup.py (path:/tmp/pip-kNJbn7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:47:48 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)) 07:47:48 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)) 07:47:48 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)) 07:47:48 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)) 07:47:48 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)) 07:47:48 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)) 07:47:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:47:48 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 07:47:48 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 07:47:48 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 07:47:48 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 07:47:48 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 07:47:48 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 07:47:49 INFO - Downloading blessings-1.6.tar.gz 07:47:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:47:50 INFO - Installing collected packages: blessings 07:47:50 INFO - Running setup.py install for blessings 07:47:50 INFO - Successfully installed blessings 07:47:50 INFO - Cleaning up... 07:47:50 INFO - Return code: 0 07:47:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:47:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:47:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:47:50 INFO - Reading from file tmpfile_stdout 07:47:50 INFO - Current package versions: 07:47:50 INFO - argparse == 1.2.1 07:47:50 INFO - blessings == 1.6 07:47:50 INFO - blobuploader == 1.2.4 07:47:50 INFO - docopt == 0.6.1 07:47:50 INFO - functools32 == 3.2.3-2 07:47:50 INFO - jsonschema == 2.5.1 07:47:50 INFO - manifestparser == 1.1 07:47:50 INFO - mozInstall == 1.12 07:47:50 INFO - mozcrash == 1.0 07:47:50 INFO - mozdebug == 0.1 07:47:50 INFO - mozdevice == 0.48 07:47:50 INFO - mozfile == 1.2 07:47:50 INFO - mozhttpd == 0.7 07:47:50 INFO - mozinfo == 0.9 07:47:50 INFO - mozleak == 0.1 07:47:50 INFO - mozlog == 3.4 07:47:50 INFO - moznetwork == 0.27 07:47:50 INFO - mozprocess == 0.23 07:47:50 INFO - mozprofile == 0.28 07:47:50 INFO - mozrunner == 6.13 07:47:50 INFO - mozscreenshot == 0.1 07:47:50 INFO - mozsystemmonitor == 0.3 07:47:50 INFO - moztest == 0.7 07:47:50 INFO - mozversion == 1.4 07:47:50 INFO - psutil == 3.1.1 07:47:50 INFO - requests == 1.2.3 07:47:50 INFO - wsgiref == 0.1.2 07:47:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:47:50 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')]} 07:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:50 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')]} 07:47:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:50 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 0x7fa7f3f0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b17f60>, '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 0x1b18d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b191d0>, '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': '52faae308a556c440401f8e5000001e8-1480000820.898883-1725220654', '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 07:47:50 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 07:47:50 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 07:47:50 INFO - Using env: {'DISPLAY': ':0', 07:47:50 INFO - 'HOME': '/home/cltbld', 07:47:50 INFO - 'LANG': 'en_US.UTF-8', 07:47:50 INFO - 'LANGUAGE': 'en_US:en', 07:47:50 INFO - 'LOGNAME': 'cltbld', 07:47:50 INFO - 'MAIL': '/var/mail/cltbld', 07:47:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:50 INFO - 'MOZ_NO_REMOTE': '1', 07:47:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:47:50 INFO - 'NO_EM_RESTART': '1', 07:47:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:47:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:50 INFO - 'PWD': '/builds/slave/test', 07:47:50 INFO - 'SHELL': '/bin/bash', 07:47:50 INFO - 'SHLVL': '1', 07:47:50 INFO - 'TERM': 'linux', 07:47:50 INFO - 'TMOUT': '86400', 07:47:50 INFO - 'USER': 'cltbld', 07:47:50 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1480000820.898883-1725220654', 07:47:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:50 INFO - '_': '/tools/buildbot/bin/python'} 07:47:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:50 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)) 07:47:50 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)) 07:47:50 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)) 07:47:50 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)) 07:47:50 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)) 07:47:50 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)) 07:47:50 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)) 07:47:50 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)) 07:47:50 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)) 07:47:50 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)) 07:47:50 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)) 07:47:50 INFO - Cleaning up... 07:47:50 INFO - Return code: 0 07:47:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:47:50 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')]} 07:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:50 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')]} 07:47:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:50 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 0x7fa7f3f0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b17f60>, '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 0x1b18d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b191d0>, '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': '52faae308a556c440401f8e5000001e8-1480000820.898883-1725220654', '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 07:47:50 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 07:47:50 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 07:47:50 INFO - Using env: {'DISPLAY': ':0', 07:47:50 INFO - 'HOME': '/home/cltbld', 07:47:50 INFO - 'LANG': 'en_US.UTF-8', 07:47:50 INFO - 'LANGUAGE': 'en_US:en', 07:47:50 INFO - 'LOGNAME': 'cltbld', 07:47:50 INFO - 'MAIL': '/var/mail/cltbld', 07:47:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:50 INFO - 'MOZ_NO_REMOTE': '1', 07:47:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:47:50 INFO - 'NO_EM_RESTART': '1', 07:47:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:47:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:50 INFO - 'PWD': '/builds/slave/test', 07:47:50 INFO - 'SHELL': '/bin/bash', 07:47:50 INFO - 'SHLVL': '1', 07:47:50 INFO - 'TERM': 'linux', 07:47:50 INFO - 'TMOUT': '86400', 07:47:50 INFO - 'USER': 'cltbld', 07:47:50 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1480000820.898883-1725220654', 07:47:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:50 INFO - '_': '/tools/buildbot/bin/python'} 07:47:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:47:50 INFO - Cleaning up... 07:47:50 INFO - Return code: 0 07:47:50 INFO - Running post-action listener: _resource_record_post_action 07:47:50 INFO - Running post-action listener: _start_resource_monitoring 07:47:50 INFO - Starting resource monitoring. 07:47:50 INFO - [mozharness: 2016-11-24 15:47:50.949976Z] Finished create-virtualenv step (success) 07:47:50 INFO - [mozharness: 2016-11-24 15:47:50.950438Z] Running install step. 07:47:50 INFO - Running pre-action listener: _resource_record_pre_action 07:47:50 INFO - Running main action method: install 07:47:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:47:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:47:51 INFO - Reading from file tmpfile_stdout 07:47:51 INFO - Detecting whether we're running mozinstall >=1.0... 07:47:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:47:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:47:51 INFO - Reading from file tmpfile_stdout 07:47:51 INFO - Output received: 07:47:51 INFO - Usage: mozinstall [options] installer 07:47:51 INFO - Options: 07:47:51 INFO - -h, --help show this help message and exit 07:47:51 INFO - -d DEST, --destination=DEST 07:47:51 INFO - Directory to install application into. [default: 07:47:51 INFO - "/builds/slave/test"] 07:47:51 INFO - --app=APP Application being installed. [default: firefox] 07:47:51 INFO - mkdir: /builds/slave/test/build/application 07:47:51 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'] 07:47:51 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 07:48:07 INFO - Reading from file tmpfile_stdout 07:48:07 INFO - Output received: 07:48:07 INFO - /builds/slave/test/build/application/firefox/firefox 07:48:07 INFO - Running post-action listener: _resource_record_post_action 07:48:07 INFO - [mozharness: 2016-11-24 15:48:07.186628Z] Finished install step (success) 07:48:07 INFO - [mozharness: 2016-11-24 15:48:07.186872Z] Running run-tests step. 07:48:07 INFO - Running pre-action listener: _resource_record_pre_action 07:48:07 INFO - Running main action method: run_tests 07:48:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:48:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:48:07 INFO - Python 2.7.3 07:48:07 INFO - Return code: 0 07:48:07 INFO - grabbing minidump binary from tooltool 07:48:07 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')]} 07:48:07 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 0x1b17f60>, '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 0x1b18d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b191d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:48:07 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 07:48:07 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 07:48:07 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 07:48:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:48:07 INFO - Return code: 0 07:48:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:48:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:48:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:48:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:48:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:48:07 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/BwlxZDJ0S0OhizATfKdDbA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 07:48:07 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/BwlxZDJ0S0OhizATfKdDbA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --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 07:48:07 INFO - Using env: {'DISPLAY': ':0', 07:48:07 INFO - 'HOME': '/home/cltbld', 07:48:07 INFO - 'LANG': 'en_US.UTF-8', 07:48:07 INFO - 'LANGUAGE': 'en_US:en', 07:48:07 INFO - 'LOGNAME': 'cltbld', 07:48:07 INFO - 'MAIL': '/var/mail/cltbld', 07:48:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:48:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:48:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:07 INFO - 'MOZ_NO_REMOTE': '1', 07:48:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:48:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:48:07 INFO - 'NO_EM_RESTART': '1', 07:48:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:48:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:07 INFO - 'PWD': '/builds/slave/test', 07:48:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:48:07 INFO - 'SHELL': '/bin/bash', 07:48:07 INFO - 'SHLVL': '1', 07:48:07 INFO - 'TERM': 'linux', 07:48:07 INFO - 'TMOUT': '86400', 07:48:07 INFO - 'USER': 'cltbld', 07:48:07 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1480000820.898883-1725220654', 07:48:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:07 INFO - '_': '/tools/buildbot/bin/python'} 07:48:07 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/BwlxZDJ0S0OhizATfKdDbA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 07:48:07 INFO - mozversion application_buildid: 20161124050619 07:48:07 INFO - mozversion application_changeset: 233a0890b3b35d778b2a50f1d7b064a8bcb82fb1 07:48:07 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:48:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:48:07 INFO - mozversion application_name: Firefox 07:48:07 INFO - mozversion application_remotingname: firefox-dev 07:48:07 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:48:07 INFO - mozversion application_vendor: Mozilla 07:48:07 INFO - mozversion application_version: 52.0a2 07:48:07 INFO - mozversion platform_buildid: 20161124050619 07:48:07 INFO - mozversion platform_changeset: 233a0890b3b35d778b2a50f1d7b064a8bcb82fb1 07:48:07 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:48:07 INFO - mozversion platform_version: 52.0a2 07:48:07 INFO - using testdate: 1480002487 07:48:07 INFO - actual date: 1480002487 07:48:07 INFO - starting webserver on 'localhost:50410' 07:48:07 INFO - SUITE-START | Running 2 tests 07:48:07 INFO - TEST-START | dromaeo_css 07:48:07 INFO - operating with platform_type : linux_ 07:48:07 INFO - Initialising browser for dromaeo_css test... 07:48:07 INFO - TEST-INFO | started process 3969 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppFrLes/profile http://localhost:50410/getInfo.html) 07:48:11 INFO - PROCESS | 3969 | __metrics Screen width/height:1600/1200 07:48:11 INFO - PROCESS | 3969 | colorDepth:24 07:48:11 INFO - PROCESS | 3969 | Browser inner width/height: 1024/697 07:48:11 INFO - PROCESS | 3969 | __metrics 07:48:12 INFO - PROCESS | 3969 | 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" 07:48:12 INFO - PROCESS | 3969 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:48:13 INFO - PROCESS | 3969 | console.error: PushService: 07:48:13 INFO - PROCESS | 3969 | stateChangeProcessEnqueue: Error transitioning state 07:48:13 INFO - PROCESS | 3969 | UnknownError 07:48:13 INFO - TEST-INFO | 3969: exit 0 07:48:13 INFO - Browser initialized. 07:48:13 INFO - Running cycle 1/1 for dromaeo_css test... 07:48:13 INFO - TEST-INFO | started process 4064 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppFrLes/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:48:25 INFO - PROCESS | 4064 | RSS: Main: 144781312 07:48:25 INFO - PROCESS | 4064 | 07:49:16 INFO - PROCESS | 4064 | 1480002556655 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] 07:51:26 INFO - PROCESS | 4064 | Cycle 1(1): loaded http://localhost:50410/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50410/tests/dromaeo/cssquery-ext.html) 07:51:28 INFO - PROCESS | 4064 | RSS: Main: 243912704 07:51:28 INFO - PROCESS | 4064 | 07:54:30 INFO - PROCESS | 4064 | Cycle 1(1): loaded http://localhost:50410/tests/dromaeo/cssquery-ext.html (next: http://localhost:50410/tests/dromaeo/cssquery-jquery.html) 07:54:31 INFO - PROCESS | 4064 | RSS: Main: 231059456 07:54:31 INFO - PROCESS | 4064 | 07:57:33 INFO - PROCESS | 4064 | Cycle 1(1): loaded http://localhost:50410/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50410/tests/dromaeo/cssquery-mootools.html) 07:57:33 INFO - PROCESS | 4064 | RSS: Main: 196313088 07:57:33 INFO - PROCESS | 4064 | 08:00:35 INFO - PROCESS | 4064 | Cycle 1(1): loaded http://localhost:50410/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50410/tests/dromaeo/cssquery-prototype.html) 08:00:36 INFO - PROCESS | 4064 | RSS: Main: 174403584 08:00:36 INFO - PROCESS | 4064 | 08:03:38 INFO - PROCESS | 4064 | Cycle 1(1): loaded http://localhost:50410/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50410/tests/dromaeo/cssquery-yui.html) 08:03:39 INFO - PROCESS | 4064 | RSS: Main: 175480832 08:03:39 INFO - PROCESS | 4064 | 08:06:41 INFO - PROCESS | 4064 | Cycle 1(1): loaded http://localhost:50410/tests/dromaeo/cssquery-yui.html (next: http://localhost:50410/tests/dromaeo/cssquery-dojo.html) 08:06:42 INFO - PROCESS | 4064 | RSS: Main: 265658368 08:06:42 INFO - PROCESS | 4064 | 08:06:42 INFO - PROCESS | 4064 | __start_tp_report 08:06:42 INFO - PROCESS | 4064 | _x_x_mozilla_page_load 08:06:42 INFO - PROCESS | 4064 | _x_x_mozilla_page_load_details 08:06:42 INFO - PROCESS | 4064 | |i|pagename|runs| 08:06:42 INFO - PROCESS | 4064 | |0;dojo.html;3188.6492485826557;3207.967920320796;3225.9354812903744;3244.286257023454;3253;5482.80810171644;5519.558435325174;5522.30971128609;5529.1982662513965;5543.833684989447;5482.095454250044;5557.888842223163;5559.833205003856;5574.832755017346;5578.497935185833;5006.073876332872;5028.195488721805;5054.797808087672;5070.492950704936;5101.38783345999;4944.480829512903;4962.776675049631;4984.127777638917;5031.22016087507;5092.134337162673;5040.1935690289565;5093.719845408501;5103.26002729604;5110.948890511103;5117.488251174871;5026.2711906773675;5040.143175660129;5062.215356619693;5074.137396642543;5113.6931784092885;4737.099951009332;4771.212749896263;4953.083679519301;4958.181899986498;5012.824551140692;5307.628466007381;5371.516563509303;5392.379876314196;5454.53636440903;5492.148716948879;5794.68129252891;5819.88360232793;5888.116782482619;5893.911591326134;5928.40715928408;5736.196932429463;5954.315253745832;6022.879542409128;6026.457618814284;6033.78881739137;5419.430959749248;5421.241026256327;5553.8333849984165;5557.166425036277;5569.415211402826;6070.666113363807;6089.543284253698;6090.177825993434;6091.086337049478;6121.418465245794;5703.030484817591;5861.531077513789;5862.062070068769;5862.384449632812;5869.589128761031;5727.656340619576;5748;5778.537716982715;5797.768089276466;5839.766409343579;5751.309842818889;5752.7698892043845;5756.107803290497;5757.280339957505;5761.337446193657;5848.853778655568;5854.151148083504;5861.41385861419;5862.149988251765;5865.882682346414;4483.730976141442;4500.729956202638;4508.932366014513;4516.728996260234;4541.75020373876;4039.0710136668145;4065.5324637666454;4080.4083407905687;4082.9591704082577;4099.8975025624595;5593.692346920959;5600.411956744565;5608.747606357723;5614.214010038598;5627.184058311522;5739.253896993364;5818.4763371296785;5886.646801191942;5893.322267939242;5941.287045554561;5679.403662615448;5685.232493613392;5686.317641882918;5695.829125126253;5720;5144.8713782155;5147.0992576298995;5150.793968241303;5156.303898973665;5195.948040519622;6018.8194354169445;6037.879242415039;6057.666828324308;6221.346758590283;6229.626222426669;5813.3605303417435;5871.412858714265;5876.706164691663;5908.231929849092;5919.408059194218;6035.577509574287;6073.453389194994;6087.726052327745;6090.269167699905;6092.360302168208;5708.571857110816;5716.28546431696;5760.711964401679;5766.798162064308;5770.105633626795;5760.279965004374;5850.64896106235;5864.824055278348;5913.58604897653;5953.791617293374;5769.192313076089;5780.884382312414;5788.536917046542;5798.10129429939;5809.157672137601;5643.915341269966;5792.362840087671;5801.158831969256;5803.622764520293;5807.767689292381;5569;5573.3869274380595;5584;5603.1875378069135;5668.688222147656;5686.459786320293;5722.971385143048;5724.313082430135;5729.169270455677;5739.9139012914;5512.062949298549;5574.637648552831;5592.133219351007;5605.943940560543;5611.8877622448135 08:06:42 INFO - PROCESS | 4064 | |1;ext.html;567.6877717255511;595.3213336796052;619.6901549225387;639.3223183425566;655.7114869457441;34522;45999.31001034983;47101.528984710145;47106.76446617771;47169.52830471694;48094.51905480944;48360.274595881005;48502.51497485033;48524.75737621316;48551.271730923974;8376.41365104443;8757.95621021894;8913.598888050054;8919.509426981513;8924.821503569925;8332.750017499455;10541.78916421671;10763.515641796099;10792.784144317147;11064.114870810316;10703.090237329836;10736.355818650867;10749.785004299909;10759.408232547246;10772.838407423895;10616.628418005334;10619.41593212373;10663.306885052447;10672.733181670481;10702.143828493701;10541.683749487527;10584.100351470135;10585.470726463645;10593.417362045084;10600.15198784103;44784.55215447869;45087.774561126986;45154.32268515975;45273.320900186525;45354;3700.8519659213866;3800;4014.2172276406113;4110.958890411088;4429.11417716458;33624.49563256553;33765;34062;34325.485117723256;34472.655273447446;4231.196072746199;4249.830006799724;4276.166147601219;4293.162833247518;4308.612224899743;372469;373427;374125.1293743541;376500;377518;65260;65759;65853.67073164604;65952.34047659462;65973.34026659672;40777.59222407738;41624.1675166495;41851.372229416585;43716.3442548362;69883.65058174677;17143;17301.480955571355;17339.47981560555;17359.305627775;17381.56546086358;13743;14160.07959482651;14168.433262669583;14348.784768228485;14659.92670036643;20233.291834785712;21306.573868522853;21441.14235430565;21485.67771483429;21567.78432215689;7556.697732090654;7698.961505192438;7723.65243564041;7737.8452430951065;7757;988.8714467119229;1012.6000229909145;1052.479022883662;1053.510117795229;1060.9629511338248;33047.50428743571;33053.66946330506;33250.50124248138;33316.666833331845;33965.32069358599;1141.4692168141853;1146.5241924601364;1156.6009726644295;1185.146694380045;1216.2945491614842;17288.542410537335;17475.737863932052;17491.650166996842;17530.56173595645;17647.55881102957;572420;579056;583260.8369581504;588458;588561;60827.695861520406;61471.69264153651;61514;61520.69239653862;61612;1280.4494067550856;1331.2411925202541;1385.6674398144373;1435.4760512413102;1448.8478709735537;32147.67852321447;34134.317313654086;34602.48096278608;34684;34970.47544286888;54183;54880.176797347274;54919.725401372736;54967.45032549623;54973;456587;458768;459097;460688;465493;30201.848990754905;31190.22024449407;31350.843245783624;31390.372192555566;32775.18062048468;49106.75446622744;49484.25773613471;49976;50125.749371254366;50694;43284.35073473837;43621;43648.78175609102;44312.77843610761;45287.54712452833;43003.784981074896;43671.344929826715;43803.561964381224;44704;44879;42109.78945105255;42930.78534607307;43252.78373608112;43387.349189761546;43428;35040.47439288362;38080;38106.61893381031;38411.6158838408;39496.40755388729;28697.139085827457;29158.41683166367;29262;29326.413471730873;29510.55734163946 08:06:42 INFO - PROCESS | 4064 | |2;jquery.html;382.69766884161515;427.5681561622761;428.1319145464057;435.6601850556563;435.769042407524;15422.460213892517;19452.705235536672;20310.593788124228;20353.49116272094;20689.68965465519;20043.699344509845;20275.188992440322;20278.49303767403;20429.18283268671;20504.487387815276;5726.284214473201;5975.0439929611275;5977.043673012319;5980.910286345708;5990.850228744294;5569.582281328896;5829.621074630157;5852;5857.502112320437;5861.17943487912;5802.767889284423;5824;5828.0675091985295;5832.300123985127;5835.4456326649115;5683.2895888014;5793.073108302672;5805.709714514257;5821.27234095738;5826.533877289807;5035.295058691786;5136.126858434075;5192.065428222918;5193.610479214074;5281.392639846428;23797.524049519085;23908.163214287415;24048.87975560111;24101.39746506334;24184.274471765875;2304.896279667419;2322.837401381904;2327.6043072677685;2340.754220806808;2905.7675385969073;7195.460340474486;7347.228541003225;14489.492867749683;14611.196384198865;14671.89960752937;1815.1287382056687;1818.1818181818103;1872.8595355348268;1880.7178923161498;1906;84959;85188.57405712994;85580;86403.56798216031;86979.56510217408;9293.210077143383;10997.780044399067;11397.943010285062;11541.653750387502;11673.88326116745;13176.73646527064;13654.795178072336;13670.316484175752;13677.31613419345;13691.383887725076;7427.405807535384;8417.116202798617;8769.429987050822;8916.73249802507;9011.77470563228;8063.637136328879;8199.95900020496;8276.627551760184;8587.527685977206;8958.507282099547;6741.966290168518;6895.241523432418;6915.204751453647;6961.37347638715;6989.965050174716;1886.5472286651104;1894.1949671389605;1935.7927175896793;1937.86434949555;2044.9386518404472;446.42857142857196;456.3724878292348;981.617169303972;1059.8749507237937;1076.381080878498;11087;11737.530498780125;11789.528418863149;11815.763684726257;11942.283462992249;482.53917508779034;497.5174081141287;499.14147666014395;500.97244651543787;961.8509131084693;9904.504774761233;10773.245872788986;10788.352698838095;10825.35047897113;10910;518356;543052;551853;566925;573696;56375.71812140913;77366.6131669338;96441.51779241199;98096;99718.50140749395;1016.8068067067381;1043.88517263101;1069.2996087562658;1077.0414331245197;1087.5377964364955;17525.123743812503;17740;17944;18023.188956496728;18098.337093006732;29623.703762962094;43005;45296.32055519236;46011.76994115008;46015.53984460246;60833.39166608454;61858.381416185264;62080;62915.37084629095;63169.68415157895;8656.523891186045;8687.739367818975;8701;8753.562321884008;8790.164934331227;11744.823827642764;13710.862891371358;13759.17444953306;13763.655908602364;13907.443702251796;11640.94179529097;11679.591214307458;11791.233569817934;11826.704332391759;12259.019278457523;11612.94193529027;11927.4036298183;11983.940080299542;12154.513819447124;12353.444095015926;11885.346305953255;11963.76072478563;11999.82000270014;12080.75838483243;12354.505819767108;8551.401401902056;8729.7341885425;8733.432326898732;8974.551272436222;8977.461352318882;8737.082606326245;11732.237404568676;12041.698957525781;12145.028397727983;12346.444410001752 08:06:42 INFO - PROCESS | 4064 | |3;mootools.html;1507.5477356792962;1523.5581681312417;1678.4377233626735;1752.3779058434263;1787.909375281079;8014.639341229644;8536.445131066477;8538.316934645229;8575.91424085759;8581.227689507943;7389.778306650809;7635;8049.879251811213;8294.170582941719;8471.830563388728;2407.3740827384877;2445.6209287560455;2450.6936632920883;2450.6936632920883;2451;2424.75752424757;2446.4617784087473;2474.950500989979;2476.455179860428;2478.7521247875247;2369.9881500592473;2378.3221781792195;2386.069432921162;2414.4808866093786;2417.0452671194867;2351.8471299365488;2363.9409014774596;2365.467769751809;2372.051179528194;2373.3117395955237;2383.13015749252;2383.165891937808;2411.3730430088303;2415.7342692303832;2416.50461655362;8497.915020849774;8574.314054875658;8592.441491303109;8602.741917742478;8618.784530386727;5181.844544663666;5324.440933701944;5332.386775520826;5336.146216605363;5345.4120046795215;3357.865685372582;3403.0981789825714;3416.777909435879;3460.9307813843584;3472.2534655049285;1064.9946750266276;1079.9460026998697;1096.9341839489575;1102.8511150994593;1104.1222228328497;11727.648170554812;11789.705257368549;11802.055835533223;11815.527378904919;11816.231944923638;4422.579854913778;4612.53874612536;4728.976355118271;4741.739204343794;4749.145153872336;9748.561314740711;9754.122129008423;9761.9023809761;9762;9786.266030047775;5233.764480598382;5235.031519168966;5248.396434410091;5249.580033597303;5259.63182577216;4362.520122786491;4382.430284063052;4745.691530050604;4787.736674482937;4853.3447984522345;3951.8419263229725;4007.458993035961;4054.493188351456;4092.120194158211;4099.877003689834;1311.90816642836;1313.7306852095298;1318.630783380655;1327.2434712214138;1341.2019848190312;853.3002937591116;967.8693376394237;975.2539307429822;1025.738436698637;1034.3121823987115;5878.2064421302575;5983.521318294526;6075.301340345828;6125.693715314216;6161.815145545641;478.8180491413241;479.68820266826845;489.530051150892;490.66389523176736;498.25759618169394;4166;4171.0823618803815;4208.22147902639;4287.699861009762;4299.591538803808;10086.747831304276;10373.896261037444;10485.947570262253;10487.108595769292;10511.684649460529;9702.466364349888;10086.44524551142;10109.949450252701;10122.746931326776;10392.688219353431;7668.079830420385;7889.289963903277;7893.210678932061;8024.799380015546;8065.556394398247;5685.289338832646;5780.248567686174;5851.297844258716;5878.441548052928;6188.0143228196475;9186.173244408035;9334.953325233602;9343.672971445967;9410.588411738294;9441.952790236279;9137.451752894847;9320;9348.95325523368;9479.241660666992;9497.47763872966;7206.819829504304;7464.888026679496;7482.289182527651;8026.43814932949;8162.877556836771;7842.686292548462;8128.349732021542;8130.186981301823;8143.552104634065;8148.5518296494265;7205.963970180115;7300.196978332486;7315.487915846053;7376.262373762581;7544;7162.89255661176;7238.493305468567;7248.637568121679;7268.0914885639295;7444.404447644284;6593.3736295051895;6720;6720.32796720324;6720.798376048726;6728.058071869844;5062.240663900445;5105.183170692671;5159.948400516097;5176.4047134578495;5421.5391691706645;5076.568491678101;5114.258432527337;5187.299714538489;5298.919831729624;5460.34475862899 08:06:42 INFO - PROCESS | 4064 | |4;prototype.html;343.4419069012854;353.95752509698826;354.67724370822555;356.7513702042849;359.1774835626414;5393.757280922358;5412.269343638608;5422.451447819529;5426.864328391792;5432.348118225814;5307.787688492465;5353.678779273247;5374.516293533581;5376.435474275204;5380.354357477108;3987.381955796842;4045.797710114497;4229.936550951738;4254.191703576326;4277.64729398831;4256.787160641971;4259.893502662443;4260.339647354649;4278.807453664593;4299.591538803808;4235;4242.787860606957;4251.362295655661;4259.212045771526;4293.742375457467;4015.2973229684835;4060.2691515527194;4216.472940882359;4251.829926802924;4261.552536983603;3763.6424539668687;3790.753601015925;3796.7219668199136;3800.239952009609;3807.676347510465;5216.921746173811;5218.478152184789;5227.738613069331;5247.186686063628;5259.526642602146;4748.5251474852585;4795.825022869384;4797.232442809134;4828.203346447832;4853.466118726938;5563.193336966117;5565.9443405565835;5569.377416744133;5584.553235741131;5593.944060559424;4190.769507677077;4198.202341555095;4199.433076534659;4207.284761590507;4210.51579068408;5560.527355174815;5771.480566748971;5802.88394232113;5816.680082595455;5830.62100963436;4135.6898232632075;4148.697472902508;4161.8959526012095;4162.211318416668;4171.6036976487185;4160.791960401968;4221.577842215754;4226.302660061117;4226.366045093199;4236.978815105905;4702.177119004161;4756.6432517561325;4776.259679749644;4796.952030479651;4812.181929072066;5604.943950560442;5616.887662246732;5624.887502249932;5625.943740562624;5635.92917345703;1391.8956078294168;1409.3164815064686;1412.971740565183;1415.221628104559;1415.7380884536394;918.4948278446827;935.4293880732747;979.8971108033696;987.9654212102541;1001.3941565353002;5109.4379618241965;5268.5491003392835;5465;5491.890162196733;5495.175723641406;5726.455986681259;5757.625754325955;5761;5790.305163380337;5795.652260864362;5257.758655033697;5461.563074953994;5509.201165830932;5522.66863988162;5523.447655234525;2927.5608658701367;2931.237878151696;2932.633420822397;2935.5743417204812;2955.2316397736313;5715.199872017921;5756.042945398501;5759.366469688331;5765.290313552624;5772.662071860903;5382.865428364244;5665;5676.25367257608;5696.629719068247;5733.770649173986;5762.538996880324;5799;5808.970955145197;5809.448102430262;5811.302643682785;5457.454254574511;5587.954564762295;5595.832125036255;5600.7199640017025;5782.508486778671;5741.598088133791;5753.453421924911;5759;5773.595848290579;5773.855653608525;6029.547783916136;6037.607555508878;6044.365341639241;6052.364501727431;6076.997295446202;4071.16541109066;4206.390073439273;4237.555056719;4243.384709217208;4250.213710463574;5827.271591051119;5852.590318677651;5853.9121913172185;5859.355470898283;5872.471477567039;5517.903196785196;5702.572307076903;5719.714014299351;5755.482006619424;5764.164196191445;5654.943450565442;5664;5695.430456954271;5713.22871412354;5716.199732037435;5629.605927585029;5638.9436105638415;5659.85850353728;5667.688277144796;5667.829965101054;5441.809536666197;5518.530924871431;5580.35825880029;5702.8289151325525;5702.857428564319;5542.418046105101;5574.209537514367;5576.024195765806;5580.832575022756;5605.775768969359 08:06:42 INFO - PROCESS | 4064 | |5;yui.html;793.6111305460323;812.731798506493;822.4612878564539;869.9782505437363;904.1184844776348;13569.66075848103;14345.856541434583;14413.495527656534;14460.5661830145;14504.274786260685;14187.574372768808;14403.063800852937;14461.63845903853;14544.999999999973;14545.709085818276;706.7385067525023;716.870963226619;831.4221615976913;845.1168528887297;849.3035710717214;828.0766944856472;845.2941793602349;851.2636569367514;854.1885209051395;855.0081904990212;893.5576889439736;896.1844721303615;897.7800438892481;898.7213963671282;899.2221728205088;744.7244519527756;763.9388848892075;890.3011136258039;896.7892545251893;897.7531178925815;636.1729751323261;648.1088503307951;651.4885814635536;651.9250286217099;652.8988006858945;14467.131972081603;14475.276236188149;14518.92740536301;14530.418783248657;14539.78190327146;12948.870511294861;13066.673333166651;13235.073544851864;13298.202107873462;13307.600771976857;12154.592147558897;12287.207146468896;12342.81485777714;12442.626721198378;12694.682632934158;4069.8168582413864;4078.245524577933;4122.649574786146;4188.958110418887;4217.7891105444605;61369.38630613726;63621.681891590706;64871.35128648747;65582.67208663974;65816;10800.945995269973;11027.944860275647;11058.557657693764;11197.832032519518;11217.943910280397;20638.58722825535;20676.58646827055;20691.27580534674;20785.168593256403;20939.267125650833;8191.139850790066;8279;8309.335253179732;8489.726541018897;8554.05905350411;4689.249720044776;4740;4827.903441931142;4837.080954618611;4903.41159060915;3393.0669066007044;3478.060923550627;3480.965190348064;3490.1449144959647;3498.1079824644553;605.794030029792;606.8998615228526;607.1954660075418;610.2768219659717;628.6982248520736;677.7390704578675;679.6567733294654;713.2261496276598;719.3777382564044;765.8085478630343;9220.400673956172;9636.800277289412;9676.371035882645;9680.370775899544;9680.564374603018;641.7817941899776;672.8015235505537;716.6631683108931;744.9702011919571;747.6000339818171;4364.13705026642;4492.752898590544;4495.910081798411;4654.720716756938;4664.183767840615;89152.5542372284;89857.10142898487;92334.53832730927;95152;96838.51580742192;52306.47693523092;52904.47095529072;54288;75932.24067759363;83692.58153709193;47889.5211047892;48063.279050814264;53115.734421328416;69844;70743.6462817693;9056.909430905607;9192.126747958933;9233.122853328923;9323.860142097737;9370.906290937277;42680.359794603726;49625.255621164986;49725.75137124436;50545;52760.472395277095;63383;67250;70584.29415705982;70842.29157708357;71856;10899.182561308093;10989;11064.336139831636;11233.943830281123;11280.435978201222;12299.754004919672;12435.253884766942;12548.749025019632;12567.18313309632;13326.800097998344;12016.519339226683;12032.09759268041;12054.939725301318;12430.689232769253;12446.813297800722;11168.66494005181;11172.273802202832;11335.03652189573;11357.261777984404;11602.303861768321;11715.824262636237;11741.530338786353;11783.116266280234;11837.171398002058;11880.10899182582;9658.661946831828;9861.359011664219;10214.336068155546;10550.472476375997;10566.735831604272;9741.172000380047;9757;9757.951210243904;10068.244881634053;10078.092971632588 08:06:42 INFO - PROCESS | 4064 | __end_tp_report 08:06:42 INFO - PROCESS | 4064 | __start_cc_report 08:06:42 INFO - PROCESS | 4064 | _x_x_mozilla_cycle_collect,1088 08:06:42 INFO - PROCESS | 4064 | __end_cc_report 08:06:42 INFO - PROCESS | 4064 | __startTimestamp1480003602208__endTimestamp 08:06:42 INFO - PROCESS | 4064 | 08:06:42 INFO - PROCESS | 4064 | ------- Summary: start ------- 08:06:42 INFO - PROCESS | 4064 | Number of tests: 6 08:06:42 INFO - PROCESS | 4064 | 08:06:42 INFO - PROCESS | 4064 | [#0] dojo.html Cycles:165 Average:5468.97 Median:5685.23 stddev:606.52 (10.7%) stddev-sans-first:581.40 08:06:42 INFO - PROCESS | 4064 | Values: 3188.6 3208.0 3225.9 3244.3 3253.0 5482.8 5519.6 5522.3 5529.2 5543.8 5482.1 5557.9 5559.8 5574.8 5578.5 5006.1 5028.2 5054.8 5070.5 5101.4 4944.5 4962.8 4984.1 5031.2 5092.1 5040.2 5093.7 5103.3 5110.9 5117.5 5026.3 5040.1 5062.2 5074.1 5113.7 4737.1 4771.2 4953.1 4958.2 5012.8 5307.6 5371.5 5392.4 5454.5 5492.1 5794.7 5819.9 5888.1 5893.9 5928.4 5736.2 5954.3 6022.9 6026.5 6033.8 5419.4 5421.2 5553.8 5557.2 5569.4 6070.7 6089.5 6090.2 6091.1 6121.4 5703.0 5861.5 5862.1 5862.4 5869.6 5727.7 5748.0 5778.5 5797.8 5839.8 5751.3 5752.8 5756.1 5757.3 5761.3 5848.9 5854.2 5861.4 5862.1 5865.9 4483.7 4500.7 4508.9 4516.7 4541.8 4039.1 4065.5 4080.4 4083.0 4099.9 5593.7 5600.4 5608.7 5614.2 5627.2 5739.3 5818.5 5886.6 5893.3 5941.3 5679.4 5685.2 5686.3 5695.8 5720.0 5144.9 5147.1 5150.8 5156.3 5195.9 6018.8 6037.9 6057.7 6221.3 6229.6 5813.4 5871.4 5876.7 5908.2 5919.4 6035.6 6073.5 6087.7 6090.3 6092.4 5708.6 5716.3 5760.7 5766.8 5770.1 5760.3 5850.6 5864.8 5913.6 5953.8 5769.2 5780.9 5788.5 5798.1 5809.2 5643.9 5792.4 5801.2 5803.6 5807.8 5569.0 5573.4 5584.0 5603.2 5668.7 5686.5 5723.0 5724.3 5729.2 5739.9 5512.1 5574.6 5592.1 5605.9 5611.9 08:06:42 INFO - PROCESS | 4064 | 08:06:42 INFO - PROCESS | 4064 | [#1] ext.html Cycles:180 Average:64082.73 Median:21755.31 stddev:127305.76 (585.2%) stddev-sans-first:127573.56 08:06:42 INFO - PROCESS | 4064 | Values: 567.7 595.3 619.7 639.3 655.7 34522.0 45999.3 47101.5 47106.8 47169.5 48094.5 48360.3 48502.5 48524.8 48551.3 8376.4 8758.0 8913.6 8919.5 8924.8 8332.8 10541.8 10763.5 10792.8 11064.1 10703.1 10736.4 10749.8 10759.4 10772.8 10616.6 10619.4 10663.3 10672.7 10702.1 10541.7 10584.1 10585.5 10593.4 10600.2 44784.6 45087.8 45154.3 45273.3 45354.0 3700.9 3800.0 4014.2 4111.0 4429.1 33624.5 33765.0 34062.0 34325.5 34472.7 4231.2 4249.8 4276.2 4293.2 4308.6 372469.0 373427.0 374125.1 376500.0 377518.0 65260.0 65759.0 65853.7 65952.3 65973.3 40777.6 41624.2 41851.4 43716.3 69883.7 17143.0 17301.5 17339.5 17359.3 17381.6 13743.0 14160.1 14168.4 14348.8 14659.9 20233.3 21306.6 21441.1 21485.7 21567.8 7556.7 7699.0 7723.7 7737.8 7757.0 988.9 1012.6 1052.5 1053.5 1061.0 33047.5 33053.7 33250.5 33316.7 33965.3 1141.5 1146.5 1156.6 1185.1 1216.3 17288.5 17475.7 17491.7 17530.6 17647.6 572420.0 579056.0 583260.8 588458.0 588561.0 60827.7 61471.7 61514.0 61520.7 61612.0 1280.4 1331.2 1385.7 1435.5 1448.8 32147.7 34134.3 34602.5 34684.0 34970.5 54183.0 54880.2 54919.7 54967.5 54973.0 456587.0 458768.0 459097.0 460688.0 465493.0 30201.8 31190.2 31350.8 31390.4 32775.2 49106.8 49484.3 49976.0 50125.7 50694.0 43284.4 43621.0 43648.8 44312.8 45287.5 43003.8 43671.3 43803.6 44704.0 44879.0 42109.8 42930.8 43252.8 43387.3 43428.0 35040.5 38080.0 38106.6 38411.6 39496.4 28697.1 29158.4 29262.0 29326.4 29510.6 08:06:42 INFO - PROCESS | 4064 | 08:06:42 INFO - PROCESS | 4064 | [#2] jquery.html Cycles:180 Average:30720.88 Median:21716.57 stddev:90629.44 (417.3%) stddev-sans-first:90855.05 08:06:42 INFO - PROCESS | 4064 | Values: 382.7 427.6 428.1 435.7 435.8 15422.5 19452.7 20310.6 20353.5 20689.7 20043.7 20275.2 20278.5 20429.2 20504.5 5726.3 5975.0 5977.0 5980.9 5990.9 5569.6 5829.6 5852.0 5857.5 5861.2 5802.8 5824.0 5828.1 5832.3 5835.4 5683.3 5793.1 5805.7 5821.3 5826.5 5035.3 5136.1 5192.1 5193.6 5281.4 23797.5 23908.2 24048.9 24101.4 24184.3 2304.9 2322.8 2327.6 2340.8 2905.8 7195.5 7347.2 14489.5 14611.2 14671.9 1815.1 1818.2 1872.9 1880.7 1906.0 84959.0 85188.6 85580.0 86403.6 86979.6 9293.2 10997.8 11397.9 11541.7 11673.9 13176.7 13654.8 13670.3 13677.3 13691.4 7427.4 8417.1 8769.4 8916.7 9011.8 8063.6 8200.0 8276.6 8587.5 8958.5 6742.0 6895.2 6915.2 6961.4 6990.0 1886.5 1894.2 1935.8 1937.9 2044.9 446.4 456.4 981.6 1059.9 1076.4 11087.0 11737.5 11789.5 11815.8 11942.3 482.5 497.5 499.1 501.0 961.9 9904.5 10773.2 10788.4 10825.4 10910.0 518356.0 543052.0 551853.0 566925.0 573696.0 56375.7 77366.6 96441.5 98096.0 99718.5 1016.8 1043.9 1069.3 1077.0 1087.5 17525.1 17740.0 17944.0 18023.2 18098.3 29623.7 43005.0 45296.3 46011.8 46015.5 60833.4 61858.4 62080.0 62915.4 63169.7 8656.5 8687.7 8701.0 8753.6 8790.2 11744.8 13710.9 13759.2 13763.7 13907.4 11640.9 11679.6 11791.2 11826.7 12259.0 11612.9 11927.4 11983.9 12154.5 12353.4 11885.3 11963.8 11999.8 12080.8 12354.5 8551.4 8729.7 8733.4 8974.6 8977.5 8737.1 11732.2 12041.7 12145.0 12346.4 08:06:42 INFO - PROCESS | 4064 | 08:06:42 INFO - PROCESS | 4064 | [#3] mootools.html Cycles:180 Average:5614.61 Median:5168.18 stddev:3068.96 (59.4%) stddev-sans-first:3062.04 08:06:42 INFO - PROCESS | 4064 | Values: 1507.5 1523.6 1678.4 1752.4 1787.9 8014.6 8536.4 8538.3 8575.9 8581.2 7389.8 7635.0 8049.9 8294.2 8471.8 2407.4 2445.6 2450.7 2450.7 2451.0 2424.8 2446.5 2475.0 2476.5 2478.8 2370.0 2378.3 2386.1 2414.5 2417.0 2351.8 2363.9 2365.5 2372.1 2373.3 2383.1 2383.2 2411.4 2415.7 2416.5 8497.9 8574.3 8592.4 8602.7 8618.8 5181.8 5324.4 5332.4 5336.1 5345.4 3357.9 3403.1 3416.8 3460.9 3472.3 1065.0 1079.9 1096.9 1102.9 1104.1 11727.6 11789.7 11802.1 11815.5 11816.2 4422.6 4612.5 4729.0 4741.7 4749.1 9748.6 9754.1 9761.9 9762.0 9786.3 5233.8 5235.0 5248.4 5249.6 5259.6 4362.5 4382.4 4745.7 4787.7 4853.3 3951.8 4007.5 4054.5 4092.1 4099.9 1311.9 1313.7 1318.6 1327.2 1341.2 853.3 967.9 975.3 1025.7 1034.3 5878.2 5983.5 6075.3 6125.7 6161.8 478.8 479.7 489.5 490.7 498.3 4166.0 4171.1 4208.2 4287.7 4299.6 10086.7 10373.9 10485.9 10487.1 10511.7 9702.5 10086.4 10109.9 10122.7 10392.7 7668.1 7889.3 7893.2 8024.8 8065.6 5685.3 5780.2 5851.3 5878.4 6188.0 9186.2 9335.0 9343.7 9410.6 9442.0 9137.5 9320.0 9349.0 9479.2 9497.5 7206.8 7464.9 7482.3 8026.4 8162.9 7842.7 8128.3 8130.2 8143.6 8148.6 7206.0 7300.2 7315.5 7376.3 7544.0 7162.9 7238.5 7248.6 7268.1 7444.4 6593.4 6720.0 6720.3 6720.8 6728.1 5062.2 5105.2 5159.9 5176.4 5421.5 5076.6 5114.3 5187.3 5298.9 5460.3 08:06:42 INFO - PROCESS | 4064 | 08:06:42 INFO - PROCESS | 4064 | [#4] prototype.html Cycles:180 Average:4745.80 Median:5449.63 stddev:1383.14 (25.4%) stddev-sans-first:1346.97 08:06:42 INFO - PROCESS | 4064 | Values: 343.4 354.0 354.7 356.8 359.2 5393.8 5412.3 5422.5 5426.9 5432.3 5307.8 5353.7 5374.5 5376.4 5380.4 3987.4 4045.8 4229.9 4254.2 4277.6 4256.8 4259.9 4260.3 4278.8 4299.6 4235.0 4242.8 4251.4 4259.2 4293.7 4015.3 4060.3 4216.5 4251.8 4261.6 3763.6 3790.8 3796.7 3800.2 3807.7 5216.9 5218.5 5227.7 5247.2 5259.5 4748.5 4795.8 4797.2 4828.2 4853.5 5563.2 5565.9 5569.4 5584.6 5593.9 4190.8 4198.2 4199.4 4207.3 4210.5 5560.5 5771.5 5802.9 5816.7 5830.6 4135.7 4148.7 4161.9 4162.2 4171.6 4160.8 4221.6 4226.3 4226.4 4237.0 4702.2 4756.6 4776.3 4797.0 4812.2 5604.9 5616.9 5624.9 5625.9 5635.9 1391.9 1409.3 1413.0 1415.2 1415.7 918.5 935.4 979.9 988.0 1001.4 5109.4 5268.5 5465.0 5491.9 5495.2 5726.5 5757.6 5761.0 5790.3 5795.7 5257.8 5461.6 5509.2 5522.7 5523.4 2927.6 2931.2 2932.6 2935.6 2955.2 5715.2 5756.0 5759.4 5765.3 5772.7 5382.9 5665.0 5676.3 5696.6 5733.8 5762.5 5799.0 5809.0 5809.4 5811.3 5457.5 5588.0 5595.8 5600.7 5782.5 5741.6 5753.5 5759.0 5773.6 5773.9 6029.5 6037.6 6044.4 6052.4 6077.0 4071.2 4206.4 4237.6 4243.4 4250.2 5827.3 5852.6 5853.9 5859.4 5872.5 5517.9 5702.6 5719.7 5755.5 5764.2 5654.9 5664.0 5695.4 5713.2 5716.2 5629.6 5638.9 5659.9 5667.7 5667.8 5441.8 5518.5 5580.4 5702.8 5702.9 5542.4 5574.2 5576.0 5580.8 5605.8 08:06:42 INFO - PROCESS | 4064 | 08:06:42 INFO - PROCESS | 4064 | [#5] yui.html Cycles:180 Average:17421.71 Median:51425.74 stddev:23278.38 (45.3%) stddev-sans-first:23310.20 08:06:42 INFO - PROCESS | 4064 | Values: 793.6 812.7 822.5 870.0 904.1 13569.7 14345.9 14413.5 14460.6 14504.3 14187.6 14403.1 14461.6 14545.0 14545.7 706.7 716.9 831.4 845.1 849.3 828.1 845.3 851.3 854.2 855.0 893.6 896.2 897.8 898.7 899.2 744.7 763.9 890.3 896.8 897.8 636.2 648.1 651.5 651.9 652.9 14467.1 14475.3 14518.9 14530.4 14539.8 12948.9 13066.7 13235.1 13298.2 13307.6 12154.6 12287.2 12342.8 12442.6 12694.7 4069.8 4078.2 4122.6 4189.0 4217.8 61369.4 63621.7 64871.4 65582.7 65816.0 10800.9 11027.9 11058.6 11197.8 11217.9 20638.6 20676.6 20691.3 20785.2 20939.3 8191.1 8279.0 8309.3 8489.7 8554.1 4689.2 4740.0 4827.9 4837.1 4903.4 3393.1 3478.1 3481.0 3490.1 3498.1 605.8 606.9 607.2 610.3 628.7 677.7 679.7 713.2 719.4 765.8 9220.4 9636.8 9676.4 9680.4 9680.6 641.8 672.8 716.7 745.0 747.6 4364.1 4492.8 4495.9 4654.7 4664.2 89152.6 89857.1 92334.5 95152.0 96838.5 52306.5 52904.5 54288.0 75932.2 83692.6 47889.5 48063.3 53115.7 69844.0 70743.6 9056.9 9192.1 9233.1 9323.9 9370.9 42680.4 49625.3 49725.8 50545.0 52760.5 63383.0 67250.0 70584.3 70842.3 71856.0 10899.2 10989.0 11064.3 11233.9 11280.4 12299.8 12435.3 12548.7 12567.2 13326.8 12016.5 12032.1 12054.9 12430.7 12446.8 11168.7 11172.3 11335.0 11357.3 11602.3 11715.8 11741.5 11783.1 11837.2 11880.1 9658.7 9861.4 10214.3 10550.5 10566.7 9741.2 9757.0 9758.0 10068.2 10078.1 08:06:42 INFO - PROCESS | 4064 | -------- Summary: end -------- 08:06:42 INFO - PROCESS | 4064 | 08:06:43 INFO - TEST-INFO | 4064: exit 0 08:06:43 INFO - TEST-OK | dromaeo_css | took 1115595ms 08:06:43 INFO - TEST-START | kraken 08:06:43 INFO - operating with platform_type : linux_ 08:06:43 INFO - Initialising browser for kraken test... 08:06:43 INFO - TEST-INFO | started process 4382 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKeHhvc/profile http://localhost:50410/getInfo.html) 08:06:47 INFO - PROCESS | 4382 | __metrics Screen width/height:1600/1200 08:06:47 INFO - PROCESS | 4382 | colorDepth:24 08:06:47 INFO - PROCESS | 4382 | Browser inner width/height: 1024/697 08:06:47 INFO - PROCESS | 4382 | __metrics 08:06:48 INFO - PROCESS | 4382 | 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" 08:06:48 INFO - PROCESS | 4382 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:06:48 INFO - PROCESS | 4382 | console.error: PushService: 08:06:48 INFO - PROCESS | 4382 | stateChangeProcessEnqueue: Error transitioning state 08:06:48 INFO - PROCESS | 4382 | UnknownError 08:06:49 INFO - TEST-INFO | 4382: exit 0 08:06:49 INFO - Browser initialized. 08:06:49 INFO - Running cycle 1/1 for kraken test... 08:06:49 INFO - TEST-INFO | started process 4476 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKeHhvc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:07:01 INFO - PROCESS | 4476 | RSS: Main: 144781312 08:07:01 INFO - PROCESS | 4476 | 08:07:03 INFO - PROCESS | 4476 | Cycle 1(1): loaded http://localhost:50410/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50410/tests/kraken/driver.html?testName=audio-beat-detection) 08:07:04 INFO - PROCESS | 4476 | RSS: Main: 185659392 08:07:04 INFO - PROCESS | 4476 | 08:07:07 INFO - PROCESS | 4476 | Cycle 1(1): loaded http://localhost:50410/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50410/tests/kraken/driver.html?testName=audio-dft) 08:07:07 INFO - PROCESS | 4476 | RSS: Main: 175476736 08:07:07 INFO - PROCESS | 4476 | 08:07:10 INFO - PROCESS | 4476 | Cycle 1(1): loaded http://localhost:50410/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50410/tests/kraken/driver.html?testName=audio-fft) 08:07:11 INFO - PROCESS | 4476 | RSS: Main: 266866688 08:07:11 INFO - PROCESS | 4476 | 08:07:13 INFO - PROCESS | 4476 | Cycle 1(1): loaded http://localhost:50410/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50410/tests/kraken/driver.html?testName=audio-oscillator) 08:07:13 INFO - PROCESS | 4476 | RSS: Main: 173830144 08:07:13 INFO - PROCESS | 4476 | 08:07:15 INFO - PROCESS | 4476 | Cycle 1(1): loaded http://localhost:50410/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50410/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:07:16 INFO - PROCESS | 4476 | RSS: Main: 175792128 08:07:16 INFO - PROCESS | 4476 | 08:07:19 INFO - PROCESS | 4476 | Cycle 1(1): loaded http://localhost:50410/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50410/tests/kraken/driver.html?testName=imaging-darkroom) 08:07:19 INFO - PROCESS | 4476 | RSS: Main: 214118400 08:07:19 INFO - PROCESS | 4476 | 08:07:23 INFO - PROCESS | 4476 | Cycle 1(1): loaded http://localhost:50410/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50410/tests/kraken/driver.html?testName=imaging-desaturate) 08:07:23 INFO - PROCESS | 4476 | RSS: Main: 213245952 08:07:23 INFO - PROCESS | 4476 | 08:07:26 INFO - PROCESS | 4476 | Cycle 1(1): loaded http://localhost:50410/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50410/tests/kraken/driver.html?testName=json-parse-financial) 08:07:27 INFO - PROCESS | 4476 | RSS: Main: 212086784 08:07:27 INFO - PROCESS | 4476 | 08:07:28 INFO - PROCESS | 4476 | Cycle 1(1): loaded http://localhost:50410/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50410/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:07:29 INFO - PROCESS | 4476 | RSS: Main: 174108672 08:07:29 INFO - PROCESS | 4476 | 08:07:30 INFO - PROCESS | 4476 | Cycle 1(1): loaded http://localhost:50410/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50410/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:07:31 INFO - PROCESS | 4476 | RSS: Main: 180969472 08:07:31 INFO - PROCESS | 4476 | 08:07:33 INFO - PROCESS | 4476 | Cycle 1(1): loaded http://localhost:50410/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50410/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:07:34 INFO - PROCESS | 4476 | RSS: Main: 191238144 08:07:34 INFO - PROCESS | 4476 | 08:07:36 INFO - PROCESS | 4476 | Cycle 1(1): loaded http://localhost:50410/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50410/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:07:37 INFO - PROCESS | 4476 | RSS: Main: 198610944 08:07:37 INFO - PROCESS | 4476 | 08:07:40 INFO - PROCESS | 4476 | Cycle 1(1): loaded http://localhost:50410/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50410/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:07:40 INFO - PROCESS | 4476 | RSS: Main: 195813376 08:07:40 INFO - PROCESS | 4476 | 08:07:42 INFO - PROCESS | 4476 | Cycle 1(1): loaded http://localhost:50410/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50410/tests/kraken/driver.html?testName=ai-astar) 08:07:42 INFO - PROCESS | 4476 | RSS: Main: 246870016 08:07:42 INFO - PROCESS | 4476 | 08:07:42 INFO - PROCESS | 4476 | __start_tp_report 08:07:42 INFO - PROCESS | 4476 | _x_x_mozilla_page_load 08:07:42 INFO - PROCESS | 4476 | _x_x_mozilla_page_load_details 08:07:42 INFO - PROCESS | 4476 | |i|pagename|runs| 08:07:42 INFO - PROCESS | 4476 | |0;ai-astar;103;113;114;113;113;115;113;112;112;111 08:07:42 INFO - PROCESS | 4476 | |1;audio-beat-detection;146;126;129;156;123;125;126;126;164;124 08:07:42 INFO - PROCESS | 4476 | |2;audio-dft;162;162;162;161;163;161;161;160;160;160 08:07:42 INFO - PROCESS | 4476 | |3;audio-fft;75;76;76;112;80;77;75;76;96;76 08:07:42 INFO - PROCESS | 4476 | |4;audio-oscillator;82;82;111;83;83;83;103;83;82;120 08:07:42 INFO - PROCESS | 4476 | |5;imaging-gaussian-blur;118;118;117;118;117;118;116;117;117;117 08:07:42 INFO - PROCESS | 4476 | |6;imaging-darkroom;147;147;147;148;147;146;146;146;146;147 08:07:42 INFO - PROCESS | 4476 | |7;imaging-desaturate;85;85;84;85;85;85;84;85;85;84 08:07:42 INFO - PROCESS | 4476 | |8;json-parse-financial;51;51;52;52;50;50;52;52;51;51 08:07:42 INFO - PROCESS | 4476 | |9;json-stringify-tinderbox;59;60;59;61;60;60;59;59;59;60 08:07:42 INFO - PROCESS | 4476 | |10;stanford-crypto-aes;80;76;79;83;76;76;76;77;85;76 08:07:42 INFO - PROCESS | 4476 | |11;stanford-crypto-ccm;130;126;129;131;126;126;126;141;171;137 08:07:42 INFO - PROCESS | 4476 | |12;stanford-crypto-pbkdf2;160;158;156;162;158;158;159;159;156;159 08:07:42 INFO - PROCESS | 4476 | |13;stanford-crypto-sha256-iterative;63;65;64;63;63;62;65;65;62;62 08:07:42 INFO - PROCESS | 4476 | __end_tp_report 08:07:42 INFO - PROCESS | 4476 | __start_cc_report 08:07:42 INFO - PROCESS | 4476 | _x_x_mozilla_cycle_collect,1614 08:07:42 INFO - PROCESS | 4476 | __end_cc_report 08:07:42 INFO - PROCESS | 4476 | __startTimestamp1480003662601__endTimestamp 08:07:42 INFO - PROCESS | 4476 | 08:07:42 INFO - PROCESS | 4476 | ------- Summary: start ------- 08:07:42 INFO - PROCESS | 4476 | Number of tests: 14 08:07:42 INFO - PROCESS | 4476 | 08:07:42 INFO - PROCESS | 4476 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.00 stddev:3.31 (2.9%) stddev-sans-first:1.17 08:07:42 INFO - PROCESS | 4476 | Values: 103.0 113.0 114.0 113.0 113.0 115.0 113.0 112.0 112.0 111.0 08:07:42 INFO - PROCESS | 4476 | 08:07:42 INFO - PROCESS | 4476 | [#1] audio-beat-detection Cycles:10 Average:134.50 Median:127.50 stddev:15.07 (11.8%) stddev-sans-first:15.40 08:07:42 INFO - PROCESS | 4476 | Values: 146.0 126.0 129.0 156.0 123.0 125.0 126.0 126.0 164.0 124.0 08:07:42 INFO - PROCESS | 4476 | 08:07:42 INFO - PROCESS | 4476 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.03 (0.6%) stddev-sans-first:1.05 08:07:42 INFO - PROCESS | 4476 | Values: 162.0 162.0 162.0 161.0 163.0 161.0 161.0 160.0 160.0 160.0 08:07:42 INFO - PROCESS | 4476 | 08:07:42 INFO - PROCESS | 4476 | [#3] audio-fft Cycles:10 Average:81.90 Median:76.00 stddev:12.32 (16.2%) stddev-sans-first:12.82 08:07:42 INFO - PROCESS | 4476 | Values: 75.0 76.0 76.0 112.0 80.0 77.0 75.0 76.0 96.0 76.0 08:07:42 INFO - PROCESS | 4476 | 08:07:42 INFO - PROCESS | 4476 | [#4] audio-oscillator Cycles:10 Average:91.20 Median:82.50 stddev:14.47 (17.5%) stddev-sans-first:14.96 08:07:42 INFO - PROCESS | 4476 | Values: 82.0 82.0 111.0 83.0 83.0 83.0 103.0 83.0 82.0 120.0 08:07:42 INFO - PROCESS | 4476 | 08:07:42 INFO - PROCESS | 4476 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.50 stddev:0.67 (0.6%) stddev-sans-first:0.67 08:07:42 INFO - PROCESS | 4476 | Values: 118.0 118.0 117.0 118.0 117.0 118.0 116.0 117.0 117.0 117.0 08:07:42 INFO - PROCESS | 4476 | 08:07:42 INFO - PROCESS | 4476 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 08:07:42 INFO - PROCESS | 4476 | Values: 147.0 147.0 147.0 148.0 147.0 146.0 146.0 146.0 146.0 147.0 08:07:42 INFO - PROCESS | 4476 | 08:07:42 INFO - PROCESS | 4476 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 08:07:42 INFO - PROCESS | 4476 | Values: 85.0 85.0 84.0 85.0 85.0 85.0 84.0 85.0 85.0 84.0 08:07:42 INFO - PROCESS | 4476 | 08:07:42 INFO - PROCESS | 4476 | [#8] json-parse-financial Cycles:10 Average:51.20 Median:51.50 stddev:0.79 (1.5%) stddev-sans-first:0.83 08:07:42 INFO - PROCESS | 4476 | Values: 51.0 51.0 52.0 52.0 50.0 50.0 52.0 52.0 51.0 51.0 08:07:42 INFO - PROCESS | 4476 | 08:07:42 INFO - PROCESS | 4476 | [#9] json-stringify-tinderbox Cycles:10 Average:59.60 Median:60.00 stddev:0.70 (1.2%) stddev-sans-first:0.71 08:07:42 INFO - PROCESS | 4476 | Values: 59.0 60.0 59.0 61.0 60.0 60.0 59.0 59.0 59.0 60.0 08:07:42 INFO - PROCESS | 4476 | 08:07:42 INFO - PROCESS | 4476 | [#10] stanford-crypto-aes Cycles:10 Average:78.40 Median:78.00 stddev:3.31 (4.2%) stddev-sans-first:3.46 08:07:42 INFO - PROCESS | 4476 | Values: 80.0 76.0 79.0 83.0 76.0 76.0 76.0 77.0 85.0 76.0 08:07:42 INFO - PROCESS | 4476 | 08:07:42 INFO - PROCESS | 4476 | [#11] stanford-crypto-ccm Cycles:10 Average:134.30 Median:130.50 stddev:13.87 (10.6%) stddev-sans-first:14.63 08:07:42 INFO - PROCESS | 4476 | Values: 130.0 126.0 129.0 131.0 126.0 126.0 126.0 141.0 171.0 137.0 08:07:42 INFO - PROCESS | 4476 | 08:07:42 INFO - PROCESS | 4476 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.50 Median:159.00 stddev:1.78 (1.1%) stddev-sans-first:1.80 08:07:42 INFO - PROCESS | 4476 | Values: 160.0 158.0 156.0 162.0 158.0 158.0 159.0 159.0 156.0 159.0 08:07:42 INFO - PROCESS | 4476 | 08:07:42 INFO - PROCESS | 4476 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:63.50 stddev:1.26 (2.0%) stddev-sans-first:1.33 08:07:42 INFO - PROCESS | 4476 | Values: 63.0 65.0 64.0 63.0 63.0 62.0 65.0 65.0 62.0 62.0 08:07:42 INFO - PROCESS | 4476 | -------- Summary: end -------- 08:07:42 INFO - PROCESS | 4476 | 08:07:43 INFO - TEST-INFO | 4476: exit 0 08:07:43 INFO - TEST-OK | kraken | took 60619ms 08:07:43 INFO - SUITE-END | took 1176s 08:07:43 INFO - Completed test suite (00:19:36) 08:07:43 INFO - javascript benchmark 08:07:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3188.6492485826557, 3207.967920320796, 3225.9354812903744, 3244.286257023454, 3253.0, 5482.80810171644, 5519.558435325174, 5522.30971128609, 5529.1982662513965, 5543.833684989447, 5482.095454250044, 5557.888842223163, 5559.833205003856, 5574.832755017346, 5578.497935185833, 5006.073876332872, 5028.195488721805, 5054.797808087672, 5070.492950704936, 5101.38783345999, 4944.480829512903, 4962.776675049631, 4984.127777638917, 5031.22016087507, 5092.134337162673, 5040.1935690289565, 5093.719845408501, 5103.26002729604, 5110.948890511103, 5117.488251174871, 5026.2711906773675, 5040.143175660129, 5062.215356619693, 5074.137396642543, 5113.6931784092885, 4737.099951009332, 4771.212749896263, 4953.083679519301, 4958.181899986498, 5012.824551140692, 5307.628466007381, 5371.516563509303, 5392.379876314196, 5454.53636440903, 5492.148716948879, 5794.68129252891, 5819.88360232793, 5888.116782482619, 5893.911591326134, 5928.40715928408, 5736.196932429463, 5954.315253745832, 6022.879542409128, 6026.457618814284, 6033.78881739137, 5419.430959749248, 5421.241026256327, 5553.8333849984165, 5557.166425036277, 5569.415211402826, 6070.666113363807, 6089.543284253698, 6090.177825993434, 6091.086337049478, 6121.418465245794, 5703.030484817591, 5861.531077513789, 5862.062070068769, 5862.384449632812, 5869.589128761031, 5727.656340619576, 5748.0, 5778.537716982715, 5797.768089276466, 5839.766409343579, 5751.309842818889, 5752.7698892043845, 5756.107803290497, 5757.280339957505, 5761.337446193657, 5848.853778655568, 5854.151148083504, 5861.41385861419, 5862.149988251765, 5865.882682346414, 4483.730976141442, 4500.729956202638, 4508.932366014513, 4516.728996260234, 4541.75020373876, 4039.0710136668145, 4065.5324637666454, 4080.4083407905687, 4082.9591704082577, 4099.8975025624595, 5593.692346920959, 5600.411956744565, 5608.747606357723, 5614.214010038598, 5627.184058311522, 5739.253896993364, 5818.4763371296785, 5886.646801191942, 5893.322267939242, 5941.287045554561, 5679.403662615448, 5685.232493613392, 5686.317641882918, 5695.829125126253, 5720.0, 5144.8713782155, 5147.0992576298995, 5150.793968241303, 5156.303898973665, 5195.948040519622, 6018.8194354169445, 6037.879242415039, 6057.666828324308, 6221.346758590283, 6229.626222426669, 5813.3605303417435, 5871.412858714265, 5876.706164691663, 5908.231929849092, 5919.408059194218, 6035.577509574287, 6073.453389194994, 6087.726052327745, 6090.269167699905, 6092.360302168208, 5708.571857110816, 5716.28546431696, 5760.711964401679, 5766.798162064308, 5770.105633626795, 5760.279965004374, 5850.64896106235, 5864.824055278348, 5913.58604897653, 5953.791617293374, 5769.192313076089, 5780.884382312414, 5788.536917046542, 5798.10129429939, 5809.157672137601, 5643.915341269966, 5792.362840087671, 5801.158831969256, 5803.622764520293, 5807.767689292381, 5569.0, 5573.3869274380595, 5584.0, 5603.1875378069135, 5668.688222147656, 5686.459786320293, 5722.971385143048, 5724.313082430135, 5729.169270455677, 5739.9139012914, 5512.062949298549, 5574.637648552831, 5592.133219351007, 5605.943940560543, 5611.8877622448135], "value": 5429.090200314171, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.6877717255511, 595.3213336796052, 619.6901549225387, 639.3223183425566, 655.7114869457441, 34522.0, 45999.31001034983, 47101.528984710145, 47106.76446617771, 47169.52830471694, 48094.51905480944, 48360.274595881005, 48502.51497485033, 48524.75737621316, 48551.271730923974, 8376.41365104443, 8757.95621021894, 8913.598888050054, 8919.509426981513, 8924.821503569925, 8332.750017499455, 10541.78916421671, 10763.515641796099, 10792.784144317147, 11064.114870810316, 10703.090237329836, 10736.355818650867, 10749.785004299909, 10759.408232547246, 10772.838407423895, 10616.628418005334, 10619.41593212373, 10663.306885052447, 10672.733181670481, 10702.143828493701, 10541.683749487527, 10584.100351470135, 10585.470726463645, 10593.417362045084, 10600.15198784103, 44784.55215447869, 45087.774561126986, 45154.32268515975, 45273.320900186525, 45354.0, 3700.8519659213866, 3800.0, 4014.2172276406113, 4110.958890411088, 4429.11417716458, 33624.49563256553, 33765.0, 34062.0, 34325.485117723256, 34472.655273447446, 4231.196072746199, 4249.830006799724, 4276.166147601219, 4293.162833247518, 4308.612224899743, 372469.0, 373427.0, 374125.1293743541, 376500.0, 377518.0, 65260.0, 65759.0, 65853.67073164604, 65952.34047659462, 65973.34026659672, 40777.59222407738, 41624.1675166495, 41851.372229416585, 43716.3442548362, 69883.65058174677, 17143.0, 17301.480955571355, 17339.47981560555, 17359.305627775, 17381.56546086358, 13743.0, 14160.07959482651, 14168.433262669583, 14348.784768228485, 14659.92670036643, 20233.291834785712, 21306.573868522853, 21441.14235430565, 21485.67771483429, 21567.78432215689, 7556.697732090654, 7698.961505192438, 7723.65243564041, 7737.8452430951065, 7757.0, 988.8714467119229, 1012.6000229909145, 1052.479022883662, 1053.510117795229, 1060.9629511338248, 33047.50428743571, 33053.66946330506, 33250.50124248138, 33316.666833331845, 33965.32069358599, 1141.4692168141853, 1146.5241924601364, 1156.6009726644295, 1185.146694380045, 1216.2945491614842, 17288.542410537335, 17475.737863932052, 17491.650166996842, 17530.56173595645, 17647.55881102957, 572420.0, 579056.0, 583260.8369581504, 588458.0, 588561.0, 60827.695861520406, 61471.69264153651, 61514.0, 61520.69239653862, 61612.0, 1280.4494067550856, 1331.2411925202541, 1385.6674398144373, 1435.4760512413102, 1448.8478709735537, 32147.67852321447, 34134.317313654086, 34602.48096278608, 34684.0, 34970.47544286888, 54183.0, 54880.176797347274, 54919.725401372736, 54967.45032549623, 54973.0, 456587.0, 458768.0, 459097.0, 460688.0, 465493.0, 30201.848990754905, 31190.22024449407, 31350.843245783624, 31390.372192555566, 32775.18062048468, 49106.75446622744, 49484.25773613471, 49976.0, 50125.749371254366, 50694.0, 43284.35073473837, 43621.0, 43648.78175609102, 44312.77843610761, 45287.54712452833, 43003.784981074896, 43671.344929826715, 43803.561964381224, 44704.0, 44879.0, 42109.78945105255, 42930.78534607307, 43252.78373608112, 43387.349189761546, 43428.0, 35040.47439288362, 38080.0, 38106.61893381031, 38411.6158838408, 39496.40755388729, 28697.139085827457, 29158.41683166367, 29262.0, 29326.413471730873, 29510.55734163946], "value": 21391.47749347416, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.69766884161515, 427.5681561622761, 428.1319145464057, 435.6601850556563, 435.769042407524, 15422.460213892517, 19452.705235536672, 20310.593788124228, 20353.49116272094, 20689.68965465519, 20043.699344509845, 20275.188992440322, 20278.49303767403, 20429.18283268671, 20504.487387815276, 5726.284214473201, 5975.0439929611275, 5977.043673012319, 5980.910286345708, 5990.850228744294, 5569.582281328896, 5829.621074630157, 5852.0, 5857.502112320437, 5861.17943487912, 5802.767889284423, 5824.0, 5828.0675091985295, 5832.300123985127, 5835.4456326649115, 5683.2895888014, 5793.073108302672, 5805.709714514257, 5821.27234095738, 5826.533877289807, 5035.295058691786, 5136.126858434075, 5192.065428222918, 5193.610479214074, 5281.392639846428, 23797.524049519085, 23908.163214287415, 24048.87975560111, 24101.39746506334, 24184.274471765875, 2304.896279667419, 2322.837401381904, 2327.6043072677685, 2340.754220806808, 2905.7675385969073, 7195.460340474486, 7347.228541003225, 14489.492867749683, 14611.196384198865, 14671.89960752937, 1815.1287382056687, 1818.1818181818103, 1872.8595355348268, 1880.7178923161498, 1906.0, 84959.0, 85188.57405712994, 85580.0, 86403.56798216031, 86979.56510217408, 9293.210077143383, 10997.780044399067, 11397.943010285062, 11541.653750387502, 11673.88326116745, 13176.73646527064, 13654.795178072336, 13670.316484175752, 13677.31613419345, 13691.383887725076, 7427.405807535384, 8417.116202798617, 8769.429987050822, 8916.73249802507, 9011.77470563228, 8063.637136328879, 8199.95900020496, 8276.627551760184, 8587.527685977206, 8958.507282099547, 6741.966290168518, 6895.241523432418, 6915.204751453647, 6961.37347638715, 6989.965050174716, 1886.5472286651104, 1894.1949671389605, 1935.7927175896793, 1937.86434949555, 2044.9386518404472, 446.42857142857196, 456.3724878292348, 981.617169303972, 1059.8749507237937, 1076.381080878498, 11087.0, 11737.530498780125, 11789.528418863149, 11815.763684726257, 11942.283462992249, 482.53917508779034, 497.5174081141287, 499.14147666014395, 500.97244651543787, 961.8509131084693, 9904.504774761233, 10773.245872788986, 10788.352698838095, 10825.35047897113, 10910.0, 518356.0, 543052.0, 551853.0, 566925.0, 573696.0, 56375.71812140913, 77366.6131669338, 96441.51779241199, 98096.0, 99718.50140749395, 1016.8068067067381, 1043.88517263101, 1069.2996087562658, 1077.0414331245197, 1087.5377964364955, 17525.123743812503, 17740.0, 17944.0, 18023.188956496728, 18098.337093006732, 29623.703762962094, 43005.0, 45296.32055519236, 46011.76994115008, 46015.53984460246, 60833.39166608454, 61858.381416185264, 62080.0, 62915.37084629095, 63169.68415157895, 8656.523891186045, 8687.739367818975, 8701.0, 8753.562321884008, 8790.164934331227, 11744.823827642764, 13710.862891371358, 13759.17444953306, 13763.655908602364, 13907.443702251796, 11640.94179529097, 11679.591214307458, 11791.233569817934, 11826.704332391759, 12259.019278457523, 11612.94193529027, 11927.4036298183, 11983.940080299542, 12154.513819447124, 12353.444095015926, 11885.346305953255, 11963.76072478563, 11999.82000270014, 12080.75838483243, 12354.505819767108, 8551.401401902056, 8729.7341885425, 8733.432326898732, 8974.551272436222, 8977.461352318882, 8737.082606326245, 11732.237404568676, 12041.698957525781, 12145.028397727983, 12346.444410001752], "value": 9159.584602898338, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1507.5477356792962, 1523.5581681312417, 1678.4377233626735, 1752.3779058434263, 1787.909375281079, 8014.639341229644, 8536.445131066477, 8538.316934645229, 8575.91424085759, 8581.227689507943, 7389.778306650809, 7635.0, 8049.879251811213, 8294.170582941719, 8471.830563388728, 2407.3740827384877, 2445.6209287560455, 2450.6936632920883, 2450.6936632920883, 2451.0, 2424.75752424757, 2446.4617784087473, 2474.950500989979, 2476.455179860428, 2478.7521247875247, 2369.9881500592473, 2378.3221781792195, 2386.069432921162, 2414.4808866093786, 2417.0452671194867, 2351.8471299365488, 2363.9409014774596, 2365.467769751809, 2372.051179528194, 2373.3117395955237, 2383.13015749252, 2383.165891937808, 2411.3730430088303, 2415.7342692303832, 2416.50461655362, 8497.915020849774, 8574.314054875658, 8592.441491303109, 8602.741917742478, 8618.784530386727, 5181.844544663666, 5324.440933701944, 5332.386775520826, 5336.146216605363, 5345.4120046795215, 3357.865685372582, 3403.0981789825714, 3416.777909435879, 3460.9307813843584, 3472.2534655049285, 1064.9946750266276, 1079.9460026998697, 1096.9341839489575, 1102.8511150994593, 1104.1222228328497, 11727.648170554812, 11789.705257368549, 11802.055835533223, 11815.527378904919, 11816.231944923638, 4422.579854913778, 4612.53874612536, 4728.976355118271, 4741.739204343794, 4749.145153872336, 9748.561314740711, 9754.122129008423, 9761.9023809761, 9762.0, 9786.266030047775, 5233.764480598382, 5235.031519168966, 5248.396434410091, 5249.580033597303, 5259.63182577216, 4362.520122786491, 4382.430284063052, 4745.691530050604, 4787.736674482937, 4853.3447984522345, 3951.8419263229725, 4007.458993035961, 4054.493188351456, 4092.120194158211, 4099.877003689834, 1311.90816642836, 1313.7306852095298, 1318.630783380655, 1327.2434712214138, 1341.2019848190312, 853.3002937591116, 967.8693376394237, 975.2539307429822, 1025.738436698637, 1034.3121823987115, 5878.2064421302575, 5983.521318294526, 6075.301340345828, 6125.693715314216, 6161.815145545641, 478.8180491413241, 479.68820266826845, 489.530051150892, 490.66389523176736, 498.25759618169394, 4166.0, 4171.0823618803815, 4208.22147902639, 4287.699861009762, 4299.591538803808, 10086.747831304276, 10373.896261037444, 10485.947570262253, 10487.108595769292, 10511.684649460529, 9702.466364349888, 10086.44524551142, 10109.949450252701, 10122.746931326776, 10392.688219353431, 7668.079830420385, 7889.289963903277, 7893.210678932061, 8024.799380015546, 8065.556394398247, 5685.289338832646, 5780.248567686174, 5851.297844258716, 5878.441548052928, 6188.0143228196475, 9186.173244408035, 9334.953325233602, 9343.672971445967, 9410.588411738294, 9441.952790236279, 9137.451752894847, 9320.0, 9348.95325523368, 9479.241660666992, 9497.47763872966, 7206.819829504304, 7464.888026679496, 7482.289182527651, 8026.43814932949, 8162.877556836771, 7842.686292548462, 8128.349732021542, 8130.186981301823, 8143.552104634065, 8148.5518296494265, 7205.963970180115, 7300.196978332486, 7315.487915846053, 7376.262373762581, 7544.0, 7162.89255661176, 7238.493305468567, 7248.637568121679, 7268.0914885639295, 7444.404447644284, 6593.3736295051895, 6720.0, 6720.32796720324, 6720.798376048726, 6728.058071869844, 5062.240663900445, 5105.183170692671, 5159.948400516097, 5176.4047134578495, 5421.5391691706645, 5076.568491678101, 5114.258432527337, 5187.299714538489, 5298.919831729624, 5460.34475862899], "value": 4501.467606825246, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.4419069012854, 353.95752509698826, 354.67724370822555, 356.7513702042849, 359.1774835626414, 5393.757280922358, 5412.269343638608, 5422.451447819529, 5426.864328391792, 5432.348118225814, 5307.787688492465, 5353.678779273247, 5374.516293533581, 5376.435474275204, 5380.354357477108, 3987.381955796842, 4045.797710114497, 4229.936550951738, 4254.191703576326, 4277.64729398831, 4256.787160641971, 4259.893502662443, 4260.339647354649, 4278.807453664593, 4299.591538803808, 4235.0, 4242.787860606957, 4251.362295655661, 4259.212045771526, 4293.742375457467, 4015.2973229684835, 4060.2691515527194, 4216.472940882359, 4251.829926802924, 4261.552536983603, 3763.6424539668687, 3790.753601015925, 3796.7219668199136, 3800.239952009609, 3807.676347510465, 5216.921746173811, 5218.478152184789, 5227.738613069331, 5247.186686063628, 5259.526642602146, 4748.5251474852585, 4795.825022869384, 4797.232442809134, 4828.203346447832, 4853.466118726938, 5563.193336966117, 5565.9443405565835, 5569.377416744133, 5584.553235741131, 5593.944060559424, 4190.769507677077, 4198.202341555095, 4199.433076534659, 4207.284761590507, 4210.51579068408, 5560.527355174815, 5771.480566748971, 5802.88394232113, 5816.680082595455, 5830.62100963436, 4135.6898232632075, 4148.697472902508, 4161.8959526012095, 4162.211318416668, 4171.6036976487185, 4160.791960401968, 4221.577842215754, 4226.302660061117, 4226.366045093199, 4236.978815105905, 4702.177119004161, 4756.6432517561325, 4776.259679749644, 4796.952030479651, 4812.181929072066, 5604.943950560442, 5616.887662246732, 5624.887502249932, 5625.943740562624, 5635.92917345703, 1391.8956078294168, 1409.3164815064686, 1412.971740565183, 1415.221628104559, 1415.7380884536394, 918.4948278446827, 935.4293880732747, 979.8971108033696, 987.9654212102541, 1001.3941565353002, 5109.4379618241965, 5268.5491003392835, 5465.0, 5491.890162196733, 5495.175723641406, 5726.455986681259, 5757.625754325955, 5761.0, 5790.305163380337, 5795.652260864362, 5257.758655033697, 5461.563074953994, 5509.201165830932, 5522.66863988162, 5523.447655234525, 2927.5608658701367, 2931.237878151696, 2932.633420822397, 2935.5743417204812, 2955.2316397736313, 5715.199872017921, 5756.042945398501, 5759.366469688331, 5765.290313552624, 5772.662071860903, 5382.865428364244, 5665.0, 5676.25367257608, 5696.629719068247, 5733.770649173986, 5762.538996880324, 5799.0, 5808.970955145197, 5809.448102430262, 5811.302643682785, 5457.454254574511, 5587.954564762295, 5595.832125036255, 5600.7199640017025, 5782.508486778671, 5741.598088133791, 5753.453421924911, 5759.0, 5773.595848290579, 5773.855653608525, 6029.547783916136, 6037.607555508878, 6044.365341639241, 6052.364501727431, 6076.997295446202, 4071.16541109066, 4206.390073439273, 4237.555056719, 4243.384709217208, 4250.213710463574, 5827.271591051119, 5852.590318677651, 5853.9121913172185, 5859.355470898283, 5872.471477567039, 5517.903196785196, 5702.572307076903, 5719.714014299351, 5755.482006619424, 5764.164196191445, 5654.943450565442, 5664.0, 5695.430456954271, 5713.22871412354, 5716.199732037435, 5629.605927585029, 5638.9436105638415, 5659.85850353728, 5667.688277144796, 5667.829965101054, 5441.809536666197, 5518.530924871431, 5580.35825880029, 5702.8289151325525, 5702.857428564319, 5542.418046105101, 5574.209537514367, 5576.024195765806, 5580.832575022756, 5605.775768969359], "value": 4307.236491326382, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [793.6111305460323, 812.731798506493, 822.4612878564539, 869.9782505437363, 904.1184844776348, 13569.66075848103, 14345.856541434583, 14413.495527656534, 14460.5661830145, 14504.274786260685, 14187.574372768808, 14403.063800852937, 14461.63845903853, 14544.999999999973, 14545.709085818276, 706.7385067525023, 716.870963226619, 831.4221615976913, 845.1168528887297, 849.3035710717214, 828.0766944856472, 845.2941793602349, 851.2636569367514, 854.1885209051395, 855.0081904990212, 893.5576889439736, 896.1844721303615, 897.7800438892481, 898.7213963671282, 899.2221728205088, 744.7244519527756, 763.9388848892075, 890.3011136258039, 896.7892545251893, 897.7531178925815, 636.1729751323261, 648.1088503307951, 651.4885814635536, 651.9250286217099, 652.8988006858945, 14467.131972081603, 14475.276236188149, 14518.92740536301, 14530.418783248657, 14539.78190327146, 12948.870511294861, 13066.673333166651, 13235.073544851864, 13298.202107873462, 13307.600771976857, 12154.592147558897, 12287.207146468896, 12342.81485777714, 12442.626721198378, 12694.682632934158, 4069.8168582413864, 4078.245524577933, 4122.649574786146, 4188.958110418887, 4217.7891105444605, 61369.38630613726, 63621.681891590706, 64871.35128648747, 65582.67208663974, 65816.0, 10800.945995269973, 11027.944860275647, 11058.557657693764, 11197.832032519518, 11217.943910280397, 20638.58722825535, 20676.58646827055, 20691.27580534674, 20785.168593256403, 20939.267125650833, 8191.139850790066, 8279.0, 8309.335253179732, 8489.726541018897, 8554.05905350411, 4689.249720044776, 4740.0, 4827.903441931142, 4837.080954618611, 4903.41159060915, 3393.0669066007044, 3478.060923550627, 3480.965190348064, 3490.1449144959647, 3498.1079824644553, 605.794030029792, 606.8998615228526, 607.1954660075418, 610.2768219659717, 628.6982248520736, 677.7390704578675, 679.6567733294654, 713.2261496276598, 719.3777382564044, 765.8085478630343, 9220.400673956172, 9636.800277289412, 9676.371035882645, 9680.370775899544, 9680.564374603018, 641.7817941899776, 672.8015235505537, 716.6631683108931, 744.9702011919571, 747.6000339818171, 4364.13705026642, 4492.752898590544, 4495.910081798411, 4654.720716756938, 4664.183767840615, 89152.5542372284, 89857.10142898487, 92334.53832730927, 95152.0, 96838.51580742192, 52306.47693523092, 52904.47095529072, 54288.0, 75932.24067759363, 83692.58153709193, 47889.5211047892, 48063.279050814264, 53115.734421328416, 69844.0, 70743.6462817693, 9056.909430905607, 9192.126747958933, 9233.122853328923, 9323.860142097737, 9370.906290937277, 42680.359794603726, 49625.255621164986, 49725.75137124436, 50545.0, 52760.472395277095, 63383.0, 67250.0, 70584.29415705982, 70842.29157708357, 71856.0, 10899.182561308093, 10989.0, 11064.336139831636, 11233.943830281123, 11280.435978201222, 12299.754004919672, 12435.253884766942, 12548.749025019632, 12567.18313309632, 13326.800097998344, 12016.519339226683, 12032.09759268041, 12054.939725301318, 12430.689232769253, 12446.813297800722, 11168.66494005181, 11172.273802202832, 11335.03652189573, 11357.261777984404, 11602.303861768321, 11715.824262636237, 11741.530338786353, 11783.116266280234, 11837.171398002058, 11880.10899182582, 9658.661946831828, 9861.359011664219, 10214.336068155546, 10550.472476375997, 10566.735831604272, 9741.172000380047, 9757.0, 9757.951210243904, 10068.244881634053, 10078.092971632588], "value": 7066.7817561542515, "unit": "score"}], "name": "dromaeo_css", "value": 7254.557084307687, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 114.0, 113.0, 113.0, 115.0, 113.0, 112.0, 112.0, 111.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 126.0, 129.0, 156.0, 123.0, 125.0, 126.0, 126.0, 164.0, 124.0], "value": 134.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 161.0, 163.0, 161.0, 161.0, 160.0, 160.0, 160.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 112.0, 80.0, 77.0, 75.0, 76.0, 96.0, 76.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 111.0, 83.0, 83.0, 83.0, 103.0, 83.0, 82.0, 120.0], "value": 91.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 116.0, 117.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 148.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 85.0, 85.0, 85.0, 84.0, 85.0, 85.0, 84.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 52.0, 52.0, 50.0, 50.0, 52.0, 52.0, 51.0, 51.0], "value": 51.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 61.0, 60.0, 60.0, 59.0, 59.0, 59.0, 60.0], "value": 59.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 76.0, 79.0, 83.0, 76.0, 76.0, 76.0, 77.0, 85.0, 76.0], "value": 78.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 126.0, 129.0, 131.0, 126.0, 126.0, 126.0, 141.0, 171.0, 137.0], "value": 134.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 158.0, 156.0, 162.0, 158.0, 158.0, 159.0, 159.0, 156.0, 159.0], "value": 158.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 64.0, 63.0, 63.0, 62.0, 65.0, 65.0, 62.0, 62.0], "value": 63.4, "unit": "score"}], "name": "kraken", "value": 1474.8000000000002, "alertThreshold": 2.0}]} 08:07:43 INFO - Return code: 0 08:07:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:07:43 INFO - # TBPL SUCCESS # 08:07:43 INFO - Running post-action listener: _resource_record_post_action 08:07:43 INFO - [mozharness: 2016-11-24 16:07:43.890938Z] Finished run-tests step (success) 08:07:43 INFO - Running post-run listener: _resource_record_post_run 08:07:43 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 688128; Write bytes: 353271808; Read time: 76; Write time: 232752 08:07:43 INFO - TinderboxPrint: CPU usage
13.0% 08:07:43 INFO - TinderboxPrint: I/O read bytes / time
688,128 / 76 08:07:43 INFO - TinderboxPrint: I/O write bytes / time
353,271,808 / 232,752 08:07:43 INFO - TinderboxPrint: CPU idle
8,275.8 (87.0%) 08:07:43 INFO - TinderboxPrint: CPU user
1,188.6 (12.5%) 08:07:43 INFO - TinderboxPrint: Swap in / out
0 / 0 08:07:43 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107954176; Read time: 0; Write time: 77572 08:07:43 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 684032; Write bytes: 245317632; Read time: 64; Write time: 155180 08:07:44 INFO - Running post-run listener: _upload_blobber_files 08:07:44 INFO - Blob upload gear active. 08:07:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:07:44 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 08:07:44 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'] 08:07:44 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 08:07:44 INFO - (blobuploader) - INFO - Open directory for files ... 08:07:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:07:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:07:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:07:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:07:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:07:48 INFO - (blobuploader) - INFO - Done attempting. 08:07:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:07:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:07:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:07:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:07:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:07:49 INFO - (blobuploader) - INFO - Done attempting. 08:07:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:07:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:07:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:07:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:07:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:07:49 INFO - (blobuploader) - INFO - Done attempting. 08:07:49 INFO - (blobuploader) - INFO - Iteration through files over. 08:07:49 INFO - Return code: 0 08:07:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:07:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:07:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a3e11795b707d94d3bf8fcf3de9ead5df099396cee280a5f3f2ff23620b6dbd85ef5cb389900ef4f7c8cd6ce0cad793f94daa2c970687f7ede022dbae189cd2a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dce8f882652f824b96db6ec72ad761de0b86e6dee1c31ce6a7cee2204820381b5e25495bc28865dd0bfb5bfc03c873bf55dd8408638a5931be2c4b52f669c3b7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d467791528223fd212721b07685e93e168c7fcb6963a8116a775461bbb5b06d936d90369c6e56c1999affd7f5fbf9a6c68582251902e647a18a2e9cdcf9856be"} 08:07:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:07:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:07:49 INFO - Contents: 08:07:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a3e11795b707d94d3bf8fcf3de9ead5df099396cee280a5f3f2ff23620b6dbd85ef5cb389900ef4f7c8cd6ce0cad793f94daa2c970687f7ede022dbae189cd2a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dce8f882652f824b96db6ec72ad761de0b86e6dee1c31ce6a7cee2204820381b5e25495bc28865dd0bfb5bfc03c873bf55dd8408638a5931be2c4b52f669c3b7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d467791528223fd212721b07685e93e168c7fcb6963a8116a775461bbb5b06d936d90369c6e56c1999affd7f5fbf9a6c68582251902e647a18a2e9cdcf9856be"} 08:07:49 INFO - Running post-run listener: copy_logs_to_upload_dir 08:07:49 INFO - Copying logs to upload dir... 08:07:49 INFO - mkdir: /builds/slave/test/build/upload/logs 08:07:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.794485 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-11-24 08:07:49.793970) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-24 08:07:49.798669) ========= 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=52faae308a556c440401f8e5000001e8-1480000820.898883-1725220654 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/a3e11795b707d94d3bf8fcf3de9ead5df099396cee280a5f3f2ff23620b6dbd85ef5cb389900ef4f7c8cd6ce0cad793f94daa2c970687f7ede022dbae189cd2a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dce8f882652f824b96db6ec72ad761de0b86e6dee1c31ce6a7cee2204820381b5e25495bc28865dd0bfb5bfc03c873bf55dd8408638a5931be2c4b52f669c3b7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d467791528223fd212721b07685e93e168c7fcb6963a8116a775461bbb5b06d936d90369c6e56c1999affd7f5fbf9a6c68582251902e647a18a2e9cdcf9856be"} build_url:https://queue.taskcluster.net/v1/task/BwlxZDJ0S0OhizATfKdDbA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011275 build_url: 'https://queue.taskcluster.net/v1/task/BwlxZDJ0S0OhizATfKdDbA/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/a3e11795b707d94d3bf8fcf3de9ead5df099396cee280a5f3f2ff23620b6dbd85ef5cb389900ef4f7c8cd6ce0cad793f94daa2c970687f7ede022dbae189cd2a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dce8f882652f824b96db6ec72ad761de0b86e6dee1c31ce6a7cee2204820381b5e25495bc28865dd0bfb5bfc03c873bf55dd8408638a5931be2c4b52f669c3b7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d467791528223fd212721b07685e93e168c7fcb6963a8116a775461bbb5b06d936d90369c6e56c1999affd7f5fbf9a6c68582251902e647a18a2e9cdcf9856be"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-24 08:07:49.826772) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 08:07:49.827119) ========= 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=52faae308a556c440401f8e5000001e8-1480000820.898883-1725220654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004472 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 08:07:49.907459) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-24 08:07:49.907777) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-24 08:07:49.908059) ========= ========= Total master_lag: 0.17 =========