builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-011 starttime: 1480142222.01 results: success (0) buildid: 20161125211919 builduid: 38ea101456ab42db84d9a364749341cc revision: ee388da4aeb6b686a04c16d11ca8606ee2b3e8e0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-25 22:37:02.010080) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-25 22:37:02.010554) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-25 22:37:02.010882) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-25 22:37:02.030855) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 22:37:02.031186) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1480137413.236495-1213197336 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-25 22:37: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.2K=0.3s 2016-11-25 22:37:02 (43.2 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.416217 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 22:37:02.461324) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 22:37:02.461670) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1480137413.236495-1213197336 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021774 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 22:37:02.511445) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 22:37:02.511836) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ee388da4aeb6b686a04c16d11ca8606ee2b3e8e0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev ee388da4aeb6b686a04c16d11ca8606ee2b3e8e0 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1480137413.236495-1213197336 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-25 22:37:03,003 truncating revision to first 12 chars 2016-11-25 22:37:03,003 Setting DEBUG logging. 2016-11-25 22:37:03,003 attempt 1/10 2016-11-25 22:37:03,003 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ee388da4aeb6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-25 22:37:03,331 unpacking tar archive at: mozilla-central-ee388da4aeb6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.656443 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 22:37:03.184255) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-25 22:37:03.184602) ========= script_repo_revision: ee388da4aeb6b686a04c16d11ca8606ee2b3e8e0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-25 22:37:03.185009) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-25 22:37:03.185320) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-25 22:37:03.196903) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-11-25 22:37:03.197275) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1480137413.236495-1213197336 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:37:03 INFO - MultiFileLogger online at 20161125 22:37:03 in /builds/slave/test 22:37:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 22:37:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:37:03 INFO - {'append_to_log': False, 22:37:03 INFO - 'base_work_dir': '/builds/slave/test', 22:37:03 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 22:37:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:37:03 INFO - 'branch': 'Firefox-Non-PGO', 22:37:03 INFO - 'buildbot_json_path': 'buildprops.json', 22:37:03 INFO - 'config_files': ('talos/linux_config.py',), 22:37:03 INFO - 'default_actions': ('clobber', 22:37:03 INFO - 'read-buildbot-config', 22:37:03 INFO - 'download-and-extract', 22:37:03 INFO - 'populate-webroot', 22:37:03 INFO - 'create-virtualenv', 22:37:03 INFO - 'install', 22:37:03 INFO - 'run-tests'), 22:37:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:37:03 INFO - 'download_minidump_stackwalk': True, 22:37:03 INFO - 'download_symbols': 'ondemand', 22:37:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:37:03 INFO - 'tooltool.py': '/tools/tooltool.py', 22:37:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:37:03 INFO - '/tools/misc-python/virtualenv.py')}, 22:37:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:37:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:37:03 INFO - 'installer_path': 'installer.exe', 22:37:03 INFO - 'log_level': 'info', 22:37:03 INFO - 'log_name': 'talos', 22:37:03 INFO - 'log_to_console': True, 22:37:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:37:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:37:03 INFO - 'opt_config_files': (), 22:37:03 INFO - 'pip_index': False, 22:37:03 INFO - 'sps_profile': False, 22:37:03 INFO - 'sps_profile_interval': 0, 22:37:03 INFO - 'suite': 'dromaeojs-e10s', 22:37:03 INFO - 'system_bits': '32', 22:37:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:37:03 INFO - 'title': 'talos-linux64-ix-011', 22:37:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:37:03 INFO - 'use_talos_json': True, 22:37:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:37:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:37:03 INFO - 'work_dir': 'build'} 22:37:03 INFO - [mozharness: 2016-11-26 06:37:03.788787Z] Running clobber step. 22:37:03 INFO - Running pre-action listener: _resource_record_pre_action 22:37:03 INFO - Running main action method: clobber 22:37:03 INFO - rmtree: /builds/slave/test/build 22:37:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:37:04 INFO - Running post-action listener: _resource_record_post_action 22:37:04 INFO - [mozharness: 2016-11-26 06:37:04.782592Z] Finished clobber step (success) 22:37:04 INFO - [mozharness: 2016-11-26 06:37:04.782690Z] Running read-buildbot-config step. 22:37:04 INFO - Running pre-action listener: _resource_record_pre_action 22:37:04 INFO - Running main action method: read_buildbot_config 22:37:04 INFO - Using buildbot properties: 22:37:04 INFO - { 22:37:04 INFO - "project": "", 22:37:04 INFO - "product": "firefox", 22:37:04 INFO - "script_repo_revision": "production", 22:37:04 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 22:37:04 INFO - "repository": "", 22:37:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 22:37:04 INFO - "buildid": "20161125211919", 22:37:04 INFO - "pgo_build": "False", 22:37:04 INFO - "basedir": "/builds/slave/test", 22:37:04 INFO - "buildnumber": 567, 22:37:04 INFO - "slavename": "talos-linux64-ix-011", 22:37:04 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:37:04 INFO - "platform": "ubuntu64_hw", 22:37:04 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 22:37:04 INFO - "branch": "mozilla-central", 22:37:04 INFO - "repo_path": "mozilla-central", 22:37:04 INFO - "revision": "ee388da4aeb6b686a04c16d11ca8606ee2b3e8e0", 22:37:04 INFO - "stage_platform": "linux64", 22:37:04 INFO - "builduid": "38ea101456ab42db84d9a364749341cc", 22:37:04 INFO - "slavebuilddir": "test" 22:37:04 INFO - } 22:37:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/by1X_ZPxT8Gfbv2tp3SjVQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 22:37:04 INFO - Running post-action listener: _resource_record_post_action 22:37:04 INFO - [mozharness: 2016-11-26 06:37:04.785087Z] Finished read-buildbot-config step (success) 22:37:04 INFO - [mozharness: 2016-11-26 06:37:04.785175Z] Running download-and-extract step. 22:37:04 INFO - Running pre-action listener: _resource_record_pre_action 22:37:04 INFO - Running main action method: download_and_extract 22:37:04 INFO - mkdir: /builds/slave/test/build/tests 22:37: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')]} 22:37:04 INFO - trying https://queue.taskcluster.net/v1/task/by1X_ZPxT8Gfbv2tp3SjVQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 22:37:04 INFO - Downloading https://queue.taskcluster.net/v1/task/by1X_ZPxT8Gfbv2tp3SjVQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 22:37:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/by1X_ZPxT8Gfbv2tp3SjVQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:37:05 INFO - Downloaded 1361 bytes. 22:37:05 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 22:37:05 INFO - Using the following test package requirements: 22:37:05 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 22:37:05 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:37:05 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:37:05 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:37:05 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:37:05 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:37:05 INFO - u'jsshell-linux-x86_64.zip'], 22:37:05 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:37:05 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:37:05 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 22:37:05 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:37:05 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:37:05 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:37:05 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:37:05 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:37:05 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:37:05 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:37:05 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:37:05 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:37:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/by1X_ZPxT8Gfbv2tp3SjVQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 22:37:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/by1X_ZPxT8Gfbv2tp3SjVQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:37:05 INFO - Fetch https://queue.taskcluster.net/v1/task/by1X_ZPxT8Gfbv2tp3SjVQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:37:05 INFO - Http code: 200 22:37:05 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 22:37:05 INFO - x-amz-cf-id: 6sQMCGojdt1nzsE8TEpQaKgVszyYRi3UOhIbPIX9ozSsJwQ6PAJi6w== 22:37:05 INFO - x-amz-version-id: r4CqcWzsGY6k6mmnXiojrnZoYTvsZbfQ 22:37:06 INFO - Expected file size: 20205206 22:37:06 INFO - Obtained file size: 20205206 22:37:10 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:37:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/by1X_ZPxT8Gfbv2tp3SjVQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 22:37:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/by1X_ZPxT8Gfbv2tp3SjVQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:37:10 INFO - Fetch https://queue.taskcluster.net/v1/task/by1X_ZPxT8Gfbv2tp3SjVQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:37:10 INFO - Http code: 200 22:37:10 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 22:37:10 INFO - x-amz-cf-id: 3zLtaXYJulkwST4-5goEooi_rkGlJ6QBXVdJJw1LSdN4nppUOaKS4g== 22:37:10 INFO - x-amz-version-id: r4CqcWzsGY6k6mmnXiojrnZoYTvsZbfQ 22:37:11 INFO - Expected file size: 20205206 22:37:11 INFO - Obtained file size: 20205206 22:37:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/by1X_ZPxT8Gfbv2tp3SjVQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 22:37:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/by1X_ZPxT8Gfbv2tp3SjVQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:37:15 INFO - Fetch https://queue.taskcluster.net/v1/task/by1X_ZPxT8Gfbv2tp3SjVQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 22:37:16 INFO - Http code: 200 22:37:16 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 22:37:16 INFO - x-amz-cf-id: lucy6_p7PDK4sNN103U61CD2kpkect7uHntaBFJ_ehIvGffGOtVayQ== 22:37:16 INFO - x-amz-version-id: JIBQtZVt2JXKrYmmSGDwulnggqw3swjV 22:37:16 INFO - Expected file size: 14409702 22:37:16 INFO - Obtained file size: 14409702 22:37:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:16 INFO - trying https://queue.taskcluster.net/v1/task/by1X_ZPxT8Gfbv2tp3SjVQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 22:37:16 INFO - Downloading https://queue.taskcluster.net/v1/task/by1X_ZPxT8Gfbv2tp3SjVQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 22:37:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/by1X_ZPxT8Gfbv2tp3SjVQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:37:17 INFO - Downloaded 55675387 bytes. 22:37:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/by1X_ZPxT8Gfbv2tp3SjVQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 22:37:17 INFO - mkdir: /builds/slave/test/properties 22:37:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:37:17 INFO - Writing to file /builds/slave/test/properties/build_url 22:37:17 INFO - Contents: 22:37:17 INFO - build_url:https://queue.taskcluster.net/v1/task/by1X_ZPxT8Gfbv2tp3SjVQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 22:37:18 INFO - Running post-action listener: _resource_record_post_action 22:37:18 INFO - Running post-action listener: set_extra_try_arguments 22:37:18 INFO - [mozharness: 2016-11-26 06:37:18.374499Z] Finished download-and-extract step (success) 22:37:18 INFO - [mozharness: 2016-11-26 06:37:18.374723Z] Running populate-webroot step. 22:37:18 INFO - Running pre-action listener: _resource_record_pre_action 22:37:18 INFO - Running main action method: populate_webroot 22:37:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:37:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:37:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:37:18 INFO - '--tppagecycles', 22:37:18 INFO - '7'], 22:37:18 INFO - 'tests': ['tsvgm']}}, 22:37:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:37:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:37:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:37:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:37:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:37:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:37:18 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 22:37:18 INFO - 'talos_options': ['--disable-e10s'], 22:37:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:37:18 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 22:37:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:37:18 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 22:37:18 INFO - 'talos_options': ['--disable-e10s'], 22:37:18 INFO - 'tests': ['damp', 'tps']}, 22:37:18 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 22:37:18 INFO - 'tests': ['damp', 'tps']}, 22:37:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:37:18 INFO - 'tests': ['dromaeo_dom']}, 22:37:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:37:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:37:18 INFO - 'tests': ['basic_compositor_video']}, 22:37:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:37:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:37:18 INFO - 'tests': ['a11yr', 22:37:18 INFO - 'ts_paint', 22:37:18 INFO - 'tpaint', 22:37:18 INFO - 'sessionrestore', 22:37:18 INFO - 'sessionrestore_no_auto_restore', 22:37:18 INFO - 'tabpaint']}, 22:37:18 INFO - 'other-e10s': {'tests': ['a11yr', 22:37:18 INFO - 'ts_paint', 22:37:18 INFO - 'tpaint', 22:37:18 INFO - 'sessionrestore', 22:37:18 INFO - 'sessionrestore_no_auto_restore', 22:37:18 INFO - 'tabpaint']}, 22:37:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:37:18 INFO - 'ts_paint', 22:37:18 INFO - 'tpaint', 22:37:18 INFO - 'sessionrestore', 22:37:18 INFO - 'sessionrestore_no_auto_restore', 22:37:18 INFO - 'tabpaint']}, 22:37:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:37:18 INFO - 'ts_paint', 22:37:18 INFO - 'tpaint', 22:37:18 INFO - 'sessionrestore', 22:37:18 INFO - 'sessionrestore_no_auto_restore', 22:37:18 INFO - 'tabpaint']}, 22:37:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:37:18 INFO - 'tests': ['a11yr', 22:37:18 INFO - 'ts_paint', 22:37:18 INFO - 'tpaint', 22:37:18 INFO - 'sessionrestore', 22:37:18 INFO - 'sessionrestore_no_auto_restore', 22:37:18 INFO - 'tabpaint']}, 22:37:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:37:18 INFO - 'tests': ['a11yr', 22:37:18 INFO - 'ts_paint', 22:37:18 INFO - 'tpaint', 22:37:18 INFO - 'sessionrestore', 22:37:18 INFO - 'sessionrestore_no_auto_restore', 22:37:18 INFO - 'tabpaint']}, 22:37:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:37:18 INFO - 'tests': ['tsvgx', 22:37:18 INFO - 'tsvgr_opacity', 22:37:18 INFO - 'tart', 22:37:18 INFO - 'tscrollx', 22:37:18 INFO - 'cart', 22:37:18 INFO - 'tsvg_static']}, 22:37:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:37:18 INFO - 'tsvgr_opacity', 22:37:18 INFO - 'tart', 22:37:18 INFO - 'tscrollx', 22:37:18 INFO - 'cart', 22:37:18 INFO - 'tsvg_static']}, 22:37:18 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 22:37:18 INFO - 'talos_options': ['--disable-e10s'], 22:37:18 INFO - 'tests': ['tp5o']}, 22:37:18 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 22:37:18 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 22:37:18 INFO - 'talos_options': ['--disable-e10s', 22:37:18 INFO - '--xperf_path', 22:37:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:37:18 INFO - 'tests': ['tp5n']}, 22:37:18 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 22:37:18 INFO - 'talos_options': ['--xperf_path', 22:37:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:37:18 INFO - 'tests': ['tp5n']}}, 22:37:18 INFO - 'talos.zip': {'path': '', 22:37:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:37:18 INFO - Running post-action listener: _resource_record_post_action 22:37:18 INFO - [mozharness: 2016-11-26 06:37:18.389628Z] Finished populate-webroot step (success) 22:37:18 INFO - [mozharness: 2016-11-26 06:37:18.389733Z] Running create-virtualenv step. 22:37:18 INFO - Running pre-action listener: _resource_record_pre_action 22:37:18 INFO - Running main action method: create_virtualenv 22:37:18 INFO - Creating virtualenv /builds/slave/test/build/venv 22:37:18 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 22:37:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:37:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:37:18 INFO - Using real prefix '/usr' 22:37:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:37:18 INFO - Installing distribute.............................................................................................................................................................................................done. 22:37:20 INFO - Installing pip.................done. 22:37:20 INFO - Return code: 0 22:37:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:37:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:37:21 INFO - Reading from file tmpfile_stdout 22:37:21 INFO - Output received: 22:37:21 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) 22:37:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:37:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:37:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:37:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:21 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 0x7f887f09fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15aeb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174a130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d8fc0>, '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 0x17d9ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17da350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480137413.236495-1213197336', '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 22:37:21 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 22:37:21 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 22:37:21 INFO - Using env: {'DISPLAY': ':0', 22:37:21 INFO - 'HOME': '/home/cltbld', 22:37:21 INFO - 'LANG': 'en_US.UTF-8', 22:37:21 INFO - 'LANGUAGE': 'en_US:en', 22:37:21 INFO - 'LOGNAME': 'cltbld', 22:37:21 INFO - 'MAIL': '/var/mail/cltbld', 22:37:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:37:21 INFO - 'MOZ_NO_REMOTE': '1', 22:37:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:37:21 INFO - 'NO_EM_RESTART': '1', 22:37:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:37:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:37:21 INFO - 'PWD': '/builds/slave/test', 22:37:21 INFO - 'SHELL': '/bin/bash', 22:37:21 INFO - 'SHLVL': '1', 22:37:21 INFO - 'TERM': 'linux', 22:37:21 INFO - 'TMOUT': '86400', 22:37:21 INFO - 'USER': 'cltbld', 22:37:21 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480137413.236495-1213197336', 22:37:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:37:21 INFO - '_': '/tools/buildbot/bin/python'} 22:37:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:37:21 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 22:37:21 INFO - Cleaning up... 22:37:21 INFO - Return code: 0 22:37:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:37:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:37:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:37:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:21 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 0x7f887f09fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15aeb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174a130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d8fc0>, '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 0x17d9ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17da350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480137413.236495-1213197336', '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 22:37:21 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 22:37:21 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 22:37:21 INFO - Using env: {'DISPLAY': ':0', 22:37:21 INFO - 'HOME': '/home/cltbld', 22:37:21 INFO - 'LANG': 'en_US.UTF-8', 22:37:21 INFO - 'LANGUAGE': 'en_US:en', 22:37:21 INFO - 'LOGNAME': 'cltbld', 22:37:21 INFO - 'MAIL': '/var/mail/cltbld', 22:37:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:37:21 INFO - 'MOZ_NO_REMOTE': '1', 22:37:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:37:21 INFO - 'NO_EM_RESTART': '1', 22:37:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:37:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:37:21 INFO - 'PWD': '/builds/slave/test', 22:37:21 INFO - 'SHELL': '/bin/bash', 22:37:21 INFO - 'SHLVL': '1', 22:37:21 INFO - 'TERM': 'linux', 22:37:21 INFO - 'TMOUT': '86400', 22:37:21 INFO - 'USER': 'cltbld', 22:37:21 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480137413.236495-1213197336', 22:37:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:37:21 INFO - '_': '/tools/buildbot/bin/python'} 22:37:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:37:21 INFO - Downloading/unpacking psutil>=3.1.1 22:37:21 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 22:37:21 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 22:37:21 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 22:37:21 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 22:37:21 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 22:37:21 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 22:37:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:37:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:37:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:37:23 INFO - Installing collected packages: psutil 22:37:23 INFO - Running setup.py install for psutil 22:37:23 INFO - building 'psutil._psutil_linux' extension 22:37: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 22:37: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 22:37:23 INFO - building 'psutil._psutil_posix' extension 22:37: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 22:37:24 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 22:37:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:37:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:37:24 INFO - Successfully installed psutil 22:37:24 INFO - Cleaning up... 22:37:24 INFO - Return code: 0 22:37:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:37:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:37:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:37:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:24 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 0x7f887f09fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15aeb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174a130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d8fc0>, '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 0x17d9ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17da350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480137413.236495-1213197336', '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 22:37:24 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 22:37:24 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 22:37:24 INFO - Using env: {'DISPLAY': ':0', 22:37:24 INFO - 'HOME': '/home/cltbld', 22:37:24 INFO - 'LANG': 'en_US.UTF-8', 22:37:24 INFO - 'LANGUAGE': 'en_US:en', 22:37:24 INFO - 'LOGNAME': 'cltbld', 22:37:24 INFO - 'MAIL': '/var/mail/cltbld', 22:37:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:37:24 INFO - 'MOZ_NO_REMOTE': '1', 22:37:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:37:24 INFO - 'NO_EM_RESTART': '1', 22:37:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:37:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:37:24 INFO - 'PWD': '/builds/slave/test', 22:37:24 INFO - 'SHELL': '/bin/bash', 22:37:24 INFO - 'SHLVL': '1', 22:37:24 INFO - 'TERM': 'linux', 22:37:24 INFO - 'TMOUT': '86400', 22:37:24 INFO - 'USER': 'cltbld', 22:37:24 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480137413.236495-1213197336', 22:37:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:37:24 INFO - '_': '/tools/buildbot/bin/python'} 22:37:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:37:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:37:24 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 22:37:24 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 22:37:24 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 22:37:24 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 22:37:24 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 22:37:24 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 22:37:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:37:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:37:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:37:26 INFO - Installing collected packages: mozsystemmonitor 22:37:26 INFO - Running setup.py install for mozsystemmonitor 22:37:26 INFO - Successfully installed mozsystemmonitor 22:37:26 INFO - Cleaning up... 22:37:26 INFO - Return code: 0 22:37:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:37:26 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')]} 22:37:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:37:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:26 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')]} 22:37:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:37:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:26 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 0x7f887f09fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15aeb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174a130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d8fc0>, '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 0x17d9ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17da350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480137413.236495-1213197336', '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 22:37:26 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 22:37:26 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 22:37:26 INFO - Using env: {'DISPLAY': ':0', 22:37:26 INFO - 'HOME': '/home/cltbld', 22:37:26 INFO - 'LANG': 'en_US.UTF-8', 22:37:26 INFO - 'LANGUAGE': 'en_US:en', 22:37:26 INFO - 'LOGNAME': 'cltbld', 22:37:26 INFO - 'MAIL': '/var/mail/cltbld', 22:37:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:37:26 INFO - 'MOZ_NO_REMOTE': '1', 22:37:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:37:26 INFO - 'NO_EM_RESTART': '1', 22:37:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:37:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:37:26 INFO - 'PWD': '/builds/slave/test', 22:37:26 INFO - 'SHELL': '/bin/bash', 22:37:26 INFO - 'SHLVL': '1', 22:37:26 INFO - 'TERM': 'linux', 22:37:26 INFO - 'TMOUT': '86400', 22:37:26 INFO - 'USER': 'cltbld', 22:37:26 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480137413.236495-1213197336', 22:37:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:37:26 INFO - '_': '/tools/buildbot/bin/python'} 22:37:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:37:26 INFO - Downloading/unpacking jsonschema==2.5.1 22:37: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 22:37: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 22:37: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 22:37: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 22:37: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 22:37: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 22:37:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:37:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:37: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 22:37: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 22:37: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 22:37: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 22:37: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 22:37: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 22:37:29 INFO - Downloading functools32-3.2.3-2.tar.gz 22:37:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:37:29 INFO - warning: no files found matching '*.txt' 22:37:29 INFO - no previously-included directories found matching 'build' 22:37:29 INFO - no previously-included directories found matching 'dist' 22:37:29 INFO - no previously-included directories found matching '.git*' 22:37:29 INFO - Installing collected packages: jsonschema, functools32 22:37:29 INFO - Running setup.py install for functools32 22:37:29 INFO - warning: no files found matching '*.txt' 22:37:29 INFO - no previously-included directories found matching 'build' 22:37:29 INFO - no previously-included directories found matching 'dist' 22:37:29 INFO - no previously-included directories found matching '.git*' 22:37:29 INFO - Successfully installed jsonschema functools32 22:37:29 INFO - Cleaning up... 22:37:29 INFO - Return code: 0 22:37:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:37:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:37:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:37:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f887f09fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15aeb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174a130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d8fc0>, '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 0x17d9ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17da350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480137413.236495-1213197336', '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 22:37:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 22:37:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 22:37:29 INFO - Using env: {'DISPLAY': ':0', 22:37:29 INFO - 'HOME': '/home/cltbld', 22:37:29 INFO - 'LANG': 'en_US.UTF-8', 22:37:29 INFO - 'LANGUAGE': 'en_US:en', 22:37:29 INFO - 'LOGNAME': 'cltbld', 22:37:29 INFO - 'MAIL': '/var/mail/cltbld', 22:37:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:37:29 INFO - 'MOZ_NO_REMOTE': '1', 22:37:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:37:29 INFO - 'NO_EM_RESTART': '1', 22:37:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:37:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:37:29 INFO - 'PWD': '/builds/slave/test', 22:37:29 INFO - 'SHELL': '/bin/bash', 22:37:29 INFO - 'SHLVL': '1', 22:37:29 INFO - 'TERM': 'linux', 22:37:29 INFO - 'TMOUT': '86400', 22:37:29 INFO - 'USER': 'cltbld', 22:37:29 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480137413.236495-1213197336', 22:37:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:37:29 INFO - '_': '/tools/buildbot/bin/python'} 22:37:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:37:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:37:29 INFO - Cleaning up... 22:37:29 INFO - Return code: 0 22:37:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:37:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:37:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:37:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f887f09fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15aeb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174a130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d8fc0>, '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 0x17d9ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17da350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480137413.236495-1213197336', '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 22:37:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:37:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:37:29 INFO - Using env: {'DISPLAY': ':0', 22:37:29 INFO - 'HOME': '/home/cltbld', 22:37:29 INFO - 'LANG': 'en_US.UTF-8', 22:37:29 INFO - 'LANGUAGE': 'en_US:en', 22:37:29 INFO - 'LOGNAME': 'cltbld', 22:37:29 INFO - 'MAIL': '/var/mail/cltbld', 22:37:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:37:29 INFO - 'MOZ_NO_REMOTE': '1', 22:37:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:37:29 INFO - 'NO_EM_RESTART': '1', 22:37:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:37:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:37:29 INFO - 'PWD': '/builds/slave/test', 22:37:29 INFO - 'SHELL': '/bin/bash', 22:37:29 INFO - 'SHLVL': '1', 22:37:29 INFO - 'TERM': 'linux', 22:37:29 INFO - 'TMOUT': '86400', 22:37:29 INFO - 'USER': 'cltbld', 22:37:29 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480137413.236495-1213197336', 22:37:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:37:29 INFO - '_': '/tools/buildbot/bin/python'} 22:37:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:37:29 INFO - Downloading/unpacking blobuploader==1.2.4 22:37: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 22:37: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 22:37: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 22:37: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 22:37: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 22:37: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 22:37:31 INFO - Downloading blobuploader-1.2.4.tar.gz 22:37:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:37:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:37:32 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 22:37:32 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 22:37:32 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 22:37:32 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 22:37:32 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 22:37:32 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 22:37:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:37:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:37:32 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 22:37:32 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 22:37:32 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 22:37:32 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 22:37:32 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 22:37:32 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 22:37:32 INFO - Downloading docopt-0.6.1.tar.gz 22:37:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:37:32 INFO - Installing collected packages: blobuploader, requests, docopt 22:37:32 INFO - Running setup.py install for blobuploader 22:37:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:37:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:37:32 INFO - Running setup.py install for requests 22:37:33 INFO - Running setup.py install for docopt 22:37:33 INFO - Successfully installed blobuploader requests docopt 22:37:33 INFO - Cleaning up... 22:37:33 INFO - Return code: 0 22:37:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:37:33 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')]} 22:37:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:37:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:33 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')]} 22:37:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:37:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:33 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 0x7f887f09fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15aeb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174a130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d8fc0>, '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 0x17d9ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17da350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480137413.236495-1213197336', '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 22:37:33 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 22:37:33 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 22:37:33 INFO - Using env: {'DISPLAY': ':0', 22:37:33 INFO - 'HOME': '/home/cltbld', 22:37:33 INFO - 'LANG': 'en_US.UTF-8', 22:37:33 INFO - 'LANGUAGE': 'en_US:en', 22:37:33 INFO - 'LOGNAME': 'cltbld', 22:37:33 INFO - 'MAIL': '/var/mail/cltbld', 22:37:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:37:33 INFO - 'MOZ_NO_REMOTE': '1', 22:37:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:37:33 INFO - 'NO_EM_RESTART': '1', 22:37:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:37:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:37:33 INFO - 'PWD': '/builds/slave/test', 22:37:33 INFO - 'SHELL': '/bin/bash', 22:37:33 INFO - 'SHLVL': '1', 22:37:33 INFO - 'TERM': 'linux', 22:37:33 INFO - 'TMOUT': '86400', 22:37:33 INFO - 'USER': 'cltbld', 22:37:33 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480137413.236495-1213197336', 22:37:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:37:33 INFO - '_': '/tools/buildbot/bin/python'} 22:37:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:37:33 INFO - Running setup.py (path:/tmp/pip-rKKOqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:37:33 INFO - Running setup.py (path:/tmp/pip-XT38V0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:37:33 INFO - Running setup.py (path:/tmp/pip-IHbAPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:37:33 INFO - Running setup.py (path:/tmp/pip-dEvfgI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:37:33 INFO - Running setup.py (path:/tmp/pip-ff3AUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:37:33 INFO - Running setup.py (path:/tmp/pip-JLQ5xH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:37:34 INFO - Running setup.py (path:/tmp/pip-UbeNab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:37:34 INFO - Running setup.py (path:/tmp/pip-FOTXWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:37:34 INFO - Running setup.py (path:/tmp/pip-vlAxR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:37:34 INFO - Running setup.py (path:/tmp/pip-YyTZm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:37:34 INFO - Running setup.py (path:/tmp/pip-tRin8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:37:34 INFO - Running setup.py (path:/tmp/pip-fAWL3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:37:34 INFO - Running setup.py (path:/tmp/pip-HssCYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:37:34 INFO - Running setup.py (path:/tmp/pip-Xdw00t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:37:34 INFO - Running setup.py (path:/tmp/pip-ZZn4tI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:37:34 INFO - Running setup.py (path:/tmp/pip-HC4fQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:37:34 INFO - Running setup.py (path:/tmp/pip-FtY7Pj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:37:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:37:34 INFO - Running setup.py install for manifestparser 22:37:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:37:34 INFO - Running setup.py install for mozcrash 22:37:35 INFO - Running setup.py install for mozdebug 22:37:35 INFO - Running setup.py install for mozdevice 22:37:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:37:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:37:35 INFO - Running setup.py install for mozfile 22:37:35 INFO - Running setup.py install for mozhttpd 22:37:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:37:35 INFO - Running setup.py install for mozinfo 22:37:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:37:35 INFO - Running setup.py install for mozInstall 22:37:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:37:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:37:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:37:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:37:35 INFO - Running setup.py install for mozleak 22:37:35 INFO - Running setup.py install for mozlog 22:37:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:37:35 INFO - Running setup.py install for moznetwork 22:37:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:37:35 INFO - Running setup.py install for mozprocess 22:37:36 INFO - Running setup.py install for mozprofile 22:37:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:37:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:37:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:37:36 INFO - Running setup.py install for mozrunner 22:37:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:37:36 INFO - Running setup.py install for mozscreenshot 22:37:36 INFO - Running setup.py install for moztest 22:37:36 INFO - Running setup.py install for mozversion 22:37:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:37:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:37:36 INFO - Cleaning up... 22:37:36 INFO - Return code: 0 22:37:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:37:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:37:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:37:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:36 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 0x7f887f09fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15aeb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174a130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d8fc0>, '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 0x17d9ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17da350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480137413.236495-1213197336', '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 22:37:36 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 22:37:36 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 22:37:36 INFO - Using env: {'DISPLAY': ':0', 22:37:36 INFO - 'HOME': '/home/cltbld', 22:37:36 INFO - 'LANG': 'en_US.UTF-8', 22:37:36 INFO - 'LANGUAGE': 'en_US:en', 22:37:36 INFO - 'LOGNAME': 'cltbld', 22:37:36 INFO - 'MAIL': '/var/mail/cltbld', 22:37:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:37:36 INFO - 'MOZ_NO_REMOTE': '1', 22:37:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:37:36 INFO - 'NO_EM_RESTART': '1', 22:37:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:37:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:37:36 INFO - 'PWD': '/builds/slave/test', 22:37:36 INFO - 'SHELL': '/bin/bash', 22:37:36 INFO - 'SHLVL': '1', 22:37:36 INFO - 'TERM': 'linux', 22:37:36 INFO - 'TMOUT': '86400', 22:37:36 INFO - 'USER': 'cltbld', 22:37:36 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480137413.236495-1213197336', 22:37:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:37:36 INFO - '_': '/tools/buildbot/bin/python'} 22:37:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:37:36 INFO - Running setup.py (path:/tmp/pip-DCZnEI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:37:36 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)) 22:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:37:36 INFO - Running setup.py (path:/tmp/pip-W92zmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:37:37 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)) 22:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:37:37 INFO - Running setup.py (path:/tmp/pip-5tGa9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:37:37 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)) 22:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:37:37 INFO - Running setup.py (path:/tmp/pip-oyfezg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 22:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:37:37 INFO - Running setup.py (path:/tmp/pip-eZeAzl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:37:37 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)) 22:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:37:37 INFO - Running setup.py (path:/tmp/pip-0ItQfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:37:37 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)) 22:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:37:37 INFO - Running setup.py (path:/tmp/pip-oPeNtC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:37:37 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)) 22:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:37:37 INFO - Running setup.py (path:/tmp/pip-Gijm0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:37:37 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)) 22:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:37:37 INFO - Running setup.py (path:/tmp/pip-b2fzcv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:37:37 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)) 22:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:37:37 INFO - Running setup.py (path:/tmp/pip-PypW7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:37:37 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)) 22:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:37:37 INFO - Running setup.py (path:/tmp/pip-qNTzg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:37:37 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)) 22:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:37:37 INFO - Running setup.py (path:/tmp/pip-LxUTmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:37:37 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)) 22:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:37:37 INFO - Running setup.py (path:/tmp/pip-tNNnZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:37:37 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)) 22:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:37:37 INFO - Running setup.py (path:/tmp/pip-f6wsVF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:37:37 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)) 22:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:37:37 INFO - Running setup.py (path:/tmp/pip-5mBjBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:37:37 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)) 22:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:37:37 INFO - Running setup.py (path:/tmp/pip-ynAVud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:37:38 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)) 22:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:37:38 INFO - Running setup.py (path:/tmp/pip-etaYbS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:37:38 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)) 22:37:38 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)) 22:37:38 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)) 22:37:38 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)) 22:37:38 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:37:38 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:37:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:37:38 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 22:37:38 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 22:37:38 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 22:37:38 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 22:37:38 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 22:37:38 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 22:37:40 INFO - Downloading blessings-1.6.tar.gz 22:37:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:37:40 INFO - Installing collected packages: blessings 22:37:40 INFO - Running setup.py install for blessings 22:37:40 INFO - Successfully installed blessings 22:37:40 INFO - Cleaning up... 22:37:40 INFO - Return code: 0 22:37:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:37:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:37:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:37:40 INFO - Reading from file tmpfile_stdout 22:37:40 INFO - Current package versions: 22:37:40 INFO - argparse == 1.2.1 22:37:40 INFO - blessings == 1.6 22:37:40 INFO - blobuploader == 1.2.4 22:37:40 INFO - docopt == 0.6.1 22:37:40 INFO - functools32 == 3.2.3-2 22:37:40 INFO - jsonschema == 2.5.1 22:37:40 INFO - manifestparser == 1.1 22:37:40 INFO - mozInstall == 1.12 22:37:40 INFO - mozcrash == 1.0 22:37:40 INFO - mozdebug == 0.1 22:37:40 INFO - mozdevice == 0.49 22:37:40 INFO - mozfile == 1.2 22:37:40 INFO - mozhttpd == 0.7 22:37:40 INFO - mozinfo == 0.9 22:37:40 INFO - mozleak == 0.1 22:37:40 INFO - mozlog == 3.4 22:37:40 INFO - moznetwork == 0.27 22:37:40 INFO - mozprocess == 0.23 22:37:40 INFO - mozprofile == 0.28 22:37:40 INFO - mozrunner == 6.13 22:37:40 INFO - mozscreenshot == 0.1 22:37:40 INFO - mozsystemmonitor == 0.3 22:37:40 INFO - moztest == 0.7 22:37:40 INFO - mozversion == 1.4 22:37:40 INFO - psutil == 3.1.1 22:37:40 INFO - requests == 1.2.3 22:37:40 INFO - wsgiref == 0.1.2 22:37:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:37:40 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')]} 22:37:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:37:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:40 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')]} 22:37:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:37:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:40 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 0x7f887f09fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15aeb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174a130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d8fc0>, '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 0x17d9ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17da350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480137413.236495-1213197336', '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 22:37:40 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 22:37:40 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 22:37:40 INFO - Using env: {'DISPLAY': ':0', 22:37:40 INFO - 'HOME': '/home/cltbld', 22:37:40 INFO - 'LANG': 'en_US.UTF-8', 22:37:40 INFO - 'LANGUAGE': 'en_US:en', 22:37:40 INFO - 'LOGNAME': 'cltbld', 22:37:40 INFO - 'MAIL': '/var/mail/cltbld', 22:37:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:37:40 INFO - 'MOZ_NO_REMOTE': '1', 22:37:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:37:40 INFO - 'NO_EM_RESTART': '1', 22:37:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:37:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:37:40 INFO - 'PWD': '/builds/slave/test', 22:37:40 INFO - 'SHELL': '/bin/bash', 22:37:40 INFO - 'SHLVL': '1', 22:37:40 INFO - 'TERM': 'linux', 22:37:40 INFO - 'TMOUT': '86400', 22:37:40 INFO - 'USER': 'cltbld', 22:37:40 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480137413.236495-1213197336', 22:37:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:37:40 INFO - '_': '/tools/buildbot/bin/python'} 22:37:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:37:40 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)) 22:37:40 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)) 22:37:40 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)) 22:37:40 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)) 22:37:40 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)) 22:37:40 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)) 22:37:40 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)) 22:37:40 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)) 22:37:40 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)) 22:37:40 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)) 22:37:40 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)) 22:37:40 INFO - Cleaning up... 22:37:40 INFO - Return code: 0 22:37:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:37:40 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')]} 22:37:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:37:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:40 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')]} 22:37:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:37:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:40 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 0x7f887f09fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15aeb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174a130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d8fc0>, '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 0x17d9ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17da350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480137413.236495-1213197336', '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 22:37:40 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 22:37:40 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 22:37:40 INFO - Using env: {'DISPLAY': ':0', 22:37:40 INFO - 'HOME': '/home/cltbld', 22:37:40 INFO - 'LANG': 'en_US.UTF-8', 22:37:40 INFO - 'LANGUAGE': 'en_US:en', 22:37:40 INFO - 'LOGNAME': 'cltbld', 22:37:40 INFO - 'MAIL': '/var/mail/cltbld', 22:37:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:37:40 INFO - 'MOZ_NO_REMOTE': '1', 22:37:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:37:40 INFO - 'NO_EM_RESTART': '1', 22:37:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:37:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:37:40 INFO - 'PWD': '/builds/slave/test', 22:37:40 INFO - 'SHELL': '/bin/bash', 22:37:40 INFO - 'SHLVL': '1', 22:37:40 INFO - 'TERM': 'linux', 22:37:40 INFO - 'TMOUT': '86400', 22:37:40 INFO - 'USER': 'cltbld', 22:37:40 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480137413.236495-1213197336', 22:37:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:37:40 INFO - '_': '/tools/buildbot/bin/python'} 22:37:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:37:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:37:40 INFO - Cleaning up... 22:37:41 INFO - Return code: 0 22:37:41 INFO - Running post-action listener: _resource_record_post_action 22:37:41 INFO - Running post-action listener: _start_resource_monitoring 22:37:41 INFO - Starting resource monitoring. 22:37:41 INFO - [mozharness: 2016-11-26 06:37:41.036585Z] Finished create-virtualenv step (success) 22:37:41 INFO - [mozharness: 2016-11-26 06:37:41.037051Z] Running install step. 22:37:41 INFO - Running pre-action listener: _resource_record_pre_action 22:37:41 INFO - Running main action method: install 22:37:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:37:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:37:41 INFO - Reading from file tmpfile_stdout 22:37:41 INFO - Detecting whether we're running mozinstall >=1.0... 22:37:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:37:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:37:41 INFO - Reading from file tmpfile_stdout 22:37:41 INFO - Output received: 22:37:41 INFO - Usage: mozinstall [options] installer 22:37:41 INFO - Options: 22:37:41 INFO - -h, --help show this help message and exit 22:37:41 INFO - -d DEST, --destination=DEST 22:37:41 INFO - Directory to install application into. [default: 22:37:41 INFO - "/builds/slave/test"] 22:37:41 INFO - --app=APP Application being installed. [default: firefox] 22:37:41 INFO - mkdir: /builds/slave/test/build/application 22:37:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:37:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:37:57 INFO - Reading from file tmpfile_stdout 22:37:57 INFO - Output received: 22:37:57 INFO - /builds/slave/test/build/application/firefox/firefox 22:37:57 INFO - Running post-action listener: _resource_record_post_action 22:37:57 INFO - [mozharness: 2016-11-26 06:37:57.398048Z] Finished install step (success) 22:37:57 INFO - [mozharness: 2016-11-26 06:37:57.398288Z] Running run-tests step. 22:37:57 INFO - Running pre-action listener: _resource_record_pre_action 22:37:57 INFO - Running main action method: run_tests 22:37:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:37:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:37:57 INFO - Python 2.7.3 22:37:57 INFO - Return code: 0 22:37:57 INFO - grabbing minidump binary from tooltool 22:37:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:57 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 0x17d8fc0>, '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 0x17d9ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17da350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:37:57 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 22:37:57 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 22:37:57 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 22:37:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:37:57 INFO - Return code: 0 22:37:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:37:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:37:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:37:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:37:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:37:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/by1X_ZPxT8Gfbv2tp3SjVQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 22:37:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/by1X_ZPxT8Gfbv2tp3SjVQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 22:37:57 INFO - Using env: {'DISPLAY': ':0', 22:37:57 INFO - 'HOME': '/home/cltbld', 22:37:57 INFO - 'LANG': 'en_US.UTF-8', 22:37:57 INFO - 'LANGUAGE': 'en_US:en', 22:37:57 INFO - 'LOGNAME': 'cltbld', 22:37:57 INFO - 'MAIL': '/var/mail/cltbld', 22:37:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:37:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:37:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:37:57 INFO - 'MOZ_NO_REMOTE': '1', 22:37:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:37:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:37:57 INFO - 'NO_EM_RESTART': '1', 22:37:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:37:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:37:57 INFO - 'PWD': '/builds/slave/test', 22:37:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:37:57 INFO - 'SHELL': '/bin/bash', 22:37:57 INFO - 'SHLVL': '1', 22:37:57 INFO - 'TERM': 'linux', 22:37:57 INFO - 'TMOUT': '86400', 22:37:57 INFO - 'USER': 'cltbld', 22:37:57 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480137413.236495-1213197336', 22:37:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:37:57 INFO - '_': '/tools/buildbot/bin/python'} 22:37:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/by1X_ZPxT8Gfbv2tp3SjVQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 22:37:57 INFO - mozversion application_buildid: 20161125211919 22:37:57 INFO - mozversion application_changeset: ee388da4aeb6b686a04c16d11ca8606ee2b3e8e0 22:37:57 INFO - mozversion application_display_name: Nightly 22:37:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:37:57 INFO - mozversion application_name: Firefox 22:37:57 INFO - mozversion application_remotingname: firefox 22:37:57 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:37:57 INFO - mozversion application_vendor: Mozilla 22:37:57 INFO - mozversion application_version: 53.0a1 22:37:57 INFO - mozversion platform_buildid: 20161125211919 22:37:57 INFO - mozversion platform_changeset: ee388da4aeb6b686a04c16d11ca8606ee2b3e8e0 22:37:57 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:37:57 INFO - mozversion platform_version: 53.0a1 22:37:57 INFO - using testdate: 1480142277 22:37:57 INFO - actual date: 1480142277 22:37:57 INFO - starting webserver on 'localhost:60027' 22:37:57 INFO - SUITE-START | Running 2 tests 22:37:57 INFO - TEST-START | dromaeo_css 22:37:57 INFO - operating with platform_type : linux_ 22:37:57 INFO - Initialising browser for dromaeo_css test... 22:37:57 INFO - TEST-INFO | started process 21165 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPcX2Qc/profile http://localhost:60027/getInfo.html) 22:38:02 INFO - PROCESS | 21165 | __metrics Screen width/height:1600/1200 22:38:02 INFO - PROCESS | 21165 | colorDepth:24 22:38:02 INFO - PROCESS | 21165 | Browser inner width/height: 1024/697 22:38:02 INFO - PROCESS | 21165 | __metrics 22:38:03 ERROR - PROCESS | 21165 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3220: TypeError: this.tabs is undefined 22:38:04 INFO - TEST-INFO | 21165: exit 0 22:38:04 INFO - Browser initialized. 22:38:04 INFO - Running cycle 1/1 for dromaeo_css test... 22:38:04 INFO - TEST-INFO | started process 21288 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPcX2Qc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:38:17 INFO - PROCESS | 21288 | RSS: Main: 187695104 22:38:17 INFO - PROCESS | 21288 | 22:39:06 INFO - PROCESS | 21288 | 1480142346896 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] 22:41:20 INFO - PROCESS | 21288 | Cycle 1(1): loaded http://localhost:60027/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60027/tests/dromaeo/cssquery-ext.html) 22:41:21 INFO - PROCESS | 21288 | RSS: Main: 197332992 22:41:21 INFO - PROCESS | 21288 | 22:44:24 INFO - PROCESS | 21288 | Cycle 1(1): loaded http://localhost:60027/tests/dromaeo/cssquery-ext.html (next: http://localhost:60027/tests/dromaeo/cssquery-jquery.html) 22:44:24 INFO - PROCESS | 21288 | RSS: Main: 197586944 22:44:24 INFO - PROCESS | 21288 | 22:47:26 INFO - PROCESS | 21288 | Cycle 1(1): loaded http://localhost:60027/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60027/tests/dromaeo/cssquery-mootools.html) 22:47:27 INFO - PROCESS | 21288 | RSS: Main: 199262208 22:47:27 INFO - PROCESS | 21288 | 22:50:29 INFO - PROCESS | 21288 | Cycle 1(1): loaded http://localhost:60027/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60027/tests/dromaeo/cssquery-prototype.html) 22:50:30 INFO - PROCESS | 21288 | RSS: Main: 196341760 22:50:30 INFO - PROCESS | 21288 | 22:53:33 INFO - PROCESS | 21288 | Cycle 1(1): loaded http://localhost:60027/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60027/tests/dromaeo/cssquery-yui.html) 22:53:34 INFO - PROCESS | 21288 | RSS: Main: 203444224 22:53:34 INFO - PROCESS | 21288 | 22:56:36 INFO - PROCESS | 21288 | Cycle 1(1): loaded http://localhost:60027/tests/dromaeo/cssquery-yui.html (next: http://localhost:60027/tests/dromaeo/cssquery-dojo.html) 22:56:37 INFO - PROCESS | 21288 | RSS: Main: 203755520 22:56:37 INFO - PROCESS | 21288 | 22:56:37 INFO - PROCESS | 21288 | __start_tp_report 22:56:37 INFO - PROCESS | 21288 | _x_x_mozilla_page_load 22:56:37 INFO - PROCESS | 21288 | _x_x_mozilla_page_load_details 22:56:37 INFO - PROCESS | 21288 | |i|pagename|runs| 22:56:37 INFO - PROCESS | 21288 | |0;dojo.html;2567.602021686639;2574.9227523174304;2579.4583137541117;2602.011235730422;2605.270524253209;4476.776161191936;4591.4260717410325;4637.026224492856;4648.69783464075;4658.836940707076;4506.504284528699;4593.379893714347;4613.054323863608;4615.100055489181;4619.86140415788;4238.597333253336;4261.8082186301535;4281.422008028907;4310.612044915957;4336.284513055342;4274.508431530383;4283.507396649378;4303.849365272216;4321.9783901080455;4390.165868484994;4344.978275108636;4345.044090300129;4350.956490435086;4389.034412429276;4390.758508282043;329.3964941927029;4311.051568654891;4314.71954322968;4336;4345.847895323648;4280.2081614901035;4284.721493102938;4295.892602684927;4309.698321117523;4344.1311737652595;4589.173948689235;4632.2588385858435;4643.442786865564;4652.162610730067;4685.882852928704;4732.716037037754;4784.976075119602;4787.6648634595595;4888.120138375127;4975.203967365241;4835.274708793674;4868.9756551217015;4880.804767809319;4887.364642596475;4893.681910675795;4605.148047611203;4611.769411529477;4629.027904140101;4643.976780116078;4658.045100754337;4989.226669866177;5000.224965130411;5022.8196373852115;5064.290999260106;5082.263071854561;4708.034852855157;4725.976370118196;4738.241881298975;4801.9039619208115;4847.030593881238;4825.252085926687;4838.782254798542;4858.416989961227;4865.391826021747;4874.025194961022;4876.146674332049;4880.82917097907;4882.462929077798;4943.060818444484;4981.726005069683;4901.313816065754;4908.312836202935;4919.729414882216;4929.137400954819;4996.575291100297;4131.5248746393945;4275.551067137906;4287.056847493546;4294.3558466230315;4342.457192850894;3617.8733744318824;3638;3663.5603727552866;3688.041109311598;3694.113412780967;4220.2192594370135;4227.175700738388;4232.534421213664;4272.4445822042935;4282.464691913511;4945.901081978341;4947.455779864212;4957.4794646561595;4972.701637901665;5016.046951079284;4150.8547200847825;4204.474440694913;4204.978975105105;4212.326027835593;4238.788060596958;4469.061497085649;4480.103979204172;4483.08096840147;4483.21543729846;4486.730796152241;4609.009063051393;4637.258038713857;4649.5815376616265;4649.883752906137;4691.460482044608;4977.950220497749;4991.850244492671;4993.825216117419;5001.374828146481;5040.697558146523;4652.697574657636;4654.953450465452;4660.906781864412;4664.533546645308;4709.835155769531;4739.3838800955655;4760.238361862085;4774;4790.5448982346625;4835.323054772264;4867.780949857194;4918.508149185053;4942.3327850741125;4960.528749768766;4962.230854217602;4780.784864681167;4830.637702172281;4833.95166048335;4835.637327200404;4875.87810304731;4721.976390118165;4809.134355815987;4828.806847726051;4830.565249127455;4832.685875418087;4717.410323709536;4720.197566413649;4724.740139292372;4782.210935195793;4829.710217386968;4823.662343635911;4864.197407427876;4866.05112003156;4867.318575399518;4893.21708526634;4560.475545312332;4732.621390288699;4738.905221895474;4758.262469317261;4792.496787837227 22:56:37 INFO - PROCESS | 21288 | |1;ext.html;527.7440441385927;532.8534652970433;549.0008185103113;553.2033871225435;554.4954091776484;35484.64515354846;36706.082347941316;37124.07189820253;40490.59509404905;40547.59452405475;38340.23319533614;38906.61093389065;38981.22037559247;38988.41517377242;39004.80497597508;7561.395088392929;7710.614469276542;7714.575698336589;9734.951325243364;10036.19710423168;9873.555689993931;9980.051895069993;9980.900190998105;9985.450800205987;9989.800203995916;9893.802123957517;9969.351992120526;10007.099361057504;10060.949695251513;10062.849057264148;9954.253430992669;9987.70036898887;10012.29913906027;10046.598136074621;10063.949680251551;9904.356216845881;9942.105210531015;9983.201343892544;9986.151177149952;9996.650117245934;36109.63890361115;36609;36632.26735465276;36649.81675091634;36785;3015.6833532478995;3161.873525058995;3249.6587858275016;3568.4825700273313;3572.285542891432;26145.346366340804;26174.345641358927;26354.73645263542;26494.86752566244;26921;3089.5211242257487;3095.767817413703;3105;3126.796758210709;3197.0568682238795;249214;249840;251447;251940;252512.73743631347;50025.74987125114;50583.66536852136;50594.241086383736;50617;50739;53783;53975.19037214445;54348;54421.45578544243;54448;12369.567065152676;12378.381080946097;12409.689757755948;12420.378981050912;12607.621771346874;9088.500132492776;9305.441673499612;9824.705258842247;10059.44673042975;10067.345622534658;16338.67322653564;16399.42602008924;16401.83598164027;16480.258388372553;16564.420245291356;6485.319041500575;6676.298988606223;6708.597484150967;6755.8935664810115;6792.788471147821;763.2215140556601;882.9337799665051;884.1732979664034;887.3522328700085;917.6283605139929;25584.8720756395;26420.603690944652;27057;27192;27214.727852721615;948.9098535639104;979.4906648542718;991.6578780320777;1006.2905651515664;1015.751140970467;13831.170129792245;14142;14328.785068223984;14474.782878256834;14562.490312839;337968;339923;342474;343521;343857;45629.08741825145;46336.304955425694;46356.3046554302;46404.53595464002;46411;1113.204059097749;1166.7083229192701;1167.4921409187032;1172.1150531348947;1176.6999415149082;25741.227763167135;26331;26554.734452655226;26691.466170676867;26768.196954091407;39544.40683389809;39723.20553588854;39773.40339894846;39845.40231896582;40056.198876021735;300399;300768.4731034403;300994;301128;301939;20532.589348212652;21383.25158619441;21436.142554297654;21444.571108577427;23737;37969.43045854259;37973;38421.231575368896;38567.42148867825;39261.60738392694;33690;33751.83124084364;33956.66043339535;34144.31711365709;34205.65794342025;33198.170045748084;33345;33498;33593;33701.831490842385;33087;33207.671693132004;33469.497957531144;33493.330133397685;33821.32357352888;28637.427251455272;31016.844915775277;31315.373692525565;31318.843405782824;31324.843375782973;24505.387365316008;24505.7115004877;24587.631185531875;24677.162126354982;24809.87595062013 22:56:37 INFO - PROCESS | 21288 | |2;jquery.html;352.51177119689225;354.3886795278145;360.9675129238368;368.7474080255024;384.20277923309123;15794.684106317867;15875.68248635028;16398.918005409985;16418.753718694228;16488.58778530537;15037;15786.289616967235;15876.047437153778;15888.205589720497;15943.282552285145;4549.590536851674;4966.304717339575;5003.4996500350035;5013.699178049311;5018.146915024437;4920.286558449023;4953.777080031407;4984.551390374865;5247.370315562138;5255.448177941299;5318.441563635821;5322.600804939626;5322.840314790563;5329.733513324338;5333.493318134771;5245.763940622681;5268.578513718893;5311.044012077825;5341.706206158659;5404.756785944642;5176.2235664650225;5192.831612887108;5199.6360254782185;5200.063988482072;5212.374515058179;11886.346250956194;15643.374265029384;16236.594085147848;16553.337866485326;17017.064061476613;1917.9424617261504;2109.7257356543705;2160.2979031814725;2185.1477923609646;2215.1803832581886;8455.492670439731;8767.956160219223;8908.554572271361;8993.865092023625;9205.401648892801;1593.283022639805;1683.9242234099372;1691.6193856382338;1692.1285537947967;1733.8352856478614;64989.67505162444;65252.3474765251;65790.01314980327;67369;67584;9304.767380815398;9711.5144242789;9875.901240987641;9925;10135.391876487434;13151.736965260641;13212.207267563977;13539.187648741106;13636.590902272948;13676.179429234078;6706.524564595781;6801.319868013159;6817.216020157745;6920.273371296042;7067.328603782633;6324.71538780756;6369.363063693686;6568.310327415648;6575.276719560845;6635.071090047397;3999.140184860269;4054.675625949917;4145.813438395279;4168.374743788456;4388.956110438919;1682.9831701682826;1725.887817291872;1798.6672465593906;1838.6322735452964;1854.3417086933944;714.9034880291198;815.2662603656756;844.9619767110495;857.2670366836389;901.4005686218723;15702;16048.518544443452;16095.758563621555;16422.75365869513;16499.6700065998;805.8710606302964;818.7257268814894;823.995880020596;826.7561069484517;872;8617.913820861711;8949.865752013726;8998.86501702475;9155.267578593697;9200.493972831424;333999;336349;336387;338906;340547;44992;51663;66233.66883165554;75861;77674.6116269415;852.1819053708385;880.9823803523893;882.3470631732472;884.9734507964771;885.3802338363172;14228.430862765374;14314.439054905843;14368.784468232776;14377.28113594337;14575.198364089652;34084;34719.13202169966;35159.47260791141;36526.817365913;36792;46477.767611161726;46539.76730116328;46714.29928551142;46945.53054469548;47545;6924.272951340036;7181.640917953977;7371.557706537625;7379.557226566423;7768.067831860213;11111.166662500507;11272.605458808903;11380.752308850886;12031.699207519532;12077.154599177973;9775.657851975147;10054.899451005396;10199.490025498548;10231.232657550565;10372.636957706443;9731.951340243253;9972.700818975442;10293.43386113741;10359.585616575252;10478.895211047791;10013.39919604826;10082.344647597884;10143.137833283958;10303.845442318521;10461.74459064917;6380.617162970237;6761.256261811295;6893.276205998298;7175.067241258603;7625.847483050197;9906.207503399855;9993.700188994342;10114.140298074451;10140.645077422254;10187 22:56:37 INFO - PROCESS | 21288 | |3;mootools.html;1290.9289989050603;1339.2500199888061;1387.6392138044105;1614.0961061805383;1620.189905047477;6268.968655156729;6471.644059576722;6775;7179.246179151192;7249.093863267091;6655.168103987002;6865.279145689693;6867.931320686792;6960.060391847099;6993.545419547726;2057.269669267411;2082.6563617003253;2090.759562650292;2094.2251366994155;2094.685797130435;1957.8825270483746;1966.4002479243825;2049.918003279867;2094.0472085201195;2115.0693694774327;2042.213747707136;2047.2732180076082;2070.420282320945;2071.2232912657755;2073.4712648274744;2005.4284528909263;2020.8181263686265;2026.5440275937945;2027.1384661518944;2030.0864610924996;1912.913918873654;1918.8752731072436;1943.620993906189;1945.7956914524054;1949.2495389275089;6919.481038922101;6956.304369563054;6992.475564332695;6996.860062798715;7098.467614928901;4224.640905523034;4297.527272000078;4319.892002699926;4335.913281734348;4345.044090300129;2510.748925107493;2604.2057172562363;2666.9066582669707;2684.1142423000365;2696.5685490321653;801.798389516606;830.767385132164;839.0895877972407;854.3293514591016;858.8625819868791;8746.387752857303;9120.224780893566;9324.533773311307;9359.578818953163;9387.76530586734;3637.9818100909856;3691.9815400922826;3719.8326075326677;3723.162288485069;3743;7595;7619.961900190575;7629.122650895107;7647.655855486517;7667.654955527015;4198.076423186894;4199.181159673895;4199.9370009449885;4213.599708027732;4214.704970652087;3408.437607794736;3925.4700615417123;3932.8623498177426;3948.3287841067086;3970.642642162219;3025.3949210158057;3026.334206474572;3143.512755522898;3156.4318422683677;3161.573187619688;916.2395211974045;916.6470908700065;925.1442415765524;928.8931772846074;930.4742820306506;731.6305265840823;760.1752098972567;766.9693212271558;775.7711475114854;798.1938242375243;4468.262736648481;4607.170709272296;4626.352310676508;4669.743164125938;4679.906401871944;381.460233769219;382.2298069390181;386.31622029008497;404.82390160280374;414.36188270064366;3084.953725694116;3089.7528197744127;3159.510275907238;3167.319026409333;3235.7087862092526;7908.169642187602;7984.880226796603;8312.127226641236;8336.83326333482;8383;8490.27832634233;8562.272206862363;8567.014793298851;8568.571571421404;8573.271271941954;6415.294317625057;6559.672016399257;6573.57271777333;6576.375244351779;6609.735610575523;4540.795664195053;4598.4941656417095;4647.465541462775;4661.3707149534375;4674.7896344663895;7460.910944935426;7561.470697051153;7588.203238659861;7613.467057305936;7661.080670319598;7635.5800430974605;7693.192214817587;7703.3067023968115;7733.961330193313;8033.477823941425;5518.668879867221;5708.885822283614;5952.58331916779;6115.235595550556;6126.23422072241;6316.463100636313;6513.772017979348;6539.967300163468;6665.466762659073;6665.600063996176;6012.579119461596;6051.031834906394;6088.634681918922;6132;6200.441960223601;5728.770849165987;5808.651480911159;5809;5812.505936995402;5965.194698715618;5287.629865909504;5305.1776974569;5319.148936170194;5346.652467589594;5351.063563876228;3885.300645883655;3957.485526881487;4012.7592344459426;4050.6151915567975;4181.581841815794;3992.7205095643026;3993.840246390112;4046.8785936421955;4078.1435898461655;4079.4288799568676 22:56:37 INFO - PROCESS | 21288 | |4;prototype.html;293.3443753211572;299.5117957728903;302.5537332434658;303.6432192174195;306.41933535949374;4964.751762411874;4970.975145124274;5016.147254966655;5020.723860187688;5036.445990940998;4904.558589726924;4905.460399356077;4925.335079764231;4928;4949.703017818933;3663.5054267673922;3756.9624303757023;3780.3384407728677;3851.2105018471284;3894.610538946111;3878.204967981571;3880.6701430378453;3882.514685664292;3888.241792850395;3888.805559722017;3849.7305188636806;3853.1715681128553;3853.8843834685003;3862.8261728222296;3873.8837834865;3735.3089678409583;3847.5960024197334;3868.2650296443585;3887.1448281378193;3898.9805050974564;3363.630000699921;3377.9831100844585;3383.8664047544103;3385.324264489094;3426.0749597608506;4776.880577985544;4787.3776409066595;4790.688605240648;4825.300331451955;4842.539958703917;4383.978080109611;4395.7142785718825;4439.245328294198;4439.889002774924;4440.800163992628;5087.49125087492;5141.511556402136;5146;5188.325517682677;5224.477552244745;3732.64539868712;3732.8055022392573;3734.141147536082;3735.290294843971;3745.606711295329;5367.651102678314;5383.407825139231;5385.623006389555;5405.891882162374;5418.485243901823;3715.702743780491;3736.682381997506;3737.252549490113;3745.176061266517;3823.3309170895536;3753.474513568103;3761.7931013793955;3768.4347347898033;3768.8304026318883;3773.471713960048;4296.4414626098405;4315.697901146889;4339.652827773771;4342.630876375543;4370.497392799869;5058.46886076964;5071.264666623319;5097.1844504879045;5126.282320475137;5131.897362052738;1292.3279894454831;1307.3071272225736;1312.4750099959901;1317.1767645221737;1318.9142705724098;881.2641444393875;896.4894153351623;913.1553313185277;927.3601215161517;938.938968967015;4284.657227421799;4364.41080454141;4544.477385100756;4553.772311384418;4567.862964111082;5389.787297858029;5396.9730151348995;5413.428621404802;5417.295751552273;5426.213199086111;4544.977380089454;4546.863594092117;4559.589636932692;4562.292844609091;4566.49768525462;2652.9336766580604;2752.862356882148;2755.531559634867;2769.695333513312;2770.86394578226;4813.975930120327;4824.855254342376;4842.297866809293;4847.830325938646;4858.514148585184;5321.840344789663;5336.599755018312;5345.438728933484;5345.893082138336;5352.464753524617;4725.64557658177;4981.750912454435;4984.601231901439;5012.749362531932;5036.395632524121;5399.811006614749;5408.918866216931;5421.728913554385;5436.320459942507;5466.5900057495055;5015.498450154955;5142.537171654569;5190.416922838571;5238.2404551340605;5267.815626453209;4982.181503751177;5037.244413338029;5037.715382577419;5058.898822023465;5075.974620126875;3713.1830997180577;3732.1602639405914;3740.775553466801;3741.30785804627;3759.1541903072684;5081.77132029067;5453.700046497481;5456.863578410413;5458.017556839807;5468.808591699271;5155.304033955518;5155.690658560498;5167.044096842096;5175.680201548732;5207.661502002509;5185.325907631984;5194.68831870089;5220.3735551734035;5233.816816411408;5257.027449921777;4899.485554016777;5064.569511591556;5120;5133.204353325241;5179.093658609803;5070.5943524517215;5205.282256855305;5225.6603320784025;5225.973870130625;5243.8164664236565;5131.923021154611;5132.640715150053;5134.922976155286;5140.948590514196;5149.356330458692 22:56:37 INFO - PROCESS | 21288 | |5;yui.html;600.4535872356157;645.0195702532154;680.8604236131592;683.7470136049659;684.9075374824397;11622.825657615133;12247.142700010992;13492.527761528348;13991.440342386319;14173.71652566948;12189.329586872718;12463.750724985495;12505.749885002295;12510.749785004295;12517.311547864863;726.803762983994;752.7177308509309;756.474250395975;757.8749506331476;757.9204183560729;744.3338212299989;756.2513112019117;759.8822182561712;762.2529920677739;768.6272158003364;791.1100012485954;798.6286376834771;799.17285609394;799.3085980626745;799.6801279488193;793.8809178623223;793.9206079392014;794.126460893013;794.4756460735915;794.5391672829745;583.4544700704812;583.6177303865975;583.8336074218827;583.9007368747323;584.3280227738093;12624.116311858174;12709.618711438672;12720.554780582635;12732.23606583608;12749.362531873368;10781.568737250578;10785.083267922237;10853;11271.492782824793;11503.827442588368;9478.857817132748;9540.793134625052;9680.128788409007;9864.95067524665;9882.160016398615;3135.263213144909;3158.96841031589;3184.0607020928883;3245.9188520286943;3317.270200555874;49123.754381228224;49328.75335623299;49436.75281623605;49703.50296497025;51240.487595124316;8783.063511830635;8843.380963332633;9065.81868362629;9169.22061624756;9173.81652366949;16183.595410114842;16379.508614741577;16574.75137872933;16683.582910427336;16795.748063779054;5759.568032397503;5885.440883116097;5947.316058653224;6048.9697551512845;6130.509559235251;3598.208394153282;3721.1999420124803;3734.8506059757306;3758.9593315645297;3789.829457674411;2682.248970288322;2683.644759396492;2764.04640399062;2766.6265054217824;2767.972320276812;476.2022622082532;478.9941123640397;480.1860845866293;482.48615224785493;489.6890474548687;395.99406008909887;427.8694998025632;438.4694519631218;507.32779067735396;528.6088294662;7065.364117229474;7239.058922340168;7277.89083163753;7301.233370496021;7342.460848331772;504.4199170953433;531.7474199755086;534.4735435595935;570.6034306157181;579.6724850459477;3434.6737059979264;3536.0629433200224;3565.982170089133;3583.3012562550052;3616.385214513539;65395.346046539875;68245.31754682389;68956.6552167246;71318;71329.64335178395;54523.72738136284;59205.70397147987;59759.70120149371;60107.699461502416;61727.38272617306;41375.379369309485;49737.25394119019;50314.49685503245;51049.48950510447;51268.743656282226;7511;8018.3585313173635;8038.276555110068;8161.673533058611;8164.265216130577;30673;33996.49005264873;36180.81909590435;36207.63792362148;37369;48427.5157248423;49263;49439.752801235765;50150;51201.7439912813;9644.324897257406;9708.951455242679;10061.69814905554;10093.69718908434;10450.16398688088;11382.772344552897;11712.180147389941;11768.35274059935;11880.584179553674;12030;9897;10396.116330112025;10594.947025264824;10648.733781655521;10667.733306667395;10877.78244435091;10888.61889833852;11133.387663678575;11312.15158863072;11395.886041139815;9722.416655000723;9907.207423406255;9942.15491683215;10079.647212347532;10430.165586753194;8655.394122411371;9105.11201599006;9173.312001599774;9361.812763744823;9489.240860731263;8860.335474839541;9221.631134754803;9245.861312080458;9260.39807412516;9296.581653825458 22:56:37 INFO - PROCESS | 21288 | __end_tp_report 22:56:37 INFO - PROCESS | 21288 | __start_cc_report 22:56:37 INFO - PROCESS | 21288 | _x_x_mozilla_cycle_collect,345 22:56:37 INFO - PROCESS | 21288 | __end_cc_report 22:56:37 INFO - PROCESS | 21288 | __startTimestamp1480143397169__endTimestamp 22:56:37 INFO - PROCESS | 21288 | 22:56:37 INFO - PROCESS | 21288 | ------- Summary: start ------- 22:56:37 INFO - PROCESS | 21288 | Number of tests: 6 22:56:37 INFO - PROCESS | 21288 | 22:56:37 INFO - PROCESS | 21288 | [#0] dojo.html Cycles:165 Average:4541.34 Median:4664.53 stddev:567.94 (12.2%) stddev-sans-first:548.17 22:56:37 INFO - PROCESS | 21288 | Values: 2567.6 2574.9 2579.5 2602.0 2605.3 4476.8 4591.4 4637.0 4648.7 4658.8 4506.5 4593.4 4613.1 4615.1 4619.9 4238.6 4261.8 4281.4 4310.6 4336.3 4274.5 4283.5 4303.8 4322.0 4390.2 4345.0 4345.0 4351.0 4389.0 4390.8 329.4 4311.1 4314.7 4336.0 4345.8 4280.2 4284.7 4295.9 4309.7 4344.1 4589.2 4632.3 4643.4 4652.2 4685.9 4732.7 4785.0 4787.7 4888.1 4975.2 4835.3 4869.0 4880.8 4887.4 4893.7 4605.1 4611.8 4629.0 4644.0 4658.0 4989.2 5000.2 5022.8 5064.3 5082.3 4708.0 4726.0 4738.2 4801.9 4847.0 4825.3 4838.8 4858.4 4865.4 4874.0 4876.1 4880.8 4882.5 4943.1 4981.7 4901.3 4908.3 4919.7 4929.1 4996.6 4131.5 4275.6 4287.1 4294.4 4342.5 3617.9 3638.0 3663.6 3688.0 3694.1 4220.2 4227.2 4232.5 4272.4 4282.5 4945.9 4947.5 4957.5 4972.7 5016.0 4150.9 4204.5 4205.0 4212.3 4238.8 4469.1 4480.1 4483.1 4483.2 4486.7 4609.0 4637.3 4649.6 4649.9 4691.5 4978.0 4991.9 4993.8 5001.4 5040.7 4652.7 4655.0 4660.9 4664.5 4709.8 4739.4 4760.2 4774.0 4790.5 4835.3 4867.8 4918.5 4942.3 4960.5 4962.2 4780.8 4830.6 4834.0 4835.6 4875.9 4722.0 4809.1 4828.8 4830.6 4832.7 4717.4 4720.2 4724.7 4782.2 4829.7 4823.7 4864.2 4866.1 4867.3 4893.2 4560.5 4732.6 4738.9 4758.3 4792.5 22:56:37 INFO - PROCESS | 21288 | 22:56:37 INFO - PROCESS | 21288 | [#1] ext.html Cycles:180 Average:44766.78 Median:185894.66 stddev:78731.64 (42.4%) stddev-sans-first:78882.43 22:56:37 INFO - PROCESS | 21288 | Values: 527.7 532.9 549.0 553.2 554.5 35484.6 36706.1 37124.1 40490.6 40547.6 38340.2 38906.6 38981.2 38988.4 39004.8 7561.4 7710.6 7714.6 9735.0 10036.2 9873.6 9980.1 9980.9 9985.5 9989.8 9893.8 9969.4 10007.1 10060.9 10062.8 9954.3 9987.7 10012.3 10046.6 10063.9 9904.4 9942.1 9983.2 9986.2 9996.7 36109.6 36609.0 36632.3 36649.8 36785.0 3015.7 3161.9 3249.7 3568.5 3572.3 26145.3 26174.3 26354.7 26494.9 26921.0 3089.5 3095.8 3105.0 3126.8 3197.1 249214.0 249840.0 251447.0 251940.0 252512.7 50025.7 50583.7 50594.2 50617.0 50739.0 53783.0 53975.2 54348.0 54421.5 54448.0 12369.6 12378.4 12409.7 12420.4 12607.6 9088.5 9305.4 9824.7 10059.4 10067.3 16338.7 16399.4 16401.8 16480.3 16564.4 6485.3 6676.3 6708.6 6755.9 6792.8 763.2 882.9 884.2 887.4 917.6 25584.9 26420.6 27057.0 27192.0 27214.7 948.9 979.5 991.7 1006.3 1015.8 13831.2 14142.0 14328.8 14474.8 14562.5 337968.0 339923.0 342474.0 343521.0 343857.0 45629.1 46336.3 46356.3 46404.5 46411.0 1113.2 1166.7 1167.5 1172.1 1176.7 25741.2 26331.0 26554.7 26691.5 26768.2 39544.4 39723.2 39773.4 39845.4 40056.2 300399.0 300768.5 300994.0 301128.0 301939.0 20532.6 21383.3 21436.1 21444.6 23737.0 37969.4 37973.0 38421.2 38567.4 39261.6 33690.0 33751.8 33956.7 34144.3 34205.7 33198.2 33345.0 33498.0 33593.0 33701.8 33087.0 33207.7 33469.5 33493.3 33821.3 28637.4 31016.8 31315.4 31318.8 31324.8 24505.4 24505.7 24587.6 24677.2 24809.9 22:56:37 INFO - PROCESS | 21288 | 22:56:37 INFO - PROCESS | 21288 | [#2] jquery.html Cycles:180 Average:21839.77 Median:46829.91 stddev:55715.11 (119.0%) stddev-sans-first:55848.05 22:56:37 INFO - PROCESS | 21288 | Values: 352.5 354.4 361.0 368.7 384.2 15794.7 15875.7 16398.9 16418.8 16488.6 15037.0 15786.3 15876.0 15888.2 15943.3 4549.6 4966.3 5003.5 5013.7 5018.1 4920.3 4953.8 4984.6 5247.4 5255.4 5318.4 5322.6 5322.8 5329.7 5333.5 5245.8 5268.6 5311.0 5341.7 5404.8 5176.2 5192.8 5199.6 5200.1 5212.4 11886.3 15643.4 16236.6 16553.3 17017.1 1917.9 2109.7 2160.3 2185.1 2215.2 8455.5 8768.0 8908.6 8993.9 9205.4 1593.3 1683.9 1691.6 1692.1 1733.8 64989.7 65252.3 65790.0 67369.0 67584.0 9304.8 9711.5 9875.9 9925.0 10135.4 13151.7 13212.2 13539.2 13636.6 13676.2 6706.5 6801.3 6817.2 6920.3 7067.3 6324.7 6369.4 6568.3 6575.3 6635.1 3999.1 4054.7 4145.8 4168.4 4389.0 1683.0 1725.9 1798.7 1838.6 1854.3 714.9 815.3 845.0 857.3 901.4 15702.0 16048.5 16095.8 16422.8 16499.7 805.9 818.7 824.0 826.8 872.0 8617.9 8949.9 8998.9 9155.3 9200.5 333999.0 336349.0 336387.0 338906.0 340547.0 44992.0 51663.0 66233.7 75861.0 77674.6 852.2 881.0 882.3 885.0 885.4 14228.4 14314.4 14368.8 14377.3 14575.2 34084.0 34719.1 35159.5 36526.8 36792.0 46477.8 46539.8 46714.3 46945.5 47545.0 6924.3 7181.6 7371.6 7379.6 7768.1 11111.2 11272.6 11380.8 12031.7 12077.2 9775.7 10054.9 10199.5 10231.2 10372.6 9732.0 9972.7 10293.4 10359.6 10478.9 10013.4 10082.3 10143.1 10303.8 10461.7 6380.6 6761.3 6893.3 7175.1 7625.8 9906.2 9993.7 10114.1 10140.6 10187.0 22:56:37 INFO - PROCESS | 21288 | 22:56:37 INFO - PROCESS | 21288 | [#3] mootools.html Cycles:180 Average:4513.64 Median:5296.40 stddev:2481.74 (46.9%) stddev-sans-first:2476.89 22:56:37 INFO - PROCESS | 21288 | Values: 1290.9 1339.3 1387.6 1614.1 1620.2 6269.0 6471.6 6775.0 7179.2 7249.1 6655.2 6865.3 6867.9 6960.1 6993.5 2057.3 2082.7 2090.8 2094.2 2094.7 1957.9 1966.4 2049.9 2094.0 2115.1 2042.2 2047.3 2070.4 2071.2 2073.5 2005.4 2020.8 2026.5 2027.1 2030.1 1912.9 1918.9 1943.6 1945.8 1949.2 6919.5 6956.3 6992.5 6996.9 7098.5 4224.6 4297.5 4319.9 4335.9 4345.0 2510.7 2604.2 2666.9 2684.1 2696.6 801.8 830.8 839.1 854.3 858.9 8746.4 9120.2 9324.5 9359.6 9387.8 3638.0 3692.0 3719.8 3723.2 3743.0 7595.0 7620.0 7629.1 7647.7 7667.7 4198.1 4199.2 4199.9 4213.6 4214.7 3408.4 3925.5 3932.9 3948.3 3970.6 3025.4 3026.3 3143.5 3156.4 3161.6 916.2 916.6 925.1 928.9 930.5 731.6 760.2 767.0 775.8 798.2 4468.3 4607.2 4626.4 4669.7 4679.9 381.5 382.2 386.3 404.8 414.4 3085.0 3089.8 3159.5 3167.3 3235.7 7908.2 7984.9 8312.1 8336.8 8383.0 8490.3 8562.3 8567.0 8568.6 8573.3 6415.3 6559.7 6573.6 6576.4 6609.7 4540.8 4598.5 4647.5 4661.4 4674.8 7460.9 7561.5 7588.2 7613.5 7661.1 7635.6 7693.2 7703.3 7734.0 8033.5 5518.7 5708.9 5952.6 6115.2 6126.2 6316.5 6513.8 6540.0 6665.5 6665.6 6012.6 6051.0 6088.6 6132.0 6200.4 5728.8 5808.7 5809.0 5812.5 5965.2 5287.6 5305.2 5319.1 5346.7 5351.1 3885.3 3957.5 4012.8 4050.6 4181.6 3992.7 3993.8 4046.9 4078.1 4079.4 22:56:37 INFO - PROCESS | 21288 | 22:56:37 INFO - PROCESS | 21288 | [#4] prototype.html Cycles:180 Average:4292.33 Median:4879.00 stddev:1252.00 (25.7%) stddev-sans-first:1219.00 22:56:37 INFO - PROCESS | 21288 | Values: 293.3 299.5 302.6 303.6 306.4 4964.8 4971.0 5016.1 5020.7 5036.4 4904.6 4905.5 4925.3 4928.0 4949.7 3663.5 3757.0 3780.3 3851.2 3894.6 3878.2 3880.7 3882.5 3888.2 3888.8 3849.7 3853.2 3853.9 3862.8 3873.9 3735.3 3847.6 3868.3 3887.1 3899.0 3363.6 3378.0 3383.9 3385.3 3426.1 4776.9 4787.4 4790.7 4825.3 4842.5 4384.0 4395.7 4439.2 4439.9 4440.8 5087.5 5141.5 5146.0 5188.3 5224.5 3732.6 3732.8 3734.1 3735.3 3745.6 5367.7 5383.4 5385.6 5405.9 5418.5 3715.7 3736.7 3737.3 3745.2 3823.3 3753.5 3761.8 3768.4 3768.8 3773.5 4296.4 4315.7 4339.7 4342.6 4370.5 5058.5 5071.3 5097.2 5126.3 5131.9 1292.3 1307.3 1312.5 1317.2 1318.9 881.3 896.5 913.2 927.4 938.9 4284.7 4364.4 4544.5 4553.8 4567.9 5389.8 5397.0 5413.4 5417.3 5426.2 4545.0 4546.9 4559.6 4562.3 4566.5 2652.9 2752.9 2755.5 2769.7 2770.9 4814.0 4824.9 4842.3 4847.8 4858.5 5321.8 5336.6 5345.4 5345.9 5352.5 4725.6 4981.8 4984.6 5012.7 5036.4 5399.8 5408.9 5421.7 5436.3 5466.6 5015.5 5142.5 5190.4 5238.2 5267.8 4982.2 5037.2 5037.7 5058.9 5076.0 3713.2 3732.2 3740.8 3741.3 3759.2 5081.8 5453.7 5456.9 5458.0 5468.8 5155.3 5155.7 5167.0 5175.7 5207.7 5185.3 5194.7 5220.4 5233.8 5257.0 4899.5 5064.6 5120.0 5133.2 5179.1 5070.6 5205.3 5225.7 5226.0 5243.8 5131.9 5132.6 5134.9 5140.9 5149.4 22:56:37 INFO - PROCESS | 21288 | 22:56:37 INFO - PROCESS | 21288 | [#5] yui.html Cycles:180 Average:14099.88 Median:51125.62 stddev:18054.35 (35.3%) stddev-sans-first:18076.54 22:56:37 INFO - PROCESS | 21288 | Values: 600.5 645.0 680.9 683.7 684.9 11622.8 12247.1 13492.5 13991.4 14173.7 12189.3 12463.8 12505.7 12510.7 12517.3 726.8 752.7 756.5 757.9 757.9 744.3 756.3 759.9 762.3 768.6 791.1 798.6 799.2 799.3 799.7 793.9 793.9 794.1 794.5 794.5 583.5 583.6 583.8 583.9 584.3 12624.1 12709.6 12720.6 12732.2 12749.4 10781.6 10785.1 10853.0 11271.5 11503.8 9478.9 9540.8 9680.1 9865.0 9882.2 3135.3 3159.0 3184.1 3245.9 3317.3 49123.8 49328.8 49436.8 49703.5 51240.5 8783.1 8843.4 9065.8 9169.2 9173.8 16183.6 16379.5 16574.8 16683.6 16795.7 5759.6 5885.4 5947.3 6049.0 6130.5 3598.2 3721.2 3734.9 3759.0 3789.8 2682.2 2683.6 2764.0 2766.6 2768.0 476.2 479.0 480.2 482.5 489.7 396.0 427.9 438.5 507.3 528.6 7065.4 7239.1 7277.9 7301.2 7342.5 504.4 531.7 534.5 570.6 579.7 3434.7 3536.1 3566.0 3583.3 3616.4 65395.3 68245.3 68956.7 71318.0 71329.6 54523.7 59205.7 59759.7 60107.7 61727.4 41375.4 49737.3 50314.5 51049.5 51268.7 7511.0 8018.4 8038.3 8161.7 8164.3 30673.0 33996.5 36180.8 36207.6 37369.0 48427.5 49263.0 49439.8 50150.0 51201.7 9644.3 9709.0 10061.7 10093.7 10450.2 11382.8 11712.2 11768.4 11880.6 12030.0 9897.0 10396.1 10594.9 10648.7 10667.7 10877.8 10888.6 11133.4 11312.2 11395.9 9722.4 9907.2 9942.2 10079.6 10430.2 8655.4 9105.1 9173.3 9361.8 9489.2 8860.3 9221.6 9245.9 9260.4 9296.6 22:56:37 INFO - PROCESS | 21288 | -------- Summary: end -------- 22:56:37 INFO - PROCESS | 21288 | 22:56:38 INFO - TEST-INFO | 21288: exit 0 22:56:38 INFO - TEST-OK | dromaeo_css | took 1120560ms 22:56:38 INFO - TEST-START | kraken 22:56:38 INFO - operating with platform_type : linux_ 22:56:38 INFO - Initialising browser for kraken test... 22:56:38 INFO - TEST-INFO | started process 21641 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYqFpAH/profile http://localhost:60027/getInfo.html) 22:56:43 INFO - PROCESS | 21641 | __metrics Screen width/height:1600/1200 22:56:43 INFO - PROCESS | 21641 | colorDepth:24 22:56:43 INFO - PROCESS | 21641 | Browser inner width/height: 1024/697 22:56:43 INFO - PROCESS | 21641 | __metrics 22:56:44 ERROR - PROCESS | 21641 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3220: TypeError: this.tabs is undefined 22:56:45 INFO - TEST-INFO | 21641: exit 0 22:56:45 INFO - Browser initialized. 22:56:45 INFO - Running cycle 1/1 for kraken test... 22:56:45 INFO - TEST-INFO | started process 21764 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYqFpAH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:56:57 INFO - PROCESS | 21764 | RSS: Main: 187277312 22:56:57 INFO - PROCESS | 21764 | 22:57:00 INFO - PROCESS | 21764 | Cycle 1(1): loaded http://localhost:60027/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60027/tests/kraken/driver.html?testName=audio-beat-detection) 22:57:01 INFO - PROCESS | 21764 | RSS: Main: 199794688 22:57:01 INFO - PROCESS | 21764 | 22:57:04 INFO - PROCESS | 21764 | Cycle 1(1): loaded http://localhost:60027/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60027/tests/kraken/driver.html?testName=audio-dft) 22:57:05 INFO - PROCESS | 21764 | RSS: Main: 198393856 22:57:05 INFO - PROCESS | 21764 | 22:57:08 INFO - PROCESS | 21764 | Cycle 1(1): loaded http://localhost:60027/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60027/tests/kraken/driver.html?testName=audio-fft) 22:57:08 INFO - PROCESS | 21764 | RSS: Main: 194220032 22:57:08 INFO - PROCESS | 21764 | 22:57:10 INFO - PROCESS | 21764 | Cycle 1(1): loaded http://localhost:60027/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60027/tests/kraken/driver.html?testName=audio-oscillator) 22:57:11 INFO - PROCESS | 21764 | RSS: Main: 195002368 22:57:11 INFO - PROCESS | 21764 | 22:57:13 INFO - PROCESS | 21764 | Cycle 1(1): loaded http://localhost:60027/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60027/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:57:14 INFO - PROCESS | 21764 | RSS: Main: 195117056 22:57:14 INFO - PROCESS | 21764 | 22:57:17 INFO - PROCESS | 21764 | Cycle 1(1): loaded http://localhost:60027/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60027/tests/kraken/driver.html?testName=imaging-darkroom) 22:57:17 INFO - PROCESS | 21764 | RSS: Main: 200454144 22:57:17 INFO - PROCESS | 21764 | 22:57:21 INFO - PROCESS | 21764 | Cycle 1(1): loaded http://localhost:60027/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60027/tests/kraken/driver.html?testName=imaging-desaturate) 22:57:22 INFO - PROCESS | 21764 | RSS: Main: 196313088 22:57:22 INFO - PROCESS | 21764 | 22:57:25 INFO - PROCESS | 21764 | Cycle 1(1): loaded http://localhost:60027/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60027/tests/kraken/driver.html?testName=json-parse-financial) 22:57:25 INFO - PROCESS | 21764 | RSS: Main: 197799936 22:57:25 INFO - PROCESS | 21764 | 22:57:27 INFO - PROCESS | 21764 | Cycle 1(1): loaded http://localhost:60027/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60027/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:57:28 INFO - PROCESS | 21764 | RSS: Main: 198021120 22:57:28 INFO - PROCESS | 21764 | 22:57:29 INFO - PROCESS | 21764 | Cycle 1(1): loaded http://localhost:60027/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60027/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:57:30 INFO - PROCESS | 21764 | RSS: Main: 197943296 22:57:30 INFO - PROCESS | 21764 | 22:57:32 INFO - PROCESS | 21764 | Cycle 1(1): loaded http://localhost:60027/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60027/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:57:33 INFO - PROCESS | 21764 | RSS: Main: 198291456 22:57:33 INFO - PROCESS | 21764 | 22:57:36 INFO - PROCESS | 21764 | Cycle 1(1): loaded http://localhost:60027/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60027/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:57:37 INFO - PROCESS | 21764 | RSS: Main: 198373376 22:57:37 INFO - PROCESS | 21764 | 22:57:40 INFO - PROCESS | 21764 | Cycle 1(1): loaded http://localhost:60027/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60027/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:57:40 INFO - PROCESS | 21764 | RSS: Main: 202797056 22:57:40 INFO - PROCESS | 21764 | 22:57:42 INFO - PROCESS | 21764 | Cycle 1(1): loaded http://localhost:60027/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60027/tests/kraken/driver.html?testName=ai-astar) 22:57:42 INFO - PROCESS | 21764 | RSS: Main: 204431360 22:57:42 INFO - PROCESS | 21764 | 22:57:42 INFO - PROCESS | 21764 | __start_tp_report 22:57:42 INFO - PROCESS | 21764 | _x_x_mozilla_page_load 22:57:42 INFO - PROCESS | 21764 | _x_x_mozilla_page_load_details 22:57:42 INFO - PROCESS | 21764 | |i|pagename|runs| 22:57:42 INFO - PROCESS | 21764 | |0;ai-astar;109;116;116;117;117;116;115;119;116;117 22:57:42 INFO - PROCESS | 21764 | |1;audio-beat-detection;157;131;138;181;133;133;132;136;165;136 22:57:42 INFO - PROCESS | 21764 | |2;audio-dft;166;178;163;165;164;171;164;165;162;163 22:57:42 INFO - PROCESS | 21764 | |3;audio-fft;79;78;77;110;77;77;77;78;91;77 22:57:42 INFO - PROCESS | 21764 | |4;audio-oscillator;85;85;104;84;83;84;101;83;83;106 22:57:42 INFO - PROCESS | 21764 | |5;imaging-gaussian-blur;118;118;117;117;120;118;119;118;117;118 22:57:42 INFO - PROCESS | 21764 | |6;imaging-darkroom;150;150;148;149;147;148;147;147;151;147 22:57:42 INFO - PROCESS | 21764 | |7;imaging-desaturate;96;96;96;96;96;97;95;95;96;97 22:57:42 INFO - PROCESS | 21764 | |8;json-parse-financial;66;68;66;68;69;68;67;67;66;66 22:57:42 INFO - PROCESS | 21764 | |9;json-stringify-tinderbox;67;76;66;66;66;66;66;67;66;67 22:57:42 INFO - PROCESS | 21764 | |10;stanford-crypto-aes;85;89;87;89;93;87;86;85;87;86 22:57:42 INFO - PROCESS | 21764 | |11;stanford-crypto-ccm;149;155;143;145;153;160;155;155;202;151 22:57:42 INFO - PROCESS | 21764 | |12;stanford-crypto-pbkdf2;179;175;176;190;184;177;177;185;174;184 22:57:42 INFO - PROCESS | 21764 | |13;stanford-crypto-sha256-iterative;73;70;70;74;71;70;72;69;69;68 22:57:42 INFO - PROCESS | 21764 | __end_tp_report 22:57:42 INFO - PROCESS | 21764 | __start_cc_report 22:57:42 INFO - PROCESS | 21764 | _x_x_mozilla_cycle_collect,888 22:57:42 INFO - PROCESS | 21764 | __end_cc_report 22:57:42 INFO - PROCESS | 21764 | __startTimestamp1480143462891__endTimestamp 22:57:42 INFO - PROCESS | 21764 | 22:57:42 INFO - PROCESS | 21764 | ------- Summary: start ------- 22:57:42 INFO - PROCESS | 21764 | Number of tests: 14 22:57:42 INFO - PROCESS | 21764 | 22:57:42 INFO - PROCESS | 21764 | [#0] ai-astar Cycles:10 Average:115.80 Median:116.50 stddev:2.62 (2.2%) stddev-sans-first:1.13 22:57:42 INFO - PROCESS | 21764 | Values: 109.0 116.0 116.0 117.0 117.0 116.0 115.0 119.0 116.0 117.0 22:57:42 INFO - PROCESS | 21764 | 22:57:42 INFO - PROCESS | 21764 | [#1] audio-beat-detection Cycles:10 Average:144.20 Median:137.00 stddev:17.31 (12.6%) stddev-sans-first:17.73 22:57:42 INFO - PROCESS | 21764 | Values: 157.0 131.0 138.0 181.0 133.0 133.0 132.0 136.0 165.0 136.0 22:57:42 INFO - PROCESS | 21764 | 22:57:42 INFO - PROCESS | 21764 | [#2] audio-dft Cycles:10 Average:166.10 Median:165.00 stddev:4.86 (2.9%) stddev-sans-first:5.16 22:57:42 INFO - PROCESS | 21764 | Values: 166.0 178.0 163.0 165.0 164.0 171.0 164.0 165.0 162.0 163.0 22:57:42 INFO - PROCESS | 21764 | 22:57:42 INFO - PROCESS | 21764 | [#3] audio-fft Cycles:10 Average:82.10 Median:77.50 stddev:10.70 (13.8%) stddev-sans-first:11.29 22:57:42 INFO - PROCESS | 21764 | Values: 79.0 78.0 77.0 110.0 77.0 77.0 77.0 78.0 91.0 77.0 22:57:42 INFO - PROCESS | 21764 | 22:57:42 INFO - PROCESS | 21764 | [#4] audio-oscillator Cycles:10 Average:89.80 Median:83.50 stddev:9.67 (11.6%) stddev-sans-first:10.10 22:57:42 INFO - PROCESS | 21764 | Values: 85.0 85.0 104.0 84.0 83.0 84.0 101.0 83.0 83.0 106.0 22:57:42 INFO - PROCESS | 21764 | 22:57:42 INFO - PROCESS | 21764 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.94 (0.8%) stddev-sans-first:1.00 22:57:42 INFO - PROCESS | 21764 | Values: 118.0 118.0 117.0 117.0 120.0 118.0 119.0 118.0 117.0 118.0 22:57:42 INFO - PROCESS | 21764 | 22:57:42 INFO - PROCESS | 21764 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.50 stddev:1.51 (1.0%) stddev-sans-first:1.48 22:57:42 INFO - PROCESS | 21764 | Values: 150.0 150.0 148.0 149.0 147.0 148.0 147.0 147.0 151.0 147.0 22:57:42 INFO - PROCESS | 21764 | 22:57:42 INFO - PROCESS | 21764 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 22:57:42 INFO - PROCESS | 21764 | Values: 96.0 96.0 96.0 96.0 96.0 97.0 95.0 95.0 96.0 97.0 22:57:42 INFO - PROCESS | 21764 | 22:57:42 INFO - PROCESS | 21764 | [#8] json-parse-financial Cycles:10 Average:67.10 Median:67.50 stddev:1.10 (1.6%) stddev-sans-first:1.09 22:57:42 INFO - PROCESS | 21764 | Values: 66.0 68.0 66.0 68.0 69.0 68.0 67.0 67.0 66.0 66.0 22:57:42 INFO - PROCESS | 21764 | 22:57:42 INFO - PROCESS | 21764 | [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:66.50 stddev:3.09 (4.7%) stddev-sans-first:3.28 22:57:42 INFO - PROCESS | 21764 | Values: 67.0 76.0 66.0 66.0 66.0 66.0 66.0 67.0 66.0 67.0 22:57:42 INFO - PROCESS | 21764 | 22:57:42 INFO - PROCESS | 21764 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:87.00 stddev:2.41 (2.8%) stddev-sans-first:2.40 22:57:42 INFO - PROCESS | 21764 | Values: 85.0 89.0 87.0 89.0 93.0 87.0 86.0 85.0 87.0 86.0 22:57:42 INFO - PROCESS | 21764 | 22:57:42 INFO - PROCESS | 21764 | [#11] stanford-crypto-ccm Cycles:10 Average:156.80 Median:155.00 stddev:16.67 (10.8%) stddev-sans-first:17.44 22:57:42 INFO - PROCESS | 21764 | Values: 149.0 155.0 143.0 145.0 153.0 160.0 155.0 155.0 202.0 151.0 22:57:42 INFO - PROCESS | 21764 | 22:57:42 INFO - PROCESS | 21764 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.10 Median:181.50 stddev:5.30 (2.9%) stddev-sans-first:5.61 22:57:42 INFO - PROCESS | 21764 | Values: 179.0 175.0 176.0 190.0 184.0 177.0 177.0 185.0 174.0 184.0 22:57:42 INFO - PROCESS | 21764 | 22:57:42 INFO - PROCESS | 21764 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:70.50 stddev:1.90 (2.7%) stddev-sans-first:1.80 22:57:42 INFO - PROCESS | 21764 | Values: 73.0 70.0 70.0 74.0 71.0 70.0 72.0 69.0 69.0 68.0 22:57:42 INFO - PROCESS | 21764 | -------- Summary: end -------- 22:57:42 INFO - PROCESS | 21764 | 22:57:44 INFO - TEST-INFO | 21764: exit 0 22:57:44 INFO - TEST-OK | kraken | took 66127ms 22:57:44 INFO - SUITE-END | took 1186s 22:57:44 INFO - Completed test suite (00:19:46) 22:57:44 INFO - javascript benchmark 22:57:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6065.282060310584, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2567.602021686639, 2574.9227523174304, 2579.4583137541117, 2602.011235730422, 2605.270524253209, 4476.776161191936, 4591.4260717410325, 4637.026224492856, 4648.69783464075, 4658.836940707076, 4506.504284528699, 4593.379893714347, 4613.054323863608, 4615.100055489181, 4619.86140415788, 4238.597333253336, 4261.8082186301535, 4281.422008028907, 4310.612044915957, 4336.284513055342, 4274.508431530383, 4283.507396649378, 4303.849365272216, 4321.9783901080455, 4390.165868484994, 4344.978275108636, 4345.044090300129, 4350.956490435086, 4389.034412429276, 4390.758508282043, 329.3964941927029, 4311.051568654891, 4314.71954322968, 4336.0, 4345.847895323648, 4280.2081614901035, 4284.721493102938, 4295.892602684927, 4309.698321117523, 4344.1311737652595, 4589.173948689235, 4632.2588385858435, 4643.442786865564, 4652.162610730067, 4685.882852928704, 4732.716037037754, 4784.976075119602, 4787.6648634595595, 4888.120138375127, 4975.203967365241, 4835.274708793674, 4868.9756551217015, 4880.804767809319, 4887.364642596475, 4893.681910675795, 4605.148047611203, 4611.769411529477, 4629.027904140101, 4643.976780116078, 4658.045100754337, 4989.226669866177, 5000.224965130411, 5022.8196373852115, 5064.290999260106, 5082.263071854561, 4708.034852855157, 4725.976370118196, 4738.241881298975, 4801.9039619208115, 4847.030593881238, 4825.252085926687, 4838.782254798542, 4858.416989961227, 4865.391826021747, 4874.025194961022, 4876.146674332049, 4880.82917097907, 4882.462929077798, 4943.060818444484, 4981.726005069683, 4901.313816065754, 4908.312836202935, 4919.729414882216, 4929.137400954819, 4996.575291100297, 4131.5248746393945, 4275.551067137906, 4287.056847493546, 4294.3558466230315, 4342.457192850894, 3617.8733744318824, 3638.0, 3663.5603727552866, 3688.041109311598, 3694.113412780967, 4220.2192594370135, 4227.175700738388, 4232.534421213664, 4272.4445822042935, 4282.464691913511, 4945.901081978341, 4947.455779864212, 4957.4794646561595, 4972.701637901665, 5016.046951079284, 4150.8547200847825, 4204.474440694913, 4204.978975105105, 4212.326027835593, 4238.788060596958, 4469.061497085649, 4480.103979204172, 4483.08096840147, 4483.21543729846, 4486.730796152241, 4609.009063051393, 4637.258038713857, 4649.5815376616265, 4649.883752906137, 4691.460482044608, 4977.950220497749, 4991.850244492671, 4993.825216117419, 5001.374828146481, 5040.697558146523, 4652.697574657636, 4654.953450465452, 4660.906781864412, 4664.533546645308, 4709.835155769531, 4739.3838800955655, 4760.238361862085, 4774.0, 4790.5448982346625, 4835.323054772264, 4867.780949857194, 4918.508149185053, 4942.3327850741125, 4960.528749768766, 4962.230854217602, 4780.784864681167, 4830.637702172281, 4833.95166048335, 4835.637327200404, 4875.87810304731, 4721.976390118165, 4809.134355815987, 4828.806847726051, 4830.565249127455, 4832.685875418087, 4717.410323709536, 4720.197566413649, 4724.740139292372, 4782.210935195793, 4829.710217386968, 4823.662343635911, 4864.197407427876, 4866.05112003156, 4867.318575399518, 4893.21708526634, 4560.475545312332, 4732.621390288699, 4738.905221895474, 4758.262469317261, 4792.496787837227], "value": 4508.6158464178725, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [527.7440441385927, 532.8534652970433, 549.0008185103113, 553.2033871225435, 554.4954091776484, 35484.64515354846, 36706.082347941316, 37124.07189820253, 40490.59509404905, 40547.59452405475, 38340.23319533614, 38906.61093389065, 38981.22037559247, 38988.41517377242, 39004.80497597508, 7561.395088392929, 7710.614469276542, 7714.575698336589, 9734.951325243364, 10036.19710423168, 9873.555689993931, 9980.051895069993, 9980.900190998105, 9985.450800205987, 9989.800203995916, 9893.802123957517, 9969.351992120526, 10007.099361057504, 10060.949695251513, 10062.849057264148, 9954.253430992669, 9987.70036898887, 10012.29913906027, 10046.598136074621, 10063.949680251551, 9904.356216845881, 9942.105210531015, 9983.201343892544, 9986.151177149952, 9996.650117245934, 36109.63890361115, 36609.0, 36632.26735465276, 36649.81675091634, 36785.0, 3015.6833532478995, 3161.873525058995, 3249.6587858275016, 3568.4825700273313, 3572.285542891432, 26145.346366340804, 26174.345641358927, 26354.73645263542, 26494.86752566244, 26921.0, 3089.5211242257487, 3095.767817413703, 3105.0, 3126.796758210709, 3197.0568682238795, 249214.0, 249840.0, 251447.0, 251940.0, 252512.73743631347, 50025.74987125114, 50583.66536852136, 50594.241086383736, 50617.0, 50739.0, 53783.0, 53975.19037214445, 54348.0, 54421.45578544243, 54448.0, 12369.567065152676, 12378.381080946097, 12409.689757755948, 12420.378981050912, 12607.621771346874, 9088.500132492776, 9305.441673499612, 9824.705258842247, 10059.44673042975, 10067.345622534658, 16338.67322653564, 16399.42602008924, 16401.83598164027, 16480.258388372553, 16564.420245291356, 6485.319041500575, 6676.298988606223, 6708.597484150967, 6755.8935664810115, 6792.788471147821, 763.2215140556601, 882.9337799665051, 884.1732979664034, 887.3522328700085, 917.6283605139929, 25584.8720756395, 26420.603690944652, 27057.0, 27192.0, 27214.727852721615, 948.9098535639104, 979.4906648542718, 991.6578780320777, 1006.2905651515664, 1015.751140970467, 13831.170129792245, 14142.0, 14328.785068223984, 14474.782878256834, 14562.490312839, 337968.0, 339923.0, 342474.0, 343521.0, 343857.0, 45629.08741825145, 46336.304955425694, 46356.3046554302, 46404.53595464002, 46411.0, 1113.204059097749, 1166.7083229192701, 1167.4921409187032, 1172.1150531348947, 1176.6999415149082, 25741.227763167135, 26331.0, 26554.734452655226, 26691.466170676867, 26768.196954091407, 39544.40683389809, 39723.20553588854, 39773.40339894846, 39845.40231896582, 40056.198876021735, 300399.0, 300768.4731034403, 300994.0, 301128.0, 301939.0, 20532.589348212652, 21383.25158619441, 21436.142554297654, 21444.571108577427, 23737.0, 37969.43045854259, 37973.0, 38421.231575368896, 38567.42148867825, 39261.60738392694, 33690.0, 33751.83124084364, 33956.66043339535, 34144.31711365709, 34205.65794342025, 33198.170045748084, 33345.0, 33498.0, 33593.0, 33701.831490842385, 33087.0, 33207.671693132004, 33469.497957531144, 33493.330133397685, 33821.32357352888, 28637.427251455272, 31016.844915775277, 31315.373692525565, 31318.843405782824, 31324.843375782973, 24505.387365316008, 24505.7115004877, 24587.631185531875, 24677.162126354982, 24809.87595062013], "value": 17168.307865130424, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.51177119689225, 354.3886795278145, 360.9675129238368, 368.7474080255024, 384.20277923309123, 15794.684106317867, 15875.68248635028, 16398.918005409985, 16418.753718694228, 16488.58778530537, 15037.0, 15786.289616967235, 15876.047437153778, 15888.205589720497, 15943.282552285145, 4549.590536851674, 4966.304717339575, 5003.4996500350035, 5013.699178049311, 5018.146915024437, 4920.286558449023, 4953.777080031407, 4984.551390374865, 5247.370315562138, 5255.448177941299, 5318.441563635821, 5322.600804939626, 5322.840314790563, 5329.733513324338, 5333.493318134771, 5245.763940622681, 5268.578513718893, 5311.044012077825, 5341.706206158659, 5404.756785944642, 5176.2235664650225, 5192.831612887108, 5199.6360254782185, 5200.063988482072, 5212.374515058179, 11886.346250956194, 15643.374265029384, 16236.594085147848, 16553.337866485326, 17017.064061476613, 1917.9424617261504, 2109.7257356543705, 2160.2979031814725, 2185.1477923609646, 2215.1803832581886, 8455.492670439731, 8767.956160219223, 8908.554572271361, 8993.865092023625, 9205.401648892801, 1593.283022639805, 1683.9242234099372, 1691.6193856382338, 1692.1285537947967, 1733.8352856478614, 64989.67505162444, 65252.3474765251, 65790.01314980327, 67369.0, 67584.0, 9304.767380815398, 9711.5144242789, 9875.901240987641, 9925.0, 10135.391876487434, 13151.736965260641, 13212.207267563977, 13539.187648741106, 13636.590902272948, 13676.179429234078, 6706.524564595781, 6801.319868013159, 6817.216020157745, 6920.273371296042, 7067.328603782633, 6324.71538780756, 6369.363063693686, 6568.310327415648, 6575.276719560845, 6635.071090047397, 3999.140184860269, 4054.675625949917, 4145.813438395279, 4168.374743788456, 4388.956110438919, 1682.9831701682826, 1725.887817291872, 1798.6672465593906, 1838.6322735452964, 1854.3417086933944, 714.9034880291198, 815.2662603656756, 844.9619767110495, 857.2670366836389, 901.4005686218723, 15702.0, 16048.518544443452, 16095.758563621555, 16422.75365869513, 16499.6700065998, 805.8710606302964, 818.7257268814894, 823.995880020596, 826.7561069484517, 872.0, 8617.913820861711, 8949.865752013726, 8998.86501702475, 9155.267578593697, 9200.493972831424, 333999.0, 336349.0, 336387.0, 338906.0, 340547.0, 44992.0, 51663.0, 66233.66883165554, 75861.0, 77674.6116269415, 852.1819053708385, 880.9823803523893, 882.3470631732472, 884.9734507964771, 885.3802338363172, 14228.430862765374, 14314.439054905843, 14368.784468232776, 14377.28113594337, 14575.198364089652, 34084.0, 34719.13202169966, 35159.47260791141, 36526.817365913, 36792.0, 46477.767611161726, 46539.76730116328, 46714.29928551142, 46945.53054469548, 47545.0, 6924.272951340036, 7181.640917953977, 7371.557706537625, 7379.557226566423, 7768.067831860213, 11111.166662500507, 11272.605458808903, 11380.752308850886, 12031.699207519532, 12077.154599177973, 9775.657851975147, 10054.899451005396, 10199.490025498548, 10231.232657550565, 10372.636957706443, 9731.951340243253, 9972.700818975442, 10293.43386113741, 10359.585616575252, 10478.895211047791, 10013.39919604826, 10082.344647597884, 10143.137833283958, 10303.845442318521, 10461.74459064917, 6380.617162970237, 6761.256261811295, 6893.276205998298, 7175.067241258603, 7625.847483050197, 9906.207503399855, 9993.700188994342, 10114.140298074451, 10140.645077422254, 10187.0], "value": 7803.795972196779, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1290.9289989050603, 1339.2500199888061, 1387.6392138044105, 1614.0961061805383, 1620.189905047477, 6268.968655156729, 6471.644059576722, 6775.0, 7179.246179151192, 7249.093863267091, 6655.168103987002, 6865.279145689693, 6867.931320686792, 6960.060391847099, 6993.545419547726, 2057.269669267411, 2082.6563617003253, 2090.759562650292, 2094.2251366994155, 2094.685797130435, 1957.8825270483746, 1966.4002479243825, 2049.918003279867, 2094.0472085201195, 2115.0693694774327, 2042.213747707136, 2047.2732180076082, 2070.420282320945, 2071.2232912657755, 2073.4712648274744, 2005.4284528909263, 2020.8181263686265, 2026.5440275937945, 2027.1384661518944, 2030.0864610924996, 1912.913918873654, 1918.8752731072436, 1943.620993906189, 1945.7956914524054, 1949.2495389275089, 6919.481038922101, 6956.304369563054, 6992.475564332695, 6996.860062798715, 7098.467614928901, 4224.640905523034, 4297.527272000078, 4319.892002699926, 4335.913281734348, 4345.044090300129, 2510.748925107493, 2604.2057172562363, 2666.9066582669707, 2684.1142423000365, 2696.5685490321653, 801.798389516606, 830.767385132164, 839.0895877972407, 854.3293514591016, 858.8625819868791, 8746.387752857303, 9120.224780893566, 9324.533773311307, 9359.578818953163, 9387.76530586734, 3637.9818100909856, 3691.9815400922826, 3719.8326075326677, 3723.162288485069, 3743.0, 7595.0, 7619.961900190575, 7629.122650895107, 7647.655855486517, 7667.654955527015, 4198.076423186894, 4199.181159673895, 4199.9370009449885, 4213.599708027732, 4214.704970652087, 3408.437607794736, 3925.4700615417123, 3932.8623498177426, 3948.3287841067086, 3970.642642162219, 3025.3949210158057, 3026.334206474572, 3143.512755522898, 3156.4318422683677, 3161.573187619688, 916.2395211974045, 916.6470908700065, 925.1442415765524, 928.8931772846074, 930.4742820306506, 731.6305265840823, 760.1752098972567, 766.9693212271558, 775.7711475114854, 798.1938242375243, 4468.262736648481, 4607.170709272296, 4626.352310676508, 4669.743164125938, 4679.906401871944, 381.460233769219, 382.2298069390181, 386.31622029008497, 404.82390160280374, 414.36188270064366, 3084.953725694116, 3089.7528197744127, 3159.510275907238, 3167.319026409333, 3235.7087862092526, 7908.169642187602, 7984.880226796603, 8312.127226641236, 8336.83326333482, 8383.0, 8490.27832634233, 8562.272206862363, 8567.014793298851, 8568.571571421404, 8573.271271941954, 6415.294317625057, 6559.672016399257, 6573.57271777333, 6576.375244351779, 6609.735610575523, 4540.795664195053, 4598.4941656417095, 4647.465541462775, 4661.3707149534375, 4674.7896344663895, 7460.910944935426, 7561.470697051153, 7588.203238659861, 7613.467057305936, 7661.080670319598, 7635.5800430974605, 7693.192214817587, 7703.3067023968115, 7733.961330193313, 8033.477823941425, 5518.668879867221, 5708.885822283614, 5952.58331916779, 6115.235595550556, 6126.23422072241, 6316.463100636313, 6513.772017979348, 6539.967300163468, 6665.466762659073, 6665.600063996176, 6012.579119461596, 6051.031834906394, 6088.634681918922, 6132.0, 6200.441960223601, 5728.770849165987, 5808.651480911159, 5809.0, 5812.505936995402, 5965.194698715618, 5287.629865909504, 5305.1776974569, 5319.148936170194, 5346.652467589594, 5351.063563876228, 3885.300645883655, 3957.485526881487, 4012.7592344459426, 4050.6151915567975, 4181.581841815794, 3992.7205095643026, 3993.840246390112, 4046.8785936421955, 4078.1435898461655, 4079.4288799568676], "value": 3611.3761966841553, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.3443753211572, 299.5117957728903, 302.5537332434658, 303.6432192174195, 306.41933535949374, 4964.751762411874, 4970.975145124274, 5016.147254966655, 5020.723860187688, 5036.445990940998, 4904.558589726924, 4905.460399356077, 4925.335079764231, 4928.0, 4949.703017818933, 3663.5054267673922, 3756.9624303757023, 3780.3384407728677, 3851.2105018471284, 3894.610538946111, 3878.204967981571, 3880.6701430378453, 3882.514685664292, 3888.241792850395, 3888.805559722017, 3849.7305188636806, 3853.1715681128553, 3853.8843834685003, 3862.8261728222296, 3873.8837834865, 3735.3089678409583, 3847.5960024197334, 3868.2650296443585, 3887.1448281378193, 3898.9805050974564, 3363.630000699921, 3377.9831100844585, 3383.8664047544103, 3385.324264489094, 3426.0749597608506, 4776.880577985544, 4787.3776409066595, 4790.688605240648, 4825.300331451955, 4842.539958703917, 4383.978080109611, 4395.7142785718825, 4439.245328294198, 4439.889002774924, 4440.800163992628, 5087.49125087492, 5141.511556402136, 5146.0, 5188.325517682677, 5224.477552244745, 3732.64539868712, 3732.8055022392573, 3734.141147536082, 3735.290294843971, 3745.606711295329, 5367.651102678314, 5383.407825139231, 5385.623006389555, 5405.891882162374, 5418.485243901823, 3715.702743780491, 3736.682381997506, 3737.252549490113, 3745.176061266517, 3823.3309170895536, 3753.474513568103, 3761.7931013793955, 3768.4347347898033, 3768.8304026318883, 3773.471713960048, 4296.4414626098405, 4315.697901146889, 4339.652827773771, 4342.630876375543, 4370.497392799869, 5058.46886076964, 5071.264666623319, 5097.1844504879045, 5126.282320475137, 5131.897362052738, 1292.3279894454831, 1307.3071272225736, 1312.4750099959901, 1317.1767645221737, 1318.9142705724098, 881.2641444393875, 896.4894153351623, 913.1553313185277, 927.3601215161517, 938.938968967015, 4284.657227421799, 4364.41080454141, 4544.477385100756, 4553.772311384418, 4567.862964111082, 5389.787297858029, 5396.9730151348995, 5413.428621404802, 5417.295751552273, 5426.213199086111, 4544.977380089454, 4546.863594092117, 4559.589636932692, 4562.292844609091, 4566.49768525462, 2652.9336766580604, 2752.862356882148, 2755.531559634867, 2769.695333513312, 2770.86394578226, 4813.975930120327, 4824.855254342376, 4842.297866809293, 4847.830325938646, 4858.514148585184, 5321.840344789663, 5336.599755018312, 5345.438728933484, 5345.893082138336, 5352.464753524617, 4725.64557658177, 4981.750912454435, 4984.601231901439, 5012.749362531932, 5036.395632524121, 5399.811006614749, 5408.918866216931, 5421.728913554385, 5436.320459942507, 5466.5900057495055, 5015.498450154955, 5142.537171654569, 5190.416922838571, 5238.2404551340605, 5267.815626453209, 4982.181503751177, 5037.244413338029, 5037.715382577419, 5058.898822023465, 5075.974620126875, 3713.1830997180577, 3732.1602639405914, 3740.775553466801, 3741.30785804627, 3759.1541903072684, 5081.77132029067, 5453.700046497481, 5456.863578410413, 5458.017556839807, 5468.808591699271, 5155.304033955518, 5155.690658560498, 5167.044096842096, 5175.680201548732, 5207.661502002509, 5185.325907631984, 5194.68831870089, 5220.3735551734035, 5233.816816411408, 5257.027449921777, 4899.485554016777, 5064.569511591556, 5120.0, 5133.204353325241, 5179.093658609803, 5070.5943524517215, 5205.282256855305, 5225.6603320784025, 5225.973870130625, 5243.8164664236565, 5131.923021154611, 5132.640715150053, 5134.922976155286, 5140.948590514196, 5149.356330458692], "value": 3895.0757807559203, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.4535872356157, 645.0195702532154, 680.8604236131592, 683.7470136049659, 684.9075374824397, 11622.825657615133, 12247.142700010992, 13492.527761528348, 13991.440342386319, 14173.71652566948, 12189.329586872718, 12463.750724985495, 12505.749885002295, 12510.749785004295, 12517.311547864863, 726.803762983994, 752.7177308509309, 756.474250395975, 757.8749506331476, 757.9204183560729, 744.3338212299989, 756.2513112019117, 759.8822182561712, 762.2529920677739, 768.6272158003364, 791.1100012485954, 798.6286376834771, 799.17285609394, 799.3085980626745, 799.6801279488193, 793.8809178623223, 793.9206079392014, 794.126460893013, 794.4756460735915, 794.5391672829745, 583.4544700704812, 583.6177303865975, 583.8336074218827, 583.9007368747323, 584.3280227738093, 12624.116311858174, 12709.618711438672, 12720.554780582635, 12732.23606583608, 12749.362531873368, 10781.568737250578, 10785.083267922237, 10853.0, 11271.492782824793, 11503.827442588368, 9478.857817132748, 9540.793134625052, 9680.128788409007, 9864.95067524665, 9882.160016398615, 3135.263213144909, 3158.96841031589, 3184.0607020928883, 3245.9188520286943, 3317.270200555874, 49123.754381228224, 49328.75335623299, 49436.75281623605, 49703.50296497025, 51240.487595124316, 8783.063511830635, 8843.380963332633, 9065.81868362629, 9169.22061624756, 9173.81652366949, 16183.595410114842, 16379.508614741577, 16574.75137872933, 16683.582910427336, 16795.748063779054, 5759.568032397503, 5885.440883116097, 5947.316058653224, 6048.9697551512845, 6130.509559235251, 3598.208394153282, 3721.1999420124803, 3734.8506059757306, 3758.9593315645297, 3789.829457674411, 2682.248970288322, 2683.644759396492, 2764.04640399062, 2766.6265054217824, 2767.972320276812, 476.2022622082532, 478.9941123640397, 480.1860845866293, 482.48615224785493, 489.6890474548687, 395.99406008909887, 427.8694998025632, 438.4694519631218, 507.32779067735396, 528.6088294662, 7065.364117229474, 7239.058922340168, 7277.89083163753, 7301.233370496021, 7342.460848331772, 504.4199170953433, 531.7474199755086, 534.4735435595935, 570.6034306157181, 579.6724850459477, 3434.6737059979264, 3536.0629433200224, 3565.982170089133, 3583.3012562550052, 3616.385214513539, 65395.346046539875, 68245.31754682389, 68956.6552167246, 71318.0, 71329.64335178395, 54523.72738136284, 59205.70397147987, 59759.70120149371, 60107.699461502416, 61727.38272617306, 41375.379369309485, 49737.25394119019, 50314.49685503245, 51049.48950510447, 51268.743656282226, 7511.0, 8018.3585313173635, 8038.276555110068, 8161.673533058611, 8164.265216130577, 30673.0, 33996.49005264873, 36180.81909590435, 36207.63792362148, 37369.0, 48427.5157248423, 49263.0, 49439.752801235765, 50150.0, 51201.7439912813, 9644.324897257406, 9708.951455242679, 10061.69814905554, 10093.69718908434, 10450.16398688088, 11382.772344552897, 11712.180147389941, 11768.35274059935, 11880.584179553674, 12030.0, 9897.0, 10396.116330112025, 10594.947025264824, 10648.733781655521, 10667.733306667395, 10877.78244435091, 10888.61889833852, 11133.387663678575, 11312.15158863072, 11395.886041139815, 9722.416655000723, 9907.207423406255, 9942.15491683215, 10079.647212347532, 10430.165586753194, 8655.394122411371, 9105.11201599006, 9173.312001599774, 9361.812763744823, 9489.240860731263, 8860.335474839541, 9221.631134754803, 9245.861312080458, 9260.39807412516, 9296.581653825458], "value": 5858.510536508915, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1589.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 116.0, 116.0, 117.0, 117.0, 116.0, 115.0, 119.0, 116.0, 117.0], "value": 115.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 131.0, 138.0, 181.0, 133.0, 133.0, 132.0, 136.0, 165.0, 136.0], "value": 144.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 178.0, 163.0, 165.0, 164.0, 171.0, 164.0, 165.0, 162.0, 163.0], "value": 166.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 77.0, 110.0, 77.0, 77.0, 77.0, 78.0, 91.0, 77.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 104.0, 84.0, 83.0, 84.0, 101.0, 83.0, 83.0, 106.0], "value": 89.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 120.0, 118.0, 119.0, 118.0, 117.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 148.0, 149.0, 147.0, 148.0, 147.0, 147.0, 151.0, 147.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 95.0, 95.0, 96.0, 97.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 66.0, 68.0, 69.0, 68.0, 67.0, 67.0, 66.0, 66.0], "value": 67.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 76.0, 66.0, 66.0, 66.0, 66.0, 66.0, 67.0, 66.0, 67.0], "value": 67.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 89.0, 87.0, 89.0, 93.0, 87.0, 86.0, 85.0, 87.0, 86.0], "value": 87.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 155.0, 143.0, 145.0, 153.0, 160.0, 155.0, 155.0, 202.0, 151.0], "value": 156.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 175.0, 176.0, 190.0, 184.0, 177.0, 177.0, 185.0, 174.0, 184.0], "value": 180.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 70.0, 70.0, 74.0, 71.0, 70.0, 72.0, 69.0, 69.0, 68.0], "value": 70.6, "unit": "score"}]}]} 22:57:44 INFO - Return code: 0 22:57:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:57:44 ERROR - # TBPL SUCCESS # 22:57:44 INFO - Running post-action listener: _resource_record_post_action 22:57:44 INFO - [mozharness: 2016-11-26 06:57:44.686346Z] Finished run-tests step (success) 22:57:44 INFO - Running post-run listener: _resource_record_post_run 22:57:44 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 405327872; Read time: 24; Write time: 425868 22:57:44 INFO - TinderboxPrint: CPU usage
13.5% 22:57:44 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 24 22:57:44 INFO - TinderboxPrint: I/O write bytes / time
405,327,872 / 425,868 22:57:44 INFO - TinderboxPrint: CPU idle
8,301.5 (86.5%) 22:57:44 INFO - TinderboxPrint: CPU user
1,226.6 (12.8%) 22:57:44 INFO - TinderboxPrint: Swap in / out
0 / 0 22:57:44 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99291136; Read time: 0; Write time: 162960 22:57:44 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 288780288; Read time: 0; Write time: 256936 22:57:45 INFO - Running post-run listener: _upload_blobber_files 22:57:45 INFO - Blob upload gear active. 22:57:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:57:45 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 22:57:45 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:57:45 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:57:45 INFO - (blobuploader) - INFO - Open directory for files ... 22:57:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:57:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:57:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:57:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:57:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:57:46 INFO - (blobuploader) - INFO - Done attempting. 22:57:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:57:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:57:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:57:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:57:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:57:47 INFO - (blobuploader) - INFO - Done attempting. 22:57:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:57:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:57:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:57:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:57:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:57:50 INFO - (blobuploader) - INFO - Done attempting. 22:57:50 INFO - (blobuploader) - INFO - Iteration through files over. 22:57:50 INFO - Return code: 0 22:57:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:57:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:57:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4c59a5ed975ee74cf50b88f6b3b5bed09050fae6e8745da24241196baaf7029292c96f15f25e546f3a1b961d323aef6c6cc23a94f9d11e9a74502d31df7ced8a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/71fa0f24b396496d7fbec9bd81e8de548404481e189c2e3ee86820e4b3b1db399d78a6a73bbbb91ed1e801558b1159f503455d12b631f056c4ca7e0ea1d8658c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/41c4dc73ffcb85c4f2c9ddb177913d9b826ebb27ab9577e3c09c28eb3edc4e2dbd8910be5e2fd9a722e658defe3a707d2fcc6bfd5354b1d66c610d04af9a0222"} 22:57:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:57:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:57:50 INFO - Contents: 22:57:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4c59a5ed975ee74cf50b88f6b3b5bed09050fae6e8745da24241196baaf7029292c96f15f25e546f3a1b961d323aef6c6cc23a94f9d11e9a74502d31df7ced8a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/71fa0f24b396496d7fbec9bd81e8de548404481e189c2e3ee86820e4b3b1db399d78a6a73bbbb91ed1e801558b1159f503455d12b631f056c4ca7e0ea1d8658c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/41c4dc73ffcb85c4f2c9ddb177913d9b826ebb27ab9577e3c09c28eb3edc4e2dbd8910be5e2fd9a722e658defe3a707d2fcc6bfd5354b1d66c610d04af9a0222"} 22:57:50 INFO - Running post-run listener: copy_logs_to_upload_dir 22:57:50 INFO - Copying logs to upload dir... 22:57:50 INFO - mkdir: /builds/slave/test/build/upload/logs 22:57:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.810397 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-11-25 22:57:50.026600) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-25 22:57:50.030053) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1480137413.236495-1213197336 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/Firefox-Non-PGO/sha512/4c59a5ed975ee74cf50b88f6b3b5bed09050fae6e8745da24241196baaf7029292c96f15f25e546f3a1b961d323aef6c6cc23a94f9d11e9a74502d31df7ced8a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/71fa0f24b396496d7fbec9bd81e8de548404481e189c2e3ee86820e4b3b1db399d78a6a73bbbb91ed1e801558b1159f503455d12b631f056c4ca7e0ea1d8658c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/41c4dc73ffcb85c4f2c9ddb177913d9b826ebb27ab9577e3c09c28eb3edc4e2dbd8910be5e2fd9a722e658defe3a707d2fcc6bfd5354b1d66c610d04af9a0222"} build_url:https://queue.taskcluster.net/v1/task/by1X_ZPxT8Gfbv2tp3SjVQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011353 build_url: 'https://queue.taskcluster.net/v1/task/by1X_ZPxT8Gfbv2tp3SjVQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4c59a5ed975ee74cf50b88f6b3b5bed09050fae6e8745da24241196baaf7029292c96f15f25e546f3a1b961d323aef6c6cc23a94f9d11e9a74502d31df7ced8a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/71fa0f24b396496d7fbec9bd81e8de548404481e189c2e3ee86820e4b3b1db399d78a6a73bbbb91ed1e801558b1159f503455d12b631f056c4ca7e0ea1d8658c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/41c4dc73ffcb85c4f2c9ddb177913d9b826ebb27ab9577e3c09c28eb3edc4e2dbd8910be5e2fd9a722e658defe3a707d2fcc6bfd5354b1d66c610d04af9a0222"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-25 22:57:50.056197) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 22:57:50.056603) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1480137413.236495-1213197336 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004452 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 22:57:50.141730) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-25 22:57:50.142107) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-25 22:57:50.142433) ========= ========= Total master_lag: 0.17 =========