builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-045 starttime: 1481732881.63 results: success (0) buildid: 20161214064001 builduid: 996d637145d44f09a99fbbf4b3c7f17c revision: 7bfeec8395e5ca28421d92f3bf51d56feafc0319 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-14 08:28:01.628873) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-14 08:28:01.629324) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-14 08:28:01.629605) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-14 08:28:01.640744) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 08:28:01.641022) ========= 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=4300f881736b422476174874000001bc-1481732881.600344-1580398743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-14 08:28:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 215M=0s 2016-12-14 08:28:02 (215 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.359419 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 08:28:02.011862) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 08:28:02.012181) ========= 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=4300f881736b422476174874000001bc-1481732881.600344-1580398743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013704 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 08:28:02.062060) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 08:28:02.062373) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7bfeec8395e5ca28421d92f3bf51d56feafc0319 --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 7bfeec8395e5ca28421d92f3bf51d56feafc0319 --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=4300f881736b422476174874000001bc-1481732881.600344-1580398743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-14 08:28:02,845 truncating revision to first 12 chars 2016-12-14 08:28:02,845 Setting DEBUG logging. 2016-12-14 08:28:02,845 attempt 1/10 2016-12-14 08:28:02,845 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7bfeec8395e5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-14 08:28:03,163 unpacking tar archive at: mozilla-aurora-7bfeec8395e5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.623298 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 08:28:02.705309) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-14 08:28:02.705649) ========= script_repo_revision: 7bfeec8395e5ca28421d92f3bf51d56feafc0319 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-14 08:28:02.706089) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-14 08:28:02.706376) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-14 08:28:02.718922) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-12-14 08:28:02.719204) ========= /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=4300f881736b422476174874000001bc-1481732881.600344-1580398743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:28:03 INFO - MultiFileLogger online at 20161214 08:28:03 in /builds/slave/test 08:28:03 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 08:28:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:28:03 INFO - {'append_to_log': False, 08:28:03 INFO - 'base_work_dir': '/builds/slave/test', 08:28:03 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:28:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:28:03 INFO - 'branch': 'Mozilla-Aurora', 08:28:03 INFO - 'buildbot_json_path': 'buildprops.json', 08:28:03 INFO - 'config_files': ('talos/linux_config.py',), 08:28:03 INFO - 'default_actions': ('clobber', 08:28:03 INFO - 'read-buildbot-config', 08:28:03 INFO - 'download-and-extract', 08:28:03 INFO - 'populate-webroot', 08:28:03 INFO - 'create-virtualenv', 08:28:03 INFO - 'install', 08:28:03 INFO - 'run-tests'), 08:28:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:28:03 INFO - 'download_minidump_stackwalk': True, 08:28:03 INFO - 'download_symbols': 'ondemand', 08:28:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:28:03 INFO - 'tooltool.py': '/tools/tooltool.py', 08:28:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:28:03 INFO - '/tools/misc-python/virtualenv.py')}, 08:28:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:28:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:28:03 INFO - 'installer_path': 'installer.exe', 08:28:03 INFO - 'log_level': 'info', 08:28:03 INFO - 'log_name': 'talos', 08:28:03 INFO - 'log_to_console': True, 08:28:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:28:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:28:03 INFO - 'opt_config_files': (), 08:28:03 INFO - 'pip_index': False, 08:28:03 INFO - 'sps_profile': False, 08:28:03 INFO - 'sps_profile_interval': 0, 08:28:03 INFO - 'suite': 'dromaeojs-e10s', 08:28:03 INFO - 'system_bits': '32', 08:28:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:28:03 INFO - 'title': 'talos-linux64-ix-045', 08:28:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:28:03 INFO - 'use_talos_json': True, 08:28:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:28:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:28:03 INFO - 'work_dir': 'build'} 08:28:03 INFO - [mozharness: 2016-12-14 16:28:03.593827Z] Running clobber step. 08:28:03 INFO - Running pre-action listener: _resource_record_pre_action 08:28:03 INFO - Running main action method: clobber 08:28:03 INFO - rmtree: /builds/slave/test/build 08:28:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:28:04 INFO - Running post-action listener: _resource_record_post_action 08:28:04 INFO - [mozharness: 2016-12-14 16:28:04.045731Z] Finished clobber step (success) 08:28:04 INFO - [mozharness: 2016-12-14 16:28:04.045831Z] Running read-buildbot-config step. 08:28:04 INFO - Running pre-action listener: _resource_record_pre_action 08:28:04 INFO - Running main action method: read_buildbot_config 08:28:04 INFO - Using buildbot properties: 08:28:04 INFO - { 08:28:04 INFO - "project": "", 08:28:04 INFO - "product": "firefox", 08:28:04 INFO - "script_repo_revision": "production", 08:28:04 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 08:28:04 INFO - "repository": "", 08:28:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 08:28:04 INFO - "buildid": "20161214064001", 08:28:04 INFO - "pgo_build": "True", 08:28:04 INFO - "basedir": "/builds/slave/test", 08:28:04 INFO - "buildnumber": 749, 08:28:04 INFO - "slavename": "talos-linux64-ix-045", 08:28:04 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:28:04 INFO - "platform": "ubuntu64_hw", 08:28:04 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 08:28:04 INFO - "branch": "mozilla-aurora", 08:28:04 INFO - "repo_path": "releases/mozilla-aurora", 08:28:04 INFO - "revision": "7bfeec8395e5ca28421d92f3bf51d56feafc0319", 08:28:04 INFO - "stage_platform": "linux64-pgo", 08:28:04 INFO - "builduid": "996d637145d44f09a99fbbf4b3c7f17c", 08:28:04 INFO - "slavebuilddir": "test" 08:28:04 INFO - } 08:28:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/LiX5Ig4KSzi7T16syMTLkA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 08:28:04 INFO - Running post-action listener: _resource_record_post_action 08:28:04 INFO - [mozharness: 2016-12-14 16:28:04.048253Z] Finished read-buildbot-config step (success) 08:28:04 INFO - [mozharness: 2016-12-14 16:28:04.048342Z] Running download-and-extract step. 08:28:04 INFO - Running pre-action listener: _resource_record_pre_action 08:28:04 INFO - Running main action method: download_and_extract 08:28:04 INFO - mkdir: /builds/slave/test/build/tests 08:28:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:04 INFO - trying https://queue.taskcluster.net/v1/task/LiX5Ig4KSzi7T16syMTLkA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:28:04 INFO - Downloading https://queue.taskcluster.net/v1/task/LiX5Ig4KSzi7T16syMTLkA/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 08:28:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LiX5Ig4KSzi7T16syMTLkA/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 08:28:04 INFO - Downloaded 1361 bytes. 08:28:04 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:28:04 INFO - Using the following test package requirements: 08:28:04 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 08:28:04 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:28:04 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 08:28:04 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:28:04 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 08:28:04 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:28:04 INFO - u'jsshell-linux-x86_64.zip'], 08:28:04 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:28:04 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 08:28:04 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 08:28:04 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:28:04 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 08:28:04 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:28:04 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 08:28:04 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:28:04 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 08:28:04 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:28:04 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 08:28:04 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:28:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LiX5Ig4KSzi7T16syMTLkA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 08:28:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LiX5Ig4KSzi7T16syMTLkA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:28:04 INFO - Fetch https://queue.taskcluster.net/v1/task/LiX5Ig4KSzi7T16syMTLkA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:28:05 INFO - Http code: 200 08:28:05 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 08:28:05 INFO - x-amz-cf-id: roeMM2y5RGDECMowQFH2kb3O1ivz_csx3hiBmN3fT0NzV9ekX81QjA== 08:28:05 INFO - x-amz-version-id: jSZ7eO1pFHzsaJPx9EajKY2Cof0DWoU3 08:28:05 INFO - Expected file size: 21953943 08:28:05 INFO - Obtained file size: 21953943 08:28:09 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 08:28:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LiX5Ig4KSzi7T16syMTLkA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 08:28:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LiX5Ig4KSzi7T16syMTLkA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:28:09 INFO - Fetch https://queue.taskcluster.net/v1/task/LiX5Ig4KSzi7T16syMTLkA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:28:10 INFO - Http code: 200 08:28:10 INFO - via: 1.1 c54d7f08e2f3dab1918454910cc8aad0.cloudfront.net (CloudFront) 08:28:10 INFO - x-amz-cf-id: mkbf1Iy8QtpnsHkoJckLibExXuH7EnC1JE8W1V773R9MmIsTJGkFkw== 08:28:10 INFO - x-amz-version-id: jSZ7eO1pFHzsaJPx9EajKY2Cof0DWoU3 08:28:10 INFO - Expected file size: 21953943 08:28:10 INFO - Obtained file size: 21953943 08:28:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LiX5Ig4KSzi7T16syMTLkA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 08:28:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LiX5Ig4KSzi7T16syMTLkA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:28:14 INFO - Fetch https://queue.taskcluster.net/v1/task/LiX5Ig4KSzi7T16syMTLkA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 08:28:15 INFO - Http code: 200 08:28:15 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 08:28:15 INFO - x-amz-cf-id: JWCF-aAmdOpxt50JdXyij2qshPR6O5Md95ny35VEcjQEoLsdOyszdg== 08:28:15 INFO - x-amz-version-id: qGU0oRnGBEm31L.diUmlXxR2tcMzJ2t5 08:28:15 INFO - Expected file size: 14409038 08:28:15 INFO - Obtained file size: 14409038 08:28:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:15 INFO - trying https://queue.taskcluster.net/v1/task/LiX5Ig4KSzi7T16syMTLkA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:28:15 INFO - Downloading https://queue.taskcluster.net/v1/task/LiX5Ig4KSzi7T16syMTLkA/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 08:28:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LiX5Ig4KSzi7T16syMTLkA/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 08:28:16 INFO - Downloaded 63999878 bytes. 08:28:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LiX5Ig4KSzi7T16syMTLkA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:28:16 INFO - mkdir: /builds/slave/test/properties 08:28:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:28:16 INFO - Writing to file /builds/slave/test/properties/build_url 08:28:16 INFO - Contents: 08:28:16 INFO - build_url:https://queue.taskcluster.net/v1/task/LiX5Ig4KSzi7T16syMTLkA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:28:17 INFO - Running post-action listener: _resource_record_post_action 08:28:17 INFO - Running post-action listener: set_extra_try_arguments 08:28:17 INFO - [mozharness: 2016-12-14 16:28:17.575142Z] Finished download-and-extract step (success) 08:28:17 INFO - [mozharness: 2016-12-14 16:28:17.575368Z] Running populate-webroot step. 08:28:17 INFO - Running pre-action listener: _resource_record_pre_action 08:28:17 INFO - Running main action method: populate_webroot 08:28:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:28:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:28:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:28:17 INFO - '--tppagecycles', 08:28:17 INFO - '7'], 08:28:17 INFO - 'tests': ['tsvgm']}}, 08:28:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:28:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:28:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:28:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:28:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:28:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:28:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:28:17 INFO - 'talos_options': ['--disable-e10s'], 08:28:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:28:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:28:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:28:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:28:17 INFO - 'talos_options': ['--disable-e10s'], 08:28:17 INFO - 'tests': ['damp', 'tps']}, 08:28:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:28:17 INFO - 'tests': ['damp', 'tps']}, 08:28:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:28:17 INFO - 'tests': ['dromaeo_dom']}, 08:28:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:28:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:28:17 INFO - 'tests': ['basic_compositor_video']}, 08:28:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:28:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:28:17 INFO - 'tests': ['a11yr', 08:28:17 INFO - 'ts_paint', 08:28:17 INFO - 'tpaint', 08:28:17 INFO - 'sessionrestore', 08:28:17 INFO - 'sessionrestore_no_auto_restore', 08:28:17 INFO - 'tabpaint']}, 08:28:17 INFO - 'other-e10s': {'tests': ['a11yr', 08:28:17 INFO - 'ts_paint', 08:28:17 INFO - 'tpaint', 08:28:17 INFO - 'sessionrestore', 08:28:17 INFO - 'sessionrestore_no_auto_restore', 08:28:17 INFO - 'tabpaint']}, 08:28:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:28:17 INFO - 'ts_paint', 08:28:17 INFO - 'tpaint', 08:28:17 INFO - 'sessionrestore', 08:28:17 INFO - 'sessionrestore_no_auto_restore', 08:28:17 INFO - 'tabpaint']}, 08:28:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:28:17 INFO - 'ts_paint', 08:28:17 INFO - 'tpaint', 08:28:17 INFO - 'sessionrestore', 08:28:17 INFO - 'sessionrestore_no_auto_restore', 08:28:17 INFO - 'tabpaint']}, 08:28:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:28:17 INFO - 'tests': ['a11yr', 08:28:17 INFO - 'ts_paint', 08:28:17 INFO - 'tpaint', 08:28:17 INFO - 'sessionrestore', 08:28:17 INFO - 'sessionrestore_no_auto_restore', 08:28:17 INFO - 'tabpaint']}, 08:28:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:28:17 INFO - 'tests': ['a11yr', 08:28:17 INFO - 'ts_paint', 08:28:17 INFO - 'tpaint', 08:28:17 INFO - 'sessionrestore', 08:28:17 INFO - 'sessionrestore_no_auto_restore', 08:28:17 INFO - 'tabpaint']}, 08:28:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:28:17 INFO - 'tests': ['tsvgx', 08:28:17 INFO - 'tsvgr_opacity', 08:28:17 INFO - 'tart', 08:28:17 INFO - 'tscrollx', 08:28:17 INFO - 'cart']}, 08:28:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:28:17 INFO - 'tsvgr_opacity', 08:28:17 INFO - 'tart', 08:28:17 INFO - 'tscrollx', 08:28:17 INFO - 'cart']}, 08:28:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:28:17 INFO - 'talos_options': ['--disable-e10s'], 08:28:17 INFO - 'tests': ['tp5o']}, 08:28:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:28:17 INFO - 'tests': ['tp5o']}, 08:28:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:28:17 INFO - 'talos_options': ['--disable-e10s', 08:28:17 INFO - '--xperf_path', 08:28:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:28:17 INFO - 'tests': ['tp5n']}, 08:28:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:28:17 INFO - 'talos_options': ['--xperf_path', 08:28:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:28:17 INFO - 'tests': ['tp5n']}}, 08:28:17 INFO - 'talos.zip': {'path': '', 08:28:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:28:17 INFO - Running post-action listener: _resource_record_post_action 08:28:17 INFO - [mozharness: 2016-12-14 16:28:17.592582Z] Finished populate-webroot step (success) 08:28:17 INFO - [mozharness: 2016-12-14 16:28:17.592670Z] Running create-virtualenv step. 08:28:17 INFO - Running pre-action listener: _resource_record_pre_action 08:28:17 INFO - Running main action method: create_virtualenv 08:28:17 INFO - Creating virtualenv /builds/slave/test/build/venv 08:28:17 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 08:28:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:28:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:28:17 INFO - Using real prefix '/usr' 08:28:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:28:18 INFO - Installing distribute.............................................................................................................................................................................................done. 08:28:20 INFO - Installing pip.................done. 08:28:20 INFO - Return code: 0 08:28:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:28:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:28:20 INFO - Reading from file tmpfile_stdout 08:28:20 INFO - Output received: 08:28:20 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) 08:28:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:28:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f765f877f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1699ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1696f60>, '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 0x1697d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16981d0>, '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': '4300f881736b422476174874000001bc-1481732881.600344-1580398743', '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 08:28:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:28:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:28:20 INFO - Using env: {'DISPLAY': ':0', 08:28:20 INFO - 'HOME': '/home/cltbld', 08:28:20 INFO - 'LANG': 'en_US.UTF-8', 08:28:20 INFO - 'LANGUAGE': 'en_US:en', 08:28:20 INFO - 'LOGNAME': 'cltbld', 08:28:20 INFO - 'MAIL': '/var/mail/cltbld', 08:28:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:20 INFO - 'MOZ_NO_REMOTE': '1', 08:28:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:20 INFO - 'NO_EM_RESTART': '1', 08:28:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:20 INFO - 'PWD': '/builds/slave/test', 08:28:20 INFO - 'SHELL': '/bin/bash', 08:28:20 INFO - 'SHLVL': '1', 08:28:20 INFO - 'TERM': 'linux', 08:28:20 INFO - 'TMOUT': '86400', 08:28:20 INFO - 'USER': 'cltbld', 08:28:20 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1481732881.600344-1580398743', 08:28:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:20 INFO - '_': '/tools/buildbot/bin/python'} 08:28:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:20 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 08:28:20 INFO - Cleaning up... 08:28:20 INFO - Return code: 0 08:28:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:28:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f765f877f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1699ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1696f60>, '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 0x1697d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16981d0>, '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': '4300f881736b422476174874000001bc-1481732881.600344-1580398743', '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 08:28:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:28:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:28:20 INFO - Using env: {'DISPLAY': ':0', 08:28:20 INFO - 'HOME': '/home/cltbld', 08:28:20 INFO - 'LANG': 'en_US.UTF-8', 08:28:20 INFO - 'LANGUAGE': 'en_US:en', 08:28:20 INFO - 'LOGNAME': 'cltbld', 08:28:20 INFO - 'MAIL': '/var/mail/cltbld', 08:28:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:20 INFO - 'MOZ_NO_REMOTE': '1', 08:28:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:20 INFO - 'NO_EM_RESTART': '1', 08:28:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:20 INFO - 'PWD': '/builds/slave/test', 08:28:20 INFO - 'SHELL': '/bin/bash', 08:28:20 INFO - 'SHLVL': '1', 08:28:20 INFO - 'TERM': 'linux', 08:28:20 INFO - 'TMOUT': '86400', 08:28:20 INFO - 'USER': 'cltbld', 08:28:20 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1481732881.600344-1580398743', 08:28:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:20 INFO - '_': '/tools/buildbot/bin/python'} 08:28:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:20 INFO - Downloading/unpacking psutil>=3.1.1 08:28:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:28:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:28:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:28:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:28:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:28:22 INFO - Installing collected packages: psutil 08:28:22 INFO - Running setup.py install for psutil 08:28:23 INFO - building 'psutil._psutil_linux' extension 08:28:23 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 08:28:23 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 08:28:23 INFO - building 'psutil._psutil_posix' extension 08:28:23 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 08:28:23 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 08:28:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:28:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:28:23 INFO - Successfully installed psutil 08:28:23 INFO - Cleaning up... 08:28:23 INFO - Return code: 0 08:28:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:28:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:23 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 0x7f765f877f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1699ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1696f60>, '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 0x1697d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16981d0>, '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': '4300f881736b422476174874000001bc-1481732881.600344-1580398743', '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 08:28:23 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 08:28:23 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 08:28:23 INFO - Using env: {'DISPLAY': ':0', 08:28:23 INFO - 'HOME': '/home/cltbld', 08:28:23 INFO - 'LANG': 'en_US.UTF-8', 08:28:23 INFO - 'LANGUAGE': 'en_US:en', 08:28:23 INFO - 'LOGNAME': 'cltbld', 08:28:23 INFO - 'MAIL': '/var/mail/cltbld', 08:28:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:23 INFO - 'MOZ_NO_REMOTE': '1', 08:28:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:23 INFO - 'NO_EM_RESTART': '1', 08:28:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:23 INFO - 'PWD': '/builds/slave/test', 08:28:23 INFO - 'SHELL': '/bin/bash', 08:28:23 INFO - 'SHLVL': '1', 08:28:23 INFO - 'TERM': 'linux', 08:28:23 INFO - 'TMOUT': '86400', 08:28:23 INFO - 'USER': 'cltbld', 08:28:23 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1481732881.600344-1580398743', 08:28:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:23 INFO - '_': '/tools/buildbot/bin/python'} 08:28:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:28:23 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 08:28:23 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 08:28:23 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 08:28:23 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 08:28:23 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 08:28:23 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 08:28:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:28:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:28:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:28:25 INFO - Installing collected packages: mozsystemmonitor 08:28:25 INFO - Running setup.py install for mozsystemmonitor 08:28:25 INFO - Successfully installed mozsystemmonitor 08:28:25 INFO - Cleaning up... 08:28:25 INFO - Return code: 0 08:28:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:28:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:25 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 0x7f765f877f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1699ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1696f60>, '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 0x1697d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16981d0>, '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': '4300f881736b422476174874000001bc-1481732881.600344-1580398743', '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 08:28:25 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 08:28:25 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 08:28:25 INFO - Using env: {'DISPLAY': ':0', 08:28:25 INFO - 'HOME': '/home/cltbld', 08:28:25 INFO - 'LANG': 'en_US.UTF-8', 08:28:25 INFO - 'LANGUAGE': 'en_US:en', 08:28:25 INFO - 'LOGNAME': 'cltbld', 08:28:25 INFO - 'MAIL': '/var/mail/cltbld', 08:28:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:25 INFO - 'MOZ_NO_REMOTE': '1', 08:28:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:25 INFO - 'NO_EM_RESTART': '1', 08:28:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:25 INFO - 'PWD': '/builds/slave/test', 08:28:25 INFO - 'SHELL': '/bin/bash', 08:28:25 INFO - 'SHLVL': '1', 08:28:25 INFO - 'TERM': 'linux', 08:28:25 INFO - 'TMOUT': '86400', 08:28:25 INFO - 'USER': 'cltbld', 08:28:25 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1481732881.600344-1580398743', 08:28:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:25 INFO - '_': '/tools/buildbot/bin/python'} 08:28:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:26 INFO - Downloading/unpacking jsonschema==2.5.1 08:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:28:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:28:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:28:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:28:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:28:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:28 INFO - Downloading functools32-3.2.3-2.tar.gz 08:28:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:28:28 INFO - warning: no files found matching '*.txt' 08:28:28 INFO - no previously-included directories found matching 'build' 08:28:28 INFO - no previously-included directories found matching 'dist' 08:28:28 INFO - no previously-included directories found matching '.git*' 08:28:28 INFO - Installing collected packages: jsonschema, functools32 08:28:28 INFO - Running setup.py install for functools32 08:28:28 INFO - warning: no files found matching '*.txt' 08:28:28 INFO - no previously-included directories found matching 'build' 08:28:28 INFO - no previously-included directories found matching 'dist' 08:28:28 INFO - no previously-included directories found matching '.git*' 08:28:28 INFO - Successfully installed jsonschema functools32 08:28:28 INFO - Cleaning up... 08:28:28 INFO - Return code: 0 08:28:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:28:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:28 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 0x7f765f877f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1699ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1696f60>, '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 0x1697d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16981d0>, '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': '4300f881736b422476174874000001bc-1481732881.600344-1580398743', '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 08:28:28 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 08:28:28 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 08:28:28 INFO - Using env: {'DISPLAY': ':0', 08:28:28 INFO - 'HOME': '/home/cltbld', 08:28:28 INFO - 'LANG': 'en_US.UTF-8', 08:28:28 INFO - 'LANGUAGE': 'en_US:en', 08:28:28 INFO - 'LOGNAME': 'cltbld', 08:28:28 INFO - 'MAIL': '/var/mail/cltbld', 08:28:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:28 INFO - 'MOZ_NO_REMOTE': '1', 08:28:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:28 INFO - 'NO_EM_RESTART': '1', 08:28:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:28 INFO - 'PWD': '/builds/slave/test', 08:28:28 INFO - 'SHELL': '/bin/bash', 08:28:28 INFO - 'SHLVL': '1', 08:28:28 INFO - 'TERM': 'linux', 08:28:28 INFO - 'TMOUT': '86400', 08:28:28 INFO - 'USER': 'cltbld', 08:28:28 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1481732881.600344-1580398743', 08:28:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:28 INFO - '_': '/tools/buildbot/bin/python'} 08:28:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:28:28 INFO - Cleaning up... 08:28:28 INFO - Return code: 0 08:28:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:28:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:28 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 0x7f765f877f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1699ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1696f60>, '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 0x1697d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16981d0>, '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': '4300f881736b422476174874000001bc-1481732881.600344-1580398743', '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 08:28:28 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 08:28:28 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 08:28:28 INFO - Using env: {'DISPLAY': ':0', 08:28:28 INFO - 'HOME': '/home/cltbld', 08:28:28 INFO - 'LANG': 'en_US.UTF-8', 08:28:28 INFO - 'LANGUAGE': 'en_US:en', 08:28:28 INFO - 'LOGNAME': 'cltbld', 08:28:28 INFO - 'MAIL': '/var/mail/cltbld', 08:28:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:28 INFO - 'MOZ_NO_REMOTE': '1', 08:28:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:28 INFO - 'NO_EM_RESTART': '1', 08:28:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:28 INFO - 'PWD': '/builds/slave/test', 08:28:28 INFO - 'SHELL': '/bin/bash', 08:28:28 INFO - 'SHLVL': '1', 08:28:28 INFO - 'TERM': 'linux', 08:28:28 INFO - 'TMOUT': '86400', 08:28:28 INFO - 'USER': 'cltbld', 08:28:28 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1481732881.600344-1580398743', 08:28:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:28 INFO - '_': '/tools/buildbot/bin/python'} 08:28:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:29 INFO - Downloading/unpacking blobuploader==1.2.4 08:28:29 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 08:28:29 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 08:28:29 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 08:28:29 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 08:28:29 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 08:28:29 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 08:28:30 INFO - Downloading blobuploader-1.2.4.tar.gz 08:28:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:28:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:28:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:28:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:28:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:28:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:28:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:28:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:28:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:31 INFO - Downloading docopt-0.6.1.tar.gz 08:28:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:28:31 INFO - Installing collected packages: blobuploader, requests, docopt 08:28:31 INFO - Running setup.py install for blobuploader 08:28:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:28:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:28:31 INFO - Running setup.py install for requests 08:28:32 INFO - Running setup.py install for docopt 08:28:32 INFO - Successfully installed blobuploader requests docopt 08:28:32 INFO - Cleaning up... 08:28:32 INFO - Return code: 0 08:28:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:28: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')]} 08:28:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28: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')]} 08:28:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:32 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 0x7f765f877f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1699ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1696f60>, '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 0x1697d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16981d0>, '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': '4300f881736b422476174874000001bc-1481732881.600344-1580398743', '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 08:28:32 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 08:28:32 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 08:28:32 INFO - Using env: {'DISPLAY': ':0', 08:28:32 INFO - 'HOME': '/home/cltbld', 08:28:32 INFO - 'LANG': 'en_US.UTF-8', 08:28:32 INFO - 'LANGUAGE': 'en_US:en', 08:28:32 INFO - 'LOGNAME': 'cltbld', 08:28:32 INFO - 'MAIL': '/var/mail/cltbld', 08:28:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:32 INFO - 'MOZ_NO_REMOTE': '1', 08:28:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:32 INFO - 'NO_EM_RESTART': '1', 08:28:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:32 INFO - 'PWD': '/builds/slave/test', 08:28:32 INFO - 'SHELL': '/bin/bash', 08:28:32 INFO - 'SHLVL': '1', 08:28:32 INFO - 'TERM': 'linux', 08:28:32 INFO - 'TMOUT': '86400', 08:28:32 INFO - 'USER': 'cltbld', 08:28:32 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1481732881.600344-1580398743', 08:28:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:32 INFO - '_': '/tools/buildbot/bin/python'} 08:28:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:28:32 INFO - Running setup.py (path:/tmp/pip-jamhS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:28:32 INFO - Running setup.py (path:/tmp/pip-U4knAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:28:32 INFO - Running setup.py (path:/tmp/pip-KGVdfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:28:32 INFO - Running setup.py (path:/tmp/pip-yAz9ve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:28:32 INFO - Running setup.py (path:/tmp/pip-gQOdWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:28:33 INFO - Running setup.py (path:/tmp/pip-p78fPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:28:33 INFO - Running setup.py (path:/tmp/pip-TaMHrN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:28:33 INFO - Running setup.py (path:/tmp/pip-WRBJzr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:28:33 INFO - Running setup.py (path:/tmp/pip-ujhnyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:28:33 INFO - Running setup.py (path:/tmp/pip-zHYLUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:28:33 INFO - Running setup.py (path:/tmp/pip-13j265-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:28:33 INFO - Running setup.py (path:/tmp/pip-goHnSU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:28:33 INFO - Running setup.py (path:/tmp/pip-kIo5nD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:28:33 INFO - Running setup.py (path:/tmp/pip-Nd3u9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:28:33 INFO - Running setup.py (path:/tmp/pip-crgHpi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:28:33 INFO - Running setup.py (path:/tmp/pip-_HF1Oi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:28:33 INFO - Running setup.py (path:/tmp/pip-KPttxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:28:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:28:33 INFO - Running setup.py install for manifestparser 08:28:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:28:33 INFO - Running setup.py install for mozcrash 08:28:34 INFO - Running setup.py install for mozdebug 08:28:34 INFO - Running setup.py install for mozdevice 08:28:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:28:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:28:34 INFO - Running setup.py install for mozfile 08:28:34 INFO - Running setup.py install for mozhttpd 08:28:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:28:34 INFO - Running setup.py install for mozinfo 08:28:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:28:34 INFO - Running setup.py install for mozInstall 08:28:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:28:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:28:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:28:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:28:34 INFO - Running setup.py install for mozleak 08:28:34 INFO - Running setup.py install for mozlog 08:28:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:28:34 INFO - Running setup.py install for moznetwork 08:28:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:28:35 INFO - Running setup.py install for mozprocess 08:28:35 INFO - Running setup.py install for mozprofile 08:28:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:28:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:28:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:28:35 INFO - Running setup.py install for mozrunner 08:28:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:28:35 INFO - Running setup.py install for mozscreenshot 08:28:35 INFO - Running setup.py install for moztest 08:28:35 INFO - Running setup.py install for mozversion 08:28:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:28:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:28:35 INFO - Cleaning up... 08:28:35 INFO - Return code: 0 08:28:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:28:35 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')]} 08:28:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:35 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')]} 08:28:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:35 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 0x7f765f877f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1699ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1696f60>, '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 0x1697d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16981d0>, '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': '4300f881736b422476174874000001bc-1481732881.600344-1580398743', '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 08:28:35 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 08:28:35 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 08:28:35 INFO - Using env: {'DISPLAY': ':0', 08:28:35 INFO - 'HOME': '/home/cltbld', 08:28:35 INFO - 'LANG': 'en_US.UTF-8', 08:28:35 INFO - 'LANGUAGE': 'en_US:en', 08:28:35 INFO - 'LOGNAME': 'cltbld', 08:28:35 INFO - 'MAIL': '/var/mail/cltbld', 08:28:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:35 INFO - 'MOZ_NO_REMOTE': '1', 08:28:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:35 INFO - 'NO_EM_RESTART': '1', 08:28:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:35 INFO - 'PWD': '/builds/slave/test', 08:28:35 INFO - 'SHELL': '/bin/bash', 08:28:35 INFO - 'SHLVL': '1', 08:28:35 INFO - 'TERM': 'linux', 08:28:35 INFO - 'TMOUT': '86400', 08:28:35 INFO - 'USER': 'cltbld', 08:28:35 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1481732881.600344-1580398743', 08:28:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:35 INFO - '_': '/tools/buildbot/bin/python'} 08:28:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:28:35 INFO - Running setup.py (path:/tmp/pip-RGFliH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:28:35 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)) 08:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:28:35 INFO - Running setup.py (path:/tmp/pip-WJECjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:28:36 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)) 08:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:28:36 INFO - Running setup.py (path:/tmp/pip-JTu8S8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:28:36 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)) 08:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:28:36 INFO - Running setup.py (path:/tmp/pip-bubAEr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:28:36 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)) 08:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:28:36 INFO - Running setup.py (path:/tmp/pip-HU5R_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:28:36 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)) 08:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:28:36 INFO - Running setup.py (path:/tmp/pip-t3E2oX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:28:36 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)) 08:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:28:36 INFO - Running setup.py (path:/tmp/pip-5epzcO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:28:36 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)) 08:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:28:36 INFO - Running setup.py (path:/tmp/pip-NEhtbi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:28:36 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)) 08:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:28:36 INFO - Running setup.py (path:/tmp/pip-ZNthup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:28:36 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)) 08:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:28:36 INFO - Running setup.py (path:/tmp/pip-Zy5VAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:28:36 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)) 08:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:28:36 INFO - Running setup.py (path:/tmp/pip-Ro1elV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:28:36 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)) 08:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:28:36 INFO - Running setup.py (path:/tmp/pip-EAsEiM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:28:36 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)) 08:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:28:36 INFO - Running setup.py (path:/tmp/pip-nu2Xys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:28:36 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)) 08:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:28:36 INFO - Running setup.py (path:/tmp/pip-SWsC0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:28:36 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)) 08:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:28:36 INFO - Running setup.py (path:/tmp/pip-D3knmH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:28:36 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)) 08:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:28:36 INFO - Running setup.py (path:/tmp/pip-_hgQjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:28:37 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)) 08:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:28:37 INFO - Running setup.py (path:/tmp/pip-gEdW04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:28:37 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)) 08:28:37 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)) 08:28:37 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)) 08:28:37 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)) 08:28:37 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)) 08:28:37 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)) 08:28:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:28:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:28:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:28:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:39 INFO - Downloading blessings-1.6.tar.gz 08:28:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:28:39 INFO - Installing collected packages: blessings 08:28:39 INFO - Running setup.py install for blessings 08:28:39 INFO - Successfully installed blessings 08:28:39 INFO - Cleaning up... 08:28:39 INFO - Return code: 0 08:28:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:28:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:28:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:28:39 INFO - Reading from file tmpfile_stdout 08:28:39 INFO - Current package versions: 08:28:39 INFO - argparse == 1.2.1 08:28:39 INFO - blessings == 1.6 08:28:39 INFO - blobuploader == 1.2.4 08:28:39 INFO - docopt == 0.6.1 08:28:39 INFO - functools32 == 3.2.3-2 08:28:39 INFO - jsonschema == 2.5.1 08:28:39 INFO - manifestparser == 1.1 08:28:39 INFO - mozInstall == 1.12 08:28:39 INFO - mozcrash == 1.0 08:28:39 INFO - mozdebug == 0.1 08:28:39 INFO - mozdevice == 0.48 08:28:39 INFO - mozfile == 1.2 08:28:39 INFO - mozhttpd == 0.7 08:28:39 INFO - mozinfo == 0.9 08:28:39 INFO - mozleak == 0.1 08:28:39 INFO - mozlog == 3.4 08:28:39 INFO - moznetwork == 0.27 08:28:39 INFO - mozprocess == 0.23 08:28:39 INFO - mozprofile == 0.28 08:28:39 INFO - mozrunner == 6.13 08:28:39 INFO - mozscreenshot == 0.1 08:28:39 INFO - mozsystemmonitor == 0.3 08:28:39 INFO - moztest == 0.7 08:28:39 INFO - mozversion == 1.4 08:28:39 INFO - psutil == 3.1.1 08:28:39 INFO - requests == 1.2.3 08:28:39 INFO - wsgiref == 0.1.2 08:28:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:28:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:39 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 0x7f765f877f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1699ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1696f60>, '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 0x1697d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16981d0>, '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': '4300f881736b422476174874000001bc-1481732881.600344-1580398743', '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 08:28:39 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 08:28:39 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 08:28:39 INFO - Using env: {'DISPLAY': ':0', 08:28:39 INFO - 'HOME': '/home/cltbld', 08:28:39 INFO - 'LANG': 'en_US.UTF-8', 08:28:39 INFO - 'LANGUAGE': 'en_US:en', 08:28:39 INFO - 'LOGNAME': 'cltbld', 08:28:39 INFO - 'MAIL': '/var/mail/cltbld', 08:28:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:39 INFO - 'MOZ_NO_REMOTE': '1', 08:28:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:39 INFO - 'NO_EM_RESTART': '1', 08:28:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:39 INFO - 'PWD': '/builds/slave/test', 08:28:39 INFO - 'SHELL': '/bin/bash', 08:28:39 INFO - 'SHLVL': '1', 08:28:39 INFO - 'TERM': 'linux', 08:28:39 INFO - 'TMOUT': '86400', 08:28:39 INFO - 'USER': 'cltbld', 08:28:39 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1481732881.600344-1580398743', 08:28:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:39 INFO - '_': '/tools/buildbot/bin/python'} 08:28:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:39 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)) 08:28:39 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)) 08:28:39 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)) 08:28:39 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)) 08:28:39 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)) 08:28:39 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)) 08:28:39 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)) 08:28:39 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)) 08:28:39 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)) 08:28:39 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)) 08:28:39 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)) 08:28:39 INFO - Cleaning up... 08:28:39 INFO - Return code: 0 08:28:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:28:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f765f877f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1699ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1696f60>, '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 0x1697d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16981d0>, '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': '4300f881736b422476174874000001bc-1481732881.600344-1580398743', '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 08:28:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:28:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:28:39 INFO - Using env: {'DISPLAY': ':0', 08:28:39 INFO - 'HOME': '/home/cltbld', 08:28:39 INFO - 'LANG': 'en_US.UTF-8', 08:28:39 INFO - 'LANGUAGE': 'en_US:en', 08:28:39 INFO - 'LOGNAME': 'cltbld', 08:28:39 INFO - 'MAIL': '/var/mail/cltbld', 08:28:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:39 INFO - 'MOZ_NO_REMOTE': '1', 08:28:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:39 INFO - 'NO_EM_RESTART': '1', 08:28:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:39 INFO - 'PWD': '/builds/slave/test', 08:28:39 INFO - 'SHELL': '/bin/bash', 08:28:39 INFO - 'SHLVL': '1', 08:28:39 INFO - 'TERM': 'linux', 08:28:39 INFO - 'TMOUT': '86400', 08:28:39 INFO - 'USER': 'cltbld', 08:28:39 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1481732881.600344-1580398743', 08:28:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:39 INFO - '_': '/tools/buildbot/bin/python'} 08:28:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:28:40 INFO - Cleaning up... 08:28:40 INFO - Return code: 0 08:28:40 INFO - Running post-action listener: _resource_record_post_action 08:28:40 INFO - Running post-action listener: _start_resource_monitoring 08:28:40 INFO - Starting resource monitoring. 08:28:40 INFO - [mozharness: 2016-12-14 16:28:40.073784Z] Finished create-virtualenv step (success) 08:28:40 INFO - [mozharness: 2016-12-14 16:28:40.074277Z] Running install step. 08:28:40 INFO - Running pre-action listener: _resource_record_pre_action 08:28:40 INFO - Running main action method: install 08:28:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:28:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:28:40 INFO - Reading from file tmpfile_stdout 08:28:40 INFO - Detecting whether we're running mozinstall >=1.0... 08:28:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:28:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:28:40 INFO - Reading from file tmpfile_stdout 08:28:40 INFO - Output received: 08:28:40 INFO - Usage: mozinstall [options] installer 08:28:40 INFO - Options: 08:28:40 INFO - -h, --help show this help message and exit 08:28:40 INFO - -d DEST, --destination=DEST 08:28:40 INFO - Directory to install application into. [default: 08:28:40 INFO - "/builds/slave/test"] 08:28:40 INFO - --app=APP Application being installed. [default: firefox] 08:28:40 INFO - mkdir: /builds/slave/test/build/application 08:28:40 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'] 08:28:40 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 08:28:56 INFO - Reading from file tmpfile_stdout 08:28:56 INFO - Output received: 08:28:56 INFO - /builds/slave/test/build/application/firefox/firefox 08:28:56 INFO - Running post-action listener: _resource_record_post_action 08:28:56 INFO - [mozharness: 2016-12-14 16:28:56.841244Z] Finished install step (success) 08:28:56 INFO - [mozharness: 2016-12-14 16:28:56.841554Z] Running run-tests step. 08:28:56 INFO - Running pre-action listener: _resource_record_pre_action 08:28:56 INFO - Running main action method: run_tests 08:28:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:28:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:28:56 INFO - Python 2.7.3 08:28:56 INFO - Return code: 0 08:28:56 INFO - grabbing minidump binary from tooltool 08:28:56 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')]} 08:28:56 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 0x1696f60>, '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 0x1697d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16981d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:28:56 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 08:28:56 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 08:28:56 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 08:28:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:28:56 INFO - Return code: 0 08:28:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:28:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:28:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:28:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:28:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:28:56 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/LiX5Ig4KSzi7T16syMTLkA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 08:28:56 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/LiX5Ig4KSzi7T16syMTLkA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --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 08:28:56 INFO - Using env: {'DISPLAY': ':0', 08:28:56 INFO - 'HOME': '/home/cltbld', 08:28:56 INFO - 'LANG': 'en_US.UTF-8', 08:28:56 INFO - 'LANGUAGE': 'en_US:en', 08:28:56 INFO - 'LOGNAME': 'cltbld', 08:28:56 INFO - 'MAIL': '/var/mail/cltbld', 08:28:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:28:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:28:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:56 INFO - 'MOZ_NO_REMOTE': '1', 08:28:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:28:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:56 INFO - 'NO_EM_RESTART': '1', 08:28:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:56 INFO - 'PWD': '/builds/slave/test', 08:28:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:28:56 INFO - 'SHELL': '/bin/bash', 08:28:56 INFO - 'SHLVL': '1', 08:28:56 INFO - 'TERM': 'linux', 08:28:56 INFO - 'TMOUT': '86400', 08:28:56 INFO - 'USER': 'cltbld', 08:28:56 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1481732881.600344-1580398743', 08:28:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:56 INFO - '_': '/tools/buildbot/bin/python'} 08:28:56 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/LiX5Ig4KSzi7T16syMTLkA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 08:28:57 INFO - mozversion application_buildid: 20161214064001 08:28:57 INFO - mozversion application_changeset: 7bfeec8395e5ca28421d92f3bf51d56feafc0319 08:28:57 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:28:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:28:57 INFO - mozversion application_name: Firefox 08:28:57 INFO - mozversion application_remotingname: firefox-dev 08:28:57 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:28:57 INFO - mozversion application_vendor: Mozilla 08:28:57 INFO - mozversion application_version: 52.0a2 08:28:57 INFO - mozversion platform_buildid: 20161214064001 08:28:57 INFO - mozversion platform_changeset: 7bfeec8395e5ca28421d92f3bf51d56feafc0319 08:28:57 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:28:57 INFO - mozversion platform_version: 52.0a2 08:28:57 INFO - using testdate: 1481732937 08:28:57 INFO - actual date: 1481732937 08:28:57 INFO - starting webserver on 'localhost:33773' 08:28:57 INFO - SUITE-START | Running 2 tests 08:28:57 INFO - TEST-START | dromaeo_css 08:28:57 INFO - operating with platform_type : linux_ 08:28:57 INFO - Initialising browser for dromaeo_css test... 08:28:57 INFO - TEST-INFO | started process 27334 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBSMlIA/profile http://localhost:33773/getInfo.html) 08:29:01 INFO - PROCESS | 27334 | __metrics Screen width/height:1600/1200 08:29:01 INFO - PROCESS | 27334 | colorDepth:24 08:29:01 INFO - PROCESS | 27334 | Browser inner width/height: 1024/697 08:29:01 INFO - PROCESS | 27334 | __metrics 08:29:02 ERROR - PROCESS | 27334 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 08:29:03 INFO - TEST-INFO | 27334: exit 0 08:29:03 INFO - Browser initialized. 08:29:03 INFO - Running cycle 1/1 for dromaeo_css test... 08:29:03 INFO - TEST-INFO | started process 27468 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBSMlIA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:29:14 INFO - PROCESS | 27468 | RSS: Main: 151941120 08:29:14 INFO - PROCESS | 27468 | 08:30:04 INFO - PROCESS | 27468 | 1481733004482 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] 08:32:15 INFO - PROCESS | 27468 | Cycle 1(1): loaded http://localhost:33773/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33773/tests/dromaeo/cssquery-ext.html) 08:32:16 INFO - PROCESS | 27468 | RSS: Main: 155635712 08:32:16 INFO - PROCESS | 27468 | 08:35:18 INFO - PROCESS | 27468 | Cycle 1(1): loaded http://localhost:33773/tests/dromaeo/cssquery-ext.html (next: http://localhost:33773/tests/dromaeo/cssquery-jquery.html) 08:35:19 INFO - PROCESS | 27468 | RSS: Main: 153292800 08:35:19 INFO - PROCESS | 27468 | 08:38:20 INFO - PROCESS | 27468 | Cycle 1(1): loaded http://localhost:33773/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33773/tests/dromaeo/cssquery-mootools.html) 08:38:21 INFO - PROCESS | 27468 | RSS: Main: 152752128 08:38:21 INFO - PROCESS | 27468 | 08:41:23 INFO - PROCESS | 27468 | Cycle 1(1): loaded http://localhost:33773/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33773/tests/dromaeo/cssquery-prototype.html) 08:41:23 INFO - PROCESS | 27468 | RSS: Main: 151658496 08:41:23 INFO - PROCESS | 27468 | 08:44:26 INFO - PROCESS | 27468 | Cycle 1(1): loaded http://localhost:33773/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33773/tests/dromaeo/cssquery-yui.html) 08:44:27 INFO - PROCESS | 27468 | RSS: Main: 153657344 08:44:27 INFO - PROCESS | 27468 | 08:47:29 INFO - PROCESS | 27468 | Cycle 1(1): loaded http://localhost:33773/tests/dromaeo/cssquery-yui.html (next: http://localhost:33773/tests/dromaeo/cssquery-dojo.html) 08:47:29 INFO - PROCESS | 27468 | RSS: Main: 155127808 08:47:29 INFO - PROCESS | 27468 | 08:47:29 INFO - PROCESS | 27468 | __start_tp_report 08:47:29 INFO - PROCESS | 27468 | _x_x_mozilla_page_load 08:47:29 INFO - PROCESS | 27468 | _x_x_mozilla_page_load_details 08:47:29 INFO - PROCESS | 27468 | |i|pagename|runs| 08:47:29 INFO - PROCESS | 27468 | |0;dojo.html;3288.2272665923506;3296.9340613187737;3298.4392653248947;3303.0965282559446;3316.0880757791606;5720.742566584503;5754.108113242443;5762.971185144069;5796.942030579693;5815.4475324844125;5793.507551858087;5816.418358164182;5842.357340692531;5848.824535263938;5863.149843272734;5220.112580861243;5259.421463638997;5292.153255479124;5301.231321458386;5321.201819727034;5313.043652142613;5322.787088516455;5331.040412725708;5338.546223571001;5359.678419294835;5119.411267704225;5150.922736158961;5356.11624082026;5362.731863406833;5383.919241211385;5214.921776173361;5249.4750524947585;5265.710385928773;5289.206619007141;5320.787168513255;5206.271122042917;5208.8958220835375;5285.207218917155;5296.92054619181;5309.442508536626;5768.74040668171;5797.942020579782;5814.186013958049;5880.852978675524;5918.171455996164;6024.728887200086;6074.5747797654185;6102.6948652567635;6143.170671959318;6156.722947467375;6173.116974573363;6188.040853667689;6221.813345599639;6225.3774622537385;6252.406021427957;5744.856378590569;5772.134179872969;5790.420957904218;5795.681237531934;5811.389804070596;6246.406591373812;6269.5611307208055;6292.622442653455;6395.648239346788;6406.391392817675;6121.755129794758;6127.387261273837;6133.355997620275;6155.692215389213;6158.261008678987;6031.849203769941;6253.405926436982;6260.436560709558;6263.467605253513;6263.592866463665;5976.103584462278;6016.759329626766;6028;6076.817695469143;6077.1491991121275;6091.969540152271;6104.481119104926;6106.877862442726;6111.236095488064;6121.387861213843;4715.7642117893965;4726.7636618169645;4739.739314337676;4740.3837501124635;4772.403449568804;4100.220958017967;4163.625273725379;4173.728707634054;4189.895252618648;4237.258479766028;5932.139839723216;5938.168656388109;5945.464908158287;5976.432238937294;6000.879982400327;5996.460318571262;6152.3540028297275;6163.106349579286;6206.317305096436;6214.782482613177;5784.82645520635;5899.557533185029;5904.616199947076;5926.348101708809;6021.3677563856045;5266.236395722599;5291.497307755757;5301.072312345401;5307.416184219733;5316;6431.6462594556815;6530.249021362414;6538.738450461929;6565.638889861103;6568;5964.343922168471;6017.518598512196;6114.054067497291;6119.724612392364;6140.938590614037;6433.742650293936;6476.125723027331;6485.643289618927;6489.123968264224;6506.967465162644;6029.035354343284;6052.455279024733;6061.424164704346;6062.454379105901;6065.8180254592435;5920.082387229986;6060.060690592965;6136.090214303778;6138.907916381168;6201.96899015502;6070.3929607038945;6085.330613632408;6122.123717501779;6126.927787637234;6129.542179248731;6091.573589848846;6105.17580126695;6108.786192483241;6117.480014198843;6126.050462178369;5787;5884.176215329771;5892.175095486721;5997.970010149921;6036.154938308552;6009.128676341818;6072.271327440735;6088.543359247986;6102.298235702951;6108.816735497942;5870.677112758839;5950.672713000827;5952.702364881825;5960.940390596039;5967.224260846062 08:47:29 INFO - PROCESS | 27468 | |1;ext.html;634.09324665728;649.8537828988477;683.8119517132787;693.7363801755332;721.8231533274342;40194.397084043725;45071.323930141036;45126;45227.547724522745;45352;45744.542554574444;46095.53904460963;46230.76884615581;46642.7667861661;46713.76643116788;8534.573271336454;8751.606177721986;8778.122187781235;8793.868091978626;8835.95582022089;8683.305335573139;8740.169683880053;8795.076516965722;8808.339374546935;8827.426217295888;8839.602217900177;8879.378443508956;8911.73264802057;8928.866067008968;8933.46399216049;8734.737957861242;8768.167024132728;8780.560971951409;8808.251298639623;8812.779680508038;8714.694985675535;8740.8688869667;8751.168638979287;8766.561671916379;8808.955955220246;42017.78991105025;42124;42289.36565951513;42543;42546.1490770186;3531.4526248431534;3684.392075307571;3692.778433294011;3769.736118471708;4002.1595464952393;31378.37243255145;31378.686213138033;31638.209044773834;31639.525407118912;31836.20409489758;4406.779661016968;4465.222212232912;4470.128324976631;4516.254817955033;4537;360323.198384009;362237;362424;363859;364248;62938.68530657318;62942.37057629457;63115.6844215776;63394.36605633977;63443;65871.67064164649;66614.33385666179;66656.6667166661;66712.33287667159;66758.66620666865;17141.914290428467;17295.394661186798;17388.739168912478;17426.65146697059;17506.12469376526;13314.600561983156;13340;13358.799618005738;13495.257760823053;13501.66245843842;18042.037714168902;18984.14571344293;19059.237630494627;19101.808981910282;19109.522261943286;6453.580517266362;6545.181852268466;6574.8356291093105;6861.382475577222;6873.690683919235;1027.7893031928436;1111.8109921313396;1117.100733909211;1148.6152139033518;1163.116031815826;32785.672143278265;33183;33228.1692957678;33259;33644.158896027795;1138.2605120686187;1216.5620376664394;1225.5097960815567;1234.2471092633486;1248.6628610275175;17335.393261235797;17444.302227910743;17475.650486990187;17533.29866805339;17743.29026838912;536452;538470;540207;542975;544174;60906.69546652327;61252.999999999105;61296.693516532134;61342.69328653417;61347.38652613506;1409.7603407420763;1441.0417072646783;1446.5732608880405;1449.6520834999524;1455.6797504548983;31396.68603314029;32589.18527036843;33024.834875826426;33244.50133247955;33259.50110748292;53824.19263711126;53829.73085134549;54060.18909716436;54113.10604128837;54269.18596221139;450236;451839;453486;455123;455357;42558.36162457504;42790.14419711526;42899.785501073544;43027;45054;49020.5097949016;50643.24035139402;50866;51663.74168129135;51773.48226517686;42537.78731106325;42814.57185428106;43575.56424435715;43816.561834382526;45351;43211.35182972195;43338.56661433345;43415.553715876034;43814.34278485762;44100;39760.403593945535;45304.77347613241;46071.3089303654;46594.76702616465;46770.53229467662;40915.59084409118;41555.1688966213;41732.58267417287;45121.54878451305;45890.541094588625;35302.29395412129;36042.8197859009;36089.81955090208;36303.81848090742;36550.817245914666 08:47:29 INFO - PROCESS | 27468 | |2;jquery.html;404.4499480706241;409.68863663615645;421.5215730146284;431.68487004486735;441.41292081531566;18786.248550057997;19748.506287342825;19831.405057848253;19952.102155403005;20529.178832846686;18987.52531186721;19423.12595933183;19477.318293859684;19583.314583989562;19591.41225763226;5126.077306084903;5356.651817631861;5378.112611419131;5423.322084739408;5425.213344065108;5165.560927321182;5344.278522399484;5351.625386222966;5361.758720857571;5368.30212072432;5265.236540701596;5330.040592693314;5347.491988261128;5353.411124776271;5356.866078348034;5285.781884292596;5337.6797392156595;5348.598855085865;5349.8127565535215;5946.851328716817;5259.631825772198;5397.379301380352;5444.727763611803;5449.809256675997;5459.563234941234;13365.53220637273;13561.86438135616;23567.17514886988;23781.88109059461;23843.82088841016;2306.1928325086255;2365.231299827563;2529.519391315644;2557.6035714464288;2726.168518601826;10098.545565449573;10104.49477526128;10143.847842282297;10521.947390263076;11412.258203216765;1920.8655394122418;1993.431871916497;2012.3962811156593;2023.6357455657976;2056.3728062940795;86898.5655071727;87062;88262.5586872068;88422.11577884204;88714.55642721745;9401.388909720847;10022.749431264278;10113.393196408091;11091.778164436666;11096.722581935515;14996.325165367585;15060.849391505944;15077.472288469851;15091.471798487;15091.773623395658;7967.322777563972;8080.636371363185;8139;8191.0580283267;8212.940553435583;7949.682012719542;8213.301869341054;8245.876311855327;8410.705625303084;8444.197801208875;4150.750954942713;4247.426597409372;4285.46431696038;4426.3581780641625;4489.7979590918485;2071.7099606055162;2101.5586726787546;2175.042981088316;2193.3529608765452;2216.9627610174166;917.8072604752944;972.8735264415723;982.1700662939804;1060.9469526523642;1075.3386667199616;20018.89990550038;20234.494137646678;20317.18731250763;20349.59300814005;20666.689999650018;990.0792263195153;1045.5765415006933;1046.4296958157822;1086.6305456144948;1102.9889701102886;10703.411312377739;11387.601433949772;11507.597234096766;11580.305181689126;11664.300141991507;501709;514388;525645;536870;540715;59607.70196148992;70372.64813675899;92965;94358.5282073599;94554;1007.6698757639845;1017.4099022566893;1028.5525796278644;1028.5834237133972;1058.0530425269342;17851.285948561912;18037.819621803614;18245.178966946783;18259.81740182581;18508.81491185071;43738;44339.55660443354;44555;44700.77649611861;45218;60970.69514652398;61284.387156127865;61621.69189154026;61883.524659013136;62278.37721622726;8520.233179013918;8650.697225597074;8704.608292626974;9283.11810378013;9454.95272523633;13079.346032698137;13103.672408189872;13135.146215495963;13157.210567365988;13234.139780914209;11062.723431913944;11386.316820990767;11516.539338426704;11636.76726465449;11781.941090294493;10933.125349972142;11245.381504017358;11329.603463878724;11440.656780296604;11958.521659133885;11418.200725949104;11599.246049006788;11699.12256580777;11909;12021.158518903943;8469.153084691481;8589.44168629037;8674;8693.434926729742;9109.407888487227;6821.965890170517;11201.599800024997;11462.885371146182;11709.941450292694;12044.819327709916 08:47:29 INFO - PROCESS | 27468 | |3;mootools.html;1481.9703605927882;1541.506717850288;1721.4749501402068;1791.1223500484766;1821.317006122705;7870.842583148334;8049.959750201241;8106.35149188065;8639.52482613456;8640.91359086409;7845.882311765328;8113.985751781027;8119.14748951359;8249.133840946704;8312.750617481484;2368.727596326423;2408.4460574067975;2409.9277021689377;2410.3853517353136;2413.613821788514;2414.5653782319177;2453.178185307924;2457.5576396248666;2459.86470744109;2481.553320402327;2389.104085967762;2401.9759802402014;2413.9275821725378;2426.9757302426924;2431.088341871798;2260.5930932432157;2305.66567847662;2308.8499247548857;2323.8373313868037;2330.102910379499;2367.5975084235547;2384.7257565380028;2389.0443822470975;2393.3537944754994;2395.616701327779;8343.749687509384;8410.285125764318;8677.349198810052;8895.243904268145;8939.150780675825;5293.57651387888;5359.356877174764;5367.812126575551;5397.568194544427;5406.513413792738;3425.794452332868;3447.77589456687;3505.964940350615;3511.2450823072904;3569.6965757910607;1130.9886901130965;1153.74040840811;1183.5029287699188;1208.836807031057;1215.6535387414633;11943.223690460092;11967.880321196852;12044.27734335934;12112.031037517065;12138.332391718452;4642.532712267347;4767.952320476751;4849.2968519565175;4919.237518184687;4974.701517908937;10249.897501025043;10254.948725256327;10258.333208341433;10290.691279261635;10317.84523232152;5481.424450432727;5491.176323551499;5501.587380946365;5522.475364840334;5537.861553461195;4543.750093744809;4698.671093023456;5011.749412529359;5058.494150584986;5094.719790411489;4191.392248124005;4209.095044565433;4306.267934451151;4322.827086916551;4331.350297455407;1366.7539842828187;1407.5566196648024;1418.319206780751;1422.665673566711;1435.346917152693;868.7871471489525;883.3904605821963;979.4612962870393;988.4958671077802;1002.3685078400707;5842;5893.381194974551;5904.76380944766;5934.258217722785;6033.366496517802;464.2201102148356;469.4015130708306;472.5492737296535;474.95487928646725;477.8279819265062;4126.339785634284;4161.750294982311;4177.811998460076;4205.516365617932;4222.493300803923;10578.471076446147;10778.029977301923;10810.081143102925;10849.02358787713;10905.890941090645;10559.894401056044;10645.680629581126;10708.785824283626;10740.94629526863;10746.570137194582;7818.765437036898;8057.35541156706;8058.395620328499;8244.134365891616;8246.422750407413;5961.837441699001;5965.73154208053;6106.542009349228;6120.816375508742;6258.217722784652;9873.308868379145;9934.652287169914;10037.397756134655;10155.136813370946;10196.898031019595;9968.800623987625;9989.400635961574;10085.949570252102;10136.847947280945;10144;7259.12890453149;7275.708971641287;7316.707331706672;7530.548167109771;7539.1706912238515;8167.959160204161;8295.460795048302;8298.294644955246;8314.584270786558;8331.33349332064;7395.926040739739;7424.36892864091;7432.702691892264;7482.2517748224745;7663.463557550918;7252.637368131467;7298.708051677873;7355.5586664800285;7376.483646144933;7421.851562968603;6863.279355667583;6970.128733908262;6989.790306290819;7000.439964802906;7007.334303241184;5219.634625576326;5245.134552798745;5267.183586544092;5322.946770532245;5466.753996070107;5096.51583099605;5128.58971282304;5169.560587349967;5219.686818790885;5258.553022993088 08:47:29 INFO - PROCESS | 27468 | |4;prototype.html;354.24545717621464;356.7538398505032;368.30941983780406;373.1585275204415;376.2024508042949;5462.153366228231;5542.949108829739;5573.33120025597;5643.830685079444;5648.491635752786;5417.6207665463435;5492.47821456961;5496.615236933416;5509.47659972302;5518.613697041209;4406.449193850769;4406.633943477525;4425.933610995838;4426.933595996063;4434.312681534351;4183.163367326531;4370.3007518797;4388.495323037843;4405.140997505488;4450.26570615848;4317.15815415994;4341.110072435144;4345.696291112654;4351.847685331014;4372.366006928994;4338.696291259613;4345.3047512398025;4354.8911277218;4368.934465983013;4446.644268458515;3852.6917846572205;3868.8065596720053;3917.8236979335998;3935.704822138351;3937.7046721496004;5391.353037635469;5409.24270602116;5431.619786614939;5435.619506634537;5467.644603100785;4958.603311735053;5023.271625614266;5029.5221953914315;5040.294358789773;5040.445550989388;5643.181738647914;5769.826905192851;5770.913436298459;5801.577069528998;5812.186293918855;4258.530806871624;4267.445232119836;4270.14597080582;4274.337477690963;4280.464941882265;6029.336772954972;6069.119977603267;6108.786192483286;6114.266288045463;6131.202943617346;4312.159128969821;4316.9639286571;4327.870163895088;4366.345048242789;4407.906244533885;4418.55814418562;4424.933625995613;4428.579284967923;4431.977840110843;4442.777861106932;5032.169692000779;5040;5055.241713742968;5056.216286475602;5065.290859279704;5640.294963129609;5739.942600573941;5855.648661080349;5892.440218179266;5907.4683278505145;1482.570054684151;1491.7762335649522;1493.6340596553914;1497.2289271025431;1501.7747337899402;1016.3150478453682;1033.547865249326;1035.9223058270659;1044.4621020174616;1049.2917280835406;5537.335519737658;5541.418151094158;5556.638818476867;5567.805126820542;5572;5816.854578635568;5870.295564532284;5884.440978107073;5926.348101708809;5944.464998150187;5478.534324582455;5560.7460292875985;5582.888342233133;5602.327720673546;5672.205891175238;3107.467414057581;3114.4861097919043;3118.454270502653;3124.6876311949036;3137.5450559669175;5871.823845284648;6003.669798161143;6063.7574497020505;6138.570300079041;6148.385161483905;5842.678652674143;5903;5921.911171332434;5941.287045554561;5966.224390829165;5959.314678811992;6014.308354539196;6022.849428764316;6040.244969378828;6072.180255665517;5677.914831277617;5678.716064196857;5690.487856092972;5782.190493331022;5786.392428794916;5658.434156584309;5708.7165133946755;5712.828615141552;5713;5729.713514324184;5782.826515204551;5975.970120149545;6096.1465394845645;6130.417610327012;6138.202033735586;4171.207470580702;4180.561041090642;4192.24539582878;4201.18076974987;4215.325547912319;5823.806119745357;5884.911726324023;5899.587028907935;5909.734061967136;6024.349286314008;5856.795012174553;5872.647641141545;5876.324222714443;5883.323417806836;5973.432523910222;5862.882742345044;5924.940750592439;5955.731992060281;5976.551758618208;5978.641281523122;5682.886342273214;5797.420257974169;5819.5344372450945;5856.882862342814;5887.911681324698;5927.8221653350465;5970.641761494324;6001.489873360813;6013.444286178269;6043.8186854394435;5689.829305120853;5750.942490575041;5807.8548036299435;5813.709314534341;5872.060470324898 08:47:29 INFO - PROCESS | 27468 | |5;yui.html;743.4647054121034;758.5638258001651;758.8216769059271;789.9368050555953;858.6007506509471;15037.62405939852;15352.232388380593;15930.20348982552;16080;16169.919150404246;13640.249786261751;13772.311384430763;13853.653658658539;13866.445342186325;13951.651208719788;839.391441205126;845.4504572028169;852.21170417364;852.9977276699852;853.5860107847689;837.8533756592602;857.0401150711181;858.8153546987396;861.1818772166436;861.2550144125318;902.4179404284265;907.9092090790934;910.2263076385053;910.7768596693819;912.1790388650202;905.4883990545354;909.0409617853162;910.9362344635878;911.0980129671577;912.2519533982137;669.6183175589915;673.3603077076797;673.9326067393271;674.4031532094132;674.514349668243;14585.124892506483;15076.09543427387;15160.09039457636;15210.695786084216;15867.44463943768;13701.109427887255;14019.579412617637;14158.929205353907;14408.567742967727;14734.115953042852;11734.589289374917;11768.646940591796;11776.332536398566;11874.762504749857;12008.69978250542;3737.6636102750613;3746.6628003479545;3765.3975363941636;3775.207206486641;3781.3760729479604;69931.65034174797;70705.64647176731;71839;72482;72867.27132728658;10826.783464330669;11087.390193539271;11108.444577771079;11258.324500529994;11313.71715707114;21188.682169767464;21219.575608487743;21219.78780212209;21226.78773212248;21228.469288267916;7830.6084695764985;7831.686732530635;8044;8181.140980197112;8220.958895205606;4704.694194877322;4725.812311198888;4916.06594746997;4918.508149185053;4940.8764780880765;3439.243366459375;3515.8593656253975;3565.4651802229873;3569.37535931211;3571.428571428559;563.6730696196196;568.85494198979;569.8603842058723;570.8316046766214;573.7733595229861;637.8437282865635;643.2827397451902;654.3521913305888;685.8491131950963;711.3775446484326;9435.90564094364;9573.18627916635;9635.084666956627;9709.616618343995;9755.463449510204;679.8164495586165;686.145748543067;693.3066933066933;719.022129903331;721.2535026247808;4407.625351845129;4408.911821763547;4481.910361792746;4489.618382437464;4528.7509186994375;61215.69392153011;92121;92396.53801730949;93119;98204.01795982092;81006.5949670248;82158.58920705358;82373.58813205895;83001.58499207466;85414.57292713497;46688;47817.282740758914;66569.66715166393;72568.73980342965;73464.26535734574;8513.872291915503;8712.564371781258;8863.734087977371;8968.551572421484;9004.684836030969;49280;50340.74829625829;50704.492955069974;50972;52255.477445225064;62187.6890615544;64660.353396465434;66205;67474;68751.31248687449;11479.8278025828;11622.476988535705;11726.589569365031;11758.58844940423;11873.525058997544;12743;12992.155509891827;13119.606411807661;13331;13373.465061397435;12155.149139560146;12209.877901220874;12226.510939562319;12259.264444133381;12363.75272494563;11522.078233741448;11757.176997610428;11957.162998590014;11966.34185119792;12440;11995.220310679779;12209.206401584224;12264.386780660752;12546.247225166519;12705.491780328683;10440.321379110334;10516.737081572715;10628.84056739134;10638.8936110641;10734.677959661223;10143.949280253551;10803.297785643908;10965.945170274097;10982.121430285717;10997.450127493434 08:47:29 INFO - PROCESS | 27468 | __end_tp_report 08:47:29 INFO - PROCESS | 27468 | __start_cc_report 08:47:29 INFO - PROCESS | 27468 | _x_x_mozilla_cycle_collect,298 08:47:29 INFO - PROCESS | 27468 | __end_cc_report 08:47:29 INFO - PROCESS | 27468 | __startTimestamp1481734049345__endTimestamp 08:47:29 INFO - PROCESS | 27468 | 08:47:29 INFO - PROCESS | 27468 | ------- Summary: start ------- 08:47:29 INFO - PROCESS | 27468 | Number of tests: 6 08:47:29 INFO - PROCESS | 27468 | 08:47:29 INFO - PROCESS | 27468 | [#0] dojo.html Cycles:165 Average:5747.42 Median:5976.10 stddev:659.07 (11.0%) stddev-sans-first:632.23 08:47:29 INFO - PROCESS | 27468 | Values: 3288.2 3296.9 3298.4 3303.1 3316.1 5720.7 5754.1 5763.0 5796.9 5815.4 5793.5 5816.4 5842.4 5848.8 5863.1 5220.1 5259.4 5292.2 5301.2 5321.2 5313.0 5322.8 5331.0 5338.5 5359.7 5119.4 5150.9 5356.1 5362.7 5383.9 5214.9 5249.5 5265.7 5289.2 5320.8 5206.3 5208.9 5285.2 5296.9 5309.4 5768.7 5797.9 5814.2 5880.9 5918.2 6024.7 6074.6 6102.7 6143.2 6156.7 6173.1 6188.0 6221.8 6225.4 6252.4 5744.9 5772.1 5790.4 5795.7 5811.4 6246.4 6269.6 6292.6 6395.6 6406.4 6121.8 6127.4 6133.4 6155.7 6158.3 6031.8 6253.4 6260.4 6263.5 6263.6 5976.1 6016.8 6028.0 6076.8 6077.1 6092.0 6104.5 6106.9 6111.2 6121.4 4715.8 4726.8 4739.7 4740.4 4772.4 4100.2 4163.6 4173.7 4189.9 4237.3 5932.1 5938.2 5945.5 5976.4 6000.9 5996.5 6152.4 6163.1 6206.3 6214.8 5784.8 5899.6 5904.6 5926.3 6021.4 5266.2 5291.5 5301.1 5307.4 5316.0 6431.6 6530.2 6538.7 6565.6 6568.0 5964.3 6017.5 6114.1 6119.7 6140.9 6433.7 6476.1 6485.6 6489.1 6507.0 6029.0 6052.5 6061.4 6062.5 6065.8 5920.1 6060.1 6136.1 6138.9 6202.0 6070.4 6085.3 6122.1 6126.9 6129.5 6091.6 6105.2 6108.8 6117.5 6126.1 5787.0 5884.2 5892.2 5998.0 6036.2 6009.1 6072.3 6088.5 6102.3 6108.8 5870.7 5950.7 5952.7 5960.9 5967.2 08:47:29 INFO - PROCESS | 27468 | 08:47:29 INFO - PROCESS | 27468 | [#1] ext.html Cycles:180 Average:62976.18 Median:227353.06 stddev:121145.80 (53.3%) stddev-sans-first:121395.22 08:47:29 INFO - PROCESS | 27468 | Values: 634.1 649.9 683.8 693.7 721.8 40194.4 45071.3 45126.0 45227.5 45352.0 45744.5 46095.5 46230.8 46642.8 46713.8 8534.6 8751.6 8778.1 8793.9 8836.0 8683.3 8740.2 8795.1 8808.3 8827.4 8839.6 8879.4 8911.7 8928.9 8933.5 8734.7 8768.2 8780.6 8808.3 8812.8 8714.7 8740.9 8751.2 8766.6 8809.0 42017.8 42124.0 42289.4 42543.0 42546.1 3531.5 3684.4 3692.8 3769.7 4002.2 31378.4 31378.7 31638.2 31639.5 31836.2 4406.8 4465.2 4470.1 4516.3 4537.0 360323.2 362237.0 362424.0 363859.0 364248.0 62938.7 62942.4 63115.7 63394.4 63443.0 65871.7 66614.3 66656.7 66712.3 66758.7 17141.9 17295.4 17388.7 17426.7 17506.1 13314.6 13340.0 13358.8 13495.3 13501.7 18042.0 18984.1 19059.2 19101.8 19109.5 6453.6 6545.2 6574.8 6861.4 6873.7 1027.8 1111.8 1117.1 1148.6 1163.1 32785.7 33183.0 33228.2 33259.0 33644.2 1138.3 1216.6 1225.5 1234.2 1248.7 17335.4 17444.3 17475.7 17533.3 17743.3 536452.0 538470.0 540207.0 542975.0 544174.0 60906.7 61253.0 61296.7 61342.7 61347.4 1409.8 1441.0 1446.6 1449.7 1455.7 31396.7 32589.2 33024.8 33244.5 33259.5 53824.2 53829.7 54060.2 54113.1 54269.2 450236.0 451839.0 453486.0 455123.0 455357.0 42558.4 42790.1 42899.8 43027.0 45054.0 49020.5 50643.2 50866.0 51663.7 51773.5 42537.8 42814.6 43575.6 43816.6 45351.0 43211.4 43338.6 43415.6 43814.3 44100.0 39760.4 45304.8 46071.3 46594.8 46770.5 40915.6 41555.2 41732.6 45121.5 45890.5 35302.3 36042.8 36089.8 36303.8 36550.8 08:47:29 INFO - PROCESS | 27468 | 08:47:29 INFO - PROCESS | 27468 | [#2] jquery.html Cycles:180 Average:29957.39 Median:13186.67 stddev:86277.26 (654.3%) stddev-sans-first:86490.75 08:47:29 INFO - PROCESS | 27468 | Values: 404.4 409.7 421.5 431.7 441.4 18786.2 19748.5 19831.4 19952.1 20529.2 18987.5 19423.1 19477.3 19583.3 19591.4 5126.1 5356.7 5378.1 5423.3 5425.2 5165.6 5344.3 5351.6 5361.8 5368.3 5265.2 5330.0 5347.5 5353.4 5356.9 5285.8 5337.7 5348.6 5349.8 5946.9 5259.6 5397.4 5444.7 5449.8 5459.6 13365.5 13561.9 23567.2 23781.9 23843.8 2306.2 2365.2 2529.5 2557.6 2726.2 10098.5 10104.5 10143.8 10521.9 11412.3 1920.9 1993.4 2012.4 2023.6 2056.4 86898.6 87062.0 88262.6 88422.1 88714.6 9401.4 10022.7 10113.4 11091.8 11096.7 14996.3 15060.8 15077.5 15091.5 15091.8 7967.3 8080.6 8139.0 8191.1 8212.9 7949.7 8213.3 8245.9 8410.7 8444.2 4150.8 4247.4 4285.5 4426.4 4489.8 2071.7 2101.6 2175.0 2193.4 2217.0 917.8 972.9 982.2 1060.9 1075.3 20018.9 20234.5 20317.2 20349.6 20666.7 990.1 1045.6 1046.4 1086.6 1103.0 10703.4 11387.6 11507.6 11580.3 11664.3 501709.0 514388.0 525645.0 536870.0 540715.0 59607.7 70372.6 92965.0 94358.5 94554.0 1007.7 1017.4 1028.6 1028.6 1058.1 17851.3 18037.8 18245.2 18259.8 18508.8 43738.0 44339.6 44555.0 44700.8 45218.0 60970.7 61284.4 61621.7 61883.5 62278.4 8520.2 8650.7 8704.6 9283.1 9455.0 13079.3 13103.7 13135.1 13157.2 13234.1 11062.7 11386.3 11516.5 11636.8 11781.9 10933.1 11245.4 11329.6 11440.7 11958.5 11418.2 11599.2 11699.1 11909.0 12021.2 8469.2 8589.4 8674.0 8693.4 9109.4 6822.0 11201.6 11462.9 11709.9 12044.8 08:47:29 INFO - PROCESS | 27468 | 08:47:29 INFO - PROCESS | 27468 | [#3] mootools.html Cycles:180 Average:5753.11 Median:2663.56 stddev:3193.04 (119.9%) stddev-sans-first:3185.86 08:47:29 INFO - PROCESS | 27468 | Values: 1482.0 1541.5 1721.5 1791.1 1821.3 7870.8 8050.0 8106.4 8639.5 8640.9 7845.9 8114.0 8119.1 8249.1 8312.8 2368.7 2408.4 2409.9 2410.4 2413.6 2414.6 2453.2 2457.6 2459.9 2481.6 2389.1 2402.0 2413.9 2427.0 2431.1 2260.6 2305.7 2308.8 2323.8 2330.1 2367.6 2384.7 2389.0 2393.4 2395.6 8343.7 8410.3 8677.3 8895.2 8939.2 5293.6 5359.4 5367.8 5397.6 5406.5 3425.8 3447.8 3506.0 3511.2 3569.7 1131.0 1153.7 1183.5 1208.8 1215.7 11943.2 11967.9 12044.3 12112.0 12138.3 4642.5 4768.0 4849.3 4919.2 4974.7 10249.9 10254.9 10258.3 10290.7 10317.8 5481.4 5491.2 5501.6 5522.5 5537.9 4543.8 4698.7 5011.7 5058.5 5094.7 4191.4 4209.1 4306.3 4322.8 4331.4 1366.8 1407.6 1418.3 1422.7 1435.3 868.8 883.4 979.5 988.5 1002.4 5842.0 5893.4 5904.8 5934.3 6033.4 464.2 469.4 472.5 475.0 477.8 4126.3 4161.8 4177.8 4205.5 4222.5 10578.5 10778.0 10810.1 10849.0 10905.9 10559.9 10645.7 10708.8 10740.9 10746.6 7818.8 8057.4 8058.4 8244.1 8246.4 5961.8 5965.7 6106.5 6120.8 6258.2 9873.3 9934.7 10037.4 10155.1 10196.9 9968.8 9989.4 10085.9 10136.8 10144.0 7259.1 7275.7 7316.7 7530.5 7539.2 8168.0 8295.5 8298.3 8314.6 8331.3 7395.9 7424.4 7432.7 7482.3 7663.5 7252.6 7298.7 7355.6 7376.5 7421.9 6863.3 6970.1 6989.8 7000.4 7007.3 5219.6 5245.1 5267.2 5322.9 5466.8 5096.5 5128.6 5169.6 5219.7 5258.6 08:47:29 INFO - PROCESS | 27468 | 08:47:29 INFO - PROCESS | 27468 | [#4] prototype.html Cycles:180 Average:4906.97 Median:5558.69 stddev:1417.41 (25.5%) stddev-sans-first:1379.58 08:47:29 INFO - PROCESS | 27468 | Values: 354.2 356.8 368.3 373.2 376.2 5462.2 5542.9 5573.3 5643.8 5648.5 5417.6 5492.5 5496.6 5509.5 5518.6 4406.4 4406.6 4425.9 4426.9 4434.3 4183.2 4370.3 4388.5 4405.1 4450.3 4317.2 4341.1 4345.7 4351.8 4372.4 4338.7 4345.3 4354.9 4368.9 4446.6 3852.7 3868.8 3917.8 3935.7 3937.7 5391.4 5409.2 5431.6 5435.6 5467.6 4958.6 5023.3 5029.5 5040.3 5040.4 5643.2 5769.8 5770.9 5801.6 5812.2 4258.5 4267.4 4270.1 4274.3 4280.5 6029.3 6069.1 6108.8 6114.3 6131.2 4312.2 4317.0 4327.9 4366.3 4407.9 4418.6 4424.9 4428.6 4432.0 4442.8 5032.2 5040.0 5055.2 5056.2 5065.3 5640.3 5739.9 5855.6 5892.4 5907.5 1482.6 1491.8 1493.6 1497.2 1501.8 1016.3 1033.5 1035.9 1044.5 1049.3 5537.3 5541.4 5556.6 5567.8 5572.0 5816.9 5870.3 5884.4 5926.3 5944.5 5478.5 5560.7 5582.9 5602.3 5672.2 3107.5 3114.5 3118.5 3124.7 3137.5 5871.8 6003.7 6063.8 6138.6 6148.4 5842.7 5903.0 5921.9 5941.3 5966.2 5959.3 6014.3 6022.8 6040.2 6072.2 5677.9 5678.7 5690.5 5782.2 5786.4 5658.4 5708.7 5712.8 5713.0 5729.7 5782.8 5976.0 6096.1 6130.4 6138.2 4171.2 4180.6 4192.2 4201.2 4215.3 5823.8 5884.9 5899.6 5909.7 6024.3 5856.8 5872.6 5876.3 5883.3 5973.4 5862.9 5924.9 5955.7 5976.6 5978.6 5682.9 5797.4 5819.5 5856.9 5887.9 5927.8 5970.6 6001.5 6013.4 6043.8 5689.8 5750.9 5807.9 5813.7 5872.1 08:47:29 INFO - PROCESS | 27468 | 08:47:29 INFO - PROCESS | 27468 | [#5] yui.html Cycles:180 Average:18208.23 Median:27099.25 stddev:24542.87 (90.6%) stddev-sans-first:24576.68 08:47:29 INFO - PROCESS | 27468 | Values: 743.5 758.6 758.8 789.9 858.6 15037.6 15352.2 15930.2 16080.0 16169.9 13640.2 13772.3 13853.7 13866.4 13951.7 839.4 845.5 852.2 853.0 853.6 837.9 857.0 858.8 861.2 861.3 902.4 907.9 910.2 910.8 912.2 905.5 909.0 910.9 911.1 912.3 669.6 673.4 673.9 674.4 674.5 14585.1 15076.1 15160.1 15210.7 15867.4 13701.1 14019.6 14158.9 14408.6 14734.1 11734.6 11768.6 11776.3 11874.8 12008.7 3737.7 3746.7 3765.4 3775.2 3781.4 69931.7 70705.6 71839.0 72482.0 72867.3 10826.8 11087.4 11108.4 11258.3 11313.7 21188.7 21219.6 21219.8 21226.8 21228.5 7830.6 7831.7 8044.0 8181.1 8221.0 4704.7 4725.8 4916.1 4918.5 4940.9 3439.2 3515.9 3565.5 3569.4 3571.4 563.7 568.9 569.9 570.8 573.8 637.8 643.3 654.4 685.8 711.4 9435.9 9573.2 9635.1 9709.6 9755.5 679.8 686.1 693.3 719.0 721.3 4407.6 4408.9 4481.9 4489.6 4528.8 61215.7 92121.0 92396.5 93119.0 98204.0 81006.6 82158.6 82373.6 83001.6 85414.6 46688.0 47817.3 66569.7 72568.7 73464.3 8513.9 8712.6 8863.7 8968.6 9004.7 49280.0 50340.7 50704.5 50972.0 52255.5 62187.7 64660.4 66205.0 67474.0 68751.3 11479.8 11622.5 11726.6 11758.6 11873.5 12743.0 12992.2 13119.6 13331.0 13373.5 12155.1 12209.9 12226.5 12259.3 12363.8 11522.1 11757.2 11957.2 11966.3 12440.0 11995.2 12209.2 12264.4 12546.2 12705.5 10440.3 10516.7 10628.8 10638.9 10734.7 10143.9 10803.3 10965.9 10982.1 10997.5 08:47:29 INFO - PROCESS | 27468 | -------- Summary: end -------- 08:47:29 INFO - PROCESS | 27468 | 08:47:30 INFO - TEST-INFO | 27468: exit 0 08:47:30 INFO - TEST-OK | dromaeo_css | took 1113040ms 08:47:30 INFO - TEST-START | kraken 08:47:30 INFO - operating with platform_type : linux_ 08:47:30 INFO - Initialising browser for kraken test... 08:47:30 INFO - TEST-INFO | started process 27852 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt_Vh_U/profile http://localhost:33773/getInfo.html) 08:47:34 INFO - PROCESS | 27852 | __metrics Screen width/height:1600/1200 08:47:34 INFO - PROCESS | 27852 | colorDepth:24 08:47:34 INFO - PROCESS | 27852 | Browser inner width/height: 1024/697 08:47:34 INFO - PROCESS | 27852 | __metrics 08:47:35 ERROR - PROCESS | 27852 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 08:47:36 INFO - TEST-INFO | 27852: exit 0 08:47:36 INFO - Browser initialized. 08:47:36 INFO - Running cycle 1/1 for kraken test... 08:47:36 INFO - TEST-INFO | started process 27984 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt_Vh_U/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:47:47 INFO - PROCESS | 27984 | RSS: Main: 151744512 08:47:47 INFO - PROCESS | 27984 | 08:47:50 INFO - PROCESS | 27984 | Cycle 1(1): loaded http://localhost:33773/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33773/tests/kraken/driver.html?testName=audio-beat-detection) 08:47:51 INFO - PROCESS | 27984 | RSS: Main: 156901376 08:47:51 INFO - PROCESS | 27984 | 08:47:53 INFO - PROCESS | 27984 | Cycle 1(1): loaded http://localhost:33773/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33773/tests/kraken/driver.html?testName=audio-dft) 08:47:54 INFO - PROCESS | 27984 | RSS: Main: 155152384 08:47:54 INFO - PROCESS | 27984 | 08:47:57 INFO - PROCESS | 27984 | Cycle 1(1): loaded http://localhost:33773/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33773/tests/kraken/driver.html?testName=audio-fft) 08:47:58 INFO - PROCESS | 27984 | RSS: Main: 155537408 08:47:58 INFO - PROCESS | 27984 | 08:48:00 INFO - PROCESS | 27984 | Cycle 1(1): loaded http://localhost:33773/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33773/tests/kraken/driver.html?testName=audio-oscillator) 08:48:00 INFO - PROCESS | 27984 | RSS: Main: 155234304 08:48:00 INFO - PROCESS | 27984 | 08:48:02 INFO - PROCESS | 27984 | Cycle 1(1): loaded http://localhost:33773/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33773/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:48:03 INFO - PROCESS | 27984 | RSS: Main: 155062272 08:48:03 INFO - PROCESS | 27984 | 08:48:06 INFO - PROCESS | 27984 | Cycle 1(1): loaded http://localhost:33773/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33773/tests/kraken/driver.html?testName=imaging-darkroom) 08:48:07 INFO - PROCESS | 27984 | RSS: Main: 158617600 08:48:07 INFO - PROCESS | 27984 | 08:48:10 INFO - PROCESS | 27984 | Cycle 1(1): loaded http://localhost:33773/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33773/tests/kraken/driver.html?testName=imaging-desaturate) 08:48:11 INFO - PROCESS | 27984 | RSS: Main: 158400512 08:48:11 INFO - PROCESS | 27984 | 08:48:13 INFO - PROCESS | 27984 | Cycle 1(1): loaded http://localhost:33773/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33773/tests/kraken/driver.html?testName=json-parse-financial) 08:48:14 INFO - PROCESS | 27984 | RSS: Main: 157917184 08:48:14 INFO - PROCESS | 27984 | 08:48:15 INFO - PROCESS | 27984 | Cycle 1(1): loaded http://localhost:33773/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33773/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:48:16 INFO - PROCESS | 27984 | RSS: Main: 156905472 08:48:16 INFO - PROCESS | 27984 | 08:48:18 INFO - PROCESS | 27984 | Cycle 1(1): loaded http://localhost:33773/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33773/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:48:18 INFO - PROCESS | 27984 | RSS: Main: 157351936 08:48:18 INFO - PROCESS | 27984 | 08:48:20 INFO - PROCESS | 27984 | Cycle 1(1): loaded http://localhost:33773/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33773/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:48:21 INFO - PROCESS | 27984 | RSS: Main: 157782016 08:48:21 INFO - PROCESS | 27984 | 08:48:24 INFO - PROCESS | 27984 | Cycle 1(1): loaded http://localhost:33773/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33773/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:48:24 INFO - PROCESS | 27984 | RSS: Main: 157351936 08:48:24 INFO - PROCESS | 27984 | 08:48:27 INFO - PROCESS | 27984 | Cycle 1(1): loaded http://localhost:33773/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33773/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:48:28 INFO - PROCESS | 27984 | RSS: Main: 157782016 08:48:28 INFO - PROCESS | 27984 | 08:48:29 INFO - PROCESS | 27984 | Cycle 1(1): loaded http://localhost:33773/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33773/tests/kraken/driver.html?testName=ai-astar) 08:48:30 INFO - PROCESS | 27984 | RSS: Main: 159657984 08:48:30 INFO - PROCESS | 27984 | 08:48:30 INFO - PROCESS | 27984 | __start_tp_report 08:48:30 INFO - PROCESS | 27984 | _x_x_mozilla_page_load 08:48:30 INFO - PROCESS | 27984 | _x_x_mozilla_page_load_details 08:48:30 INFO - PROCESS | 27984 | |i|pagename|runs| 08:48:30 INFO - PROCESS | 27984 | |0;ai-astar;108;111;112;113;113;113;112;113;114;112 08:48:30 INFO - PROCESS | 27984 | |1;audio-beat-detection;139;122;120;164;121;123;119;119;143;123 08:48:30 INFO - PROCESS | 27984 | |2;audio-dft;163;165;164;164;162;163;163;162;162;163 08:48:30 INFO - PROCESS | 27984 | |3;audio-fft;76;75;75;112;77;77;75;76;99;76 08:48:30 INFO - PROCESS | 27984 | |4;audio-oscillator;81;82;116;84;83;83;107;83;81;120 08:48:30 INFO - PROCESS | 27984 | |5;imaging-gaussian-blur;117;118;117;118;118;118;118;118;118;118 08:48:30 INFO - PROCESS | 27984 | |6;imaging-darkroom;147;148;151;147;149;149;147;148;147;148 08:48:30 INFO - PROCESS | 27984 | |7;imaging-desaturate;86;85;85;85;85;86;85;86;86;85 08:48:30 INFO - PROCESS | 27984 | |8;json-parse-financial;50;51;52;51;53;51;52;55;54;52 08:48:30 INFO - PROCESS | 27984 | |9;json-stringify-tinderbox;67;59;59;58;60;58;57;58;58;58 08:48:30 INFO - PROCESS | 27984 | |10;stanford-crypto-aes;80;83;83;75;83;76;74;80;80;73 08:48:30 INFO - PROCESS | 27984 | |11;stanford-crypto-ccm;134;123;124;123;125;122;131;130;173;134 08:48:30 INFO - PROCESS | 27984 | |12;stanford-crypto-pbkdf2;156;159;165;156;155;157;162;161;163;156 08:48:30 INFO - PROCESS | 27984 | |13;stanford-crypto-sha256-iterative;63;62;69;69;63;64;62;65;60;62 08:48:30 INFO - PROCESS | 27984 | __end_tp_report 08:48:30 INFO - PROCESS | 27984 | __start_cc_report 08:48:30 INFO - PROCESS | 27984 | _x_x_mozilla_cycle_collect,806 08:48:30 INFO - PROCESS | 27984 | __end_cc_report 08:48:30 INFO - PROCESS | 27984 | __startTimestamp1481734110056__endTimestamp 08:48:30 INFO - PROCESS | 27984 | 08:48:30 INFO - PROCESS | 27984 | ------- Summary: start ------- 08:48:30 INFO - PROCESS | 27984 | Number of tests: 14 08:48:30 INFO - PROCESS | 27984 | 08:48:30 INFO - PROCESS | 27984 | [#0] ai-astar Cycles:10 Average:112.10 Median:113.00 stddev:1.66 (1.5%) stddev-sans-first:0.88 08:48:30 INFO - PROCESS | 27984 | Values: 108.0 111.0 112.0 113.0 113.0 113.0 112.0 113.0 114.0 112.0 08:48:30 INFO - PROCESS | 27984 | 08:48:30 INFO - PROCESS | 27984 | [#1] audio-beat-detection Cycles:10 Average:129.30 Median:123.00 stddev:14.86 (12.1%) stddev-sans-first:15.34 08:48:30 INFO - PROCESS | 27984 | Values: 139.0 122.0 120.0 164.0 121.0 123.0 119.0 119.0 143.0 123.0 08:48:30 INFO - PROCESS | 27984 | 08:48:30 INFO - PROCESS | 27984 | [#2] audio-dft Cycles:10 Average:163.10 Median:163.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 08:48:30 INFO - PROCESS | 27984 | Values: 163.0 165.0 164.0 164.0 162.0 163.0 163.0 162.0 162.0 163.0 08:48:30 INFO - PROCESS | 27984 | 08:48:30 INFO - PROCESS | 27984 | [#3] audio-fft Cycles:10 Average:81.80 Median:76.00 stddev:12.88 (17.0%) stddev-sans-first:13.49 08:48:30 INFO - PROCESS | 27984 | Values: 76.0 75.0 75.0 112.0 77.0 77.0 75.0 76.0 99.0 76.0 08:48:30 INFO - PROCESS | 27984 | 08:48:30 INFO - PROCESS | 27984 | [#4] audio-oscillator Cycles:10 Average:92.00 Median:82.50 stddev:15.76 (19.1%) stddev-sans-first:16.20 08:48:30 INFO - PROCESS | 27984 | Values: 81.0 82.0 116.0 84.0 83.0 83.0 107.0 83.0 81.0 120.0 08:48:30 INFO - PROCESS | 27984 | 08:48:30 INFO - PROCESS | 27984 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 08:48:30 INFO - PROCESS | 27984 | Values: 117.0 118.0 117.0 118.0 118.0 118.0 118.0 118.0 118.0 118.0 08:48:30 INFO - PROCESS | 27984 | 08:48:30 INFO - PROCESS | 27984 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:1.29 (0.9%) stddev-sans-first:1.30 08:48:30 INFO - PROCESS | 27984 | Values: 147.0 148.0 151.0 147.0 149.0 149.0 147.0 148.0 147.0 148.0 08:48:30 INFO - PROCESS | 27984 | 08:48:30 INFO - PROCESS | 27984 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:85.50 stddev:0.52 (0.6%) stddev-sans-first:0.50 08:48:30 INFO - PROCESS | 27984 | Values: 86.0 85.0 85.0 85.0 85.0 86.0 85.0 86.0 86.0 85.0 08:48:30 INFO - PROCESS | 27984 | 08:48:30 INFO - PROCESS | 27984 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:52.00 stddev:1.52 (2.9%) stddev-sans-first:1.41 08:48:30 INFO - PROCESS | 27984 | Values: 50.0 51.0 52.0 51.0 53.0 51.0 52.0 55.0 54.0 52.0 08:48:30 INFO - PROCESS | 27984 | 08:48:30 INFO - PROCESS | 27984 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:58.50 stddev:2.86 (4.9%) stddev-sans-first:0.87 08:48:30 INFO - PROCESS | 27984 | Values: 67.0 59.0 59.0 58.0 60.0 58.0 57.0 58.0 58.0 58.0 08:48:30 INFO - PROCESS | 27984 | 08:48:30 INFO - PROCESS | 27984 | [#10] stanford-crypto-aes Cycles:10 Average:78.70 Median:80.00 stddev:3.89 (4.9%) stddev-sans-first:4.10 08:48:30 INFO - PROCESS | 27984 | Values: 80.0 83.0 83.0 75.0 83.0 76.0 74.0 80.0 80.0 73.0 08:48:30 INFO - PROCESS | 27984 | 08:48:30 INFO - PROCESS | 27984 | [#11] stanford-crypto-ccm Cycles:10 Average:131.90 Median:130.50 stddev:15.16 (11.6%) stddev-sans-first:16.06 08:48:30 INFO - PROCESS | 27984 | Values: 134.0 123.0 124.0 123.0 125.0 122.0 131.0 130.0 173.0 134.0 08:48:30 INFO - PROCESS | 27984 | 08:48:30 INFO - PROCESS | 27984 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.00 Median:160.00 stddev:3.53 (2.2%) stddev-sans-first:3.57 08:48:30 INFO - PROCESS | 27984 | Values: 156.0 159.0 165.0 156.0 155.0 157.0 162.0 161.0 163.0 156.0 08:48:30 INFO - PROCESS | 27984 | 08:48:30 INFO - PROCESS | 27984 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:63.50 stddev:3.00 (4.7%) stddev-sans-first:3.16 08:48:30 INFO - PROCESS | 27984 | Values: 63.0 62.0 69.0 69.0 63.0 64.0 62.0 65.0 60.0 62.0 08:48:30 INFO - PROCESS | 27984 | -------- Summary: end -------- 08:48:30 INFO - PROCESS | 27984 | 08:48:31 INFO - TEST-INFO | 27984: exit 0 08:48:31 INFO - TEST-OK | kraken | took 60946ms 08:48:31 INFO - SUITE-END | took 1173s 08:48:31 INFO - Completed test suite (00:19:34) 08:48:31 INFO - javascript benchmark 08:48:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7406.549208504312, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3288.2272665923506, 3296.9340613187737, 3298.4392653248947, 3303.0965282559446, 3316.0880757791606, 5720.742566584503, 5754.108113242443, 5762.971185144069, 5796.942030579693, 5815.4475324844125, 5793.507551858087, 5816.418358164182, 5842.357340692531, 5848.824535263938, 5863.149843272734, 5220.112580861243, 5259.421463638997, 5292.153255479124, 5301.231321458386, 5321.201819727034, 5313.043652142613, 5322.787088516455, 5331.040412725708, 5338.546223571001, 5359.678419294835, 5119.411267704225, 5150.922736158961, 5356.11624082026, 5362.731863406833, 5383.919241211385, 5214.921776173361, 5249.4750524947585, 5265.710385928773, 5289.206619007141, 5320.787168513255, 5206.271122042917, 5208.8958220835375, 5285.207218917155, 5296.92054619181, 5309.442508536626, 5768.74040668171, 5797.942020579782, 5814.186013958049, 5880.852978675524, 5918.171455996164, 6024.728887200086, 6074.5747797654185, 6102.6948652567635, 6143.170671959318, 6156.722947467375, 6173.116974573363, 6188.040853667689, 6221.813345599639, 6225.3774622537385, 6252.406021427957, 5744.856378590569, 5772.134179872969, 5790.420957904218, 5795.681237531934, 5811.389804070596, 6246.406591373812, 6269.5611307208055, 6292.622442653455, 6395.648239346788, 6406.391392817675, 6121.755129794758, 6127.387261273837, 6133.355997620275, 6155.692215389213, 6158.261008678987, 6031.849203769941, 6253.405926436982, 6260.436560709558, 6263.467605253513, 6263.592866463665, 5976.103584462278, 6016.759329626766, 6028.0, 6076.817695469143, 6077.1491991121275, 6091.969540152271, 6104.481119104926, 6106.877862442726, 6111.236095488064, 6121.387861213843, 4715.7642117893965, 4726.7636618169645, 4739.739314337676, 4740.3837501124635, 4772.403449568804, 4100.220958017967, 4163.625273725379, 4173.728707634054, 4189.895252618648, 4237.258479766028, 5932.139839723216, 5938.168656388109, 5945.464908158287, 5976.432238937294, 6000.879982400327, 5996.460318571262, 6152.3540028297275, 6163.106349579286, 6206.317305096436, 6214.782482613177, 5784.82645520635, 5899.557533185029, 5904.616199947076, 5926.348101708809, 6021.3677563856045, 5266.236395722599, 5291.497307755757, 5301.072312345401, 5307.416184219733, 5316.0, 6431.6462594556815, 6530.249021362414, 6538.738450461929, 6565.638889861103, 6568.0, 5964.343922168471, 6017.518598512196, 6114.054067497291, 6119.724612392364, 6140.938590614037, 6433.742650293936, 6476.125723027331, 6485.643289618927, 6489.123968264224, 6506.967465162644, 6029.035354343284, 6052.455279024733, 6061.424164704346, 6062.454379105901, 6065.8180254592435, 5920.082387229986, 6060.060690592965, 6136.090214303778, 6138.907916381168, 6201.96899015502, 6070.3929607038945, 6085.330613632408, 6122.123717501779, 6126.927787637234, 6129.542179248731, 6091.573589848846, 6105.17580126695, 6108.786192483241, 6117.480014198843, 6126.050462178369, 5787.0, 5884.176215329771, 5892.175095486721, 5997.970010149921, 6036.154938308552, 6009.128676341818, 6072.271327440735, 6088.543359247986, 6102.298235702951, 6108.816735497942, 5870.677112758839, 5950.672713000827, 5952.702364881825, 5960.940390596039, 5967.224260846062], "value": 5702.033001845721, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [634.09324665728, 649.8537828988477, 683.8119517132787, 693.7363801755332, 721.8231533274342, 40194.397084043725, 45071.323930141036, 45126.0, 45227.547724522745, 45352.0, 45744.542554574444, 46095.53904460963, 46230.76884615581, 46642.7667861661, 46713.76643116788, 8534.573271336454, 8751.606177721986, 8778.122187781235, 8793.868091978626, 8835.95582022089, 8683.305335573139, 8740.169683880053, 8795.076516965722, 8808.339374546935, 8827.426217295888, 8839.602217900177, 8879.378443508956, 8911.73264802057, 8928.866067008968, 8933.46399216049, 8734.737957861242, 8768.167024132728, 8780.560971951409, 8808.251298639623, 8812.779680508038, 8714.694985675535, 8740.8688869667, 8751.168638979287, 8766.561671916379, 8808.955955220246, 42017.78991105025, 42124.0, 42289.36565951513, 42543.0, 42546.1490770186, 3531.4526248431534, 3684.392075307571, 3692.778433294011, 3769.736118471708, 4002.1595464952393, 31378.37243255145, 31378.686213138033, 31638.209044773834, 31639.525407118912, 31836.20409489758, 4406.779661016968, 4465.222212232912, 4470.128324976631, 4516.254817955033, 4537.0, 360323.198384009, 362237.0, 362424.0, 363859.0, 364248.0, 62938.68530657318, 62942.37057629457, 63115.6844215776, 63394.36605633977, 63443.0, 65871.67064164649, 66614.33385666179, 66656.6667166661, 66712.33287667159, 66758.66620666865, 17141.914290428467, 17295.394661186798, 17388.739168912478, 17426.65146697059, 17506.12469376526, 13314.600561983156, 13340.0, 13358.799618005738, 13495.257760823053, 13501.66245843842, 18042.037714168902, 18984.14571344293, 19059.237630494627, 19101.808981910282, 19109.522261943286, 6453.580517266362, 6545.181852268466, 6574.8356291093105, 6861.382475577222, 6873.690683919235, 1027.7893031928436, 1111.8109921313396, 1117.100733909211, 1148.6152139033518, 1163.116031815826, 32785.672143278265, 33183.0, 33228.1692957678, 33259.0, 33644.158896027795, 1138.2605120686187, 1216.5620376664394, 1225.5097960815567, 1234.2471092633486, 1248.6628610275175, 17335.393261235797, 17444.302227910743, 17475.650486990187, 17533.29866805339, 17743.29026838912, 536452.0, 538470.0, 540207.0, 542975.0, 544174.0, 60906.69546652327, 61252.999999999105, 61296.693516532134, 61342.69328653417, 61347.38652613506, 1409.7603407420763, 1441.0417072646783, 1446.5732608880405, 1449.6520834999524, 1455.6797504548983, 31396.68603314029, 32589.18527036843, 33024.834875826426, 33244.50133247955, 33259.50110748292, 53824.19263711126, 53829.73085134549, 54060.18909716436, 54113.10604128837, 54269.18596221139, 450236.0, 451839.0, 453486.0, 455123.0, 455357.0, 42558.36162457504, 42790.14419711526, 42899.785501073544, 43027.0, 45054.0, 49020.5097949016, 50643.24035139402, 50866.0, 51663.74168129135, 51773.48226517686, 42537.78731106325, 42814.57185428106, 43575.56424435715, 43816.561834382526, 45351.0, 43211.35182972195, 43338.56661433345, 43415.553715876034, 43814.34278485762, 44100.0, 39760.403593945535, 45304.77347613241, 46071.3089303654, 46594.76702616465, 46770.53229467662, 40915.59084409118, 41555.1688966213, 41732.58267417287, 45121.54878451305, 45890.541094588625, 35302.29395412129, 36042.8197859009, 36089.81955090208, 36303.81848090742, 36550.817245914666], "value": 21272.256321262452, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.4499480706241, 409.68863663615645, 421.5215730146284, 431.68487004486735, 441.41292081531566, 18786.248550057997, 19748.506287342825, 19831.405057848253, 19952.102155403005, 20529.178832846686, 18987.52531186721, 19423.12595933183, 19477.318293859684, 19583.314583989562, 19591.41225763226, 5126.077306084903, 5356.651817631861, 5378.112611419131, 5423.322084739408, 5425.213344065108, 5165.560927321182, 5344.278522399484, 5351.625386222966, 5361.758720857571, 5368.30212072432, 5265.236540701596, 5330.040592693314, 5347.491988261128, 5353.411124776271, 5356.866078348034, 5285.781884292596, 5337.6797392156595, 5348.598855085865, 5349.8127565535215, 5946.851328716817, 5259.631825772198, 5397.379301380352, 5444.727763611803, 5449.809256675997, 5459.563234941234, 13365.53220637273, 13561.86438135616, 23567.17514886988, 23781.88109059461, 23843.82088841016, 2306.1928325086255, 2365.231299827563, 2529.519391315644, 2557.6035714464288, 2726.168518601826, 10098.545565449573, 10104.49477526128, 10143.847842282297, 10521.947390263076, 11412.258203216765, 1920.8655394122418, 1993.431871916497, 2012.3962811156593, 2023.6357455657976, 2056.3728062940795, 86898.5655071727, 87062.0, 88262.5586872068, 88422.11577884204, 88714.55642721745, 9401.388909720847, 10022.749431264278, 10113.393196408091, 11091.778164436666, 11096.722581935515, 14996.325165367585, 15060.849391505944, 15077.472288469851, 15091.471798487, 15091.773623395658, 7967.322777563972, 8080.636371363185, 8139.0, 8191.0580283267, 8212.940553435583, 7949.682012719542, 8213.301869341054, 8245.876311855327, 8410.705625303084, 8444.197801208875, 4150.750954942713, 4247.426597409372, 4285.46431696038, 4426.3581780641625, 4489.7979590918485, 2071.7099606055162, 2101.5586726787546, 2175.042981088316, 2193.3529608765452, 2216.9627610174166, 917.8072604752944, 972.8735264415723, 982.1700662939804, 1060.9469526523642, 1075.3386667199616, 20018.89990550038, 20234.494137646678, 20317.18731250763, 20349.59300814005, 20666.689999650018, 990.0792263195153, 1045.5765415006933, 1046.4296958157822, 1086.6305456144948, 1102.9889701102886, 10703.411312377739, 11387.601433949772, 11507.597234096766, 11580.305181689126, 11664.300141991507, 501709.0, 514388.0, 525645.0, 536870.0, 540715.0, 59607.70196148992, 70372.64813675899, 92965.0, 94358.5282073599, 94554.0, 1007.6698757639845, 1017.4099022566893, 1028.5525796278644, 1028.5834237133972, 1058.0530425269342, 17851.285948561912, 18037.819621803614, 18245.178966946783, 18259.81740182581, 18508.81491185071, 43738.0, 44339.55660443354, 44555.0, 44700.77649611861, 45218.0, 60970.69514652398, 61284.387156127865, 61621.69189154026, 61883.524659013136, 62278.37721622726, 8520.233179013918, 8650.697225597074, 8704.608292626974, 9283.11810378013, 9454.95272523633, 13079.346032698137, 13103.672408189872, 13135.146215495963, 13157.210567365988, 13234.139780914209, 11062.723431913944, 11386.316820990767, 11516.539338426704, 11636.76726465449, 11781.941090294493, 10933.125349972142, 11245.381504017358, 11329.603463878724, 11440.656780296604, 11958.521659133885, 11418.200725949104, 11599.246049006788, 11699.12256580777, 11909.0, 12021.158518903943, 8469.153084691481, 8589.44168629037, 8674.0, 8693.434926729742, 9109.407888487227, 6821.965890170517, 11201.599800024997, 11462.885371146182, 11709.941450292694, 12044.819327709916], "value": 9235.414750952941, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1481.9703605927882, 1541.506717850288, 1721.4749501402068, 1791.1223500484766, 1821.317006122705, 7870.842583148334, 8049.959750201241, 8106.35149188065, 8639.52482613456, 8640.91359086409, 7845.882311765328, 8113.985751781027, 8119.14748951359, 8249.133840946704, 8312.750617481484, 2368.727596326423, 2408.4460574067975, 2409.9277021689377, 2410.3853517353136, 2413.613821788514, 2414.5653782319177, 2453.178185307924, 2457.5576396248666, 2459.86470744109, 2481.553320402327, 2389.104085967762, 2401.9759802402014, 2413.9275821725378, 2426.9757302426924, 2431.088341871798, 2260.5930932432157, 2305.66567847662, 2308.8499247548857, 2323.8373313868037, 2330.102910379499, 2367.5975084235547, 2384.7257565380028, 2389.0443822470975, 2393.3537944754994, 2395.616701327779, 8343.749687509384, 8410.285125764318, 8677.349198810052, 8895.243904268145, 8939.150780675825, 5293.57651387888, 5359.356877174764, 5367.812126575551, 5397.568194544427, 5406.513413792738, 3425.794452332868, 3447.77589456687, 3505.964940350615, 3511.2450823072904, 3569.6965757910607, 1130.9886901130965, 1153.74040840811, 1183.5029287699188, 1208.836807031057, 1215.6535387414633, 11943.223690460092, 11967.880321196852, 12044.27734335934, 12112.031037517065, 12138.332391718452, 4642.532712267347, 4767.952320476751, 4849.2968519565175, 4919.237518184687, 4974.701517908937, 10249.897501025043, 10254.948725256327, 10258.333208341433, 10290.691279261635, 10317.84523232152, 5481.424450432727, 5491.176323551499, 5501.587380946365, 5522.475364840334, 5537.861553461195, 4543.750093744809, 4698.671093023456, 5011.749412529359, 5058.494150584986, 5094.719790411489, 4191.392248124005, 4209.095044565433, 4306.267934451151, 4322.827086916551, 4331.350297455407, 1366.7539842828187, 1407.5566196648024, 1418.319206780751, 1422.665673566711, 1435.346917152693, 868.7871471489525, 883.3904605821963, 979.4612962870393, 988.4958671077802, 1002.3685078400707, 5842.0, 5893.381194974551, 5904.76380944766, 5934.258217722785, 6033.366496517802, 464.2201102148356, 469.4015130708306, 472.5492737296535, 474.95487928646725, 477.8279819265062, 4126.339785634284, 4161.750294982311, 4177.811998460076, 4205.516365617932, 4222.493300803923, 10578.471076446147, 10778.029977301923, 10810.081143102925, 10849.02358787713, 10905.890941090645, 10559.894401056044, 10645.680629581126, 10708.785824283626, 10740.94629526863, 10746.570137194582, 7818.765437036898, 8057.35541156706, 8058.395620328499, 8244.134365891616, 8246.422750407413, 5961.837441699001, 5965.73154208053, 6106.542009349228, 6120.816375508742, 6258.217722784652, 9873.308868379145, 9934.652287169914, 10037.397756134655, 10155.136813370946, 10196.898031019595, 9968.800623987625, 9989.400635961574, 10085.949570252102, 10136.847947280945, 10144.0, 7259.12890453149, 7275.708971641287, 7316.707331706672, 7530.548167109771, 7539.1706912238515, 8167.959160204161, 8295.460795048302, 8298.294644955246, 8314.584270786558, 8331.33349332064, 7395.926040739739, 7424.36892864091, 7432.702691892264, 7482.2517748224745, 7663.463557550918, 7252.637368131467, 7298.708051677873, 7355.5586664800285, 7376.483646144933, 7421.851562968603, 6863.279355667583, 6970.128733908262, 6989.790306290819, 7000.439964802906, 7007.334303241184, 5219.634625576326, 5245.134552798745, 5267.183586544092, 5322.946770532245, 5466.753996070107, 5096.51583099605, 5128.58971282304, 5169.560587349967, 5219.686818790885, 5258.553022993088], "value": 4588.372986303547, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.24545717621464, 356.7538398505032, 368.30941983780406, 373.1585275204415, 376.2024508042949, 5462.153366228231, 5542.949108829739, 5573.33120025597, 5643.830685079444, 5648.491635752786, 5417.6207665463435, 5492.47821456961, 5496.615236933416, 5509.47659972302, 5518.613697041209, 4406.449193850769, 4406.633943477525, 4425.933610995838, 4426.933595996063, 4434.312681534351, 4183.163367326531, 4370.3007518797, 4388.495323037843, 4405.140997505488, 4450.26570615848, 4317.15815415994, 4341.110072435144, 4345.696291112654, 4351.847685331014, 4372.366006928994, 4338.696291259613, 4345.3047512398025, 4354.8911277218, 4368.934465983013, 4446.644268458515, 3852.6917846572205, 3868.8065596720053, 3917.8236979335998, 3935.704822138351, 3937.7046721496004, 5391.353037635469, 5409.24270602116, 5431.619786614939, 5435.619506634537, 5467.644603100785, 4958.603311735053, 5023.271625614266, 5029.5221953914315, 5040.294358789773, 5040.445550989388, 5643.181738647914, 5769.826905192851, 5770.913436298459, 5801.577069528998, 5812.186293918855, 4258.530806871624, 4267.445232119836, 4270.14597080582, 4274.337477690963, 4280.464941882265, 6029.336772954972, 6069.119977603267, 6108.786192483286, 6114.266288045463, 6131.202943617346, 4312.159128969821, 4316.9639286571, 4327.870163895088, 4366.345048242789, 4407.906244533885, 4418.55814418562, 4424.933625995613, 4428.579284967923, 4431.977840110843, 4442.777861106932, 5032.169692000779, 5040.0, 5055.241713742968, 5056.216286475602, 5065.290859279704, 5640.294963129609, 5739.942600573941, 5855.648661080349, 5892.440218179266, 5907.4683278505145, 1482.570054684151, 1491.7762335649522, 1493.6340596553914, 1497.2289271025431, 1501.7747337899402, 1016.3150478453682, 1033.547865249326, 1035.9223058270659, 1044.4621020174616, 1049.2917280835406, 5537.335519737658, 5541.418151094158, 5556.638818476867, 5567.805126820542, 5572.0, 5816.854578635568, 5870.295564532284, 5884.440978107073, 5926.348101708809, 5944.464998150187, 5478.534324582455, 5560.7460292875985, 5582.888342233133, 5602.327720673546, 5672.205891175238, 3107.467414057581, 3114.4861097919043, 3118.454270502653, 3124.6876311949036, 3137.5450559669175, 5871.823845284648, 6003.669798161143, 6063.7574497020505, 6138.570300079041, 6148.385161483905, 5842.678652674143, 5903.0, 5921.911171332434, 5941.287045554561, 5966.224390829165, 5959.314678811992, 6014.308354539196, 6022.849428764316, 6040.244969378828, 6072.180255665517, 5677.914831277617, 5678.716064196857, 5690.487856092972, 5782.190493331022, 5786.392428794916, 5658.434156584309, 5708.7165133946755, 5712.828615141552, 5713.0, 5729.713514324184, 5782.826515204551, 5975.970120149545, 6096.1465394845645, 6130.417610327012, 6138.202033735586, 4171.207470580702, 4180.561041090642, 4192.24539582878, 4201.18076974987, 4215.325547912319, 5823.806119745357, 5884.911726324023, 5899.587028907935, 5909.734061967136, 6024.349286314008, 5856.795012174553, 5872.647641141545, 5876.324222714443, 5883.323417806836, 5973.432523910222, 5862.882742345044, 5924.940750592439, 5955.731992060281, 5976.551758618208, 5978.641281523122, 5682.886342273214, 5797.420257974169, 5819.5344372450945, 5856.882862342814, 5887.911681324698, 5927.8221653350465, 5970.641761494324, 6001.489873360813, 6013.444286178269, 6043.8186854394435, 5689.829305120853, 5750.942490575041, 5807.8548036299435, 5813.709314534341, 5872.060470324898], "value": 4461.395291091922, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [743.4647054121034, 758.5638258001651, 758.8216769059271, 789.9368050555953, 858.6007506509471, 15037.62405939852, 15352.232388380593, 15930.20348982552, 16080.0, 16169.919150404246, 13640.249786261751, 13772.311384430763, 13853.653658658539, 13866.445342186325, 13951.651208719788, 839.391441205126, 845.4504572028169, 852.21170417364, 852.9977276699852, 853.5860107847689, 837.8533756592602, 857.0401150711181, 858.8153546987396, 861.1818772166436, 861.2550144125318, 902.4179404284265, 907.9092090790934, 910.2263076385053, 910.7768596693819, 912.1790388650202, 905.4883990545354, 909.0409617853162, 910.9362344635878, 911.0980129671577, 912.2519533982137, 669.6183175589915, 673.3603077076797, 673.9326067393271, 674.4031532094132, 674.514349668243, 14585.124892506483, 15076.09543427387, 15160.09039457636, 15210.695786084216, 15867.44463943768, 13701.109427887255, 14019.579412617637, 14158.929205353907, 14408.567742967727, 14734.115953042852, 11734.589289374917, 11768.646940591796, 11776.332536398566, 11874.762504749857, 12008.69978250542, 3737.6636102750613, 3746.6628003479545, 3765.3975363941636, 3775.207206486641, 3781.3760729479604, 69931.65034174797, 70705.64647176731, 71839.0, 72482.0, 72867.27132728658, 10826.783464330669, 11087.390193539271, 11108.444577771079, 11258.324500529994, 11313.71715707114, 21188.682169767464, 21219.575608487743, 21219.78780212209, 21226.78773212248, 21228.469288267916, 7830.6084695764985, 7831.686732530635, 8044.0, 8181.140980197112, 8220.958895205606, 4704.694194877322, 4725.812311198888, 4916.06594746997, 4918.508149185053, 4940.8764780880765, 3439.243366459375, 3515.8593656253975, 3565.4651802229873, 3569.37535931211, 3571.428571428559, 563.6730696196196, 568.85494198979, 569.8603842058723, 570.8316046766214, 573.7733595229861, 637.8437282865635, 643.2827397451902, 654.3521913305888, 685.8491131950963, 711.3775446484326, 9435.90564094364, 9573.18627916635, 9635.084666956627, 9709.616618343995, 9755.463449510204, 679.8164495586165, 686.145748543067, 693.3066933066933, 719.022129903331, 721.2535026247808, 4407.625351845129, 4408.911821763547, 4481.910361792746, 4489.618382437464, 4528.7509186994375, 61215.69392153011, 92121.0, 92396.53801730949, 93119.0, 98204.01795982092, 81006.5949670248, 82158.58920705358, 82373.58813205895, 83001.58499207466, 85414.57292713497, 46688.0, 47817.282740758914, 66569.66715166393, 72568.73980342965, 73464.26535734574, 8513.872291915503, 8712.564371781258, 8863.734087977371, 8968.551572421484, 9004.684836030969, 49280.0, 50340.74829625829, 50704.492955069974, 50972.0, 52255.477445225064, 62187.6890615544, 64660.353396465434, 66205.0, 67474.0, 68751.31248687449, 11479.8278025828, 11622.476988535705, 11726.589569365031, 11758.58844940423, 11873.525058997544, 12743.0, 12992.155509891827, 13119.606411807661, 13331.0, 13373.465061397435, 12155.149139560146, 12209.877901220874, 12226.510939562319, 12259.264444133381, 12363.75272494563, 11522.078233741448, 11757.176997610428, 11957.162998590014, 11966.34185119792, 12440.0, 11995.220310679779, 12209.206401584224, 12264.386780660752, 12546.247225166519, 12705.491780328683, 10440.321379110334, 10516.737081572715, 10628.84056739134, 10638.8936110641, 10734.677959661223, 10143.949280253551, 10803.297785643908, 10965.945170274097, 10982.121430285717, 10997.450127493434], "value": 7198.172728483068, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1474.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 111.0, 112.0, 113.0, 113.0, 113.0, 112.0, 113.0, 114.0, 112.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 122.0, 120.0, 164.0, 121.0, 123.0, 119.0, 119.0, 143.0, 123.0], "value": 129.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 164.0, 164.0, 162.0, 163.0, 163.0, 162.0, 162.0, 163.0], "value": 163.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 112.0, 77.0, 77.0, 75.0, 76.0, 99.0, 76.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 116.0, 84.0, 83.0, 83.0, 107.0, 83.0, 81.0, 120.0], "value": 92.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 151.0, 147.0, 149.0, 149.0, 147.0, 148.0, 147.0, 148.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 85.0, 85.0, 85.0, 86.0, 85.0, 86.0, 86.0, 85.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 52.0, 51.0, 53.0, 51.0, 52.0, 55.0, 54.0, 52.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 59.0, 59.0, 58.0, 60.0, 58.0, 57.0, 58.0, 58.0, 58.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 83.0, 83.0, 75.0, 83.0, 76.0, 74.0, 80.0, 80.0, 73.0], "value": 78.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 123.0, 124.0, 123.0, 125.0, 122.0, 131.0, 130.0, 173.0, 134.0], "value": 131.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 159.0, 165.0, 156.0, 155.0, 157.0, 162.0, 161.0, 163.0, 156.0], "value": 159.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 69.0, 69.0, 63.0, 64.0, 62.0, 65.0, 60.0, 62.0], "value": 63.9, "unit": "score"}]}]} 08:48:31 INFO - Return code: 0 08:48:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:48:31 ERROR - # TBPL SUCCESS # 08:48:31 INFO - Running post-action listener: _resource_record_post_action 08:48:31 INFO - [mozharness: 2016-12-14 16:48:31.387101Z] Finished run-tests step (success) 08:48:31 INFO - Running post-run listener: _resource_record_post_run 08:48:31 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 266240; Write bytes: 364724224; Read time: 24; Write time: 213660 08:48:31 INFO - TinderboxPrint: CPU usage
13.3% 08:48:31 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 24 08:48:31 INFO - TinderboxPrint: I/O write bytes / time
364,724,224 / 213,660 08:48:31 INFO - TinderboxPrint: CPU idle
8,233.7 (86.6%) 08:48:31 INFO - TinderboxPrint: CPU user
1,210.8 (12.7%) 08:48:31 INFO - TinderboxPrint: Swap in / out
0 / 0 08:48:31 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 118370304; Read time: 0; Write time: 89680 08:48:31 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 266240; Write bytes: 245440512; Read time: 24; Write time: 123956 08:48:32 INFO - Running post-run listener: _upload_blobber_files 08:48:32 INFO - Blob upload gear active. 08:48:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:48:32 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:48:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:48:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:48:32 INFO - (blobuploader) - INFO - Open directory for files ... 08:48:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:48:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:48:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:48:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:48:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:48:33 INFO - (blobuploader) - INFO - Done attempting. 08:48:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:48:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:48:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:48:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:48:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:48:36 INFO - (blobuploader) - INFO - Done attempting. 08:48:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:48:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:48:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:48:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:48:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:48:37 INFO - (blobuploader) - INFO - Done attempting. 08:48:37 INFO - (blobuploader) - INFO - Iteration through files over. 08:48:37 INFO - Return code: 0 08:48:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:48:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:48:37 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3e0bdd3df617a1cb18129e46e64cba2dae0977fdf80e6756b3061e03fb27cfb30ed5599767cc7ad8cd982d72e9d8496672048d86fcd0c20aa1a62775d183e644", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a2f73ff9130774cd2b742b11d2adcfa573df20fe58a328972b95c3902d74d1cf6ba97c4299d592da6769fc7e7195ef1e70aad9aba7a33d2f227bbccc0fa78adb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ed435f0b7c251a623653b96d637d109344f02d2e452c8e05bc86adb9658eec1f1050bde7d1b32b7cc5c0c7131132939d9a39a3dbac119bbcbfd7547b8d470dd8"} 08:48:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:48:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:48:37 INFO - Contents: 08:48:37 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3e0bdd3df617a1cb18129e46e64cba2dae0977fdf80e6756b3061e03fb27cfb30ed5599767cc7ad8cd982d72e9d8496672048d86fcd0c20aa1a62775d183e644", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a2f73ff9130774cd2b742b11d2adcfa573df20fe58a328972b95c3902d74d1cf6ba97c4299d592da6769fc7e7195ef1e70aad9aba7a33d2f227bbccc0fa78adb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ed435f0b7c251a623653b96d637d109344f02d2e452c8e05bc86adb9658eec1f1050bde7d1b32b7cc5c0c7131132939d9a39a3dbac119bbcbfd7547b8d470dd8"} 08:48:37 INFO - Running post-run listener: copy_logs_to_upload_dir 08:48:37 INFO - Copying logs to upload dir... 08:48:37 INFO - mkdir: /builds/slave/test/build/upload/logs 08:48:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.650356 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-12-14 08:48:36.382684) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-14 08:48:36.386180) ========= 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=4300f881736b422476174874000001bc-1481732881.600344-1580398743 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/3e0bdd3df617a1cb18129e46e64cba2dae0977fdf80e6756b3061e03fb27cfb30ed5599767cc7ad8cd982d72e9d8496672048d86fcd0c20aa1a62775d183e644", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a2f73ff9130774cd2b742b11d2adcfa573df20fe58a328972b95c3902d74d1cf6ba97c4299d592da6769fc7e7195ef1e70aad9aba7a33d2f227bbccc0fa78adb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ed435f0b7c251a623653b96d637d109344f02d2e452c8e05bc86adb9658eec1f1050bde7d1b32b7cc5c0c7131132939d9a39a3dbac119bbcbfd7547b8d470dd8"} build_url:https://queue.taskcluster.net/v1/task/LiX5Ig4KSzi7T16syMTLkA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011803 build_url: 'https://queue.taskcluster.net/v1/task/LiX5Ig4KSzi7T16syMTLkA/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/3e0bdd3df617a1cb18129e46e64cba2dae0977fdf80e6756b3061e03fb27cfb30ed5599767cc7ad8cd982d72e9d8496672048d86fcd0c20aa1a62775d183e644", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a2f73ff9130774cd2b742b11d2adcfa573df20fe58a328972b95c3902d74d1cf6ba97c4299d592da6769fc7e7195ef1e70aad9aba7a33d2f227bbccc0fa78adb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ed435f0b7c251a623653b96d637d109344f02d2e452c8e05bc86adb9658eec1f1050bde7d1b32b7cc5c0c7131132939d9a39a3dbac119bbcbfd7547b8d470dd8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-14 08:48:36.411121) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 08:48:36.411401) ========= 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=4300f881736b422476174874000001bc-1481732881.600344-1580398743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004469 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 08:48:36.496283) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-14 08:48:36.496561) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-14 08:48:36.496831) ========= ========= Total master_lag: 0.17 =========