builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-031 starttime: 1482393690.24 results: success (0) buildid: 20161221221553 builduid: 8fa1493d90e5428d95bb159d62c1a2d8 revision: 40e863f1e8180487fa1011ed6ac807a30905d617 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-22 00:01:30.236492) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-22 00:01:30.236916) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-22 00:01:30.237187) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-22 00:01:30.285609) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 00:01:30.285862) ========= 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=db0483c52d987ecb441a263b000001ad-1482392870.129988-1560250367 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-22 00:01:30-- 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% 43.0M=0s 2016-12-22 00:01:30 (43.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.092833 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 00:01:30.392931) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 00:01:30.393228) ========= 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=db0483c52d987ecb441a263b000001ad-1482392870.129988-1560250367 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020604 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 00:01:30.444165) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 00:01:30.444507) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 40e863f1e8180487fa1011ed6ac807a30905d617 --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 40e863f1e8180487fa1011ed6ac807a30905d617 --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=db0483c52d987ecb441a263b000001ad-1482392870.129988-1560250367 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-22 00:01:30,724 truncating revision to first 12 chars 2016-12-22 00:01:30,724 Setting DEBUG logging. 2016-12-22 00:01:30,724 attempt 1/10 2016-12-22 00:01:30,724 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/40e863f1e818?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-22 00:01:31,047 unpacking tar archive at: mozilla-aurora-40e863f1e818/testing/mozharness/ program finished with exit code 0 elapsedTime=0.664027 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 00:01:31.167812) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-22 00:01:31.168107) ========= script_repo_revision: 40e863f1e8180487fa1011ed6ac807a30905d617 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-22 00:01:31.168599) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-22 00:01:31.168901) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-22 00:01:31.190124) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-12-22 00:01:31.190420) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=db0483c52d987ecb441a263b000001ad-1482392870.129988-1560250367 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:01:31 INFO - MultiFileLogger online at 20161222 00:01:31 in /builds/slave/test 00:01:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 00:01:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:01:31 INFO - {'append_to_log': False, 00:01:31 INFO - 'base_work_dir': '/builds/slave/test', 00:01:31 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 00:01:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:01:31 INFO - 'branch': 'Mozilla-Aurora', 00:01:31 INFO - 'buildbot_json_path': 'buildprops.json', 00:01:31 INFO - 'config_files': ('talos/linux_config.py',), 00:01:31 INFO - 'default_actions': ('clobber', 00:01:31 INFO - 'read-buildbot-config', 00:01:31 INFO - 'download-and-extract', 00:01:31 INFO - 'populate-webroot', 00:01:31 INFO - 'create-virtualenv', 00:01:31 INFO - 'install', 00:01:31 INFO - 'run-tests'), 00:01:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:01:31 INFO - 'download_minidump_stackwalk': True, 00:01:31 INFO - 'download_symbols': 'ondemand', 00:01:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:01:31 INFO - 'tooltool.py': '/tools/tooltool.py', 00:01:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:01:31 INFO - '/tools/misc-python/virtualenv.py')}, 00:01:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:01:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:01:31 INFO - 'installer_path': 'installer.exe', 00:01:31 INFO - 'log_level': 'info', 00:01:31 INFO - 'log_name': 'talos', 00:01:31 INFO - 'log_to_console': True, 00:01:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:01:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:01:31 INFO - 'opt_config_files': (), 00:01:31 INFO - 'pip_index': False, 00:01:31 INFO - 'sps_profile': False, 00:01:31 INFO - 'sps_profile_interval': 0, 00:01:31 INFO - 'suite': 'dromaeojs-e10s', 00:01:31 INFO - 'system_bits': '32', 00:01:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:01:31 INFO - 'title': 'talos-linux64-ix-031', 00:01:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:01:31 INFO - 'use_talos_json': True, 00:01:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:01:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:01:31 INFO - 'work_dir': 'build'} 00:01:31 INFO - [mozharness: 2016-12-22 08:01:31.604980Z] Running clobber step. 00:01:31 INFO - Running pre-action listener: _resource_record_pre_action 00:01:31 INFO - Running main action method: clobber 00:01:31 INFO - rmtree: /builds/slave/test/build 00:01:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:01:32 INFO - Running post-action listener: _resource_record_post_action 00:01:32 INFO - [mozharness: 2016-12-22 08:01:32.064933Z] Finished clobber step (success) 00:01:32 INFO - [mozharness: 2016-12-22 08:01:32.065032Z] Running read-buildbot-config step. 00:01:32 INFO - Running pre-action listener: _resource_record_pre_action 00:01:32 INFO - Running main action method: read_buildbot_config 00:01:32 INFO - Using buildbot properties: 00:01:32 INFO - { 00:01:32 INFO - "project": "", 00:01:32 INFO - "product": "firefox", 00:01:32 INFO - "script_repo_revision": "production", 00:01:32 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 00:01:32 INFO - "repository": "", 00:01:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 00:01:32 INFO - "buildid": "20161221221553", 00:01:32 INFO - "pgo_build": "True", 00:01:32 INFO - "basedir": "/builds/slave/test", 00:01:32 INFO - "buildnumber": 775, 00:01:32 INFO - "slavename": "talos-linux64-ix-031", 00:01:32 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 00:01:32 INFO - "platform": "ubuntu64_hw", 00:01:32 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 00:01:32 INFO - "branch": "mozilla-aurora", 00:01:32 INFO - "repo_path": "releases/mozilla-aurora", 00:01:32 INFO - "revision": "40e863f1e8180487fa1011ed6ac807a30905d617", 00:01:32 INFO - "stage_platform": "linux64-pgo", 00:01:32 INFO - "builduid": "8fa1493d90e5428d95bb159d62c1a2d8", 00:01:32 INFO - "slavebuilddir": "test" 00:01:32 INFO - } 00:01:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/M9coC_jMS-W1mvNRh8carg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 00:01:32 INFO - Running post-action listener: _resource_record_post_action 00:01:32 INFO - [mozharness: 2016-12-22 08:01:32.067461Z] Finished read-buildbot-config step (success) 00:01:32 INFO - [mozharness: 2016-12-22 08:01:32.067550Z] Running download-and-extract step. 00:01:32 INFO - Running pre-action listener: _resource_record_pre_action 00:01:32 INFO - Running main action method: download_and_extract 00:01:32 INFO - mkdir: /builds/slave/test/build/tests 00:01:32 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')]} 00:01:32 INFO - trying https://queue.taskcluster.net/v1/task/M9coC_jMS-W1mvNRh8carg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 00:01:32 INFO - Downloading https://queue.taskcluster.net/v1/task/M9coC_jMS-W1mvNRh8carg/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 00:01:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M9coC_jMS-W1mvNRh8carg/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 00:01:32 INFO - Downloaded 1361 bytes. 00:01:32 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 00:01:32 INFO - Using the following test package requirements: 00:01:32 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 00:01:32 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 00:01:32 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 00:01:32 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 00:01:32 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 00:01:32 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 00:01:32 INFO - u'jsshell-linux-x86_64.zip'], 00:01:32 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 00:01:32 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 00:01:32 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 00:01:32 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 00:01:32 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 00:01:32 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 00:01:32 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 00:01:32 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 00:01:32 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 00:01:32 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 00:01:32 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 00:01:32 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:01:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M9coC_jMS-W1mvNRh8carg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 00:01:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M9coC_jMS-W1mvNRh8carg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:01:32 INFO - Fetch https://queue.taskcluster.net/v1/task/M9coC_jMS-W1mvNRh8carg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 00:01:33 INFO - Http code: 200 00:01:33 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 00:01:33 INFO - x-amz-cf-id: QbAuIfV1PuyhBbQFK03wV1UrQw9A4E0NE1QxKzoDK1repruuuAhoEQ== 00:01:33 INFO - x-amz-version-id: wKw0rSaKs2e11kyoum0hNrqObZdqL3Io 00:01:34 INFO - Expected file size: 21942703 00:01:34 INFO - Obtained file size: 21942703 00:01:38 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 00:01:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M9coC_jMS-W1mvNRh8carg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 00:01:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M9coC_jMS-W1mvNRh8carg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:01:38 INFO - Fetch https://queue.taskcluster.net/v1/task/M9coC_jMS-W1mvNRh8carg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 00:01:38 INFO - Http code: 200 00:01:38 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 00:01:38 INFO - x-amz-cf-id: jnaNCa9klLixrX9QsXC29OMsU5VEC_LAxXCEOmpt004M2yZG8Mo4Ig== 00:01:38 INFO - x-amz-version-id: wKw0rSaKs2e11kyoum0hNrqObZdqL3Io 00:01:39 INFO - Expected file size: 21942703 00:01:39 INFO - Obtained file size: 21942703 00:01:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M9coC_jMS-W1mvNRh8carg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 00:01:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M9coC_jMS-W1mvNRh8carg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 00:01:43 INFO - Fetch https://queue.taskcluster.net/v1/task/M9coC_jMS-W1mvNRh8carg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 00:01:44 INFO - Http code: 200 00:01:44 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 00:01:44 INFO - x-amz-cf-id: WtsjHFSqwZ4Yl2L4hE7kcMIdGDUumFSqmNqrqJK9W3czIS_lddjTBg== 00:01:44 INFO - x-amz-version-id: bCQSHdA3j4V8mschrIunQJvKPmpQNMFD 00:01:45 INFO - Expected file size: 14409038 00:01:45 INFO - Obtained file size: 14409038 00:01:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:01:45 INFO - trying https://queue.taskcluster.net/v1/task/M9coC_jMS-W1mvNRh8carg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 00:01:45 INFO - Downloading https://queue.taskcluster.net/v1/task/M9coC_jMS-W1mvNRh8carg/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 00:01:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M9coC_jMS-W1mvNRh8carg/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 00:01:48 INFO - Downloaded 63972204 bytes. 00:01:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M9coC_jMS-W1mvNRh8carg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 00:01:48 INFO - mkdir: /builds/slave/test/properties 00:01:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:01:48 INFO - Writing to file /builds/slave/test/properties/build_url 00:01:48 INFO - Contents: 00:01:48 INFO - build_url:https://queue.taskcluster.net/v1/task/M9coC_jMS-W1mvNRh8carg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 00:01:48 INFO - Running post-action listener: _resource_record_post_action 00:01:48 INFO - Running post-action listener: set_extra_try_arguments 00:01:48 INFO - [mozharness: 2016-12-22 08:01:48.932756Z] Finished download-and-extract step (success) 00:01:48 INFO - [mozharness: 2016-12-22 08:01:48.932983Z] Running populate-webroot step. 00:01:48 INFO - Running pre-action listener: _resource_record_pre_action 00:01:48 INFO - Running main action method: populate_webroot 00:01:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:01:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:01:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:01:48 INFO - '--tppagecycles', 00:01:48 INFO - '7'], 00:01:48 INFO - 'tests': ['tsvgm']}}, 00:01:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:01:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:01:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:01:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:01:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:01:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:01:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:01:48 INFO - 'talos_options': ['--disable-e10s'], 00:01:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:01:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:01:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:01:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:01:48 INFO - 'talos_options': ['--disable-e10s'], 00:01:48 INFO - 'tests': ['damp', 'tps']}, 00:01:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:01:48 INFO - 'tests': ['damp', 'tps']}, 00:01:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:01:48 INFO - 'tests': ['dromaeo_dom']}, 00:01:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:01:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:01:48 INFO - 'tests': ['basic_compositor_video']}, 00:01:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:01:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:01:48 INFO - 'tests': ['a11yr', 00:01:48 INFO - 'ts_paint', 00:01:48 INFO - 'tpaint', 00:01:48 INFO - 'sessionrestore', 00:01:48 INFO - 'sessionrestore_no_auto_restore', 00:01:48 INFO - 'tabpaint']}, 00:01:48 INFO - 'other-e10s': {'tests': ['a11yr', 00:01:48 INFO - 'ts_paint', 00:01:48 INFO - 'tpaint', 00:01:48 INFO - 'sessionrestore', 00:01:48 INFO - 'sessionrestore_no_auto_restore', 00:01:48 INFO - 'tabpaint']}, 00:01:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:01:48 INFO - 'ts_paint', 00:01:48 INFO - 'tpaint', 00:01:48 INFO - 'sessionrestore', 00:01:48 INFO - 'sessionrestore_no_auto_restore', 00:01:48 INFO - 'tabpaint']}, 00:01:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:01:48 INFO - 'ts_paint', 00:01:48 INFO - 'tpaint', 00:01:48 INFO - 'sessionrestore', 00:01:48 INFO - 'sessionrestore_no_auto_restore', 00:01:48 INFO - 'tabpaint']}, 00:01:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:01:48 INFO - 'tests': ['a11yr', 00:01:48 INFO - 'ts_paint', 00:01:48 INFO - 'tpaint', 00:01:48 INFO - 'sessionrestore', 00:01:48 INFO - 'sessionrestore_no_auto_restore', 00:01:48 INFO - 'tabpaint']}, 00:01:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:01:48 INFO - 'tests': ['a11yr', 00:01:48 INFO - 'ts_paint', 00:01:48 INFO - 'tpaint', 00:01:48 INFO - 'sessionrestore', 00:01:48 INFO - 'sessionrestore_no_auto_restore', 00:01:48 INFO - 'tabpaint']}, 00:01:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:01:48 INFO - 'tests': ['tsvgx', 00:01:48 INFO - 'tsvgr_opacity', 00:01:48 INFO - 'tart', 00:01:48 INFO - 'tscrollx', 00:01:48 INFO - 'cart']}, 00:01:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:01:48 INFO - 'tsvgr_opacity', 00:01:48 INFO - 'tart', 00:01:48 INFO - 'tscrollx', 00:01:48 INFO - 'cart']}, 00:01:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:01:48 INFO - 'talos_options': ['--disable-e10s'], 00:01:48 INFO - 'tests': ['tp5o']}, 00:01:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:01:48 INFO - 'tests': ['tp5o']}, 00:01:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:01:48 INFO - 'talos_options': ['--disable-e10s', 00:01:48 INFO - '--xperf_path', 00:01:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:01:48 INFO - 'tests': ['tp5n']}, 00:01:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:01:48 INFO - 'talos_options': ['--xperf_path', 00:01:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:01:48 INFO - 'tests': ['tp5n']}}, 00:01:48 INFO - 'talos.zip': {'path': '', 00:01:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:01:48 INFO - Running post-action listener: _resource_record_post_action 00:01:48 INFO - [mozharness: 2016-12-22 08:01:48.951624Z] Finished populate-webroot step (success) 00:01:48 INFO - [mozharness: 2016-12-22 08:01:48.951712Z] Running create-virtualenv step. 00:01:48 INFO - Running pre-action listener: _resource_record_pre_action 00:01:48 INFO - Running main action method: create_virtualenv 00:01:48 INFO - Creating virtualenv /builds/slave/test/build/venv 00:01:48 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 00:01:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:01:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:01:49 INFO - Using real prefix '/usr' 00:01:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:01:49 INFO - Installing distribute.............................................................................................................................................................................................done. 00:01:51 INFO - Installing pip.................done. 00:01:51 INFO - Return code: 0 00:01:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:01:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:01:51 INFO - Reading from file tmpfile_stdout 00:01:51 INFO - Output received: 00:01:51 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) 00:01:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:01:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:01:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:01:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:01:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:01:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:01:51 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 0x7fd86b96cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2381ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237ef60>, '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 0x237fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23801d0>, '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': 'db0483c52d987ecb441a263b000001ad-1482392870.129988-1560250367', '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 00:01:51 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 00:01:51 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 00:01:51 INFO - Using env: {'DISPLAY': ':0', 00:01:51 INFO - 'HOME': '/home/cltbld', 00:01:51 INFO - 'LANG': 'en_US.UTF-8', 00:01:51 INFO - 'LANGUAGE': 'en_US:en', 00:01:51 INFO - 'LOGNAME': 'cltbld', 00:01:51 INFO - 'MAIL': '/var/mail/cltbld', 00:01:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:01:51 INFO - 'MOZ_NO_REMOTE': '1', 00:01:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:01:51 INFO - 'NO_EM_RESTART': '1', 00:01:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:01:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:01:51 INFO - 'PWD': '/builds/slave/test', 00:01:51 INFO - 'SHELL': '/bin/bash', 00:01:51 INFO - 'SHLVL': '1', 00:01:51 INFO - 'TERM': 'linux', 00:01:51 INFO - 'TMOUT': '86400', 00:01:51 INFO - 'USER': 'cltbld', 00:01:51 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1482392870.129988-1560250367', 00:01:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:01:51 INFO - '_': '/tools/buildbot/bin/python'} 00:01:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:01:51 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 00:01:51 INFO - Cleaning up... 00:01:51 INFO - Return code: 0 00:01:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:01:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:01:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:01:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:01:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:01:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:01:51 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 0x7fd86b96cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2381ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237ef60>, '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 0x237fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23801d0>, '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': 'db0483c52d987ecb441a263b000001ad-1482392870.129988-1560250367', '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 00:01:51 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 00:01:51 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 00:01:51 INFO - Using env: {'DISPLAY': ':0', 00:01:51 INFO - 'HOME': '/home/cltbld', 00:01:51 INFO - 'LANG': 'en_US.UTF-8', 00:01:51 INFO - 'LANGUAGE': 'en_US:en', 00:01:51 INFO - 'LOGNAME': 'cltbld', 00:01:51 INFO - 'MAIL': '/var/mail/cltbld', 00:01:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:01:51 INFO - 'MOZ_NO_REMOTE': '1', 00:01:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:01:51 INFO - 'NO_EM_RESTART': '1', 00:01:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:01:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:01:51 INFO - 'PWD': '/builds/slave/test', 00:01:51 INFO - 'SHELL': '/bin/bash', 00:01:51 INFO - 'SHLVL': '1', 00:01:51 INFO - 'TERM': 'linux', 00:01:51 INFO - 'TMOUT': '86400', 00:01:51 INFO - 'USER': 'cltbld', 00:01:51 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1482392870.129988-1560250367', 00:01:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:01:51 INFO - '_': '/tools/buildbot/bin/python'} 00:01:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:01:52 INFO - Downloading/unpacking psutil>=3.1.1 00:01:52 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 00:01:52 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 00:01:52 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 00:01:52 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 00:01:52 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 00:01:52 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 00:01:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:01:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:01:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:01:54 INFO - Installing collected packages: psutil 00:01:54 INFO - Running setup.py install for psutil 00:01:54 INFO - building 'psutil._psutil_linux' extension 00:01:54 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 00:01:54 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 00:01:54 INFO - building 'psutil._psutil_posix' extension 00:01:54 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 00:01:54 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 00:01:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:01:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:01:54 INFO - Successfully installed psutil 00:01:54 INFO - Cleaning up... 00:01:54 INFO - Return code: 0 00:01:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:01:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:01:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:01:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:01:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:01:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:01:54 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 0x7fd86b96cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2381ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237ef60>, '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 0x237fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23801d0>, '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': 'db0483c52d987ecb441a263b000001ad-1482392870.129988-1560250367', '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 00:01:54 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 00:01:54 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 00:01:54 INFO - Using env: {'DISPLAY': ':0', 00:01:54 INFO - 'HOME': '/home/cltbld', 00:01:54 INFO - 'LANG': 'en_US.UTF-8', 00:01:54 INFO - 'LANGUAGE': 'en_US:en', 00:01:54 INFO - 'LOGNAME': 'cltbld', 00:01:54 INFO - 'MAIL': '/var/mail/cltbld', 00:01:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:01:54 INFO - 'MOZ_NO_REMOTE': '1', 00:01:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:01:54 INFO - 'NO_EM_RESTART': '1', 00:01:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:01:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:01:54 INFO - 'PWD': '/builds/slave/test', 00:01:54 INFO - 'SHELL': '/bin/bash', 00:01:54 INFO - 'SHLVL': '1', 00:01:54 INFO - 'TERM': 'linux', 00:01:54 INFO - 'TMOUT': '86400', 00:01:54 INFO - 'USER': 'cltbld', 00:01:54 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1482392870.129988-1560250367', 00:01:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:01:54 INFO - '_': '/tools/buildbot/bin/python'} 00:01:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:01:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:01:55 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 00:01:55 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 00:01:55 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 00:01:55 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 00:01:55 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 00:01:55 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 00:01:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:01:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:01:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:01:57 INFO - Installing collected packages: mozsystemmonitor 00:01:57 INFO - Running setup.py install for mozsystemmonitor 00:01:57 INFO - Successfully installed mozsystemmonitor 00:01:57 INFO - Cleaning up... 00:01:57 INFO - Return code: 0 00:01:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:01:57 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')]} 00:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:01:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:01:57 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')]} 00:01:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:01:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:01:57 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 0x7fd86b96cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2381ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237ef60>, '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 0x237fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23801d0>, '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': 'db0483c52d987ecb441a263b000001ad-1482392870.129988-1560250367', '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 00:01:57 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 00:01:57 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 00:01:57 INFO - Using env: {'DISPLAY': ':0', 00:01:57 INFO - 'HOME': '/home/cltbld', 00:01:57 INFO - 'LANG': 'en_US.UTF-8', 00:01:57 INFO - 'LANGUAGE': 'en_US:en', 00:01:57 INFO - 'LOGNAME': 'cltbld', 00:01:57 INFO - 'MAIL': '/var/mail/cltbld', 00:01:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:01:57 INFO - 'MOZ_NO_REMOTE': '1', 00:01:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:01:57 INFO - 'NO_EM_RESTART': '1', 00:01:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:01:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:01:57 INFO - 'PWD': '/builds/slave/test', 00:01:57 INFO - 'SHELL': '/bin/bash', 00:01:57 INFO - 'SHLVL': '1', 00:01:57 INFO - 'TERM': 'linux', 00:01:57 INFO - 'TMOUT': '86400', 00:01:57 INFO - 'USER': 'cltbld', 00:01:57 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1482392870.129988-1560250367', 00:01:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:01:57 INFO - '_': '/tools/buildbot/bin/python'} 00:01:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:01:57 INFO - Downloading/unpacking jsonschema==2.5.1 00:01:57 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 00:01:57 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 00:01:57 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 00:01:57 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 00:01:57 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 00:01:57 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 00:01:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:01:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:01:59 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 00:01:59 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 00:01:59 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 00:01:59 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 00:01:59 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 00:01:59 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 00:01:59 INFO - Downloading functools32-3.2.3-2.tar.gz 00:01:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:01:59 INFO - warning: no files found matching '*.txt' 00:01:59 INFO - no previously-included directories found matching 'build' 00:01:59 INFO - no previously-included directories found matching 'dist' 00:01:59 INFO - no previously-included directories found matching '.git*' 00:01:59 INFO - Installing collected packages: jsonschema, functools32 00:01:59 INFO - Running setup.py install for functools32 00:01:59 INFO - warning: no files found matching '*.txt' 00:01:59 INFO - no previously-included directories found matching 'build' 00:01:59 INFO - no previously-included directories found matching 'dist' 00:01:59 INFO - no previously-included directories found matching '.git*' 00:01:59 INFO - Successfully installed jsonschema functools32 00:01:59 INFO - Cleaning up... 00:01:59 INFO - Return code: 0 00:01:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:01:59 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')]} 00:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:01:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:01:59 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')]} 00:01:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:01:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:01:59 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 0x7fd86b96cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2381ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237ef60>, '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 0x237fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23801d0>, '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': 'db0483c52d987ecb441a263b000001ad-1482392870.129988-1560250367', '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 00:01:59 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 00:01:59 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 00:01:59 INFO - Using env: {'DISPLAY': ':0', 00:01:59 INFO - 'HOME': '/home/cltbld', 00:01:59 INFO - 'LANG': 'en_US.UTF-8', 00:01:59 INFO - 'LANGUAGE': 'en_US:en', 00:01:59 INFO - 'LOGNAME': 'cltbld', 00:01:59 INFO - 'MAIL': '/var/mail/cltbld', 00:01:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:01:59 INFO - 'MOZ_NO_REMOTE': '1', 00:01:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:01:59 INFO - 'NO_EM_RESTART': '1', 00:01:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:01:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:01:59 INFO - 'PWD': '/builds/slave/test', 00:01:59 INFO - 'SHELL': '/bin/bash', 00:01:59 INFO - 'SHLVL': '1', 00:01:59 INFO - 'TERM': 'linux', 00:01:59 INFO - 'TMOUT': '86400', 00:01:59 INFO - 'USER': 'cltbld', 00:01:59 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1482392870.129988-1560250367', 00:01:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:01:59 INFO - '_': '/tools/buildbot/bin/python'} 00:02:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:02:00 INFO - Cleaning up... 00:02:00 INFO - Return code: 0 00:02:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:02:00 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')]} 00:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:02:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:02:00 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')]} 00:02:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:02:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:02:00 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 0x7fd86b96cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2381ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237ef60>, '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 0x237fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23801d0>, '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': 'db0483c52d987ecb441a263b000001ad-1482392870.129988-1560250367', '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 00:02:00 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 00:02:00 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 00:02:00 INFO - Using env: {'DISPLAY': ':0', 00:02:00 INFO - 'HOME': '/home/cltbld', 00:02:00 INFO - 'LANG': 'en_US.UTF-8', 00:02:00 INFO - 'LANGUAGE': 'en_US:en', 00:02:00 INFO - 'LOGNAME': 'cltbld', 00:02:00 INFO - 'MAIL': '/var/mail/cltbld', 00:02:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:02:00 INFO - 'MOZ_NO_REMOTE': '1', 00:02:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:02:00 INFO - 'NO_EM_RESTART': '1', 00:02:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:02:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:02:00 INFO - 'PWD': '/builds/slave/test', 00:02:00 INFO - 'SHELL': '/bin/bash', 00:02:00 INFO - 'SHLVL': '1', 00:02:00 INFO - 'TERM': 'linux', 00:02:00 INFO - 'TMOUT': '86400', 00:02:00 INFO - 'USER': 'cltbld', 00:02:00 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1482392870.129988-1560250367', 00:02:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:02:00 INFO - '_': '/tools/buildbot/bin/python'} 00:02:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:02:00 INFO - Downloading/unpacking blobuploader==1.2.4 00:02:00 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 00:02:00 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 00:02:00 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 00:02:00 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 00:02:00 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 00:02:00 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 00:02:02 INFO - Downloading blobuploader-1.2.4.tar.gz 00:02:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:02:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:02:02 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 00:02:02 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 00:02:02 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 00:02:02 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 00:02:02 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 00:02:02 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 00:02:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:02:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:02:02 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 00:02:02 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 00:02:02 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 00:02:02 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 00:02:02 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 00:02:02 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 00:02:03 INFO - Downloading docopt-0.6.1.tar.gz 00:02:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:02:03 INFO - Installing collected packages: blobuploader, requests, docopt 00:02:03 INFO - Running setup.py install for blobuploader 00:02:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:02:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:02:03 INFO - Running setup.py install for requests 00:02:03 INFO - Running setup.py install for docopt 00:02:03 INFO - Successfully installed blobuploader requests docopt 00:02:03 INFO - Cleaning up... 00:02:03 INFO - Return code: 0 00:02:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:02:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:02:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:02:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:02:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:02:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:02:03 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 0x7fd86b96cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2381ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237ef60>, '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 0x237fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23801d0>, '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': 'db0483c52d987ecb441a263b000001ad-1482392870.129988-1560250367', '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 00:02:03 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 00:02:03 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 00:02:03 INFO - Using env: {'DISPLAY': ':0', 00:02:03 INFO - 'HOME': '/home/cltbld', 00:02:03 INFO - 'LANG': 'en_US.UTF-8', 00:02:03 INFO - 'LANGUAGE': 'en_US:en', 00:02:03 INFO - 'LOGNAME': 'cltbld', 00:02:03 INFO - 'MAIL': '/var/mail/cltbld', 00:02:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:02:03 INFO - 'MOZ_NO_REMOTE': '1', 00:02:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:02:03 INFO - 'NO_EM_RESTART': '1', 00:02:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:02:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:02:03 INFO - 'PWD': '/builds/slave/test', 00:02:03 INFO - 'SHELL': '/bin/bash', 00:02:03 INFO - 'SHLVL': '1', 00:02:03 INFO - 'TERM': 'linux', 00:02:03 INFO - 'TMOUT': '86400', 00:02:03 INFO - 'USER': 'cltbld', 00:02:03 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1482392870.129988-1560250367', 00:02:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:02:03 INFO - '_': '/tools/buildbot/bin/python'} 00:02:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:02:04 INFO - Running setup.py (path:/tmp/pip-zrtg6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:02:04 INFO - Running setup.py (path:/tmp/pip-Vb6Plw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:02:04 INFO - Running setup.py (path:/tmp/pip-vHg6pD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:02:04 INFO - Running setup.py (path:/tmp/pip-7mcobO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:02:04 INFO - Running setup.py (path:/tmp/pip-xLBCl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:02:04 INFO - Running setup.py (path:/tmp/pip-36ZIYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:02:04 INFO - Running setup.py (path:/tmp/pip-zoCsu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:02:04 INFO - Running setup.py (path:/tmp/pip-tIrcN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:02:04 INFO - Running setup.py (path:/tmp/pip-cOGQOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:02:04 INFO - Running setup.py (path:/tmp/pip-KzSdZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:02:04 INFO - Running setup.py (path:/tmp/pip-KBdZ7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:02:04 INFO - Running setup.py (path:/tmp/pip-Esz58P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:02:04 INFO - Running setup.py (path:/tmp/pip-oJViCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:02:04 INFO - Running setup.py (path:/tmp/pip-aNeXTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:02:05 INFO - Running setup.py (path:/tmp/pip-5X5lcn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:02:05 INFO - Running setup.py (path:/tmp/pip-fvPjoi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:02:05 INFO - Running setup.py (path:/tmp/pip-KjvF4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:02:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:02:05 INFO - Running setup.py install for manifestparser 00:02:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:02:05 INFO - Running setup.py install for mozcrash 00:02:05 INFO - Running setup.py install for mozdebug 00:02:05 INFO - Running setup.py install for mozdevice 00:02:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:02:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:02:05 INFO - Running setup.py install for mozfile 00:02:05 INFO - Running setup.py install for mozhttpd 00:02:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:02:05 INFO - Running setup.py install for mozinfo 00:02:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:02:05 INFO - Running setup.py install for mozInstall 00:02:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:02:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:02:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:02:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:02:06 INFO - Running setup.py install for mozleak 00:02:06 INFO - Running setup.py install for mozlog 00:02:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:02:06 INFO - Running setup.py install for moznetwork 00:02:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:02:06 INFO - Running setup.py install for mozprocess 00:02:06 INFO - Running setup.py install for mozprofile 00:02:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:02:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:02:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:02:06 INFO - Running setup.py install for mozrunner 00:02:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:02:06 INFO - Running setup.py install for mozscreenshot 00:02:06 INFO - Running setup.py install for moztest 00:02:06 INFO - Running setup.py install for mozversion 00:02:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:02:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:02:07 INFO - Cleaning up... 00:02:07 INFO - Return code: 0 00:02:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:02: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')]} 00:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:02:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:02: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')]} 00:02:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:02:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:02:07 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 0x7fd86b96cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2381ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237ef60>, '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 0x237fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23801d0>, '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': 'db0483c52d987ecb441a263b000001ad-1482392870.129988-1560250367', '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 00:02:07 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 00:02:07 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 00:02:07 INFO - Using env: {'DISPLAY': ':0', 00:02:07 INFO - 'HOME': '/home/cltbld', 00:02:07 INFO - 'LANG': 'en_US.UTF-8', 00:02:07 INFO - 'LANGUAGE': 'en_US:en', 00:02:07 INFO - 'LOGNAME': 'cltbld', 00:02:07 INFO - 'MAIL': '/var/mail/cltbld', 00:02:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:02:07 INFO - 'MOZ_NO_REMOTE': '1', 00:02:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:02:07 INFO - 'NO_EM_RESTART': '1', 00:02:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:02:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:02:07 INFO - 'PWD': '/builds/slave/test', 00:02:07 INFO - 'SHELL': '/bin/bash', 00:02:07 INFO - 'SHLVL': '1', 00:02:07 INFO - 'TERM': 'linux', 00:02:07 INFO - 'TMOUT': '86400', 00:02:07 INFO - 'USER': 'cltbld', 00:02:07 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1482392870.129988-1560250367', 00:02:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:02:07 INFO - '_': '/tools/buildbot/bin/python'} 00:02:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:02:07 INFO - Running setup.py (path:/tmp/pip-jtQMfj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:02:07 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)) 00:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:02:07 INFO - Running setup.py (path:/tmp/pip-H36DtD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:02:07 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)) 00:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:02:07 INFO - Running setup.py (path:/tmp/pip-CBgPkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:02:07 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)) 00:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:02:07 INFO - Running setup.py (path:/tmp/pip-mUXkF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:02:07 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)) 00:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:02:07 INFO - Running setup.py (path:/tmp/pip-WRRDQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:02:07 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)) 00:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:02:07 INFO - Running setup.py (path:/tmp/pip-13JAUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:02:07 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)) 00:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:02:07 INFO - Running setup.py (path:/tmp/pip-8e755F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:02:07 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)) 00:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:02:07 INFO - Running setup.py (path:/tmp/pip-W_E2jT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:02:07 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)) 00:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:02:07 INFO - Running setup.py (path:/tmp/pip-TXGyMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:02:07 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)) 00:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:02:07 INFO - Running setup.py (path:/tmp/pip-LmH8oP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:02:08 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)) 00:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:02:08 INFO - Running setup.py (path:/tmp/pip-8VHQjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:02:08 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)) 00:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:02:08 INFO - Running setup.py (path:/tmp/pip-gOgGxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:02:08 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)) 00:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:02:08 INFO - Running setup.py (path:/tmp/pip-Q3sApQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:02:08 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)) 00:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:02:08 INFO - Running setup.py (path:/tmp/pip-E1n9b3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:02:08 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)) 00:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:02:08 INFO - Running setup.py (path:/tmp/pip-gvJ1Hp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:02:08 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)) 00:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:02:08 INFO - Running setup.py (path:/tmp/pip-N7yoki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:02:08 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)) 00:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:02:08 INFO - Running setup.py (path:/tmp/pip-YCGxKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:02:08 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)) 00:02:08 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)) 00:02:08 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)) 00:02:08 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)) 00:02:08 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)) 00:02:08 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)) 00:02:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:02:08 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 00:02:08 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 00:02:08 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 00:02:08 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 00:02:08 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 00:02:08 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 00:02:10 INFO - Downloading blessings-1.6.tar.gz 00:02:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:02:10 INFO - Installing collected packages: blessings 00:02:10 INFO - Running setup.py install for blessings 00:02:10 INFO - Successfully installed blessings 00:02:10 INFO - Cleaning up... 00:02:10 INFO - Return code: 0 00:02:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:02:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:02:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:02:10 INFO - Reading from file tmpfile_stdout 00:02:10 INFO - Current package versions: 00:02:10 INFO - argparse == 1.2.1 00:02:10 INFO - blessings == 1.6 00:02:10 INFO - blobuploader == 1.2.4 00:02:10 INFO - docopt == 0.6.1 00:02:10 INFO - functools32 == 3.2.3-2 00:02:10 INFO - jsonschema == 2.5.1 00:02:10 INFO - manifestparser == 1.1 00:02:10 INFO - mozInstall == 1.12 00:02:10 INFO - mozcrash == 1.0 00:02:10 INFO - mozdebug == 0.1 00:02:10 INFO - mozdevice == 0.48 00:02:10 INFO - mozfile == 1.2 00:02:10 INFO - mozhttpd == 0.7 00:02:10 INFO - mozinfo == 0.9 00:02:11 INFO - mozleak == 0.1 00:02:11 INFO - mozlog == 3.4 00:02:11 INFO - moznetwork == 0.27 00:02:11 INFO - mozprocess == 0.23 00:02:11 INFO - mozprofile == 0.28 00:02:11 INFO - mozrunner == 6.13 00:02:11 INFO - mozscreenshot == 0.1 00:02:11 INFO - mozsystemmonitor == 0.3 00:02:11 INFO - moztest == 0.7 00:02:11 INFO - mozversion == 1.4 00:02:11 INFO - psutil == 3.1.1 00:02:11 INFO - requests == 1.2.3 00:02:11 INFO - wsgiref == 0.1.2 00:02:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:02:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:02:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:02:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:02:11 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 0x7fd86b96cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2381ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237ef60>, '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 0x237fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23801d0>, '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': 'db0483c52d987ecb441a263b000001ad-1482392870.129988-1560250367', '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 00:02:11 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 00:02:11 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 00:02:11 INFO - Using env: {'DISPLAY': ':0', 00:02:11 INFO - 'HOME': '/home/cltbld', 00:02:11 INFO - 'LANG': 'en_US.UTF-8', 00:02:11 INFO - 'LANGUAGE': 'en_US:en', 00:02:11 INFO - 'LOGNAME': 'cltbld', 00:02:11 INFO - 'MAIL': '/var/mail/cltbld', 00:02:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:02:11 INFO - 'MOZ_NO_REMOTE': '1', 00:02:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:02:11 INFO - 'NO_EM_RESTART': '1', 00:02:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:02:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:02:11 INFO - 'PWD': '/builds/slave/test', 00:02:11 INFO - 'SHELL': '/bin/bash', 00:02:11 INFO - 'SHLVL': '1', 00:02:11 INFO - 'TERM': 'linux', 00:02:11 INFO - 'TMOUT': '86400', 00:02:11 INFO - 'USER': 'cltbld', 00:02:11 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1482392870.129988-1560250367', 00:02:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:02:11 INFO - '_': '/tools/buildbot/bin/python'} 00:02:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:02:11 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)) 00:02:11 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)) 00:02:11 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)) 00:02:11 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)) 00:02:11 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)) 00:02:11 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)) 00:02:11 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)) 00:02:11 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)) 00:02:11 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)) 00:02:11 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)) 00:02:11 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)) 00:02:11 INFO - Cleaning up... 00:02:11 INFO - Return code: 0 00:02:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:02:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:02:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:02:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:02:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd86b96cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2381ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237ef60>, '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 0x237fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23801d0>, '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': 'db0483c52d987ecb441a263b000001ad-1482392870.129988-1560250367', '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 00:02:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 00:02:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 00:02:11 INFO - Using env: {'DISPLAY': ':0', 00:02:11 INFO - 'HOME': '/home/cltbld', 00:02:11 INFO - 'LANG': 'en_US.UTF-8', 00:02:11 INFO - 'LANGUAGE': 'en_US:en', 00:02:11 INFO - 'LOGNAME': 'cltbld', 00:02:11 INFO - 'MAIL': '/var/mail/cltbld', 00:02:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:02:11 INFO - 'MOZ_NO_REMOTE': '1', 00:02:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:02:11 INFO - 'NO_EM_RESTART': '1', 00:02:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:02:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:02:11 INFO - 'PWD': '/builds/slave/test', 00:02:11 INFO - 'SHELL': '/bin/bash', 00:02:11 INFO - 'SHLVL': '1', 00:02:11 INFO - 'TERM': 'linux', 00:02:11 INFO - 'TMOUT': '86400', 00:02:11 INFO - 'USER': 'cltbld', 00:02:11 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1482392870.129988-1560250367', 00:02:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:02:11 INFO - '_': '/tools/buildbot/bin/python'} 00:02:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:02:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:02:11 INFO - Cleaning up... 00:02:11 INFO - Return code: 0 00:02:11 INFO - Running post-action listener: _resource_record_post_action 00:02:11 INFO - Running post-action listener: _start_resource_monitoring 00:02:11 INFO - Starting resource monitoring. 00:02:11 INFO - [mozharness: 2016-12-22 08:02:11.491818Z] Finished create-virtualenv step (success) 00:02:11 INFO - [mozharness: 2016-12-22 08:02:11.492322Z] Running install step. 00:02:11 INFO - Running pre-action listener: _resource_record_pre_action 00:02:11 INFO - Running main action method: install 00:02:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:02:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:02:11 INFO - Reading from file tmpfile_stdout 00:02:11 INFO - Detecting whether we're running mozinstall >=1.0... 00:02:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:02:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:02:11 INFO - Reading from file tmpfile_stdout 00:02:11 INFO - Output received: 00:02:11 INFO - Usage: mozinstall [options] installer 00:02:11 INFO - Options: 00:02:11 INFO - -h, --help show this help message and exit 00:02:11 INFO - -d DEST, --destination=DEST 00:02:11 INFO - Directory to install application into. [default: 00:02:11 INFO - "/builds/slave/test"] 00:02:11 INFO - --app=APP Application being installed. [default: firefox] 00:02:11 INFO - mkdir: /builds/slave/test/build/application 00:02:11 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'] 00:02:11 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 00:02:27 INFO - Reading from file tmpfile_stdout 00:02:27 INFO - Output received: 00:02:27 INFO - /builds/slave/test/build/application/firefox/firefox 00:02:27 INFO - Running post-action listener: _resource_record_post_action 00:02:27 INFO - [mozharness: 2016-12-22 08:02:27.712607Z] Finished install step (success) 00:02:27 INFO - [mozharness: 2016-12-22 08:02:27.712850Z] Running run-tests step. 00:02:27 INFO - Running pre-action listener: _resource_record_pre_action 00:02:27 INFO - Running main action method: run_tests 00:02:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:02:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:02:27 INFO - Python 2.7.3 00:02:27 INFO - Return code: 0 00:02:27 INFO - grabbing minidump binary from tooltool 00:02:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:02:27 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 0x237ef60>, '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 0x237fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23801d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:02:27 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 00:02:27 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 00:02:27 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 00:02:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:02:27 INFO - Return code: 0 00:02:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:02:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:02:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:02:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:02:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:02:27 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M9coC_jMS-W1mvNRh8carg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 00:02:27 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/M9coC_jMS-W1mvNRh8carg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 00:02:27 INFO - Using env: {'DISPLAY': ':0', 00:02:27 INFO - 'HOME': '/home/cltbld', 00:02:27 INFO - 'LANG': 'en_US.UTF-8', 00:02:27 INFO - 'LANGUAGE': 'en_US:en', 00:02:27 INFO - 'LOGNAME': 'cltbld', 00:02:27 INFO - 'MAIL': '/var/mail/cltbld', 00:02:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:02:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:02:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:02:27 INFO - 'MOZ_NO_REMOTE': '1', 00:02:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:02:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:02:27 INFO - 'NO_EM_RESTART': '1', 00:02:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:02:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:02:27 INFO - 'PWD': '/builds/slave/test', 00:02:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:02:27 INFO - 'SHELL': '/bin/bash', 00:02:27 INFO - 'SHLVL': '1', 00:02:27 INFO - 'TERM': 'linux', 00:02:27 INFO - 'TMOUT': '86400', 00:02:27 INFO - 'USER': 'cltbld', 00:02:27 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1482392870.129988-1560250367', 00:02:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:02:27 INFO - '_': '/tools/buildbot/bin/python'} 00:02:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M9coC_jMS-W1mvNRh8carg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 00:02:27 INFO - mozversion application_buildid: 20161221221553 00:02:27 INFO - mozversion application_changeset: 40e863f1e8180487fa1011ed6ac807a30905d617 00:02:27 INFO - mozversion application_display_name: FirefoxDeveloperEdition 00:02:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:02:27 INFO - mozversion application_name: Firefox 00:02:27 INFO - mozversion application_remotingname: firefox-dev 00:02:27 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 00:02:27 INFO - mozversion application_vendor: Mozilla 00:02:27 INFO - mozversion application_version: 52.0a2 00:02:27 INFO - mozversion platform_buildid: 20161221221553 00:02:27 INFO - mozversion platform_changeset: 40e863f1e8180487fa1011ed6ac807a30905d617 00:02:27 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 00:02:27 INFO - mozversion platform_version: 52.0a2 00:02:27 INFO - using testdate: 1482393747 00:02:27 INFO - actual date: 1482393747 00:02:27 INFO - starting webserver on 'localhost:32904' 00:02:27 INFO - SUITE-START | Running 2 tests 00:02:27 INFO - TEST-START | dromaeo_css 00:02:27 INFO - operating with platform_type : linux_ 00:02:27 INFO - Initialising browser for dromaeo_css test... 00:02:27 INFO - TEST-INFO | started process 10550 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzD0KDg/profile http://localhost:32904/getInfo.html) 00:02:32 INFO - PROCESS | 10550 | __metrics Screen width/height:1600/1200 00:02:32 INFO - PROCESS | 10550 | colorDepth:24 00:02:32 INFO - PROCESS | 10550 | Browser inner width/height: 1024/697 00:02:32 INFO - PROCESS | 10550 | __metrics 00:02:32 ERROR - PROCESS | 10550 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 00:02:33 INFO - TEST-INFO | 10550: exit 0 00:02:33 INFO - Browser initialized. 00:02:33 INFO - Running cycle 1/1 for dromaeo_css test... 00:02:33 INFO - TEST-INFO | started process 10681 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzD0KDg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:02:45 INFO - PROCESS | 10681 | RSS: Main: 151523328 00:02:45 INFO - PROCESS | 10681 | 00:03:35 INFO - PROCESS | 10681 | 1482393815087 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] 00:05:45 INFO - PROCESS | 10681 | Cycle 1(1): loaded http://localhost:32904/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32904/tests/dromaeo/cssquery-ext.html) 00:05:47 INFO - PROCESS | 10681 | RSS: Main: 155586560 00:05:47 INFO - PROCESS | 10681 | 00:08:49 INFO - PROCESS | 10681 | Cycle 1(1): loaded http://localhost:32904/tests/dromaeo/cssquery-ext.html (next: http://localhost:32904/tests/dromaeo/cssquery-jquery.html) 00:08:49 INFO - PROCESS | 10681 | RSS: Main: 153280512 00:08:49 INFO - PROCESS | 10681 | 00:11:51 INFO - PROCESS | 10681 | Cycle 1(1): loaded http://localhost:32904/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32904/tests/dromaeo/cssquery-mootools.html) 00:11:52 INFO - PROCESS | 10681 | RSS: Main: 153358336 00:11:52 INFO - PROCESS | 10681 | 00:14:53 INFO - PROCESS | 10681 | Cycle 1(1): loaded http://localhost:32904/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32904/tests/dromaeo/cssquery-prototype.html) 00:14:54 INFO - PROCESS | 10681 | RSS: Main: 151486464 00:14:54 INFO - PROCESS | 10681 | 00:17:57 INFO - PROCESS | 10681 | Cycle 1(1): loaded http://localhost:32904/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32904/tests/dromaeo/cssquery-yui.html) 00:17:57 INFO - PROCESS | 10681 | RSS: Main: 154288128 00:17:57 INFO - PROCESS | 10681 | 00:20:59 INFO - PROCESS | 10681 | Cycle 1(1): loaded http://localhost:32904/tests/dromaeo/cssquery-yui.html (next: http://localhost:32904/tests/dromaeo/cssquery-dojo.html) 00:21:00 INFO - PROCESS | 10681 | RSS: Main: 155148288 00:21:00 INFO - PROCESS | 10681 | 00:21:00 INFO - PROCESS | 10681 | __start_tp_report 00:21:00 INFO - PROCESS | 10681 | _x_x_mozilla_page_load 00:21:00 INFO - PROCESS | 10681 | _x_x_mozilla_page_load_details 00:21:00 INFO - PROCESS | 10681 | |i|pagename|runs| 00:21:00 INFO - PROCESS | 10681 | |0;dojo.html;3272.9018129456117;3312.354090952262;3312.569365982422;3320.9501857472155;3330.5836770403694;5736.426357364261;5753.4821866032;5805.535557155428;5807.303123625171;5815.447532484418;5663.4336566343345;5762.711864406773;5776.39347868474;5776.451237132465;5790.913136302959;5212.4266330703595;5231.712255825928;5234.790608375661;5251.816186433475;5276.868078298035;5286.259923610698;5297.073012222865;5311.336082989626;5325.920111198335;5328.600354973373;5109.080365534202;5144.022635699224;5246.449122842104;5282.709450980195;5290.153575427932;5131.255967884655;5151.716655583923;5178;5197.428282888879;5197.58419326453;5176.50823171798;5179.818706345298;5187.04039752647;5254.238135470374;5309.5752339812725;5557.360903496109;5719.914201286984;5734.283214598176;5802.274715660543;5803.245578074865;6013.909791353133;6094.9390506094815;6100.023996160638;6103.633781973052;6127.172831667757;6117.66352850593;6153.753849846001;6158.599691020069;6160.6611636359985;6176.166217560662;5679.432056794288;5736.4550367715;5738.42615738427;5748.425157484218;5753.935521928456;6233.532485063638;6239.188905442355;6268.216472940882;6354.618722876642;6373.968130159319;6081.483073938676;6081.939180608226;6088.4215999479975;6089.147519347295;6114.2357205349335;5976.133460648181;6192.473639740582;6192.752289908443;6204.7828326008375;6217.751289948442;5915.024021036566;5992.910106348409;5996.072875500228;6035.6076855004285;6111.724972376253;6069.3627169147485;6094.39056094387;6104.4200800923845;6112.969435152796;6114.48026917717;4701.435827700698;4705.788239529229;4707.976460117678;4716.1510928033285;4735.621150307967;4097.569755175723;4113.588641135862;4123.463949686581;4155;4184.5187803403;5628.099504079328;5729.713514324267;5738.856528586819;5756.597038207369;5769.1923130761725;5875.383084776123;5902.321233058167;6103.633781973096;6179.62922224668;6182.072689096582;5694.032014557535;5726.99777538929;5735.713214339266;5789.507891829157;5824.359320474744;5291.206319052173;5295.12630415977;5299.364076310791;5301.496357845998;5302.125149350314;6191.81424557264;6303.590266632654;6351.110844481776;6365.58623689468;6370.267419246753;6106.6336019838955;6143.235544005126;6186.969065154825;6193.318734939243;6217.129601855653;6283.214598175228;6326.746930122928;6350.396712312323;6352.269489008823;6353.809385718436;6010.278766548042;6048.667323297085;6049.697515124139;6095.817125486243;6131.877362452637;5995.2206213192;6029.065494848305;6160;6173.722182501709;6205.5345849062405;6117.096718007379;6121.348852995844;6133.334663918993;6149.508039356931;6155.969220153871;6090.360512146338;6130.386961303834;6132;6139.140520327069;6162.784302549389;5921.052631578927;5944.197533332945;5969.492593129633;5969.611975221596;6005.159277701038;6032.6983650818165;6065.939340606714;6122.846928826815;6122.977604208298;6126.1423400724825;5973.402659733992;5985.581009329305;5987.101934709828;5998.70006499682;6002.369751176064 00:21:00 INFO - PROCESS | 10681 | |1;ext.html;629.6379581740499;654.2508827392636;661.1240106858414;669.7254125808416;721.6752461392375;40607.593924060784;44272.55727442724;44274.55725442745;44299.33550996738;44350.778246108806;44331.55668443315;44901.550984490146;45006.32490512637;45109.7744511277;45169.548304516946;8613.870791938141;8655.437396569203;8702.47785132894;8751.12488751123;8757.562121893912;8662.263707584863;8742.4754514729;8765.605547750334;8768.035516093225;8771.298296136294;8776;8793.824123517526;8797.648094076229;8815.867761983576;8835.602397892078;8703.651853925867;8723.345749068845;8759.167879051543;8806.075362086985;8815.250703690193;8649.1350864913;8668.479891206485;8677.609507572111;8704.56477176145;8731.563421828947;41941.370879436836;42290.577094228975;42298.30806767726;42342.78828605837;42469;3766.227923275722;3773.4528493368307;3777.395616701315;3832.156925476391;3903.5315762108444;32081.839590801897;32802;33071;33174;33259.6674033259;4479.798409071567;4480.5743454372105;4481.798319075617;4506.233940230136;4521.457425109008;348561;351885;352200;352632;352636;59987;60194.097088543705;60312.396876031555;60371.69814150989;60402;62668;62836.68581657062;63051;63113.684431577545;63221;17433.651326973642;17585.56036099082;17665.823341766674;17735.73396399055;17807.287708491516;13747.931260343634;13817.101888377223;13851.030427869953;13918.652033699238;13926.094803837717;16727;16764.916175419046;16901.154942252837;16946;16950.321987120624;5888.882222355529;5922.555808314393;5979.880402391927;6019.969900150471;6094.908576371358;1037.5901518899993;1106.95018724156;1110.5169251375678;1134.6993046842592;1170.8477897873222;32406.83796581002;33321.43034270713;33387;33603;33647.83176084153;1101.6860194844592;1114.039290848113;1117.8323251512174;1132.7451323452322;1189.916705830601;15728;16912.492625221264;17355.47933561995;18122.184501697455;18283.63432731338;494697;496292;498212;499333;499801;59474.10788838171;59814.10278845821;59825.401745982854;59864;59949.400505995254;1340.9530666426629;1348.919064856092;1405.1639274631577;1415.9150450972975;1419.7941298511657;31746.365072698878;32165.839170803996;32466.513002305455;34381.82809085939;36025.63974360328;56621.71689141528;57098.714506427204;57353.713231433576;57415.42584574268;57683.4231657678;442742;449991;453666;454770;455543;28518.42963140767;29664.406711866075;29839.552406714352;30069.54895676523;30157.69842301549;48766.5123348762;49314;49369.753151234014;49630.503694964034;49749.25376119433;41355.1728965413;42174.36738448864;42226.577734222265;42325.36511952385;43135.35296970611;40823;41016.79491602523;41424.37863431991;41850.37224441697;42356;39210.803945980086;39221.41167882427;39459;39848.402273966494;43988.34017489676;31865.522017169296;33790;34044.31911361709;34123;34260.14349641279;29358.559621605265;29393.853030735565;29646.407071858874;29675.258118546346;29828.403431931674 00:21:00 INFO - PROCESS | 10681 | |2;jquery.html;428.4943766355699;431.115648011417;433.6249144490016;441.3886766827944;442.81623126402525;19246.615067698636;19728.70406943897;20143.697844532326;20894.373168804923;21093.15627374903;16833.494995150133;19546.902265488654;19654.21383144676;19724.309649162282;20226.494337641565;5686.0617998030275;5947.732352044147;5949.732262048218;5969.4925931295675;5976.342602313764;5685.687287199203;5797;5846.386129456409;5903.586748927577;5961.076033214837;5793.768249270024;5803.796867109652;5809.3900140485275;5819.82540523785;5827.067669172912;5644.350899646532;5784.913226301609;5883.588148829563;5898.941010589882;5908.379620139866;5348.973255133699;5362.356517217959;5366.114591092504;5369.48989845964;5372.516473517363;21927.561448770935;22814.65778013331;23048.308550743506;23080.88459557708;23090.53818923629;2468.543319485901;2470.1601455505215;2728.7816974641983;2774.597683335905;3120.828354440505;14730.926345368205;14948.40206391743;15151.621209469851;15287.312070956834;15369.923150384177;1967.3704414587337;2007.247282269149;2033.4814622271374;2038.5922815436973;2074.512489564951;84751.57624211839;85773;87607.56196219042;88078;88288.55855720745;11210;11505.597304094317;11553.36456494884;12041.939790301167;12053.276803391824;16331.26509307084;16353.672926541403;16383.754243686355;16417.1791410429;16477.176141192893;8626.870596941051;8698.608222684341;8755.693550725695;8855.822883542292;8954.149355811187;8294.253517183482;8327.250547450638;8509.361797865186;8581.098984606651;8586.65653373858;7030.660436292822;7148.891077132258;7186.784396468114;7230.2046774854725;7244.26072630049;1900.7148927660962;1911.120884393167;1929.2765213045109;1937.2541571495076;1954.784973652897;995.2883688162998;1095.446799366315;1129.943502824872;1132.7281452451516;1181.0728578066348;20558.794412055988;20716.792832071485;20829.89585052065;20936.581268374546;21195.47011324729;1027.445179603021;1038.6676263595577;1078.789636020984;1136.2841409911703;1140.2588317593465;11460.770784584261;11584.304941703525;11684.47419866108;11748.177627565989;11870.109741769229;477012;482082;485336;487961;490107;79680.60159699165;81429.07075448097;86357.5682121598;89507.55246223857;91271.54364228137;1030.7165529479303;1066.317556763672;1066.5360568152878;1077.49357801833;1078.2021304234809;17983.820161798216;18199.999000055122;18418.723719143956;18548.814511854707;18812.435626930666;30560.541591876583;32977.175570610925;43508.564914351715;43823;44588.55411445844;57399.426005739406;62354;62699.37300626935;64028;64141.35858641354;8567.657293708182;8870.689525866565;8971.461712297283;9008.504532250789;9131;10127.949360253151;13178.934105329412;13360.93319533396;13645.044846860625;13956.232407217294;11830.171887968105;11985.700357491132;12219;12348.135630505778;12395.132340736061;11757.941210293893;12106.455209515769;12157.69605759863;12198.75602487963;12335.629931102081;11955.64133076009;11963.700907477383;12025.398730063287;12206.816897746363;12453;8775;9055.36612437123;9097.1812536872;9126.13301736334;9312.953435233052;11782.234154779911;11787.11596630239;12169.939150304192;12177.756444871231;12322.137450378388 00:21:00 INFO - PROCESS | 10681 | |3;mootools.html;1504.3681653705446;1528.5261568913638;1713.7772089628347;1790.561312478443;1832.9633407331853;7688.461807673465;7829.060512738465;8640.39517233793;9212.401193922398;9214.078592140791;8632.697855575056;8865.379423440345;8881.378303518757;9121.908780912188;9122.543872806365;2525.785308248801;2570.4216551276;2570.652961850145;2571.100114959768;2573.4209802794408;2512.773850353468;2514.8365356251875;2549.146036077916;2553.731858154895;2555.910543130991;2498.3129639349236;2503.5243303772318;2504.273760609421;2523.14213167523;2530.139752484155;2480.677511923456;2487.1916627096266;2513.170653684289;2519.8362106463023;2520.206135067466;2455.091616102036;2476.529459402726;2484.962725559118;2492.8255022148455;2497.475530138673;9041.23149532284;9079.319051071196;9088.09119088086;9099.590518426687;9153.862692059625;5435.1847222916485;5596.720163991825;5628.127640215773;5628.915566266509;5642.379338272786;3509.298140371936;3565.714742820568;3726.6832319252894;3764.9435258471144;3770.1328694400167;1132.8583927009124;1170.7365842685413;1180.2328486483768;1181.8345431639577;1193.9522419103225;12691.04817138709;12720.87279127206;12723.745525089538;12751.426185821567;12779.61661150167;4966.801327946914;5065.873353166126;5154.974225128851;5189.896202075937;5231.895362092737;10532.631357902437;10547.419891906018;10617.575296988034;10620.09729173029;10646.680599582025;5594.24477695514;5619.887602247933;5652.18043383707;5652.349979752299;5663.461971112738;5067.670601410897;5082.33929589151;5141.820036298712;5228.477152284817;5286.233496143038;4021.8523892529893;4084.6323830855367;4088.448059511987;4131.215069136854;4153.1070819773895;1308.1366298243113;1309.8297221361163;1313.2251971336957;1317.6508225320106;1322.8875545578542;936.8782058332373;990.8166989107038;1016.8881423043459;1040.1834559870617;1046.4035499765062;6003.069524223665;6101.511879049665;6104.816855494342;6178.258608966953;6213.192285003011;496.8335607571504;497.99004019919397;505.171518709317;511.45785467403925;536.5224949794685;4243.469566304212;4317.8272869084885;4337.240982828055;4360.585744354281;4408.625266852354;10996.670099897015;11265;11325.2072354936;11363.488643011084;11412;10851.294665846852;11129.777404452028;11224.775504490028;11307.378094204898;11345.829812552818;8419.915800841913;8497.532635705096;8556.529390883561;8574.914250857411;8681.435706679045;6176.722047507963;6247.468965138014;6265.749370025148;6308.905366419599;6401.839954001187;10301.227407944285;10316.690499285034;10389.688309350731;10422.322549034288;10431.165506759593;9400.29497787655;10025.649102281384;10310.07209351132;10394.324368915995;10529.42088185157;7517.361024312776;7649.349805266392;7725.188855170351;7753.728619498291;7789.883151752615;8674.566271686517;8741.34439916996;8784.121587841164;8799.12008799115;8800.38397312182;7853.253940875607;7964.20357964199;8130.390220733587;8175.67297308101;8284.544350060805;7767.883481747665;7889.4082943780595;7925.801854953672;7985.161558036322;8013.879791803011;7205.135383753774;7280;7351;7402.00072990161;7412.555246685216;5506.174073888948;5620.381758006534;5676.716164191691;5693.4591213836275;5729.2265544151005;5434.456554344534;5467.097928841856;5488.341399032141;5523.475269849358;5546.805861794818 00:21:00 INFO - PROCESS | 10681 | |4;prototype.html;363.42941581716707;366.86976123476165;367.9282539904718;369.19331261194276;370.8164458592997;5682.232898558698;5690.886182276357;5711.628744131639;5716.428357164282;5722.628029178106;5420.5934554908445;5560;5578.470045345696;5578.944210557893;5605.113366616196;4374.803133858984;4441.401095605579;4446.644268458532;4448.777561121931;4454.576815202567;4428.073787902256;4438.844640437585;4452.510223875371;4458.97770511147;4473.94862207381;4422.491413487442;4431.601155895969;4434.822607095713;4446.622037126848;4451.643868490529;4296.656267498593;4398.802053907598;4436.755978421185;4466.330050492452;4480.6191473724775;4000.919751667063;4016.49793775778;4020.1356708307853;4028.8589899353674;4030.979845100756;5509.47659972302;5537.224788529569;5538.9169162462595;5563.193336966157;5577.386487486373;5091.898162036776;5157.922631160535;5163.122269214243;5178.352705911761;5178.663386879841;5977.133315669247;5988.97005514974;6006.399360064002;6019.548533859978;6041.667708276043;4335.219660461115;4410.823567057314;4415.757133357664;4445.844395446176;4450.688451808374;5926;6119.602225855305;6205.441510264052;6216.844578885519;6223.688815559204;4404.889877753082;4423.623991960655;4429.313456414261;4437.667174961891;4444.666650001198;4477.552244775497;4483.260262056724;4502.774861256924;4512.187806194851;4512.638988880882;4909.410870695468;5050.419201791841;5078.847634570969;5078.898422031539;5085.516875896784;5886.470217680429;5891.204687367236;5935.970320148372;5951.583389162717;5981.162637230791;1474.9822622390516;1489.4340150742864;1504.5335945856818;1506.2167672810297;1506.811648543932;1003.8795344558554;1041.2242879055152;1043.9060484556426;1055.1611468882256;1064.956342784076;5471.7264136793;5480.725963701799;5498.835034948958;5621.397901598025;5632.464915832989;5916;5960.761569537257;5963.493103086286;6014.669193194329;6031.285921335417;5294.97352513235;5441.80280338325;5469.234307196995;5494.313210848644;5571.972140139354;3126.7811253212512;3137.654857965622;3140.874365025373;3141.434541782455;3154.3848949454637;5835.2122463466885;6033.771932016351;6048.002079656807;6049.848753781191;6072.2390506752545;5908.3205431375945;5931.466168044811;5932.940670593325;5943.613665111754;5956.970215148983;5810.750688601971;5871.706414679249;5922.7927022554;5951.553633477506;5997;5823.126531020381;5868.853278668067;6110.358412366638;6183.907241391293;6217.658028808459;6056;6111.633302001894;6113.938860611337;6124.560728228774;6128.908066379097;6022.247219097613;6265.749370025148;6267.2479302484;6272.560920735687;6301.842453938505;4387.276099443556;4402.427684401136;4413.7351758894565;4417.293233082692;4434.51220365753;5859.472647461749;6077.574569780073;6158.568900176944;6162.291336496181;6162.722677479614;5959.702014899324;5977.820665380045;5991.490723288569;5995.970020149872;6023.759049637965;5967.46292833647;5978.701064946648;5982.312034116132;5990.281166260077;6026.655206360512;5807.535397168301;5914.58597898143;5937.287525496968;5953.880922381441;5975.312839023394;5988.221531200916;6000.339962604023;6022;6024.156618073561;6060.848438796615;5685.886282274414;5818.796342128006;5869.765209391577;5885.617434866891;5918.3489816121055 00:21:00 INFO - PROCESS | 10681 | |5;yui.html;795.6101510259971;806.0770417871537;844.5734903873542;857.7726902370872;862.9773718143998;15030.248487575618;16050.27773750181;16092.83907160928;16105.83894161061;16137.596560085989;14489.420423183086;14730.410783568672;14759.92620036901;14777.852221477782;14786.556403307917;825.3933358981159;835.2274146414572;835.8119423129808;840.277361469136;843.0599881132555;840.0381563110235;841.1714461255658;841.9536925469097;842.2041171093289;842.2840585502336;890.1721399098835;891.7146513115806;892.6429428228728;894.1773568317132;898.0435835834847;888.2671795768484;891.3715830339595;894.6242578117207;896.4442045931564;897.9865302020474;656.7832615236961;657.4346062386344;658.6212927566669;659.3900641906265;661.0711949710665;13595.660108497268;13599.524016659469;13635.931820340835;13663.726725465434;13692.315384230847;12858.807117893239;13003.674908127277;13212.801807972888;13385.464581416732;13423.194608323434;11398.715032124263;11481.48333324994;11522.539098436053;11551.249168804;11580.536778528849;3777.4851549106866;3828.1960788234505;3840.462335273064;3849.2493963677093;3883.1457079442475;59427.78489818913;60912.390876091114;64620;64700;65404.67297663529;9988.500574971222;10042.096211341015;10061.949690251648;10062.949685251528;10411.947940260401;16722.665546688997;16749.33002679879;16991.40530081441;18343.81656183448;19636.41090767279;8200.42597018203;8395.580220989048;8462.449940753831;8536.8719469208;8700.869486957701;4815.951840481621;4912.778924948386;4920.901581968412;4984.22744474607;5087.465816089331;3357.2446199605383;3384.9323013539592;3407.4377727674655;3441.346144232588;3456.2223499712363;642.9003504456816;645.8320836582523;650.4016304999412;667.9833004174934;669.2404121322335;586.4458087107643;623.3486007122568;688.6109348218241;729.2233771033938;734.086062851753;9424.62301507932;9491.430514169171;9509.191718703849;9793.21654267657;9916.305858589974;582.2692520886261;626.8025571944822;695.3741632530763;712.1276436365514;724.3263764698776;4517.751523666164;4699.506551812011;4705.6470764692785;4709.411323584552;4745.6440766942615;87538.56230718934;88464;89625.55187224153;91603;93424.53287733518;65789.67105164443;66687.3331266681;67175.66412167907;77892.22107778963;81743;45456.772716136205;46556.7672161637;54070;62088.68955655193;68841.65579172072;9759.47944160805;9964.900350996397;10270.743231419274;10561.841572376266;10779.407132607468;46038.539614603425;47977;48568.5143148564;48772.26841597308;49202;63963.36036639574;66132.66933665301;66815;66827;67001.66499167473;13089;13114.60656180316;13235.27206003679;13274;13373.06388552792;14175.645608859448;14913.776293355391;14961;15207.391704331703;15318.617034574225;13883.930580347034;14298;14383.280835958369;14406.639834003814;14734.263286835401;11912.40437978115;12092.455839487067;12476.376181191086;12703.110782245523;13268.867311326763;12263.26420414778;13541.796873046715;13981;13985.300734963415;14684.706305874037;10875.728106797393;11125.054370378608;11167.72080697989;11398.658040258806;11767.529298828293;10187.796244074929;10838.543692224559;10866.402347870942;10989.285696429706;11169.553217871195 00:21:00 INFO - PROCESS | 10681 | __end_tp_report 00:21:00 INFO - PROCESS | 10681 | __start_cc_report 00:21:00 INFO - PROCESS | 10681 | _x_x_mozilla_cycle_collect,310 00:21:00 INFO - PROCESS | 10681 | __end_cc_report 00:21:00 INFO - PROCESS | 10681 | __startTimestamp1482394860120__endTimestamp 00:21:00 INFO - PROCESS | 10681 | 00:21:00 INFO - PROCESS | 10681 | ------- Summary: start ------- 00:21:00 INFO - PROCESS | 10681 | Number of tests: 6 00:21:00 INFO - PROCESS | 10681 | 00:21:00 INFO - PROCESS | 10681 | [#0] dojo.html Cycles:165 Average:5707.20 Median:5973.40 stddev:651.86 (10.9%) stddev-sans-first:625.26 00:21:00 INFO - PROCESS | 10681 | Values: 3272.9 3312.4 3312.6 3321.0 3330.6 5736.4 5753.5 5805.5 5807.3 5815.4 5663.4 5762.7 5776.4 5776.5 5790.9 5212.4 5231.7 5234.8 5251.8 5276.9 5286.3 5297.1 5311.3 5325.9 5328.6 5109.1 5144.0 5246.4 5282.7 5290.2 5131.3 5151.7 5178.0 5197.4 5197.6 5176.5 5179.8 5187.0 5254.2 5309.6 5557.4 5719.9 5734.3 5802.3 5803.2 6013.9 6094.9 6100.0 6103.6 6127.2 6117.7 6153.8 6158.6 6160.7 6176.2 5679.4 5736.5 5738.4 5748.4 5753.9 6233.5 6239.2 6268.2 6354.6 6374.0 6081.5 6081.9 6088.4 6089.1 6114.2 5976.1 6192.5 6192.8 6204.8 6217.8 5915.0 5992.9 5996.1 6035.6 6111.7 6069.4 6094.4 6104.4 6113.0 6114.5 4701.4 4705.8 4708.0 4716.2 4735.6 4097.6 4113.6 4123.5 4155.0 4184.5 5628.1 5729.7 5738.9 5756.6 5769.2 5875.4 5902.3 6103.6 6179.6 6182.1 5694.0 5727.0 5735.7 5789.5 5824.4 5291.2 5295.1 5299.4 5301.5 5302.1 6191.8 6303.6 6351.1 6365.6 6370.3 6106.6 6143.2 6187.0 6193.3 6217.1 6283.2 6326.7 6350.4 6352.3 6353.8 6010.3 6048.7 6049.7 6095.8 6131.9 5995.2 6029.1 6160.0 6173.7 6205.5 6117.1 6121.3 6133.3 6149.5 6156.0 6090.4 6130.4 6132.0 6139.1 6162.8 5921.1 5944.2 5969.5 5969.6 6005.2 6032.7 6065.9 6122.8 6123.0 6126.1 5973.4 5985.6 5987.1 5998.7 6002.4 00:21:00 INFO - PROCESS | 10681 | 00:21:00 INFO - PROCESS | 10681 | [#1] ext.html Cycles:180 Average:60146.92 Median:42334.08 stddev:115821.54 (273.6%) stddev-sans-first:116060.25 00:21:00 INFO - PROCESS | 10681 | Values: 629.6 654.3 661.1 669.7 721.7 40607.6 44272.6 44274.6 44299.3 44350.8 44331.6 44901.6 45006.3 45109.8 45169.5 8613.9 8655.4 8702.5 8751.1 8757.6 8662.3 8742.5 8765.6 8768.0 8771.3 8776.0 8793.8 8797.6 8815.9 8835.6 8703.7 8723.3 8759.2 8806.1 8815.3 8649.1 8668.5 8677.6 8704.6 8731.6 41941.4 42290.6 42298.3 42342.8 42469.0 3766.2 3773.5 3777.4 3832.2 3903.5 32081.8 32802.0 33071.0 33174.0 33259.7 4479.8 4480.6 4481.8 4506.2 4521.5 348561.0 351885.0 352200.0 352632.0 352636.0 59987.0 60194.1 60312.4 60371.7 60402.0 62668.0 62836.7 63051.0 63113.7 63221.0 17433.7 17585.6 17665.8 17735.7 17807.3 13747.9 13817.1 13851.0 13918.7 13926.1 16727.0 16764.9 16901.2 16946.0 16950.3 5888.9 5922.6 5979.9 6020.0 6094.9 1037.6 1107.0 1110.5 1134.7 1170.8 32406.8 33321.4 33387.0 33603.0 33647.8 1101.7 1114.0 1117.8 1132.7 1189.9 15728.0 16912.5 17355.5 18122.2 18283.6 494697.0 496292.0 498212.0 499333.0 499801.0 59474.1 59814.1 59825.4 59864.0 59949.4 1341.0 1348.9 1405.2 1415.9 1419.8 31746.4 32165.8 32466.5 34381.8 36025.6 56621.7 57098.7 57353.7 57415.4 57683.4 442742.0 449991.0 453666.0 454770.0 455543.0 28518.4 29664.4 29839.6 30069.5 30157.7 48766.5 49314.0 49369.8 49630.5 49749.3 41355.2 42174.4 42226.6 42325.4 43135.4 40823.0 41016.8 41424.4 41850.4 42356.0 39210.8 39221.4 39459.0 39848.4 43988.3 31865.5 33790.0 34044.3 34123.0 34260.1 29358.6 29393.9 29646.4 29675.3 29828.4 00:21:00 INFO - PROCESS | 10681 | 00:21:00 INFO - PROCESS | 10681 | [#2] jquery.html Cycles:180 Average:29370.12 Median:22931.48 stddev:79837.17 (348.2%) stddev-sans-first:80031.56 00:21:00 INFO - PROCESS | 10681 | Values: 428.5 431.1 433.6 441.4 442.8 19246.6 19728.7 20143.7 20894.4 21093.2 16833.5 19546.9 19654.2 19724.3 20226.5 5686.1 5947.7 5949.7 5969.5 5976.3 5685.7 5797.0 5846.4 5903.6 5961.1 5793.8 5803.8 5809.4 5819.8 5827.1 5644.4 5784.9 5883.6 5898.9 5908.4 5349.0 5362.4 5366.1 5369.5 5372.5 21927.6 22814.7 23048.3 23080.9 23090.5 2468.5 2470.2 2728.8 2774.6 3120.8 14730.9 14948.4 15151.6 15287.3 15369.9 1967.4 2007.2 2033.5 2038.6 2074.5 84751.6 85773.0 87607.6 88078.0 88288.6 11210.0 11505.6 11553.4 12041.9 12053.3 16331.3 16353.7 16383.8 16417.2 16477.2 8626.9 8698.6 8755.7 8855.8 8954.1 8294.3 8327.3 8509.4 8581.1 8586.7 7030.7 7148.9 7186.8 7230.2 7244.3 1900.7 1911.1 1929.3 1937.3 1954.8 995.3 1095.4 1129.9 1132.7 1181.1 20558.8 20716.8 20829.9 20936.6 21195.5 1027.4 1038.7 1078.8 1136.3 1140.3 11460.8 11584.3 11684.5 11748.2 11870.1 477012.0 482082.0 485336.0 487961.0 490107.0 79680.6 81429.1 86357.6 89507.6 91271.5 1030.7 1066.3 1066.5 1077.5 1078.2 17983.8 18200.0 18418.7 18548.8 18812.4 30560.5 32977.2 43508.6 43823.0 44588.6 57399.4 62354.0 62699.4 64028.0 64141.4 8567.7 8870.7 8971.5 9008.5 9131.0 10127.9 13178.9 13360.9 13645.0 13956.2 11830.2 11985.7 12219.0 12348.1 12395.1 11757.9 12106.5 12157.7 12198.8 12335.6 11955.6 11963.7 12025.4 12206.8 12453.0 8775.0 9055.4 9097.2 9126.1 9313.0 11782.2 11787.1 12169.9 12177.8 12322.1 00:21:00 INFO - PROCESS | 10681 | 00:21:00 INFO - PROCESS | 10681 | [#3] mootools.html Cycles:180 Average:6015.09 Median:2785.52 stddev:3354.68 (120.4%) stddev-sans-first:3346.97 00:21:00 INFO - PROCESS | 10681 | Values: 1504.4 1528.5 1713.8 1790.6 1833.0 7688.5 7829.1 8640.4 9212.4 9214.1 8632.7 8865.4 8881.4 9121.9 9122.5 2525.8 2570.4 2570.7 2571.1 2573.4 2512.8 2514.8 2549.1 2553.7 2555.9 2498.3 2503.5 2504.3 2523.1 2530.1 2480.7 2487.2 2513.2 2519.8 2520.2 2455.1 2476.5 2485.0 2492.8 2497.5 9041.2 9079.3 9088.1 9099.6 9153.9 5435.2 5596.7 5628.1 5628.9 5642.4 3509.3 3565.7 3726.7 3764.9 3770.1 1132.9 1170.7 1180.2 1181.8 1194.0 12691.0 12720.9 12723.7 12751.4 12779.6 4966.8 5065.9 5155.0 5189.9 5231.9 10532.6 10547.4 10617.6 10620.1 10646.7 5594.2 5619.9 5652.2 5652.3 5663.5 5067.7 5082.3 5141.8 5228.5 5286.2 4021.9 4084.6 4088.4 4131.2 4153.1 1308.1 1309.8 1313.2 1317.7 1322.9 936.9 990.8 1016.9 1040.2 1046.4 6003.1 6101.5 6104.8 6178.3 6213.2 496.8 498.0 505.2 511.5 536.5 4243.5 4317.8 4337.2 4360.6 4408.6 10996.7 11265.0 11325.2 11363.5 11412.0 10851.3 11129.8 11224.8 11307.4 11345.8 8419.9 8497.5 8556.5 8574.9 8681.4 6176.7 6247.5 6265.7 6308.9 6401.8 10301.2 10316.7 10389.7 10422.3 10431.2 9400.3 10025.6 10310.1 10394.3 10529.4 7517.4 7649.3 7725.2 7753.7 7789.9 8674.6 8741.3 8784.1 8799.1 8800.4 7853.3 7964.2 8130.4 8175.7 8284.5 7767.9 7889.4 7925.8 7985.2 8013.9 7205.1 7280.0 7351.0 7402.0 7412.6 5506.2 5620.4 5676.7 5693.5 5729.2 5434.5 5467.1 5488.3 5523.5 5546.8 00:21:00 INFO - PROCESS | 10681 | 00:21:00 INFO - PROCESS | 10681 | [#4] prototype.html Cycles:180 Average:4990.38 Median:5578.71 stddev:1442.43 (25.9%) stddev-sans-first:1404.04 00:21:00 INFO - PROCESS | 10681 | Values: 363.4 366.9 367.9 369.2 370.8 5682.2 5690.9 5711.6 5716.4 5722.6 5420.6 5560.0 5578.5 5578.9 5605.1 4374.8 4441.4 4446.6 4448.8 4454.6 4428.1 4438.8 4452.5 4459.0 4473.9 4422.5 4431.6 4434.8 4446.6 4451.6 4296.7 4398.8 4436.8 4466.3 4480.6 4000.9 4016.5 4020.1 4028.9 4031.0 5509.5 5537.2 5538.9 5563.2 5577.4 5091.9 5157.9 5163.1 5178.4 5178.7 5977.1 5989.0 6006.4 6019.5 6041.7 4335.2 4410.8 4415.8 4445.8 4450.7 5926.0 6119.6 6205.4 6216.8 6223.7 4404.9 4423.6 4429.3 4437.7 4444.7 4477.6 4483.3 4502.8 4512.2 4512.6 4909.4 5050.4 5078.8 5078.9 5085.5 5886.5 5891.2 5936.0 5951.6 5981.2 1475.0 1489.4 1504.5 1506.2 1506.8 1003.9 1041.2 1043.9 1055.2 1065.0 5471.7 5480.7 5498.8 5621.4 5632.5 5916.0 5960.8 5963.5 6014.7 6031.3 5295.0 5441.8 5469.2 5494.3 5572.0 3126.8 3137.7 3140.9 3141.4 3154.4 5835.2 6033.8 6048.0 6049.8 6072.2 5908.3 5931.5 5932.9 5943.6 5957.0 5810.8 5871.7 5922.8 5951.6 5997.0 5823.1 5868.9 6110.4 6183.9 6217.7 6056.0 6111.6 6113.9 6124.6 6128.9 6022.2 6265.7 6267.2 6272.6 6301.8 4387.3 4402.4 4413.7 4417.3 4434.5 5859.5 6077.6 6158.6 6162.3 6162.7 5959.7 5977.8 5991.5 5996.0 6023.8 5967.5 5978.7 5982.3 5990.3 6026.7 5807.5 5914.6 5937.3 5953.9 5975.3 5988.2 6000.3 6022.0 6024.2 6060.8 5685.9 5818.8 5869.8 5885.6 5918.3 00:21:00 INFO - PROCESS | 10681 | 00:21:00 INFO - PROCESS | 10681 | [#5] yui.html Cycles:180 Average:17618.98 Median:26396.48 stddev:22974.61 (87.0%) stddev-sans-first:23004.33 00:21:00 INFO - PROCESS | 10681 | Values: 795.6 806.1 844.6 857.8 863.0 15030.2 16050.3 16092.8 16105.8 16137.6 14489.4 14730.4 14759.9 14777.9 14786.6 825.4 835.2 835.8 840.3 843.1 840.0 841.2 842.0 842.2 842.3 890.2 891.7 892.6 894.2 898.0 888.3 891.4 894.6 896.4 898.0 656.8 657.4 658.6 659.4 661.1 13595.7 13599.5 13635.9 13663.7 13692.3 12858.8 13003.7 13212.8 13385.5 13423.2 11398.7 11481.5 11522.5 11551.2 11580.5 3777.5 3828.2 3840.5 3849.2 3883.1 59427.8 60912.4 64620.0 64700.0 65404.7 9988.5 10042.1 10061.9 10062.9 10411.9 16722.7 16749.3 16991.4 18343.8 19636.4 8200.4 8395.6 8462.4 8536.9 8700.9 4816.0 4912.8 4920.9 4984.2 5087.5 3357.2 3384.9 3407.4 3441.3 3456.2 642.9 645.8 650.4 668.0 669.2 586.4 623.3 688.6 729.2 734.1 9424.6 9491.4 9509.2 9793.2 9916.3 582.3 626.8 695.4 712.1 724.3 4517.8 4699.5 4705.6 4709.4 4745.6 87538.6 88464.0 89625.6 91603.0 93424.5 65789.7 66687.3 67175.7 77892.2 81743.0 45456.8 46556.8 54070.0 62088.7 68841.7 9759.5 9964.9 10270.7 10561.8 10779.4 46038.5 47977.0 48568.5 48772.3 49202.0 63963.4 66132.7 66815.0 66827.0 67001.7 13089.0 13114.6 13235.3 13274.0 13373.1 14175.6 14913.8 14961.0 15207.4 15318.6 13883.9 14298.0 14383.3 14406.6 14734.3 11912.4 12092.5 12476.4 12703.1 13268.9 12263.3 13541.8 13981.0 13985.3 14684.7 10875.7 11125.1 11167.7 11398.7 11767.5 10187.8 10838.5 10866.4 10989.3 11169.6 00:21:00 INFO - PROCESS | 10681 | -------- Summary: end -------- 00:21:00 INFO - PROCESS | 10681 | 00:21:00 INFO - TEST-INFO | 10681: exit 0 00:21:00 INFO - TEST-OK | dromaeo_css | took 1112870ms 00:21:00 INFO - TEST-START | kraken 00:21:00 INFO - operating with platform_type : linux_ 00:21:00 INFO - Initialising browser for kraken test... 00:21:00 INFO - TEST-INFO | started process 11057 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5EOiod/profile http://localhost:32904/getInfo.html) 00:21:05 INFO - PROCESS | 11057 | __metrics Screen width/height:1600/1200 00:21:05 INFO - PROCESS | 11057 | colorDepth:24 00:21:05 INFO - PROCESS | 11057 | Browser inner width/height: 1024/697 00:21:05 INFO - PROCESS | 11057 | __metrics 00:21:05 ERROR - PROCESS | 11057 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 00:21:06 INFO - TEST-INFO | 11057: exit 0 00:21:06 INFO - Browser initialized. 00:21:06 INFO - Running cycle 1/1 for kraken test... 00:21:06 INFO - TEST-INFO | started process 11188 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5EOiod/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:21:18 INFO - PROCESS | 11188 | RSS: Main: 151212032 00:21:18 INFO - PROCESS | 11188 | 00:21:21 INFO - PROCESS | 11188 | Cycle 1(1): loaded http://localhost:32904/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32904/tests/kraken/driver.html?testName=audio-beat-detection) 00:21:21 INFO - PROCESS | 11188 | RSS: Main: 157143040 00:21:21 INFO - PROCESS | 11188 | 00:21:24 INFO - PROCESS | 11188 | Cycle 1(1): loaded http://localhost:32904/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32904/tests/kraken/driver.html?testName=audio-dft) 00:21:25 INFO - PROCESS | 11188 | RSS: Main: 154943488 00:21:25 INFO - PROCESS | 11188 | 00:21:28 INFO - PROCESS | 11188 | Cycle 1(1): loaded http://localhost:32904/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32904/tests/kraken/driver.html?testName=audio-fft) 00:21:28 INFO - PROCESS | 11188 | RSS: Main: 155566080 00:21:28 INFO - PROCESS | 11188 | 00:21:30 INFO - PROCESS | 11188 | Cycle 1(1): loaded http://localhost:32904/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32904/tests/kraken/driver.html?testName=audio-oscillator) 00:21:31 INFO - PROCESS | 11188 | RSS: Main: 155156480 00:21:31 INFO - PROCESS | 11188 | 00:21:33 INFO - PROCESS | 11188 | Cycle 1(1): loaded http://localhost:32904/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32904/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:21:34 INFO - PROCESS | 11188 | RSS: Main: 155230208 00:21:34 INFO - PROCESS | 11188 | 00:21:37 INFO - PROCESS | 11188 | Cycle 1(1): loaded http://localhost:32904/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32904/tests/kraken/driver.html?testName=imaging-darkroom) 00:21:37 INFO - PROCESS | 11188 | RSS: Main: 158429184 00:21:37 INFO - PROCESS | 11188 | 00:21:41 INFO - PROCESS | 11188 | Cycle 1(1): loaded http://localhost:32904/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32904/tests/kraken/driver.html?testName=imaging-desaturate) 00:21:41 INFO - PROCESS | 11188 | RSS: Main: 158429184 00:21:41 INFO - PROCESS | 11188 | 00:21:44 INFO - PROCESS | 11188 | Cycle 1(1): loaded http://localhost:32904/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32904/tests/kraken/driver.html?testName=json-parse-financial) 00:21:44 INFO - PROCESS | 11188 | RSS: Main: 157827072 00:21:44 INFO - PROCESS | 11188 | 00:21:46 INFO - PROCESS | 11188 | Cycle 1(1): loaded http://localhost:32904/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32904/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:21:47 INFO - PROCESS | 11188 | RSS: Main: 157392896 00:21:47 INFO - PROCESS | 11188 | 00:21:48 INFO - PROCESS | 11188 | Cycle 1(1): loaded http://localhost:32904/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32904/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:21:49 INFO - PROCESS | 11188 | RSS: Main: 156958720 00:21:49 INFO - PROCESS | 11188 | 00:21:51 INFO - PROCESS | 11188 | Cycle 1(1): loaded http://localhost:32904/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32904/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:21:52 INFO - PROCESS | 11188 | RSS: Main: 157331456 00:21:52 INFO - PROCESS | 11188 | 00:21:54 INFO - PROCESS | 11188 | Cycle 1(1): loaded http://localhost:32904/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32904/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:21:55 INFO - PROCESS | 11188 | RSS: Main: 157470720 00:21:55 INFO - PROCESS | 11188 | 00:21:58 INFO - PROCESS | 11188 | Cycle 1(1): loaded http://localhost:32904/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32904/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:21:58 INFO - PROCESS | 11188 | RSS: Main: 157466624 00:21:58 INFO - PROCESS | 11188 | 00:22:00 INFO - PROCESS | 11188 | Cycle 1(1): loaded http://localhost:32904/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32904/tests/kraken/driver.html?testName=ai-astar) 00:22:00 INFO - PROCESS | 11188 | RSS: Main: 159514624 00:22:00 INFO - PROCESS | 11188 | 00:22:00 INFO - PROCESS | 11188 | __start_tp_report 00:22:00 INFO - PROCESS | 11188 | _x_x_mozilla_page_load 00:22:00 INFO - PROCESS | 11188 | _x_x_mozilla_page_load_details 00:22:00 INFO - PROCESS | 11188 | |i|pagename|runs| 00:22:00 INFO - PROCESS | 11188 | |0;ai-astar;103;110;113;112;111;112;112;112;113;112 00:22:00 INFO - PROCESS | 11188 | |1;audio-beat-detection;149;122;124;162;124;119;118;120;144;120 00:22:00 INFO - PROCESS | 11188 | |2;audio-dft;162;164;163;163;164;161;161;164;162;163 00:22:00 INFO - PROCESS | 11188 | |3;audio-fft;75;75;76;123;76;75;75;75;95;75 00:22:00 INFO - PROCESS | 11188 | |4;audio-oscillator;82;82;126;83;85;82;99;85;83;105 00:22:00 INFO - PROCESS | 11188 | |5;imaging-gaussian-blur;117;117;117;118;117;118;117;118;118;118 00:22:00 INFO - PROCESS | 11188 | |6;imaging-darkroom;150;149;147;148;148;147;148;145;146;147 00:22:00 INFO - PROCESS | 11188 | |7;imaging-desaturate;85;85;85;86;86;86;84;85;87;85 00:22:00 INFO - PROCESS | 11188 | |8;json-parse-financial;53;53;55;52;51;56;53;58;52;54 00:22:00 INFO - PROCESS | 11188 | |9;json-stringify-tinderbox;58;60;58;57;59;59;59;59;59;58 00:22:00 INFO - PROCESS | 11188 | |10;stanford-crypto-aes;75;76;75;75;76;81;81;75;76;78 00:22:00 INFO - PROCESS | 11188 | |11;stanford-crypto-ccm;134;124;122;121;124;132;129;122;165;123 00:22:00 INFO - PROCESS | 11188 | |12;stanford-crypto-pbkdf2;155;159;159;156;154;152;153;156;161;169 00:22:00 INFO - PROCESS | 11188 | |13;stanford-crypto-sha256-iterative;65;62;61;64;64;61;62;61;66;62 00:22:00 INFO - PROCESS | 11188 | __end_tp_report 00:22:00 INFO - PROCESS | 11188 | __start_cc_report 00:22:00 INFO - PROCESS | 11188 | _x_x_mozilla_cycle_collect,792 00:22:00 INFO - PROCESS | 11188 | __end_cc_report 00:22:00 INFO - PROCESS | 11188 | __startTimestamp1482394920609__endTimestamp 00:22:00 INFO - PROCESS | 11188 | 00:22:00 INFO - PROCESS | 11188 | ------- Summary: start ------- 00:22:00 INFO - PROCESS | 11188 | Number of tests: 14 00:22:00 INFO - PROCESS | 11188 | 00:22:00 INFO - PROCESS | 11188 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:2.94 (2.6%) stddev-sans-first:0.93 00:22:00 INFO - PROCESS | 11188 | Values: 103.0 110.0 113.0 112.0 111.0 112.0 112.0 112.0 113.0 112.0 00:22:00 INFO - PROCESS | 11188 | 00:22:00 INFO - PROCESS | 11188 | [#1] audio-beat-detection Cycles:10 Average:130.20 Median:124.00 stddev:15.57 (12.6%) stddev-sans-first:14.95 00:22:00 INFO - PROCESS | 11188 | Values: 149.0 122.0 124.0 162.0 124.0 119.0 118.0 120.0 144.0 120.0 00:22:00 INFO - PROCESS | 11188 | 00:22:00 INFO - PROCESS | 11188 | [#2] audio-dft Cycles:10 Average:162.70 Median:163.00 stddev:1.16 (0.7%) stddev-sans-first:1.20 00:22:00 INFO - PROCESS | 11188 | Values: 162.0 164.0 163.0 163.0 164.0 161.0 161.0 164.0 162.0 163.0 00:22:00 INFO - PROCESS | 11188 | 00:22:00 INFO - PROCESS | 11188 | [#3] audio-fft Cycles:10 Average:82.00 Median:75.00 stddev:15.69 (20.9%) stddev-sans-first:16.44 00:22:00 INFO - PROCESS | 11188 | Values: 75.0 75.0 76.0 123.0 76.0 75.0 75.0 75.0 95.0 75.0 00:22:00 INFO - PROCESS | 11188 | 00:22:00 INFO - PROCESS | 11188 | [#4] audio-oscillator Cycles:10 Average:91.20 Median:83.00 stddev:14.63 (17.6%) stddev-sans-first:15.14 00:22:00 INFO - PROCESS | 11188 | Values: 82.0 82.0 126.0 83.0 85.0 82.0 99.0 85.0 83.0 105.0 00:22:00 INFO - PROCESS | 11188 | 00:22:00 INFO - PROCESS | 11188 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 00:22:00 INFO - PROCESS | 11188 | Values: 117.0 117.0 117.0 118.0 117.0 118.0 117.0 118.0 118.0 118.0 00:22:00 INFO - PROCESS | 11188 | 00:22:00 INFO - PROCESS | 11188 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:1.43 (1.0%) stddev-sans-first:1.20 00:22:00 INFO - PROCESS | 11188 | Values: 150.0 149.0 147.0 148.0 148.0 147.0 148.0 145.0 146.0 147.0 00:22:00 INFO - PROCESS | 11188 | 00:22:00 INFO - PROCESS | 11188 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:85.50 stddev:0.84 (1.0%) stddev-sans-first:0.88 00:22:00 INFO - PROCESS | 11188 | Values: 85.0 85.0 85.0 86.0 86.0 86.0 84.0 85.0 87.0 85.0 00:22:00 INFO - PROCESS | 11188 | 00:22:00 INFO - PROCESS | 11188 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:53.50 stddev:2.11 (3.9%) stddev-sans-first:2.22 00:22:00 INFO - PROCESS | 11188 | Values: 53.0 53.0 55.0 52.0 51.0 56.0 53.0 58.0 52.0 54.0 00:22:00 INFO - PROCESS | 11188 | 00:22:00 INFO - PROCESS | 11188 | [#9] json-stringify-tinderbox Cycles:10 Average:58.60 Median:59.00 stddev:0.84 (1.4%) stddev-sans-first:0.87 00:22:00 INFO - PROCESS | 11188 | Values: 58.0 60.0 58.0 57.0 59.0 59.0 59.0 59.0 59.0 58.0 00:22:00 INFO - PROCESS | 11188 | 00:22:00 INFO - PROCESS | 11188 | [#10] stanford-crypto-aes Cycles:10 Average:76.80 Median:76.00 stddev:2.39 (3.2%) stddev-sans-first:2.45 00:22:00 INFO - PROCESS | 11188 | Values: 75.0 76.0 75.0 75.0 76.0 81.0 81.0 75.0 76.0 78.0 00:22:00 INFO - PROCESS | 11188 | 00:22:00 INFO - PROCESS | 11188 | [#11] stanford-crypto-ccm Cycles:10 Average:129.60 Median:126.50 stddev:13.23 (10.5%) stddev-sans-first:13.93 00:22:00 INFO - PROCESS | 11188 | Values: 134.0 124.0 122.0 121.0 124.0 132.0 129.0 122.0 165.0 123.0 00:22:00 INFO - PROCESS | 11188 | 00:22:00 INFO - PROCESS | 11188 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.40 Median:157.50 stddev:4.97 (3.2%) stddev-sans-first:5.20 00:22:00 INFO - PROCESS | 11188 | Values: 155.0 159.0 159.0 156.0 154.0 152.0 153.0 156.0 161.0 169.0 00:22:00 INFO - PROCESS | 11188 | 00:22:00 INFO - PROCESS | 11188 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:63.00 stddev:1.81 (2.9%) stddev-sans-first:1.74 00:22:00 INFO - PROCESS | 11188 | Values: 65.0 62.0 61.0 64.0 64.0 61.0 62.0 61.0 66.0 62.0 00:22:00 INFO - PROCESS | 11188 | -------- Summary: end -------- 00:22:00 INFO - PROCESS | 11188 | 00:22:01 INFO - TEST-INFO | 11188: exit 0 00:22:01 INFO - TEST-OK | kraken | took 60775ms 00:22:01 INFO - SUITE-END | took 1173s 00:22:01 INFO - Completed test suite (00:19:33) 00:22:01 INFO - javascript benchmark 00:22:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7492.42216198618, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3272.9018129456117, 3312.354090952262, 3312.569365982422, 3320.9501857472155, 3330.5836770403694, 5736.426357364261, 5753.4821866032, 5805.535557155428, 5807.303123625171, 5815.447532484418, 5663.4336566343345, 5762.711864406773, 5776.39347868474, 5776.451237132465, 5790.913136302959, 5212.4266330703595, 5231.712255825928, 5234.790608375661, 5251.816186433475, 5276.868078298035, 5286.259923610698, 5297.073012222865, 5311.336082989626, 5325.920111198335, 5328.600354973373, 5109.080365534202, 5144.022635699224, 5246.449122842104, 5282.709450980195, 5290.153575427932, 5131.255967884655, 5151.716655583923, 5178.0, 5197.428282888879, 5197.58419326453, 5176.50823171798, 5179.818706345298, 5187.04039752647, 5254.238135470374, 5309.5752339812725, 5557.360903496109, 5719.914201286984, 5734.283214598176, 5802.274715660543, 5803.245578074865, 6013.909791353133, 6094.9390506094815, 6100.023996160638, 6103.633781973052, 6127.172831667757, 6117.66352850593, 6153.753849846001, 6158.599691020069, 6160.6611636359985, 6176.166217560662, 5679.432056794288, 5736.4550367715, 5738.42615738427, 5748.425157484218, 5753.935521928456, 6233.532485063638, 6239.188905442355, 6268.216472940882, 6354.618722876642, 6373.968130159319, 6081.483073938676, 6081.939180608226, 6088.4215999479975, 6089.147519347295, 6114.2357205349335, 5976.133460648181, 6192.473639740582, 6192.752289908443, 6204.7828326008375, 6217.751289948442, 5915.024021036566, 5992.910106348409, 5996.072875500228, 6035.6076855004285, 6111.724972376253, 6069.3627169147485, 6094.39056094387, 6104.4200800923845, 6112.969435152796, 6114.48026917717, 4701.435827700698, 4705.788239529229, 4707.976460117678, 4716.1510928033285, 4735.621150307967, 4097.569755175723, 4113.588641135862, 4123.463949686581, 4155.0, 4184.5187803403, 5628.099504079328, 5729.713514324267, 5738.856528586819, 5756.597038207369, 5769.1923130761725, 5875.383084776123, 5902.321233058167, 6103.633781973096, 6179.62922224668, 6182.072689096582, 5694.032014557535, 5726.99777538929, 5735.713214339266, 5789.507891829157, 5824.359320474744, 5291.206319052173, 5295.12630415977, 5299.364076310791, 5301.496357845998, 5302.125149350314, 6191.81424557264, 6303.590266632654, 6351.110844481776, 6365.58623689468, 6370.267419246753, 6106.6336019838955, 6143.235544005126, 6186.969065154825, 6193.318734939243, 6217.129601855653, 6283.214598175228, 6326.746930122928, 6350.396712312323, 6352.269489008823, 6353.809385718436, 6010.278766548042, 6048.667323297085, 6049.697515124139, 6095.817125486243, 6131.877362452637, 5995.2206213192, 6029.065494848305, 6160.0, 6173.722182501709, 6205.5345849062405, 6117.096718007379, 6121.348852995844, 6133.334663918993, 6149.508039356931, 6155.969220153871, 6090.360512146338, 6130.386961303834, 6132.0, 6139.140520327069, 6162.784302549389, 5921.052631578927, 5944.197533332945, 5969.492593129633, 5969.611975221596, 6005.159277701038, 6032.6983650818165, 6065.939340606714, 6122.846928826815, 6122.977604208298, 6126.1423400724825, 5973.402659733992, 5985.581009329305, 5987.101934709828, 5998.70006499682, 6002.369751176064], "value": 5662.651058919035, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [629.6379581740499, 654.2508827392636, 661.1240106858414, 669.7254125808416, 721.6752461392375, 40607.593924060784, 44272.55727442724, 44274.55725442745, 44299.33550996738, 44350.778246108806, 44331.55668443315, 44901.550984490146, 45006.32490512637, 45109.7744511277, 45169.548304516946, 8613.870791938141, 8655.437396569203, 8702.47785132894, 8751.12488751123, 8757.562121893912, 8662.263707584863, 8742.4754514729, 8765.605547750334, 8768.035516093225, 8771.298296136294, 8776.0, 8793.824123517526, 8797.648094076229, 8815.867761983576, 8835.602397892078, 8703.651853925867, 8723.345749068845, 8759.167879051543, 8806.075362086985, 8815.250703690193, 8649.1350864913, 8668.479891206485, 8677.609507572111, 8704.56477176145, 8731.563421828947, 41941.370879436836, 42290.577094228975, 42298.30806767726, 42342.78828605837, 42469.0, 3766.227923275722, 3773.4528493368307, 3777.395616701315, 3832.156925476391, 3903.5315762108444, 32081.839590801897, 32802.0, 33071.0, 33174.0, 33259.6674033259, 4479.798409071567, 4480.5743454372105, 4481.798319075617, 4506.233940230136, 4521.457425109008, 348561.0, 351885.0, 352200.0, 352632.0, 352636.0, 59987.0, 60194.097088543705, 60312.396876031555, 60371.69814150989, 60402.0, 62668.0, 62836.68581657062, 63051.0, 63113.684431577545, 63221.0, 17433.651326973642, 17585.56036099082, 17665.823341766674, 17735.73396399055, 17807.287708491516, 13747.931260343634, 13817.101888377223, 13851.030427869953, 13918.652033699238, 13926.094803837717, 16727.0, 16764.916175419046, 16901.154942252837, 16946.0, 16950.321987120624, 5888.882222355529, 5922.555808314393, 5979.880402391927, 6019.969900150471, 6094.908576371358, 1037.5901518899993, 1106.95018724156, 1110.5169251375678, 1134.6993046842592, 1170.8477897873222, 32406.83796581002, 33321.43034270713, 33387.0, 33603.0, 33647.83176084153, 1101.6860194844592, 1114.039290848113, 1117.8323251512174, 1132.7451323452322, 1189.916705830601, 15728.0, 16912.492625221264, 17355.47933561995, 18122.184501697455, 18283.63432731338, 494697.0, 496292.0, 498212.0, 499333.0, 499801.0, 59474.10788838171, 59814.10278845821, 59825.401745982854, 59864.0, 59949.400505995254, 1340.9530666426629, 1348.919064856092, 1405.1639274631577, 1415.9150450972975, 1419.7941298511657, 31746.365072698878, 32165.839170803996, 32466.513002305455, 34381.82809085939, 36025.63974360328, 56621.71689141528, 57098.714506427204, 57353.713231433576, 57415.42584574268, 57683.4231657678, 442742.0, 449991.0, 453666.0, 454770.0, 455543.0, 28518.42963140767, 29664.406711866075, 29839.552406714352, 30069.54895676523, 30157.69842301549, 48766.5123348762, 49314.0, 49369.753151234014, 49630.503694964034, 49749.25376119433, 41355.1728965413, 42174.36738448864, 42226.577734222265, 42325.36511952385, 43135.35296970611, 40823.0, 41016.79491602523, 41424.37863431991, 41850.37224441697, 42356.0, 39210.803945980086, 39221.41167882427, 39459.0, 39848.402273966494, 43988.34017489676, 31865.522017169296, 33790.0, 34044.31911361709, 34123.0, 34260.14349641279, 29358.559621605265, 29393.853030735565, 29646.407071858874, 29675.258118546346, 29828.403431931674], "value": 20392.042086092337, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [428.4943766355699, 431.115648011417, 433.6249144490016, 441.3886766827944, 442.81623126402525, 19246.615067698636, 19728.70406943897, 20143.697844532326, 20894.373168804923, 21093.15627374903, 16833.494995150133, 19546.902265488654, 19654.21383144676, 19724.309649162282, 20226.494337641565, 5686.0617998030275, 5947.732352044147, 5949.732262048218, 5969.4925931295675, 5976.342602313764, 5685.687287199203, 5797.0, 5846.386129456409, 5903.586748927577, 5961.076033214837, 5793.768249270024, 5803.796867109652, 5809.3900140485275, 5819.82540523785, 5827.067669172912, 5644.350899646532, 5784.913226301609, 5883.588148829563, 5898.941010589882, 5908.379620139866, 5348.973255133699, 5362.356517217959, 5366.114591092504, 5369.48989845964, 5372.516473517363, 21927.561448770935, 22814.65778013331, 23048.308550743506, 23080.88459557708, 23090.53818923629, 2468.543319485901, 2470.1601455505215, 2728.7816974641983, 2774.597683335905, 3120.828354440505, 14730.926345368205, 14948.40206391743, 15151.621209469851, 15287.312070956834, 15369.923150384177, 1967.3704414587337, 2007.247282269149, 2033.4814622271374, 2038.5922815436973, 2074.512489564951, 84751.57624211839, 85773.0, 87607.56196219042, 88078.0, 88288.55855720745, 11210.0, 11505.597304094317, 11553.36456494884, 12041.939790301167, 12053.276803391824, 16331.26509307084, 16353.672926541403, 16383.754243686355, 16417.1791410429, 16477.176141192893, 8626.870596941051, 8698.608222684341, 8755.693550725695, 8855.822883542292, 8954.149355811187, 8294.253517183482, 8327.250547450638, 8509.361797865186, 8581.098984606651, 8586.65653373858, 7030.660436292822, 7148.891077132258, 7186.784396468114, 7230.2046774854725, 7244.26072630049, 1900.7148927660962, 1911.120884393167, 1929.2765213045109, 1937.2541571495076, 1954.784973652897, 995.2883688162998, 1095.446799366315, 1129.943502824872, 1132.7281452451516, 1181.0728578066348, 20558.794412055988, 20716.792832071485, 20829.89585052065, 20936.581268374546, 21195.47011324729, 1027.445179603021, 1038.6676263595577, 1078.789636020984, 1136.2841409911703, 1140.2588317593465, 11460.770784584261, 11584.304941703525, 11684.47419866108, 11748.177627565989, 11870.109741769229, 477012.0, 482082.0, 485336.0, 487961.0, 490107.0, 79680.60159699165, 81429.07075448097, 86357.5682121598, 89507.55246223857, 91271.54364228137, 1030.7165529479303, 1066.317556763672, 1066.5360568152878, 1077.49357801833, 1078.2021304234809, 17983.820161798216, 18199.999000055122, 18418.723719143956, 18548.814511854707, 18812.435626930666, 30560.541591876583, 32977.175570610925, 43508.564914351715, 43823.0, 44588.55411445844, 57399.426005739406, 62354.0, 62699.37300626935, 64028.0, 64141.35858641354, 8567.657293708182, 8870.689525866565, 8971.461712297283, 9008.504532250789, 9131.0, 10127.949360253151, 13178.934105329412, 13360.93319533396, 13645.044846860625, 13956.232407217294, 11830.171887968105, 11985.700357491132, 12219.0, 12348.135630505778, 12395.132340736061, 11757.941210293893, 12106.455209515769, 12157.69605759863, 12198.75602487963, 12335.629931102081, 11955.64133076009, 11963.700907477383, 12025.398730063287, 12206.816897746363, 12453.0, 8775.0, 9055.36612437123, 9097.1812536872, 9126.13301736334, 9312.953435233052, 11782.234154779911, 11787.11596630239, 12169.939150304192, 12177.756444871231, 12322.137450378388], "value": 9775.078382673159, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1504.3681653705446, 1528.5261568913638, 1713.7772089628347, 1790.561312478443, 1832.9633407331853, 7688.461807673465, 7829.060512738465, 8640.39517233793, 9212.401193922398, 9214.078592140791, 8632.697855575056, 8865.379423440345, 8881.378303518757, 9121.908780912188, 9122.543872806365, 2525.785308248801, 2570.4216551276, 2570.652961850145, 2571.100114959768, 2573.4209802794408, 2512.773850353468, 2514.8365356251875, 2549.146036077916, 2553.731858154895, 2555.910543130991, 2498.3129639349236, 2503.5243303772318, 2504.273760609421, 2523.14213167523, 2530.139752484155, 2480.677511923456, 2487.1916627096266, 2513.170653684289, 2519.8362106463023, 2520.206135067466, 2455.091616102036, 2476.529459402726, 2484.962725559118, 2492.8255022148455, 2497.475530138673, 9041.23149532284, 9079.319051071196, 9088.09119088086, 9099.590518426687, 9153.862692059625, 5435.1847222916485, 5596.720163991825, 5628.127640215773, 5628.915566266509, 5642.379338272786, 3509.298140371936, 3565.714742820568, 3726.6832319252894, 3764.9435258471144, 3770.1328694400167, 1132.8583927009124, 1170.7365842685413, 1180.2328486483768, 1181.8345431639577, 1193.9522419103225, 12691.04817138709, 12720.87279127206, 12723.745525089538, 12751.426185821567, 12779.61661150167, 4966.801327946914, 5065.873353166126, 5154.974225128851, 5189.896202075937, 5231.895362092737, 10532.631357902437, 10547.419891906018, 10617.575296988034, 10620.09729173029, 10646.680599582025, 5594.24477695514, 5619.887602247933, 5652.18043383707, 5652.349979752299, 5663.461971112738, 5067.670601410897, 5082.33929589151, 5141.820036298712, 5228.477152284817, 5286.233496143038, 4021.8523892529893, 4084.6323830855367, 4088.448059511987, 4131.215069136854, 4153.1070819773895, 1308.1366298243113, 1309.8297221361163, 1313.2251971336957, 1317.6508225320106, 1322.8875545578542, 936.8782058332373, 990.8166989107038, 1016.8881423043459, 1040.1834559870617, 1046.4035499765062, 6003.069524223665, 6101.511879049665, 6104.816855494342, 6178.258608966953, 6213.192285003011, 496.8335607571504, 497.99004019919397, 505.171518709317, 511.45785467403925, 536.5224949794685, 4243.469566304212, 4317.8272869084885, 4337.240982828055, 4360.585744354281, 4408.625266852354, 10996.670099897015, 11265.0, 11325.2072354936, 11363.488643011084, 11412.0, 10851.294665846852, 11129.777404452028, 11224.775504490028, 11307.378094204898, 11345.829812552818, 8419.915800841913, 8497.532635705096, 8556.529390883561, 8574.914250857411, 8681.435706679045, 6176.722047507963, 6247.468965138014, 6265.749370025148, 6308.905366419599, 6401.839954001187, 10301.227407944285, 10316.690499285034, 10389.688309350731, 10422.322549034288, 10431.165506759593, 9400.29497787655, 10025.649102281384, 10310.07209351132, 10394.324368915995, 10529.42088185157, 7517.361024312776, 7649.349805266392, 7725.188855170351, 7753.728619498291, 7789.883151752615, 8674.566271686517, 8741.34439916996, 8784.121587841164, 8799.12008799115, 8800.38397312182, 7853.253940875607, 7964.20357964199, 8130.390220733587, 8175.67297308101, 8284.544350060805, 7767.883481747665, 7889.4082943780595, 7925.801854953672, 7985.161558036322, 8013.879791803011, 7205.135383753774, 7280.0, 7351.0, 7402.00072990161, 7412.555246685216, 5506.174073888948, 5620.381758006534, 5676.716164191691, 5693.4591213836275, 5729.2265544151005, 5434.456554344534, 5467.097928841856, 5488.341399032141, 5523.475269849358, 5546.805861794818], "value": 4780.651372384216, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.42941581716707, 366.86976123476165, 367.9282539904718, 369.19331261194276, 370.8164458592997, 5682.232898558698, 5690.886182276357, 5711.628744131639, 5716.428357164282, 5722.628029178106, 5420.5934554908445, 5560.0, 5578.470045345696, 5578.944210557893, 5605.113366616196, 4374.803133858984, 4441.401095605579, 4446.644268458532, 4448.777561121931, 4454.576815202567, 4428.073787902256, 4438.844640437585, 4452.510223875371, 4458.97770511147, 4473.94862207381, 4422.491413487442, 4431.601155895969, 4434.822607095713, 4446.622037126848, 4451.643868490529, 4296.656267498593, 4398.802053907598, 4436.755978421185, 4466.330050492452, 4480.6191473724775, 4000.919751667063, 4016.49793775778, 4020.1356708307853, 4028.8589899353674, 4030.979845100756, 5509.47659972302, 5537.224788529569, 5538.9169162462595, 5563.193336966157, 5577.386487486373, 5091.898162036776, 5157.922631160535, 5163.122269214243, 5178.352705911761, 5178.663386879841, 5977.133315669247, 5988.97005514974, 6006.399360064002, 6019.548533859978, 6041.667708276043, 4335.219660461115, 4410.823567057314, 4415.757133357664, 4445.844395446176, 4450.688451808374, 5926.0, 6119.602225855305, 6205.441510264052, 6216.844578885519, 6223.688815559204, 4404.889877753082, 4423.623991960655, 4429.313456414261, 4437.667174961891, 4444.666650001198, 4477.552244775497, 4483.260262056724, 4502.774861256924, 4512.187806194851, 4512.638988880882, 4909.410870695468, 5050.419201791841, 5078.847634570969, 5078.898422031539, 5085.516875896784, 5886.470217680429, 5891.204687367236, 5935.970320148372, 5951.583389162717, 5981.162637230791, 1474.9822622390516, 1489.4340150742864, 1504.5335945856818, 1506.2167672810297, 1506.811648543932, 1003.8795344558554, 1041.2242879055152, 1043.9060484556426, 1055.1611468882256, 1064.956342784076, 5471.7264136793, 5480.725963701799, 5498.835034948958, 5621.397901598025, 5632.464915832989, 5916.0, 5960.761569537257, 5963.493103086286, 6014.669193194329, 6031.285921335417, 5294.97352513235, 5441.80280338325, 5469.234307196995, 5494.313210848644, 5571.972140139354, 3126.7811253212512, 3137.654857965622, 3140.874365025373, 3141.434541782455, 3154.3848949454637, 5835.2122463466885, 6033.771932016351, 6048.002079656807, 6049.848753781191, 6072.2390506752545, 5908.3205431375945, 5931.466168044811, 5932.940670593325, 5943.613665111754, 5956.970215148983, 5810.750688601971, 5871.706414679249, 5922.7927022554, 5951.553633477506, 5997.0, 5823.126531020381, 5868.853278668067, 6110.358412366638, 6183.907241391293, 6217.658028808459, 6056.0, 6111.633302001894, 6113.938860611337, 6124.560728228774, 6128.908066379097, 6022.247219097613, 6265.749370025148, 6267.2479302484, 6272.560920735687, 6301.842453938505, 4387.276099443556, 4402.427684401136, 4413.7351758894565, 4417.293233082692, 4434.51220365753, 5859.472647461749, 6077.574569780073, 6158.568900176944, 6162.291336496181, 6162.722677479614, 5959.702014899324, 5977.820665380045, 5991.490723288569, 5995.970020149872, 6023.759049637965, 5967.46292833647, 5978.701064946648, 5982.312034116132, 5990.281166260077, 6026.655206360512, 5807.535397168301, 5914.58597898143, 5937.287525496968, 5953.880922381441, 5975.312839023394, 5988.221531200916, 6000.339962604023, 6022.0, 6024.156618073561, 6060.848438796615, 5685.886282274414, 5818.796342128006, 5869.765209391577, 5885.617434866891, 5918.3489816121055], "value": 4534.000723890036, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [795.6101510259971, 806.0770417871537, 844.5734903873542, 857.7726902370872, 862.9773718143998, 15030.248487575618, 16050.27773750181, 16092.83907160928, 16105.83894161061, 16137.596560085989, 14489.420423183086, 14730.410783568672, 14759.92620036901, 14777.852221477782, 14786.556403307917, 825.3933358981159, 835.2274146414572, 835.8119423129808, 840.277361469136, 843.0599881132555, 840.0381563110235, 841.1714461255658, 841.9536925469097, 842.2041171093289, 842.2840585502336, 890.1721399098835, 891.7146513115806, 892.6429428228728, 894.1773568317132, 898.0435835834847, 888.2671795768484, 891.3715830339595, 894.6242578117207, 896.4442045931564, 897.9865302020474, 656.7832615236961, 657.4346062386344, 658.6212927566669, 659.3900641906265, 661.0711949710665, 13595.660108497268, 13599.524016659469, 13635.931820340835, 13663.726725465434, 13692.315384230847, 12858.807117893239, 13003.674908127277, 13212.801807972888, 13385.464581416732, 13423.194608323434, 11398.715032124263, 11481.48333324994, 11522.539098436053, 11551.249168804, 11580.536778528849, 3777.4851549106866, 3828.1960788234505, 3840.462335273064, 3849.2493963677093, 3883.1457079442475, 59427.78489818913, 60912.390876091114, 64620.0, 64700.0, 65404.67297663529, 9988.500574971222, 10042.096211341015, 10061.949690251648, 10062.949685251528, 10411.947940260401, 16722.665546688997, 16749.33002679879, 16991.40530081441, 18343.81656183448, 19636.41090767279, 8200.42597018203, 8395.580220989048, 8462.449940753831, 8536.8719469208, 8700.869486957701, 4815.951840481621, 4912.778924948386, 4920.901581968412, 4984.22744474607, 5087.465816089331, 3357.2446199605383, 3384.9323013539592, 3407.4377727674655, 3441.346144232588, 3456.2223499712363, 642.9003504456816, 645.8320836582523, 650.4016304999412, 667.9833004174934, 669.2404121322335, 586.4458087107643, 623.3486007122568, 688.6109348218241, 729.2233771033938, 734.086062851753, 9424.62301507932, 9491.430514169171, 9509.191718703849, 9793.21654267657, 9916.305858589974, 582.2692520886261, 626.8025571944822, 695.3741632530763, 712.1276436365514, 724.3263764698776, 4517.751523666164, 4699.506551812011, 4705.6470764692785, 4709.411323584552, 4745.6440766942615, 87538.56230718934, 88464.0, 89625.55187224153, 91603.0, 93424.53287733518, 65789.67105164443, 66687.3331266681, 67175.66412167907, 77892.22107778963, 81743.0, 45456.772716136205, 46556.7672161637, 54070.0, 62088.68955655193, 68841.65579172072, 9759.47944160805, 9964.900350996397, 10270.743231419274, 10561.841572376266, 10779.407132607468, 46038.539614603425, 47977.0, 48568.5143148564, 48772.26841597308, 49202.0, 63963.36036639574, 66132.66933665301, 66815.0, 66827.0, 67001.66499167473, 13089.0, 13114.60656180316, 13235.27206003679, 13274.0, 13373.06388552792, 14175.645608859448, 14913.776293355391, 14961.0, 15207.391704331703, 15318.617034574225, 13883.930580347034, 14298.0, 14383.280835958369, 14406.639834003814, 14734.263286835401, 11912.40437978115, 12092.455839487067, 12476.376181191086, 12703.110782245523, 13268.867311326763, 12263.26420414778, 13541.796873046715, 13981.0, 13985.300734963415, 14684.706305874037, 10875.728106797393, 11125.054370378608, 11167.72080697989, 11398.658040258806, 11767.529298828293, 10187.796244074929, 10838.543692224559, 10866.402347870942, 10989.285696429706, 11169.553217871195], "value": 7229.740143222475, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1466.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 110.0, 113.0, 112.0, 111.0, 112.0, 112.0, 112.0, 113.0, 112.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 122.0, 124.0, 162.0, 124.0, 119.0, 118.0, 120.0, 144.0, 120.0], "value": 130.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 163.0, 163.0, 164.0, 161.0, 161.0, 164.0, 162.0, 163.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 123.0, 76.0, 75.0, 75.0, 75.0, 95.0, 75.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 126.0, 83.0, 85.0, 82.0, 99.0, 85.0, 83.0, 105.0], "value": 91.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 147.0, 148.0, 148.0, 147.0, 148.0, 145.0, 146.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 86.0, 86.0, 86.0, 84.0, 85.0, 87.0, 85.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 55.0, 52.0, 51.0, 56.0, 53.0, 58.0, 52.0, 54.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 58.0, 57.0, 59.0, 59.0, 59.0, 59.0, 59.0, 58.0], "value": 58.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 75.0, 76.0, 81.0, 81.0, 75.0, 76.0, 78.0], "value": 76.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 124.0, 122.0, 121.0, 124.0, 132.0, 129.0, 122.0, 165.0, 123.0], "value": 129.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 159.0, 159.0, 156.0, 154.0, 152.0, 153.0, 156.0, 161.0, 169.0], "value": 157.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 61.0, 64.0, 64.0, 61.0, 62.0, 61.0, 66.0, 62.0], "value": 62.8, "unit": "score"}]}]} 00:22:01 INFO - Return code: 0 00:22:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:22:01 ERROR - # TBPL SUCCESS # 00:22:01 INFO - Running post-action listener: _resource_record_post_action 00:22:01 INFO - [mozharness: 2016-12-22 08:22:01.943480Z] Finished run-tests step (success) 00:22:01 INFO - Running post-run listener: _resource_record_post_run 00:22:02 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 364011520; Read time: 12; Write time: 321424 00:22:02 INFO - TinderboxPrint: CPU usage
13.3% 00:22:02 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 00:22:02 INFO - TinderboxPrint: I/O write bytes / time
364,011,520 / 321,424 00:22:02 INFO - TinderboxPrint: CPU idle
8,227.2 (86.7%) 00:22:02 INFO - TinderboxPrint: CPU user
1,208.7 (12.7%) 00:22:02 INFO - TinderboxPrint: Swap in / out
0 / 0 00:22:02 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 117059584; Read time: 0; Write time: 113888 00:22:02 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 246460416; Read time: 0; Write time: 207532 00:22:02 INFO - Running post-run listener: _upload_blobber_files 00:22:02 INFO - Blob upload gear active. 00:22:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:22:02 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 00:22:02 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'] 00:22:02 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 00:22:02 INFO - (blobuploader) - INFO - Open directory for files ... 00:22:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:22:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:22:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:22:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:22:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:22:03 INFO - (blobuploader) - INFO - Done attempting. 00:22:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:22:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:22:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:22:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:22:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:22:07 INFO - (blobuploader) - INFO - Done attempting. 00:22:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:22:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:22:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:22:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:22:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:22:08 INFO - (blobuploader) - INFO - Done attempting. 00:22:08 INFO - (blobuploader) - INFO - Iteration through files over. 00:22:08 INFO - Return code: 0 00:22:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:22:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:22:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/762b86a95c689df0f239bba8442dcd63746bd75f610a767066b1bf3bc51ba24d6bf82ce19b1545a0fb65742af61d91efc57964f2a0fa20e1a37b44259ed07529", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0fbb5c973d1515b45dcbdb8a9429ff7ebbcbd80345eb691ab2fd008caee66ced635ef87a25ae01f88d5a4e90a7a4de05290df3515632d4c4e60fccb651cde902", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8b43217b9f6223075db549ad526f99fbe6331d7820f12689b0ad32f2167b770ee6fc820d3a8b37f2582a77f2a345e55a7dc189edb4047631092bfa3f711e0ff5"} 00:22:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:22:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:22:08 INFO - Contents: 00:22:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/762b86a95c689df0f239bba8442dcd63746bd75f610a767066b1bf3bc51ba24d6bf82ce19b1545a0fb65742af61d91efc57964f2a0fa20e1a37b44259ed07529", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0fbb5c973d1515b45dcbdb8a9429ff7ebbcbd80345eb691ab2fd008caee66ced635ef87a25ae01f88d5a4e90a7a4de05290df3515632d4c4e60fccb651cde902", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8b43217b9f6223075db549ad526f99fbe6331d7820f12689b0ad32f2167b770ee6fc820d3a8b37f2582a77f2a345e55a7dc189edb4047631092bfa3f711e0ff5"} 00:22:08 INFO - Running post-run listener: copy_logs_to_upload_dir 00:22:08 INFO - Copying logs to upload dir... 00:22:08 INFO - mkdir: /builds/slave/test/build/upload/logs 00:22:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.204366 ========= master_lag: 0.43 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-12-22 00:22:08.828589) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-22 00:22:08.831882) ========= 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=db0483c52d987ecb441a263b000001ad-1482392870.129988-1560250367 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/762b86a95c689df0f239bba8442dcd63746bd75f610a767066b1bf3bc51ba24d6bf82ce19b1545a0fb65742af61d91efc57964f2a0fa20e1a37b44259ed07529", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0fbb5c973d1515b45dcbdb8a9429ff7ebbcbd80345eb691ab2fd008caee66ced635ef87a25ae01f88d5a4e90a7a4de05290df3515632d4c4e60fccb651cde902", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8b43217b9f6223075db549ad526f99fbe6331d7820f12689b0ad32f2167b770ee6fc820d3a8b37f2582a77f2a345e55a7dc189edb4047631092bfa3f711e0ff5"} build_url:https://queue.taskcluster.net/v1/task/M9coC_jMS-W1mvNRh8carg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011318 build_url: 'https://queue.taskcluster.net/v1/task/M9coC_jMS-W1mvNRh8carg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/762b86a95c689df0f239bba8442dcd63746bd75f610a767066b1bf3bc51ba24d6bf82ce19b1545a0fb65742af61d91efc57964f2a0fa20e1a37b44259ed07529", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0fbb5c973d1515b45dcbdb8a9429ff7ebbcbd80345eb691ab2fd008caee66ced635ef87a25ae01f88d5a4e90a7a4de05290df3515632d4c4e60fccb651cde902", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8b43217b9f6223075db549ad526f99fbe6331d7820f12689b0ad32f2167b770ee6fc820d3a8b37f2582a77f2a345e55a7dc189edb4047631092bfa3f711e0ff5"}' ========= master_lag: 0.06 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-22 00:22:08.901360) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 00:22:08.901714) ========= 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=db0483c52d987ecb441a263b000001ad-1482392870.129988-1560250367 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004542 ========= master_lag: 0.28 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 00:22:09.182921) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-22 00:22:09.183268) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-22 00:22:09.188066) ========= ========= Total master_lag: 0.87 =========