builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-019 starttime: 1480142221.08 results: success (0) buildid: 20161125211919 builduid: 38ea101456ab42db84d9a364749341cc revision: ee388da4aeb6b686a04c16d11ca8606ee2b3e8e0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-25 22:37:01.082733) ========= 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:01.083427) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-25 22:37:01.084092) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-25 22:37:01.101900) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 22:37:01.102342) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1480141982.947840-964587317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-25 22:37:01-- 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% 21.9M=0.001s 2016-11-25 22:37:01 (21.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.091120 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 22:37:01.208345) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 22:37:01.208703) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1480141982.947840-964587317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018819 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 22:37:01.261766) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-25 22:37:01.262409) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1480141982.947840-964587317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-25 22:37:01,778 truncating revision to first 12 chars 2016-11-25 22:37:01,778 Setting DEBUG logging. 2016-11-25 22:37:01,778 attempt 1/10 2016-11-25 22:37:01,778 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:02,589 unpacking tar archive at: mozilla-central-ee388da4aeb6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.160318 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-25 22:37:02.438625) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-25 22:37:02.438945) ========= script_repo_revision: ee388da4aeb6b686a04c16d11ca8606ee2b3e8e0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-25 22:37:02.439392) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-25 22:37:02.439711) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-25 22:37:02.450402) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-11-25 22:37:02.450733) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=78329bfc0fd5309db0a6e0ac000001b4-1480141982.947840-964587317 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 --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', 22:37:03 INFO - 'system_bits': '32', 22:37:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:37:03 INFO - 'title': 'talos-linux64-ix-019', 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.067438Z] 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:03 INFO - Running post-action listener: _resource_record_post_action 22:37:03 INFO - [mozharness: 2016-11-26 06:37:03.527390Z] Finished clobber step (success) 22:37:03 INFO - [mozharness: 2016-11-26 06:37:03.527488Z] Running read-buildbot-config step. 22:37:03 INFO - Running pre-action listener: _resource_record_pre_action 22:37:03 INFO - Running main action method: read_buildbot_config 22:37:03 INFO - Using buildbot properties: 22:37:03 INFO - { 22:37:03 INFO - "project": "", 22:37:03 INFO - "product": "firefox", 22:37:03 INFO - "script_repo_revision": "production", 22:37:03 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 22:37:03 INFO - "repository": "", 22:37:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 22:37:03 INFO - "buildid": "20161125211919", 22:37:03 INFO - "pgo_build": "False", 22:37:03 INFO - "basedir": "/builds/slave/test", 22:37:03 INFO - "buildnumber": 834, 22:37:03 INFO - "slavename": "talos-linux64-ix-019", 22:37:03 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:37:03 INFO - "platform": "ubuntu64_hw", 22:37:03 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 22:37:03 INFO - "branch": "mozilla-central", 22:37:03 INFO - "repo_path": "mozilla-central", 22:37:03 INFO - "revision": "ee388da4aeb6b686a04c16d11ca8606ee2b3e8e0", 22:37:03 INFO - "stage_platform": "linux64", 22:37:03 INFO - "builduid": "38ea101456ab42db84d9a364749341cc", 22:37:03 INFO - "slavebuilddir": "test" 22:37:03 INFO - } 22:37:03 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:03 INFO - Running post-action listener: _resource_record_post_action 22:37:03 INFO - [mozharness: 2016-11-26 06:37:03.529894Z] Finished read-buildbot-config step (success) 22:37:03 INFO - [mozharness: 2016-11-26 06:37:03.529981Z] Running download-and-extract step. 22:37:03 INFO - Running pre-action listener: _resource_record_pre_action 22:37:03 INFO - Running main action method: download_and_extract 22:37:03 INFO - mkdir: /builds/slave/test/build/tests 22:37:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:03 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:03 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:03 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:04 INFO - Downloaded 1361 bytes. 22:37:04 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 22:37:04 INFO - Using the following test package requirements: 22:37:04 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 22:37:04 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:37:04 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:37:04 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:37:04 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:37:04 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:37:04 INFO - u'jsshell-linux-x86_64.zip'], 22:37:04 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:37:04 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:37:04 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 22:37:04 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:37:04 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:37:04 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:37:04 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:37:04 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:37:04 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:37:04 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:37:04 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:37:04 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:37:04 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:04 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:04 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:04 INFO - Http code: 200 22:37:04 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 22:37:04 INFO - x-amz-cf-id: vSQ8ruoSZCD7I7hDd2FIYHpiGK7yno1ba_-0upvXkF5StGd0mueSbg== 22:37:04 INFO - x-amz-version-id: r4CqcWzsGY6k6mmnXiojrnZoYTvsZbfQ 22:37:04 INFO - Expected file size: 20205206 22:37:04 INFO - Obtained file size: 20205206 22:37:08 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:08 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:08 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:08 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:09 INFO - Http code: 200 22:37:09 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 22:37:09 INFO - x-amz-cf-id: 9okRBq-VHrBQZxTHZcJfMCglJv7aaGQo8cUiCCEWPiazDTD3F-HaCQ== 22:37:09 INFO - x-amz-version-id: r4CqcWzsGY6k6mmnXiojrnZoYTvsZbfQ 22:37:09 INFO - Expected file size: 20205206 22:37:09 INFO - Obtained file size: 20205206 22:37:14 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:14 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:14 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:14 INFO - Http code: 200 22:37:14 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 22:37:14 INFO - x-amz-cf-id: 6nGBV233T9O2lmoXZMZ1SvkLkPptMixIbCdPVsTyZpvip0j2gEOYmQ== 22:37:14 INFO - x-amz-version-id: JIBQtZVt2JXKrYmmSGDwulnggqw3swjV 22:37:15 INFO - Expected file size: 14409702 22:37:15 INFO - Obtained file size: 14409702 22:37:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:15 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:15 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:15 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:17 INFO - Running post-action listener: _resource_record_post_action 22:37:17 INFO - Running post-action listener: set_extra_try_arguments 22:37:17 INFO - [mozharness: 2016-11-26 06:37:17.872071Z] Finished download-and-extract step (success) 22:37:17 INFO - [mozharness: 2016-11-26 06:37:17.872298Z] Running populate-webroot step. 22:37:17 INFO - Running pre-action listener: _resource_record_pre_action 22:37:17 INFO - Running main action method: populate_webroot 22:37:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:37:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:37:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:37:17 INFO - '--tppagecycles', 22:37:17 INFO - '7'], 22:37:17 INFO - 'tests': ['tsvgm']}}, 22:37:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:37:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:37:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:37:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:37:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:37:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:37:17 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 22:37:17 INFO - 'talos_options': ['--disable-e10s'], 22:37:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:37:17 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 22:37:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:37:17 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 22:37:17 INFO - 'talos_options': ['--disable-e10s'], 22:37:17 INFO - 'tests': ['damp', 'tps']}, 22:37:17 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 22:37:17 INFO - 'tests': ['damp', 'tps']}, 22:37:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:37:17 INFO - 'tests': ['dromaeo_dom']}, 22:37:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:37:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:37:17 INFO - 'tests': ['basic_compositor_video']}, 22:37:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:37:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:37:17 INFO - 'tests': ['a11yr', 22:37:17 INFO - 'ts_paint', 22:37:17 INFO - 'tpaint', 22:37:17 INFO - 'sessionrestore', 22:37:17 INFO - 'sessionrestore_no_auto_restore', 22:37:17 INFO - 'tabpaint']}, 22:37:17 INFO - 'other-e10s': {'tests': ['a11yr', 22:37:17 INFO - 'ts_paint', 22:37:17 INFO - 'tpaint', 22:37:17 INFO - 'sessionrestore', 22:37:17 INFO - 'sessionrestore_no_auto_restore', 22:37:17 INFO - 'tabpaint']}, 22:37:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:37:17 INFO - 'ts_paint', 22:37:17 INFO - 'tpaint', 22:37:17 INFO - 'sessionrestore', 22:37:17 INFO - 'sessionrestore_no_auto_restore', 22:37:17 INFO - 'tabpaint']}, 22:37:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:37:17 INFO - 'ts_paint', 22:37:17 INFO - 'tpaint', 22:37:17 INFO - 'sessionrestore', 22:37:17 INFO - 'sessionrestore_no_auto_restore', 22:37:17 INFO - 'tabpaint']}, 22:37:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:37:17 INFO - 'tests': ['a11yr', 22:37:17 INFO - 'ts_paint', 22:37:17 INFO - 'tpaint', 22:37:17 INFO - 'sessionrestore', 22:37:17 INFO - 'sessionrestore_no_auto_restore', 22:37:17 INFO - 'tabpaint']}, 22:37:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:37:17 INFO - 'tests': ['a11yr', 22:37:17 INFO - 'ts_paint', 22:37:17 INFO - 'tpaint', 22:37:17 INFO - 'sessionrestore', 22:37:17 INFO - 'sessionrestore_no_auto_restore', 22:37:17 INFO - 'tabpaint']}, 22:37:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:37:17 INFO - 'tests': ['tsvgx', 22:37:17 INFO - 'tsvgr_opacity', 22:37:17 INFO - 'tart', 22:37:17 INFO - 'tscrollx', 22:37:17 INFO - 'cart', 22:37:17 INFO - 'tsvg_static']}, 22:37:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:37:17 INFO - 'tsvgr_opacity', 22:37:17 INFO - 'tart', 22:37:17 INFO - 'tscrollx', 22:37:17 INFO - 'cart', 22:37:17 INFO - 'tsvg_static']}, 22:37:17 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 22:37:17 INFO - 'talos_options': ['--disable-e10s'], 22:37:17 INFO - 'tests': ['tp5o']}, 22:37:17 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 22:37:17 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 22:37:17 INFO - 'talos_options': ['--disable-e10s', 22:37:17 INFO - '--xperf_path', 22:37:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:37:17 INFO - 'tests': ['tp5n']}, 22:37:17 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 22:37:17 INFO - 'talos_options': ['--xperf_path', 22:37:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:37:17 INFO - 'tests': ['tp5n']}}, 22:37:17 INFO - 'talos.zip': {'path': '', 22:37:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:37:17 INFO - Running post-action listener: _resource_record_post_action 22:37:17 INFO - [mozharness: 2016-11-26 06:37:17.887652Z] Finished populate-webroot step (success) 22:37:17 INFO - [mozharness: 2016-11-26 06:37:17.887739Z] Running create-virtualenv step. 22:37:17 INFO - Running pre-action listener: _resource_record_pre_action 22:37:17 INFO - Running main action method: create_virtualenv 22:37:17 INFO - Creating virtualenv /builds/slave/test/build/venv 22:37:17 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 22:37:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:37:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:37:17 INFO - Using real prefix '/usr' 22:37:17 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:20 INFO - Reading from file tmpfile_stdout 22:37:20 INFO - Output received: 22:37:20 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 22:37:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:37:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:37:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:37:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1e1a465e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c16130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca4fc0>, '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 0x1ca5ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca6350>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1480141982.947840-964587317', '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:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:37:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:37:20 INFO - Using env: {'DISPLAY': ':0', 22:37:20 INFO - 'HOME': '/home/cltbld', 22:37:20 INFO - 'LANG': 'en_US.UTF-8', 22:37:20 INFO - 'LANGUAGE': 'en_US:en', 22:37:20 INFO - 'LOGNAME': 'cltbld', 22:37:20 INFO - 'MAIL': '/var/mail/cltbld', 22:37:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:37:20 INFO - 'MOZ_NO_REMOTE': '1', 22:37:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:37:20 INFO - 'NO_EM_RESTART': '1', 22:37:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:37:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:37:20 INFO - 'PWD': '/builds/slave/test', 22:37:20 INFO - 'SHELL': '/bin/bash', 22:37:20 INFO - 'SHLVL': '1', 22:37:20 INFO - 'TERM': 'linux', 22:37:20 INFO - 'TMOUT': '86400', 22:37:20 INFO - 'USER': 'cltbld', 22:37:20 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1480141982.947840-964587317', 22:37:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:37:20 INFO - '_': '/tools/buildbot/bin/python'} 22:37:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:37:20 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 22:37:20 INFO - Cleaning up... 22:37:20 INFO - Return code: 0 22:37:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:37:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:37:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:37:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1e1a465e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c16130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca4fc0>, '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 0x1ca5ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca6350>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1480141982.947840-964587317', '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:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 22:37:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 22:37:20 INFO - Using env: {'DISPLAY': ':0', 22:37:20 INFO - 'HOME': '/home/cltbld', 22:37:20 INFO - 'LANG': 'en_US.UTF-8', 22:37:20 INFO - 'LANGUAGE': 'en_US:en', 22:37:20 INFO - 'LOGNAME': 'cltbld', 22:37:20 INFO - 'MAIL': '/var/mail/cltbld', 22:37:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:37:20 INFO - 'MOZ_NO_REMOTE': '1', 22:37:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:37:20 INFO - 'NO_EM_RESTART': '1', 22:37:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:37:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:37:20 INFO - 'PWD': '/builds/slave/test', 22:37:20 INFO - 'SHELL': '/bin/bash', 22:37:20 INFO - 'SHLVL': '1', 22:37:20 INFO - 'TERM': 'linux', 22:37:20 INFO - 'TMOUT': '86400', 22:37:20 INFO - 'USER': 'cltbld', 22:37:20 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1480141982.947840-964587317', 22:37:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:37:20 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:23 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 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 - Successfully installed psutil 22:37:23 INFO - Cleaning up... 22:37:23 INFO - Return code: 0 22:37:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:37:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:37:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:37:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1e1a465e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c16130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca4fc0>, '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 0x1ca5ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca6350>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1480141982.947840-964587317', '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:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 22:37:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 22:37:23 INFO - Using env: {'DISPLAY': ':0', 22:37:23 INFO - 'HOME': '/home/cltbld', 22:37:23 INFO - 'LANG': 'en_US.UTF-8', 22:37:23 INFO - 'LANGUAGE': 'en_US:en', 22:37:23 INFO - 'LOGNAME': 'cltbld', 22:37:23 INFO - 'MAIL': '/var/mail/cltbld', 22:37:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:37:23 INFO - 'MOZ_NO_REMOTE': '1', 22:37:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:37:23 INFO - 'NO_EM_RESTART': '1', 22:37:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:37:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:37:23 INFO - 'PWD': '/builds/slave/test', 22:37:23 INFO - 'SHELL': '/bin/bash', 22:37:23 INFO - 'SHLVL': '1', 22:37:23 INFO - 'TERM': 'linux', 22:37:23 INFO - 'TMOUT': '86400', 22:37:23 INFO - 'USER': 'cltbld', 22:37:23 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1480141982.947840-964587317', 22:37:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:37:23 INFO - '_': '/tools/buildbot/bin/python'} 22:37:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:37:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:37:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:37:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:37:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:37:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:37:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:37:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:37:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:37:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:37:25 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:25 INFO - Installing collected packages: mozsystemmonitor 22:37:25 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 0x7f1e1a465e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c16130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca4fc0>, '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 0x1ca5ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca6350>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1480141982.947840-964587317', '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': '78329bfc0fd5309db0a6e0ac000001b4-1480141982.947840-964587317', 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:28 INFO - Downloading functools32-3.2.3-2.tar.gz 22:37:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:37:28 INFO - warning: no files found matching '*.txt' 22:37:28 INFO - no previously-included directories found matching 'build' 22:37:28 INFO - no previously-included directories found matching 'dist' 22:37:28 INFO - no previously-included directories found matching '.git*' 22:37:28 INFO - Installing collected packages: jsonschema, functools32 22:37:28 INFO - Running setup.py install for functools32 22:37:28 INFO - warning: no files found matching '*.txt' 22:37:28 INFO - no previously-included directories found matching 'build' 22:37:28 INFO - no previously-included directories found matching 'dist' 22:37:28 INFO - no previously-included directories found matching '.git*' 22:37:28 INFO - Successfully installed jsonschema functools32 22:37:28 INFO - Cleaning up... 22:37:28 INFO - Return code: 0 22:37:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:37:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:37:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:37:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1e1a465e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c16130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca4fc0>, '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 0x1ca5ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca6350>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1480141982.947840-964587317', '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:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 22:37:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 22:37:28 INFO - Using env: {'DISPLAY': ':0', 22:37:28 INFO - 'HOME': '/home/cltbld', 22:37:28 INFO - 'LANG': 'en_US.UTF-8', 22:37:28 INFO - 'LANGUAGE': 'en_US:en', 22:37:28 INFO - 'LOGNAME': 'cltbld', 22:37:28 INFO - 'MAIL': '/var/mail/cltbld', 22:37:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:37:28 INFO - 'MOZ_NO_REMOTE': '1', 22:37:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:37:28 INFO - 'NO_EM_RESTART': '1', 22:37:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:37:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:37:28 INFO - 'PWD': '/builds/slave/test', 22:37:28 INFO - 'SHELL': '/bin/bash', 22:37:28 INFO - 'SHLVL': '1', 22:37:28 INFO - 'TERM': 'linux', 22:37:28 INFO - 'TMOUT': '86400', 22:37:28 INFO - 'USER': 'cltbld', 22:37:28 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1480141982.947840-964587317', 22:37:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:37:28 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 0x7f1e1a465e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c16130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca4fc0>, '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 0x1ca5ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca6350>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1480141982.947840-964587317', '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': '78329bfc0fd5309db0a6e0ac000001b4-1480141982.947840-964587317', 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:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:37:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:37:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:37:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:37:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:37:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:37:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:37:31 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:32 INFO - Running setup.py install for docopt 22:37:32 INFO - Successfully installed blobuploader requests docopt 22:37:32 INFO - Cleaning up... 22:37:32 INFO - Return code: 0 22:37:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:37:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:37:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:37:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:37:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:37:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1e1a465e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c16130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca4fc0>, '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 0x1ca5ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca6350>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1480141982.947840-964587317', '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:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:37:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:37:32 INFO - Using env: {'DISPLAY': ':0', 22:37:32 INFO - 'HOME': '/home/cltbld', 22:37:32 INFO - 'LANG': 'en_US.UTF-8', 22:37:32 INFO - 'LANGUAGE': 'en_US:en', 22:37:32 INFO - 'LOGNAME': 'cltbld', 22:37:32 INFO - 'MAIL': '/var/mail/cltbld', 22:37:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:37:32 INFO - 'MOZ_NO_REMOTE': '1', 22:37:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:37:32 INFO - 'NO_EM_RESTART': '1', 22:37:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:37:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:37:32 INFO - 'PWD': '/builds/slave/test', 22:37:32 INFO - 'SHELL': '/bin/bash', 22:37:32 INFO - 'SHLVL': '1', 22:37:32 INFO - 'TERM': 'linux', 22:37:32 INFO - 'TMOUT': '86400', 22:37:32 INFO - 'USER': 'cltbld', 22:37:32 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1480141982.947840-964587317', 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-xfJYfH-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-0OZhF9-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-F1RVm6-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-KY8Knf-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-q12kgl-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-kKlu0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:37:33 INFO - Running setup.py (path:/tmp/pip-uez4KP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:37:33 INFO - Running setup.py (path:/tmp/pip-TlMZuq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:37:33 INFO - Running setup.py (path:/tmp/pip-Ma_vHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:37:33 INFO - Running setup.py (path:/tmp/pip-UY3E8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:37:33 INFO - Running setup.py (path:/tmp/pip-Ji7VU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:37:33 INFO - Running setup.py (path:/tmp/pip-fzCRwX-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-vJNZSl-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-rZkdhE-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-TbVXz0-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-1pASL8-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-iDTgjQ-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:34 INFO - Running setup.py install for mozdebug 22:37:34 INFO - Running setup.py install for mozdevice 22:37:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:37:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:37:34 INFO - Running setup.py install for mozfile 22:37:34 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:35 INFO - Running setup.py install for mozprofile 22:37:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:37:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:37:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:37:35 INFO - Running setup.py install for mozrunner 22:37:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:37:35 INFO - Running setup.py install for mozscreenshot 22:37:35 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 0x7f1e1a465e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c16130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca4fc0>, '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 0x1ca5ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca6350>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1480141982.947840-964587317', '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': '78329bfc0fd5309db0a6e0ac000001b4-1480141982.947840-964587317', 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-_d2N3u-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-1TUw10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:37:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:37:36 INFO - Running setup.py (path:/tmp/pip-keLRJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:37:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:37:36 INFO - Running setup.py (path:/tmp/pip-3zcY8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:37:36 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:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:37:36 INFO - Running setup.py (path:/tmp/pip-Bks2OI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:37:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 22:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:37:36 INFO - Running setup.py (path:/tmp/pip-4OZ3FA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:37:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 22:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:37:36 INFO - Running setup.py (path:/tmp/pip-eQ7fJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:37:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 22:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:37:36 INFO - Running setup.py (path:/tmp/pip-UeF_Ll-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-uBkoXb-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-qjYvJy-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-l6BE2v-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-rXPo72-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-BvRP6F-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-MIdBmv-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-OOhjBN-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-OVVS8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 22:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:37:37 INFO - Running setup.py (path:/tmp/pip-4bvv0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 22:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:37:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:37:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:37:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:37:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:37:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:37:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:37:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:37:39 INFO - Downloading blessings-1.6.tar.gz 22:37:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:37:39 INFO - Installing collected packages: blessings 22:37:39 INFO - Running setup.py install for blessings 22:37:39 INFO - Successfully installed blessings 22:37:39 INFO - Cleaning up... 22:37:39 INFO - Return code: 0 22:37:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:37:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:37:39 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 0x7f1e1a465e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c16130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca4fc0>, '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 0x1ca5ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca6350>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1480141982.947840-964587317', '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': '78329bfc0fd5309db0a6e0ac000001b4-1480141982.947840-964587317', 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 0x7f1e1a465e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c16130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca4fc0>, '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 0x1ca5ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca6350>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1480141982.947840-964587317', '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': '78329bfc0fd5309db0a6e0ac000001b4-1480141982.947840-964587317', 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:40 INFO - Return code: 0 22:37:40 INFO - Running post-action listener: _resource_record_post_action 22:37:40 INFO - Running post-action listener: _start_resource_monitoring 22:37:40 INFO - Starting resource monitoring. 22:37:40 INFO - [mozharness: 2016-11-26 06:37:40.621583Z] Finished create-virtualenv step (success) 22:37:40 INFO - [mozharness: 2016-11-26 06:37:40.622065Z] Running install step. 22:37:40 INFO - Running pre-action listener: _resource_record_pre_action 22:37:40 INFO - Running main action method: install 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 - Detecting whether we're running mozinstall >=1.0... 22:37:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:37:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:37:40 INFO - Reading from file tmpfile_stdout 22:37:40 INFO - Output received: 22:37:40 INFO - Usage: mozinstall [options] installer 22:37:40 INFO - Options: 22:37:40 INFO - -h, --help show this help message and exit 22:37:40 INFO - -d DEST, --destination=DEST 22:37:40 INFO - Directory to install application into. [default: 22:37:40 INFO - "/builds/slave/test"] 22:37:40 INFO - --app=APP Application being installed. [default: firefox] 22:37:40 INFO - mkdir: /builds/slave/test/build/application 22:37:40 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:40 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.023268Z] Finished install step (success) 22:37:57 INFO - [mozharness: 2016-11-26 06:37:57.023509Z] 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 0x1ca4fc0>, '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 0x1ca5ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca6350>, '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', '--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-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 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 --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-019 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 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': '78329bfc0fd5309db0a6e0ac000001b4-1480141982.947840-964587317', 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', '--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-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 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:35291' 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 2195 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgzT_YQ/profile http://localhost:35291/getInfo.html) 22:38:01 INFO - PROCESS | 2195 | __metrics Screen width/height:1600/1200 22:38:01 INFO - PROCESS | 2195 | colorDepth:24 22:38:01 INFO - PROCESS | 2195 | Browser inner width/height: 1024/697 22:38:01 INFO - PROCESS | 2195 | __metrics 22:38:02 INFO - PROCESS | 2195 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:38:02 INFO - PROCESS | 2195 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:38:03 INFO - PROCESS | 2195 | console.error: PushService: 22:38:03 INFO - PROCESS | 2195 | stateChangeProcessEnqueue: Error transitioning state 22:38:03 INFO - PROCESS | 2195 | UnknownError 22:38:03 INFO - TEST-INFO | 2195: exit 0 22:38:03 INFO - Browser initialized. 22:38:03 INFO - Running cycle 1/1 for dromaeo_css test... 22:38:03 INFO - TEST-INFO | started process 2278 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgzT_YQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:38:16 INFO - PROCESS | 2278 | RSS: Main: 175644672 22:38:16 INFO - PROCESS | 2278 | 22:39:07 INFO - PROCESS | 2278 | 1480142347249 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:21 INFO - PROCESS | 2278 | Cycle 1(1): loaded http://localhost:35291/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35291/tests/dromaeo/cssquery-ext.html) 22:41:23 INFO - PROCESS | 2278 | RSS: Main: 298475520 22:41:23 INFO - PROCESS | 2278 | 22:44:25 INFO - PROCESS | 2278 | Cycle 1(1): loaded http://localhost:35291/tests/dromaeo/cssquery-ext.html (next: http://localhost:35291/tests/dromaeo/cssquery-jquery.html) 22:44:26 INFO - PROCESS | 2278 | RSS: Main: 288727040 22:44:26 INFO - PROCESS | 2278 | 22:47:28 INFO - PROCESS | 2278 | Cycle 1(1): loaded http://localhost:35291/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35291/tests/dromaeo/cssquery-mootools.html) 22:47:29 INFO - PROCESS | 2278 | RSS: Main: 257118208 22:47:29 INFO - PROCESS | 2278 | 22:50:31 INFO - PROCESS | 2278 | Cycle 1(1): loaded http://localhost:35291/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35291/tests/dromaeo/cssquery-prototype.html) 22:50:32 INFO - PROCESS | 2278 | RSS: Main: 241336320 22:50:32 INFO - PROCESS | 2278 | 22:53:35 INFO - PROCESS | 2278 | Cycle 1(1): loaded http://localhost:35291/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35291/tests/dromaeo/cssquery-yui.html) 22:53:36 INFO - PROCESS | 2278 | RSS: Main: 226922496 22:53:36 INFO - PROCESS | 2278 | 22:56:38 INFO - PROCESS | 2278 | Cycle 1(1): loaded http://localhost:35291/tests/dromaeo/cssquery-yui.html (next: http://localhost:35291/tests/dromaeo/cssquery-dojo.html) 22:56:39 INFO - PROCESS | 2278 | RSS: Main: 307965952 22:56:39 INFO - PROCESS | 2278 | 22:56:39 INFO - PROCESS | 2278 | __start_tp_report 22:56:39 INFO - PROCESS | 2278 | _x_x_mozilla_page_load 22:56:39 INFO - PROCESS | 2278 | _x_x_mozilla_page_load_details 22:56:39 INFO - PROCESS | 2278 | |i|pagename|runs| 22:56:39 INFO - PROCESS | 2278 | |0;dojo.html;2557.475717477917;2593.6887573491185;2607.217834649605;2624.6325514427986;2634.10440450247;4469.597736203741;4524.5701658342405;4630.166570017395;4635.327877457771;4639.396878405807;4591.288350305699;4593.655475839309;4605.194091034064;4655.394798676184;4671.416072990876;4151.481064866892;4177.394277829713;4211.05251318454;4286.742795432284;4372.8469503567385;4214.346776249671;4282.957170428303;4326.048269380747;4354.956450435503;4402.537733537981;4180;4237.32202847546;4329.242382583036;4372.5627437256335;4399.736015839044;4167.270727622684;4193.1404062167185;4231.407602935591;4268.9573104268875;4303.806328715215;4223.746575205498;4224.5353011168745;4231.280682284019;4232.3016702244095;4266.402703621496;4540.841070562547;4572.108438854425;4577.656675749332;4603.677742558022;4625.930611040803;4736.076465089309;4781.139394908915;4786.7845946932475;4826.686265392738;4883.02339532095;4880.853574392774;4939.604831613462;4939.876503087416;4962.776675049631;4977.377827771528;4553.612942899825;4556.134334476439;4557.977210113928;4593.632509399274;4652.651051171108;4833.4441539222735;4852.17513022787;4855.393075865517;5013.623978201649;5019.29729837823;4767.4517430495935;4812.1578723723205;4816.157172494799;4841.878953026203;4892.363992681;4888.535589119028;4888.608911287089;4890.926636100461;4899.730514821719;4949.554540091337;4722.220833562424;4846.055019271208;4862.149123903303;4900.681455705368;4902.460729319772;4709.128811169944;4823.1800593898415;4827.444843842933;4830.130576496194;4833.275008748716;4180.3102488089735;4196.664266858705;4199.2441360554785;4209.894752631209;4213.578642135762;3706.6108058653454;3733.0667333166707;3739.439084137401;3760.7179461539945;3761.9811900940867;4267.210566045292;4269.082147338338;4269.4449721536;4298.677599180011;4307.65538756905;4778.354922085474;4995.900081998339;4999.475055119233;5005.074061298671;5052.141136006888;4181.080162364275;4184.309588917856;4193.35003074524;4194.853180138742;4199.223143718361;4446.021875187454;4458.866234012985;4459.620932220732;4461.665375096881;4461.687681862303;4563.703359281636;4606.032733126014;4606.677532572822;4610.147122782296;4611.377464042312;4883.731394773322;4890.535399137077;4895.461499235153;4900.607951363811;4903.5586797188425;4579.175748365326;4599.425071866017;4603.608693261111;4604.309353596987;4609.124266389375;4818.734969576707;4851.078295123915;4894.535019173173;4907.950920490892;4970.8757281068265;4988.12707776145;4989.501049894981;4990.750462476789;4993.15116430215;5029.4216165140015;4859.562639362474;4860.465348811698;4862.294967229803;4868.586170175433;4894.19245824435;4631.4905360411;4705.55297246761;4736.905261894812;4767.523247675204;4893.0458560581765;4717.622590192845;4726.645501587326;4732.97633511844;4759.833405830779;4780.378550788375;4835.734034628129;4835.782389792397;4836.202026665702;4839.322494850653;4869.415670119608;4517.119161763556;4559.658025648156;4703.905921881612;4734.07685501324;4771.66598338113 22:56:39 INFO - PROCESS | 2278 | |1;ext.html;541.1828139509342;544.6024402186405;550.7576666266845;553.5599198637082;566.4562020460361;27316.45367092657;30347.089587312388;37097.81451092748;38370.42444363337;38438.807805961;38452.42321365182;38821.80589097051;38827;38878.61121388785;38888.80555597218;7455.366293865014;7590.620468976556;7604.315611594955;7613.162552119263;7617.619119044053;7380.704771809121;7587.317141457268;9608.951955240249;9841.852372214422;9844.803103937917;9941.701748947544;9980.20158387331;9990.350627209244;10003.499825008721;10059.748506287366;9773.07155820196;9826.06652368024;9839.47488139336;9840.557174927073;9905.851412228822;9702.805943881154;9763.023697630251;9782.706518804447;9790.1678357339;9798.90201097987;36977;37077.629223707954;37127.4430883537;37140.44289335662;37509.24981500382;3045.2082458560712;3092.922676933072;3115.7818952673324;3325.8004519728893;3533.0990597397754;27698.169054928385;28137;28298.858505707547;28845.42309153826;29592;3470.0804286864;3485.4771784232566;3522.452538543862;3584.2831433713363;3610.3681855675413;238366;238603.80698096572;239330;239420;239785;50496.747516262185;50813;50986;50990.74504627453;51040.234396484084;53673.731631341594;53710.73144634252;53790.46209537933;53795.46204537905;53871;14347.78478322826;14638.341274642667;14647.487337943121;14668.193249371174;14681.01806256163;9788.119069283655;10442.269041167197;10513.632022879163;10530.894691053145;10532.15742740579;13394.062415630813;15372.692546149237;15998.360065597246;16005;16012.67974640524;6111.5110791137495;6221.720022598994;6225.097360882737;6287.779927702509;6292.779752708633;778.4006315137312;913.6528119314618;943.9993606776839;959.640134949394;1001.2990906365428;26046.218613441626;27375.315617109332;27611.72388276132;27710.783137348964;27784.722152778617;941.6657086734248;966.8888077870994;975.40987702439;980.1423754215061;1052.3370276725766;14309.713805723828;14545;14633.268336583342;14661.85338146605;14663.71452967681;114984.42507787407;115122.42438787753;115186;115364;115842;41450.585494144674;42231.577684223375;46680.5331946683;48228.27657585139;48293.75853120712;1095.6439157273917;1119.3731510354228;1142.87999760024;1167.8481797366458;1179.3690375649157;26855.597166042917;27694.307642308297;28415.715842842135;28449.573256400756;29085;41266.79366603148;41954.79022604867;41990;42017.57982420137;42032.78983605062;313779;315367;315391;316072;316229;34083.82958085194;34524.13689657779;34653.653463465045;34829.825850871595;34855.12862178466;39472;39556.20887582174;40143.39784903287;40447.79776101218;40904.38643420291;34154;34889.12777180591;35061.29877402387;35087.122821928635;35569.28861422809;34617.480737789454;35185.296294073465;35321.47017794684;35511.82244088763;35542.64457355497;34951.30097397987;35046.12384690403;35297.29405411929;35460.46809297811;35857.82071089628;29262.561061583667;32057.51913721343;32098.67901320957;34230;34292.48561271533;23919.641205381584;24757;24792.628110577996;24804.255872323858;25034.62448063317 22:56:39 INFO - PROCESS | 2278 | |2;jquery.html;335.23231799179877;342.6350936252891;347.26380074242593;355.1937102776696;374.6534455628543;12377.443015064322;15508.294087650349;15703.685926281467;17026.74459883103;17167.227474763633;16384.590385240346;16443.8756636239;16658.750118748227;16769.91615041926;16820.747688784646;4847.1517484440255;5075.3909530856345;5158.8710282243055;5388.272583201277;5429.104197807357;3423.8801641942537;3570.553680789901;5439.809606663767;5482.451754824526;5483.8080667176655;5074.974625126869;5295.735213239342;5313.282706834586;5379.946200537984;5387.164989426626;5367.892642147155;5380.91928621071;5381.165919282478;5540.141278101901;5867.911981320283;5299.54953828925;5312.73436328182;5316.9734151329385;5337.733113344318;5345.251664766935;11847.466863991054;13537.45850166002;19571.315003974934;19730.30943916956;19730.309439169705;1807.8734488585803;1837.9081045947648;1911.3310341380545;2070.440980935154;2299.5056062946546;8977.910220897773;9225.12361325673;9351.859722104175;11790;12431.191972521758;1636.6317578544852;1664.5588918936492;1691.501007202878;1731.5151757507917;1789.105447276362;65337.85270062195;65484.345156548305;66326;67304;67950;9439.24486041115;9554.14012738843;9730.513474326255;9751.463669498246;10045.949770251102;13317.667058323426;13323.533676321282;13332;13346.399412026482;13360.93319533396;6502.804915852532;6654.76886775948;6739.730410783513;6759.053732477457;6918;6181.690915454209;6251.156093927261;6295.181626388632;6372.84067898297;6385.48916086712;4030.899227519277;4057.33054046085;4182.393552934807;4289.378040184156;4301.182775272689;1732.8786984911187;1736.2360561352964;1769.5929936114508;1796.7304904264204;1800.9009504477117;772.6252767407802;820.7004443378124;846.7764080903036;906.1436942089794;906.2704522859161;15765.763513547307;15988.440404585785;16313.265903034391;16703;16792;817.7751118442357;830.5862903466747;849.0321034021221;863.5336918064176;908.927285817133;8912.485356065652;8966.282697384193;9392.95303523478;9406.341556091145;9510.619575217052;129008;129169;129230.35384823015;129595;130424;51223;68489;73482.74039276667;75006;76824;874.4796845876693;877.6006916852945;911.832853946949;914.9634014639473;917.40368760305;10315.638952636622;13067.738645227233;13229;13645.658858528615;13647.11293765902;34566.30867382588;35412.82293588515;35599.64400356067;35960.64039359573;36579.63420365869;47176.528234718586;47296.29055564238;47362.763186183845;47563.52436475591;47637;7286.271372862883;7318.3047610476915;7347.889781653386;7376.520526165782;7835.608219589112;8037.839243214986;10610.734731631463;10767.192460565333;11084.501197446296;11802.350870702194;8468.602680557638;10256.282060255711;10310;10452.790944181226;10842.783144337227;10298.433586152834;10457.320274182459;10565.418901960158;10590.470476475992;10601.098906593026;10407.271490995558;10465.267431279737;10643.308184967953;10671.679849604525;11130.220884538005;7522.849543009;7632.692804483101;7813.960930195312;7830.373570114263;7946.284834364935;8024.679012839654;9306.441613503212;10296.227782916461;10366.170706343626;10438.11276041545 22:56:39 INFO - PROCESS | 2278 | |3;mootools.html;1316.5721140629296;1359.2116572388015;1405.7188562287538;1594.6651203247318;1615.095546493964;6021.126936594192;6216.627002379861;6594.769183078587;7044.682989265482;7053;6340.4927605791545;6545.672716364186;6545.869082618345;6707.295733947938;6715.731370745164;2011.1653663729571;2044.5297581556251;2045.1921491011042;2045.4886278430392;2046.2122082998078;1678.0938293321592;1734.3322820714052;1986.1856638778104;2027.4525878012928;2036.541778099923;1967.301607929186;2041.1121162294448;2042.1831267492973;2057.567910738739;2060.0420804325986;2022.3427386099577;2024.0486971123548;2039.0926037913134;2042.4689580708973;2048.9590208195755;2022.5550378916614;2033.298512013353;2033.6237796007786;2036.3076553971573;2042.8365730741655;6755.324467553254;6809.250982391933;6814.965925170342;6818.318168183192;6820;4065.308897487434;4165.166966606691;4181.351890456984;4185.414042034117;4187.979060104711;2516.886740096682;2759.434315965222;2760.2823265950797;2766.8616569171663;2767.1560174146875;817.4808996287401;871.9825603487894;895.7447127568677;899.7660608241839;908.318760929303;9066.818663626756;9071.501067441288;9103.954480227623;9155;9158.084191580856;3549.8047607381327;3768.2840260350995;3836.0985168485386;3862.208247309295;3949.3878448840474;7915.406344524184;7927.722529711433;7927.722529711547;7928;7945.523268603903;4260.936085958713;4283.571642835754;4287.09970906107;4325.52419233884;4332.415123958288;3726.4224045273027;3924.823382947774;3942.250972315251;3945.861894833667;3949.624785645359;3146.7797254191987;3187.9362412751616;3226.951595726066;3308.801471911693;3353.3293341331832;987.6740675577042;1017.99491002546;1123.775244951013;1126.1272513801869;1145.9025982791388;588.5350573047244;607.1408956326749;633.439406125573;690.9566554502636;714.9571025738472;4337.8264869404875;4537.500874903758;4586.610138138229;4594.379758732595;4658.790354434059;430.9396684464177;433.15318552230315;448.4148186616497;458.41552021172606;581.9214406055213;3249.77251592391;3281.52417899408;3314.419976504102;3323.3353329333745;3432.1934345428804;7888.881666775003;8374.162583741578;8380.58097095155;8384.706535271236;8394.370422218359;8313;8345.707900223462;8353.749387518385;8359.164083591713;8359.8328033439;6392.552521323462;6512.05575191604;6589.670516474253;6598.802035938929;6603.372679595431;4554.271316589462;4582.495925448131;4614.077184563033;4703.647226458098;4764.118638051833;7384.37232835215;7470.4023678106705;7560.508566943131;7603;7660.80847978805;7592.278733520307;7625.542467451971;7667.884981725167;7672.501287416523;7714.1128770192145;5746.827595172152;5866.3547009828035;5867.589268751147;5877.823665290048;5879.088741245114;6335.841603959938;6397.392247736458;6405.7117429714845;6410.294867564471;6411.5832470889245;5853.1220316952795;5889.882202356014;5945.672987985702;5958.076498142795;6032.90950635732;5766.365699772938;5838.805970149254;5885.970570147122;5903.498202652822;5957.553183511167;5302.761375738024;5403.405625381126;5416.729163541886;5417.702026388429;5424.430434804289;4038.939415908705;4062.8374865005067;4076.9592304076577;4119.196756632428;4200.894977625461;4026.6979976501293;4060.1067765091634;4089.079957009649;4130.215259100762;4223.9017855357215 22:56:39 INFO - PROCESS | 2278 | |4;prototype.html;289.4226019091912;293.59777105365646;297.2924439833197;299.1176030709408;302.455579956079;4669.7198168109935;4717.245240761479;4836.371271734678;4840.6369522285795;4873.22028475444;4635.860924172272;4670.206064968955;4711.740854253015;4745.430548334196;4749.4775574686755;3765.6610905018542;3769.09541709989;3771.3400154972906;3776.584575696671;3782.2624588205313;3751.3247615429214;3780.6786423154067;3782.4326351047425;3797.2974999625158;3801.3537698591167;3413.822231330187;3565.4830049642787;3669.981650091746;3740.8129593520353;3748.9502939177073;3744.850205991757;3753.428901202671;3755.455458958463;3755.7746535207975;3763.604821493731;3347.129746265988;3353.3293341331832;3355.8154301513405;3360.7647464677484;3369.7135743461836;4511.2406161597;4692.906141877177;4693.7653117344;4700.5064468230685;4703.2474804031535;4291.35629655551;4294.592013758688;4295.312749959991;4301.74189548625;4310.935335969963;4988.800447982077;5000.799968001275;5004.949950500485;5010.248462730583;5017.247412888059;3649.160693040589;3652.6712595866234;3660.359437098524;3660.5058317127114;3666.4866918631415;5006.874828129289;5169.810943482982;5189.896202075937;5190.948090519122;5196.142636465017;3714.9628503715157;3726.8136593170234;3728.2357116790995;3734.234481931252;3741.073347226181;3755.117547376364;3776.9244615108096;3786.6024067473068;3790.677792387678;3793.981030094887;4155.480564929384;4227.788610569459;4276.615104640598;4297.9369902447;4298.720583162084;4952.4057113146655;4953.281774142729;4969.552740253394;4975.303457515951;4975.701457912464;1218.3542722357165;1220.2434490615874;1233.7409144079663;1262.5959692898184;1281.2824818101706;869.2090197919863;880.1858281089966;890.4123278636199;890.808476177612;892.8437673213205;4169.749815011109;4170.937435938464;4197.4753155855515;4232.936505952413;4242.4272723181975;4902.90194196114;4903.215485522299;4903.436104847917;4929;4978.178600530872;4167.708260421741;4172.7079104463;4211.557786432441;4217.8787697104535;4229.91540169201;2548.2737419835257;2635.420207554335;2713.077553631735;2714.83710977342;2726.922865468129;4676.462206846189;4716.551927566876;4727.83452579165;4781.426228852491;4787.832425865078;5120.231965205175;5133.460986596354;5134.2298655201275;5175.689458632494;5188.9740551297;4490.595846373842;4692.3576748137875;4702.1536123496735;4711.74085425298;4736.242201247784;4994.350734404504;5002.574781143643;5040.2198351236575;5040.974795126001;5064;4927.310176575354;4964.652474326763;4966.627502937366;4978.4025916890205;5001.799928002984;4483.730976141442;4664.183767840682;4696.600788932979;4702.52974702527;4712.481627021093;3482.373172828814;3502.772319799205;3521.207728261223;3530.011596752913;3532.64673532655;4945.901081978413;4966.013594562204;4999.550040496373;5030.245463180552;5036.287662194872;4874.805007799649;4954.702717836942;4991.775370108281;5008.549230569266;5016.398032236155;4992.800287988585;4994.700317980933;4996.950030499794;4998.375203099613;5029.1953287473825;4814.301926220608;4904.362432883702;4934.235193545006;4955.603551715926;4964.801407943642;5019.297298378157;5026.296318515484;5045.612456574471;5047.091523525801;5048.318477005557;4880.6095512358215;4889.755512224446;4912.361393018885;4923.286123512143;4928.137575924127 22:56:39 INFO - PROCESS | 2278 | |5;yui.html;601.8856417280716;650.8080116365671;683.4668958212594;686.1971493352777;691.7475121580621;11016.339019658815;11445.256058356212;12178.08664350175;12264.386780660954;12361.443735031922;11102.944485277561;11225.32648041116;11269.718257043578;11295.152863535248;11466.025387842023;742.191011797141;763.1071646173962;763.6945221911252;763.7746864674906;764.6520833020962;614.7356636646263;632.8006677896448;734.2180577684749;762;762.1996903251592;796.0566728426804;798.1340245833278;799.8080460689422;800.2837460472873;800.7998000499875;795.6300320351036;797.3302425962162;797.4457751862458;797.6410615223115;797.9601019949008;474.04716519795113;482.2332491338788;563.4140493886354;582.4990508162977;583.7314835175824;11972.461239244254;11981.161318707695;12013.038956883429;12039.759204815942;12046.397680116046;11034.944825275823;11150.776984460266;11280.32318060919;11321.830172547336;11597.304161750237;10244.385336879812;10316.432596207205;10360.48197590125;10445.895541044569;10466.738331541696;3764.190698999701;3764.623537646241;3773.415120656275;3779.811009449544;3829.17672700368;47675;47825.282620760714;48085.51914480845;48810;51006.7449662753;9044;9212.170904618482;9257.90742092584;9284;9349.205317548085;16958.152092395576;17008.149592520323;17033.063181525136;17047.573810654583;17315.91342043282;6026;6112.786052488142;6119.571629985859;6350.428461438492;6375.936240637627;3557.8932632021083;3558.0749005258303;3575.213453040327;3583.0146709655055;3644.9635503645154;2494.9376265593505;2560.641510188575;2579.948401031969;2581.2127301172945;2581.5611346071214;432.275937804183;433.1467009990314;442.0628268071644;442.3409120410565;443.16463466366133;429.27452605097284;511.1719015195333;532.0795024607373;545.1876703711441;546.1698218707543;6718.93281067183;6776.288489708608;6938.6138613861385;7333.97324374588;7496.287852653989;517.5807595847376;520.3131865936926;526.9262303277544;537.4341245833842;546.9261649677322;3346.9330613387597;3540.592831824373;3564;3619.4208926571623;3714.888553343404;67092;67539.3246067533;69100.30899691039;69219.65390173017;69246.65376673185;60852;63110.68444657747;63491.36508634947;63698.36301637017;63765;45998.5400146001;48578.999999999294;50811;53951.730241348545;56594.15108773372;6657.667116644052;6679.628731800141;6999.965000174967;7940.285374316109;8777.736667899973;33910.15224619404;35462.82268588641;35587;35889.46165807567;38778.6122138775;32022.6797732029;33597.66402335945;34262.31475370429;49249.753751231015;50807.74596126996;8284.46151000183;8285.792855178428;8318;8387.790305242417;8845.027047024694;9084.591193396445;9357.812843742951;9456.527173641429;9460.195883349717;9550.665726699532;8796.648134074565;8838.867416988878;8929.73210803677;9049.502277374808;9192.402493837879;9093.545322733704;9176.128267814547;9277.1650551448;9465.100815422524;9470.384425012353;8743.38796284254;8861.424007439497;8911.187062187926;8995.190432861074;9174.26605871542;7392.186859445349;7524.811879703051;7527.585982771;7569.772906812805;7903.407244456804;7438.73964411243;7563.432742544442;7715.614219289126;7846.0976987647155;8029.919700802917 22:56:39 INFO - PROCESS | 2278 | __end_tp_report 22:56:39 INFO - PROCESS | 2278 | __start_cc_report 22:56:39 INFO - PROCESS | 2278 | _x_x_mozilla_cycle_collect,1238 22:56:39 INFO - PROCESS | 2278 | __end_cc_report 22:56:39 INFO - PROCESS | 2278 | __startTimestamp1480143399249__endTimestamp 22:56:39 INFO - PROCESS | 2278 | 22:56:39 INFO - PROCESS | 2278 | ------- Summary: start ------- 22:56:39 INFO - PROCESS | 2278 | Number of tests: 6 22:56:39 INFO - PROCESS | 2278 | 22:56:39 INFO - PROCESS | 2278 | [#0] dojo.html Cycles:165 Average:4545.99 Median:4631.49 stddev:457.55 (9.9%) stddev-sans-first:431.55 22:56:39 INFO - PROCESS | 2278 | Values: 2557.5 2593.7 2607.2 2624.6 2634.1 4469.6 4524.6 4630.2 4635.3 4639.4 4591.3 4593.7 4605.2 4655.4 4671.4 4151.5 4177.4 4211.1 4286.7 4372.8 4214.3 4283.0 4326.0 4355.0 4402.5 4180.0 4237.3 4329.2 4372.6 4399.7 4167.3 4193.1 4231.4 4269.0 4303.8 4223.7 4224.5 4231.3 4232.3 4266.4 4540.8 4572.1 4577.7 4603.7 4625.9 4736.1 4781.1 4786.8 4826.7 4883.0 4880.9 4939.6 4939.9 4962.8 4977.4 4553.6 4556.1 4558.0 4593.6 4652.7 4833.4 4852.2 4855.4 5013.6 5019.3 4767.5 4812.2 4816.2 4841.9 4892.4 4888.5 4888.6 4890.9 4899.7 4949.6 4722.2 4846.1 4862.1 4900.7 4902.5 4709.1 4823.2 4827.4 4830.1 4833.3 4180.3 4196.7 4199.2 4209.9 4213.6 3706.6 3733.1 3739.4 3760.7 3762.0 4267.2 4269.1 4269.4 4298.7 4307.7 4778.4 4995.9 4999.5 5005.1 5052.1 4181.1 4184.3 4193.4 4194.9 4199.2 4446.0 4458.9 4459.6 4461.7 4461.7 4563.7 4606.0 4606.7 4610.1 4611.4 4883.7 4890.5 4895.5 4900.6 4903.6 4579.2 4599.4 4603.6 4604.3 4609.1 4818.7 4851.1 4894.5 4908.0 4970.9 4988.1 4989.5 4990.8 4993.2 5029.4 4859.6 4860.5 4862.3 4868.6 4894.2 4631.5 4705.6 4736.9 4767.5 4893.0 4717.6 4726.6 4733.0 4759.8 4780.4 4835.7 4835.8 4836.2 4839.3 4869.4 4517.1 4559.7 4703.9 4734.1 4771.7 22:56:39 INFO - PROCESS | 2278 | 22:56:39 INFO - PROCESS | 2278 | [#1] ext.html Cycles:180 Average:39181.83 Median:35309.38 stddev:62495.89 (177.0%) stddev-sans-first:62603.86 22:56:39 INFO - PROCESS | 2278 | Values: 541.2 544.6 550.8 553.6 566.5 27316.5 30347.1 37097.8 38370.4 38438.8 38452.4 38821.8 38827.0 38878.6 38888.8 7455.4 7590.6 7604.3 7613.2 7617.6 7380.7 7587.3 9609.0 9841.9 9844.8 9941.7 9980.2 9990.4 10003.5 10059.7 9773.1 9826.1 9839.5 9840.6 9905.9 9702.8 9763.0 9782.7 9790.2 9798.9 36977.0 37077.6 37127.4 37140.4 37509.2 3045.2 3092.9 3115.8 3325.8 3533.1 27698.2 28137.0 28298.9 28845.4 29592.0 3470.1 3485.5 3522.5 3584.3 3610.4 238366.0 238603.8 239330.0 239420.0 239785.0 50496.7 50813.0 50986.0 50990.7 51040.2 53673.7 53710.7 53790.5 53795.5 53871.0 14347.8 14638.3 14647.5 14668.2 14681.0 9788.1 10442.3 10513.6 10530.9 10532.2 13394.1 15372.7 15998.4 16005.0 16012.7 6111.5 6221.7 6225.1 6287.8 6292.8 778.4 913.7 944.0 959.6 1001.3 26046.2 27375.3 27611.7 27710.8 27784.7 941.7 966.9 975.4 980.1 1052.3 14309.7 14545.0 14633.3 14661.9 14663.7 114984.4 115122.4 115186.0 115364.0 115842.0 41450.6 42231.6 46680.5 48228.3 48293.8 1095.6 1119.4 1142.9 1167.8 1179.4 26855.6 27694.3 28415.7 28449.6 29085.0 41266.8 41954.8 41990.0 42017.6 42032.8 313779.0 315367.0 315391.0 316072.0 316229.0 34083.8 34524.1 34653.7 34829.8 34855.1 39472.0 39556.2 40143.4 40447.8 40904.4 34154.0 34889.1 35061.3 35087.1 35569.3 34617.5 35185.3 35321.5 35511.8 35542.6 34951.3 35046.1 35297.3 35460.5 35857.8 29262.6 32057.5 32098.7 34230.0 34292.5 23919.6 24757.0 24792.6 24804.3 25034.6 22:56:39 INFO - PROCESS | 2278 | 22:56:39 INFO - PROCESS | 2278 | [#2] jquery.html Cycles:180 Average:16303.33 Median:25738.86 stddev:25124.46 (97.6%) stddev-sans-first:25166.33 22:56:39 INFO - PROCESS | 2278 | Values: 335.2 342.6 347.3 355.2 374.7 12377.4 15508.3 15703.7 17026.7 17167.2 16384.6 16443.9 16658.8 16769.9 16820.7 4847.2 5075.4 5158.9 5388.3 5429.1 3423.9 3570.6 5439.8 5482.5 5483.8 5075.0 5295.7 5313.3 5379.9 5387.2 5367.9 5380.9 5381.2 5540.1 5867.9 5299.5 5312.7 5317.0 5337.7 5345.3 11847.5 13537.5 19571.3 19730.3 19730.3 1807.9 1837.9 1911.3 2070.4 2299.5 8977.9 9225.1 9351.9 11790.0 12431.2 1636.6 1664.6 1691.5 1731.5 1789.1 65337.9 65484.3 66326.0 67304.0 67950.0 9439.2 9554.1 9730.5 9751.5 10045.9 13317.7 13323.5 13332.0 13346.4 13360.9 6502.8 6654.8 6739.7 6759.1 6918.0 6181.7 6251.2 6295.2 6372.8 6385.5 4030.9 4057.3 4182.4 4289.4 4301.2 1732.9 1736.2 1769.6 1796.7 1800.9 772.6 820.7 846.8 906.1 906.3 15765.8 15988.4 16313.3 16703.0 16792.0 817.8 830.6 849.0 863.5 908.9 8912.5 8966.3 9393.0 9406.3 9510.6 129008.0 129169.0 129230.4 129595.0 130424.0 51223.0 68489.0 73482.7 75006.0 76824.0 874.5 877.6 911.8 915.0 917.4 10315.6 13067.7 13229.0 13645.7 13647.1 34566.3 35412.8 35599.6 35960.6 36579.6 47176.5 47296.3 47362.8 47563.5 47637.0 7286.3 7318.3 7347.9 7376.5 7835.6 8037.8 10610.7 10767.2 11084.5 11802.4 8468.6 10256.3 10310.0 10452.8 10842.8 10298.4 10457.3 10565.4 10590.5 10601.1 10407.3 10465.3 10643.3 10671.7 11130.2 7522.8 7632.7 7814.0 7830.4 7946.3 8024.7 9306.4 10296.2 10366.2 10438.1 22:56:39 INFO - PROCESS | 2278 | 22:56:39 INFO - PROCESS | 2278 | [#3] mootools.html Cycles:180 Average:4505.17 Median:4681.22 stddev:2443.16 (52.2%) stddev-sans-first:2438.26 22:56:39 INFO - PROCESS | 2278 | Values: 1316.6 1359.2 1405.7 1594.7 1615.1 6021.1 6216.6 6594.8 7044.7 7053.0 6340.5 6545.7 6545.9 6707.3 6715.7 2011.2 2044.5 2045.2 2045.5 2046.2 1678.1 1734.3 1986.2 2027.5 2036.5 1967.3 2041.1 2042.2 2057.6 2060.0 2022.3 2024.0 2039.1 2042.5 2049.0 2022.6 2033.3 2033.6 2036.3 2042.8 6755.3 6809.3 6815.0 6818.3 6820.0 4065.3 4165.2 4181.4 4185.4 4188.0 2516.9 2759.4 2760.3 2766.9 2767.2 817.5 872.0 895.7 899.8 908.3 9066.8 9071.5 9104.0 9155.0 9158.1 3549.8 3768.3 3836.1 3862.2 3949.4 7915.4 7927.7 7927.7 7928.0 7945.5 4260.9 4283.6 4287.1 4325.5 4332.4 3726.4 3924.8 3942.3 3945.9 3949.6 3146.8 3187.9 3227.0 3308.8 3353.3 987.7 1018.0 1123.8 1126.1 1145.9 588.5 607.1 633.4 691.0 715.0 4337.8 4537.5 4586.6 4594.4 4658.8 430.9 433.2 448.4 458.4 581.9 3249.8 3281.5 3314.4 3323.3 3432.2 7888.9 8374.2 8380.6 8384.7 8394.4 8313.0 8345.7 8353.7 8359.2 8359.8 6392.6 6512.1 6589.7 6598.8 6603.4 4554.3 4582.5 4614.1 4703.6 4764.1 7384.4 7470.4 7560.5 7603.0 7660.8 7592.3 7625.5 7667.9 7672.5 7714.1 5746.8 5866.4 5867.6 5877.8 5879.1 6335.8 6397.4 6405.7 6410.3 6411.6 5853.1 5889.9 5945.7 5958.1 6032.9 5766.4 5838.8 5886.0 5903.5 5957.6 5302.8 5403.4 5416.7 5417.7 5424.4 4038.9 4062.8 4077.0 4119.2 4200.9 4026.7 4060.1 4089.1 4130.2 4223.9 22:56:39 INFO - PROCESS | 2278 | 22:56:39 INFO - PROCESS | 2278 | [#4] prototype.html Cycles:180 Average:4117.91 Median:4695.18 stddev:1180.12 (25.1%) stddev-sans-first:1147.91 22:56:39 INFO - PROCESS | 2278 | Values: 289.4 293.6 297.3 299.1 302.5 4669.7 4717.2 4836.4 4840.6 4873.2 4635.9 4670.2 4711.7 4745.4 4749.5 3765.7 3769.1 3771.3 3776.6 3782.3 3751.3 3780.7 3782.4 3797.3 3801.4 3413.8 3565.5 3670.0 3740.8 3749.0 3744.9 3753.4 3755.5 3755.8 3763.6 3347.1 3353.3 3355.8 3360.8 3369.7 4511.2 4692.9 4693.8 4700.5 4703.2 4291.4 4294.6 4295.3 4301.7 4310.9 4988.8 5000.8 5004.9 5010.2 5017.2 3649.2 3652.7 3660.4 3660.5 3666.5 5006.9 5169.8 5189.9 5190.9 5196.1 3715.0 3726.8 3728.2 3734.2 3741.1 3755.1 3776.9 3786.6 3790.7 3794.0 4155.5 4227.8 4276.6 4297.9 4298.7 4952.4 4953.3 4969.6 4975.3 4975.7 1218.4 1220.2 1233.7 1262.6 1281.3 869.2 880.2 890.4 890.8 892.8 4169.7 4170.9 4197.5 4232.9 4242.4 4902.9 4903.2 4903.4 4929.0 4978.2 4167.7 4172.7 4211.6 4217.9 4229.9 2548.3 2635.4 2713.1 2714.8 2726.9 4676.5 4716.6 4727.8 4781.4 4787.8 5120.2 5133.5 5134.2 5175.7 5189.0 4490.6 4692.4 4702.2 4711.7 4736.2 4994.4 5002.6 5040.2 5041.0 5064.0 4927.3 4964.7 4966.6 4978.4 5001.8 4483.7 4664.2 4696.6 4702.5 4712.5 3482.4 3502.8 3521.2 3530.0 3532.6 4945.9 4966.0 4999.6 5030.2 5036.3 4874.8 4954.7 4991.8 5008.5 5016.4 4992.8 4994.7 4997.0 4998.4 5029.2 4814.3 4904.4 4934.2 4955.6 4964.8 5019.3 5026.3 5045.6 5047.1 5048.3 4880.6 4889.8 4912.4 4923.3 4928.1 22:56:39 INFO - PROCESS | 2278 | 22:56:39 INFO - PROCESS | 2278 | [#5] yui.html Cycles:180 Average:13624.19 Median:3313.94 stddev:18060.12 (545.0%) stddev-sans-first:18084.31 22:56:39 INFO - PROCESS | 2278 | Values: 601.9 650.8 683.5 686.2 691.7 11016.3 11445.3 12178.1 12264.4 12361.4 11102.9 11225.3 11269.7 11295.2 11466.0 742.2 763.1 763.7 763.8 764.7 614.7 632.8 734.2 762.0 762.2 796.1 798.1 799.8 800.3 800.8 795.6 797.3 797.4 797.6 798.0 474.0 482.2 563.4 582.5 583.7 11972.5 11981.2 12013.0 12039.8 12046.4 11034.9 11150.8 11280.3 11321.8 11597.3 10244.4 10316.4 10360.5 10445.9 10466.7 3764.2 3764.6 3773.4 3779.8 3829.2 47675.0 47825.3 48085.5 48810.0 51006.7 9044.0 9212.2 9257.9 9284.0 9349.2 16958.2 17008.1 17033.1 17047.6 17315.9 6026.0 6112.8 6119.6 6350.4 6375.9 3557.9 3558.1 3575.2 3583.0 3645.0 2494.9 2560.6 2579.9 2581.2 2581.6 432.3 433.1 442.1 442.3 443.2 429.3 511.2 532.1 545.2 546.2 6718.9 6776.3 6938.6 7334.0 7496.3 517.6 520.3 526.9 537.4 546.9 3346.9 3540.6 3564.0 3619.4 3714.9 67092.0 67539.3 69100.3 69219.7 69246.7 60852.0 63110.7 63491.4 63698.4 63765.0 45998.5 48579.0 50811.0 53951.7 56594.2 6657.7 6679.6 7000.0 7940.3 8777.7 33910.2 35462.8 35587.0 35889.5 38778.6 32022.7 33597.7 34262.3 49249.8 50807.7 8284.5 8285.8 8318.0 8387.8 8845.0 9084.6 9357.8 9456.5 9460.2 9550.7 8796.6 8838.9 8929.7 9049.5 9192.4 9093.5 9176.1 9277.2 9465.1 9470.4 8743.4 8861.4 8911.2 8995.2 9174.3 7392.2 7524.8 7527.6 7569.8 7903.4 7438.7 7563.4 7715.6 7846.1 8029.9 22:56:39 INFO - PROCESS | 2278 | -------- Summary: end -------- 22:56:39 INFO - PROCESS | 2278 | 22:56:40 INFO - TEST-INFO | 2278: exit 0 22:56:40 INFO - TEST-OK | dromaeo_css | took 1122979ms 22:56:40 INFO - TEST-START | kraken 22:56:40 INFO - operating with platform_type : linux_ 22:56:40 INFO - Initialising browser for kraken test... 22:56:40 INFO - TEST-INFO | started process 2669 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNziKXI/profile http://localhost:35291/getInfo.html) 22:56:44 INFO - PROCESS | 2669 | __metrics Screen width/height:1600/1200 22:56:44 INFO - PROCESS | 2669 | colorDepth:24 22:56:44 INFO - PROCESS | 2669 | Browser inner width/height: 1024/697 22:56:44 INFO - PROCESS | 2669 | __metrics 22:56:45 INFO - PROCESS | 2669 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:56:45 INFO - PROCESS | 2669 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:56:46 INFO - PROCESS | 2669 | console.error: PushService: 22:56:46 INFO - PROCESS | 2669 | stateChangeProcessEnqueue: Error transitioning state 22:56:46 INFO - PROCESS | 2669 | UnknownError 22:56:47 INFO - TEST-INFO | 2669: exit 0 22:56:47 INFO - Browser initialized. 22:56:47 INFO - Running cycle 1/1 for kraken test... 22:56:47 INFO - TEST-INFO | started process 2780 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNziKXI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:56:59 INFO - PROCESS | 2780 | RSS: Main: 174493696 22:56:59 INFO - PROCESS | 2780 | 22:57:02 INFO - PROCESS | 2780 | Cycle 1(1): loaded http://localhost:35291/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35291/tests/kraken/driver.html?testName=audio-beat-detection) 22:57:03 INFO - PROCESS | 2780 | RSS: Main: 235212800 22:57:03 INFO - PROCESS | 2780 | 22:57:05 INFO - PROCESS | 2780 | Cycle 1(1): loaded http://localhost:35291/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35291/tests/kraken/driver.html?testName=audio-dft) 22:57:06 INFO - PROCESS | 2780 | RSS: Main: 218263552 22:57:06 INFO - PROCESS | 2780 | 22:57:09 INFO - PROCESS | 2780 | Cycle 1(1): loaded http://localhost:35291/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35291/tests/kraken/driver.html?testName=audio-fft) 22:57:10 INFO - PROCESS | 2780 | RSS: Main: 299810816 22:57:10 INFO - PROCESS | 2780 | 22:57:12 INFO - PROCESS | 2780 | Cycle 1(1): loaded http://localhost:35291/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35291/tests/kraken/driver.html?testName=audio-oscillator) 22:57:12 INFO - PROCESS | 2780 | RSS: Main: 211677184 22:57:12 INFO - PROCESS | 2780 | 22:57:15 INFO - PROCESS | 2780 | Cycle 1(1): loaded http://localhost:35291/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35291/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:57:15 INFO - PROCESS | 2780 | RSS: Main: 214839296 22:57:15 INFO - PROCESS | 2780 | 22:57:18 INFO - PROCESS | 2780 | Cycle 1(1): loaded http://localhost:35291/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35291/tests/kraken/driver.html?testName=imaging-darkroom) 22:57:19 INFO - PROCESS | 2780 | RSS: Main: 254013440 22:57:19 INFO - PROCESS | 2780 | 22:57:23 INFO - PROCESS | 2780 | Cycle 1(1): loaded http://localhost:35291/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35291/tests/kraken/driver.html?testName=imaging-desaturate) 22:57:23 INFO - PROCESS | 2780 | RSS: Main: 253947904 22:57:23 INFO - PROCESS | 2780 | 22:57:26 INFO - PROCESS | 2780 | Cycle 1(1): loaded http://localhost:35291/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35291/tests/kraken/driver.html?testName=json-parse-financial) 22:57:27 INFO - PROCESS | 2780 | RSS: Main: 251879424 22:57:27 INFO - PROCESS | 2780 | 22:57:28 INFO - PROCESS | 2780 | Cycle 1(1): loaded http://localhost:35291/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35291/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:57:29 INFO - PROCESS | 2780 | RSS: Main: 214188032 22:57:29 INFO - PROCESS | 2780 | 22:57:31 INFO - PROCESS | 2780 | Cycle 1(1): loaded http://localhost:35291/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35291/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:57:32 INFO - PROCESS | 2780 | RSS: Main: 221634560 22:57:32 INFO - PROCESS | 2780 | 22:57:34 INFO - PROCESS | 2780 | Cycle 1(1): loaded http://localhost:35291/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35291/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:57:34 INFO - PROCESS | 2780 | RSS: Main: 230014976 22:57:34 INFO - PROCESS | 2780 | 22:57:37 INFO - PROCESS | 2780 | Cycle 1(1): loaded http://localhost:35291/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35291/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:57:38 INFO - PROCESS | 2780 | RSS: Main: 239603712 22:57:38 INFO - PROCESS | 2780 | 22:57:41 INFO - PROCESS | 2780 | Cycle 1(1): loaded http://localhost:35291/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35291/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:57:42 INFO - PROCESS | 2780 | RSS: Main: 236257280 22:57:42 INFO - PROCESS | 2780 | 22:57:44 INFO - PROCESS | 2780 | Cycle 1(1): loaded http://localhost:35291/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35291/tests/kraken/driver.html?testName=ai-astar) 22:57:44 INFO - PROCESS | 2780 | RSS: Main: 286752768 22:57:44 INFO - PROCESS | 2780 | 22:57:44 INFO - PROCESS | 2780 | __start_tp_report 22:57:44 INFO - PROCESS | 2780 | _x_x_mozilla_page_load 22:57:44 INFO - PROCESS | 2780 | _x_x_mozilla_page_load_details 22:57:44 INFO - PROCESS | 2780 | |i|pagename|runs| 22:57:44 INFO - PROCESS | 2780 | |0;ai-astar;108;116;115;117;115;119;115;116;117;115 22:57:44 INFO - PROCESS | 2780 | |1;audio-beat-detection;157;127;132;185;129;129;132;134;153;133 22:57:44 INFO - PROCESS | 2780 | |2;audio-dft;161;161;162;161;161;161;162;162;161;162 22:57:44 INFO - PROCESS | 2780 | |3;audio-fft;76;78;77;110;77;78;77;76;103;76 22:57:44 INFO - PROCESS | 2780 | |4;audio-oscillator;83;83;107;84;84;83;109;83;83;107 22:57:44 INFO - PROCESS | 2780 | |5;imaging-gaussian-blur;119;118;118;118;118;118;118;118;118;117 22:57:44 INFO - PROCESS | 2780 | |6;imaging-darkroom;148;147;147;147;147;148;147;147;148;148 22:57:44 INFO - PROCESS | 2780 | |7;imaging-desaturate;95;96;96;96;96;96;96;96;96;96 22:57:44 INFO - PROCESS | 2780 | |8;json-parse-financial;65;65;73;64;75;67;66;67;66;66 22:57:44 INFO - PROCESS | 2780 | |9;json-stringify-tinderbox;66;66;66;66;66;65;66;66;70;66 22:57:44 INFO - PROCESS | 2780 | |10;stanford-crypto-aes;84;85;84;84;86;85;85;84;86;84 22:57:44 INFO - PROCESS | 2780 | |11;stanford-crypto-ccm;149;160;154;141;159;141;141;144;196;153 22:57:44 INFO - PROCESS | 2780 | |12;stanford-crypto-pbkdf2;178;176;181;181;175;178;181;181;175;178 22:57:44 INFO - PROCESS | 2780 | |13;stanford-crypto-sha256-iterative;67;68;71;69;68;68;68;72;72;72 22:57:44 INFO - PROCESS | 2780 | __end_tp_report 22:57:44 INFO - PROCESS | 2780 | __start_cc_report 22:57:44 INFO - PROCESS | 2780 | _x_x_mozilla_cycle_collect,1960 22:57:44 INFO - PROCESS | 2780 | __end_cc_report 22:57:44 INFO - PROCESS | 2780 | __startTimestamp1480143464273__endTimestamp 22:57:44 INFO - PROCESS | 2780 | 22:57:44 INFO - PROCESS | 2780 | ------- Summary: start ------- 22:57:44 INFO - PROCESS | 2780 | Number of tests: 14 22:57:44 INFO - PROCESS | 2780 | 22:57:44 INFO - PROCESS | 2780 | [#0] ai-astar Cycles:10 Average:115.30 Median:116.00 stddev:2.87 (2.5%) stddev-sans-first:1.36 22:57:44 INFO - PROCESS | 2780 | Values: 108.0 116.0 115.0 117.0 115.0 119.0 115.0 116.0 117.0 115.0 22:57:44 INFO - PROCESS | 2780 | 22:57:44 INFO - PROCESS | 2780 | [#1] audio-beat-detection Cycles:10 Average:141.10 Median:133.50 stddev:18.54 (13.9%) stddev-sans-first:18.75 22:57:44 INFO - PROCESS | 2780 | Values: 157.0 127.0 132.0 185.0 129.0 129.0 132.0 134.0 153.0 133.0 22:57:44 INFO - PROCESS | 2780 | 22:57:44 INFO - PROCESS | 2780 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:0.52 (0.3%) stddev-sans-first:0.53 22:57:44 INFO - PROCESS | 2780 | Values: 161.0 161.0 162.0 161.0 161.0 161.0 162.0 162.0 161.0 162.0 22:57:44 INFO - PROCESS | 2780 | 22:57:44 INFO - PROCESS | 2780 | [#3] audio-fft Cycles:10 Average:82.80 Median:77.00 stddev:12.62 (16.4%) stddev-sans-first:13.14 22:57:44 INFO - PROCESS | 2780 | Values: 76.0 78.0 77.0 110.0 77.0 78.0 77.0 76.0 103.0 76.0 22:57:44 INFO - PROCESS | 2780 | 22:57:44 INFO - PROCESS | 2780 | [#4] audio-oscillator Cycles:10 Average:90.60 Median:83.00 stddev:11.80 (14.2%) stddev-sans-first:12.19 22:57:44 INFO - PROCESS | 2780 | Values: 83.0 83.0 107.0 84.0 84.0 83.0 109.0 83.0 83.0 107.0 22:57:44 INFO - PROCESS | 2780 | 22:57:44 INFO - PROCESS | 2780 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 22:57:44 INFO - PROCESS | 2780 | Values: 119.0 118.0 118.0 118.0 118.0 118.0 118.0 118.0 118.0 117.0 22:57:44 INFO - PROCESS | 2780 | 22:57:44 INFO - PROCESS | 2780 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 22:57:44 INFO - PROCESS | 2780 | Values: 148.0 147.0 147.0 147.0 147.0 148.0 147.0 147.0 148.0 148.0 22:57:44 INFO - PROCESS | 2780 | 22:57:44 INFO - PROCESS | 2780 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 22:57:44 INFO - PROCESS | 2780 | Values: 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 22:57:44 INFO - PROCESS | 2780 | 22:57:44 INFO - PROCESS | 2780 | [#8] json-parse-financial Cycles:10 Average:67.40 Median:66.50 stddev:3.63 (5.5%) stddev-sans-first:3.74 22:57:44 INFO - PROCESS | 2780 | Values: 65.0 65.0 73.0 64.0 75.0 67.0 66.0 67.0 66.0 66.0 22:57:44 INFO - PROCESS | 2780 | 22:57:44 INFO - PROCESS | 2780 | [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:66.00 stddev:1.34 (2.0%) stddev-sans-first:1.41 22:57:44 INFO - PROCESS | 2780 | Values: 66.0 66.0 66.0 66.0 66.0 65.0 66.0 66.0 70.0 66.0 22:57:44 INFO - PROCESS | 2780 | 22:57:44 INFO - PROCESS | 2780 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:85.00 stddev:0.82 (1.0%) stddev-sans-first:0.83 22:57:44 INFO - PROCESS | 2780 | Values: 84.0 85.0 84.0 84.0 86.0 85.0 85.0 84.0 86.0 84.0 22:57:44 INFO - PROCESS | 2780 | 22:57:44 INFO - PROCESS | 2780 | [#11] stanford-crypto-ccm Cycles:10 Average:153.80 Median:153.50 stddev:16.52 (10.8%) stddev-sans-first:17.44 22:57:44 INFO - PROCESS | 2780 | Values: 149.0 160.0 154.0 141.0 159.0 141.0 141.0 144.0 196.0 153.0 22:57:44 INFO - PROCESS | 2780 | 22:57:44 INFO - PROCESS | 2780 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.40 Median:179.50 stddev:2.50 (1.4%) stddev-sans-first:2.65 22:57:44 INFO - PROCESS | 2780 | Values: 178.0 176.0 181.0 181.0 175.0 178.0 181.0 181.0 175.0 178.0 22:57:44 INFO - PROCESS | 2780 | 22:57:44 INFO - PROCESS | 2780 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:70.00 stddev:2.01 (2.9%) stddev-sans-first:1.92 22:57:44 INFO - PROCESS | 2780 | Values: 67.0 68.0 71.0 69.0 68.0 68.0 68.0 72.0 72.0 72.0 22:57:44 INFO - PROCESS | 2780 | -------- Summary: end -------- 22:57:44 INFO - PROCESS | 2780 | 22:57:45 INFO - TEST-INFO | 2780: exit 0 22:57:45 INFO - TEST-OK | kraken | took 65362ms 22:57:45 INFO - SUITE-END | took 1188s 22:57:45 INFO - Completed test suite (00:19:48) 22:57:45 INFO - javascript benchmark 22:57:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2557.475717477917, 2593.6887573491185, 2607.217834649605, 2624.6325514427986, 2634.10440450247, 4469.597736203741, 4524.5701658342405, 4630.166570017395, 4635.327877457771, 4639.396878405807, 4591.288350305699, 4593.655475839309, 4605.194091034064, 4655.394798676184, 4671.416072990876, 4151.481064866892, 4177.394277829713, 4211.05251318454, 4286.742795432284, 4372.8469503567385, 4214.346776249671, 4282.957170428303, 4326.048269380747, 4354.956450435503, 4402.537733537981, 4180.0, 4237.32202847546, 4329.242382583036, 4372.5627437256335, 4399.736015839044, 4167.270727622684, 4193.1404062167185, 4231.407602935591, 4268.9573104268875, 4303.806328715215, 4223.746575205498, 4224.5353011168745, 4231.280682284019, 4232.3016702244095, 4266.402703621496, 4540.841070562547, 4572.108438854425, 4577.656675749332, 4603.677742558022, 4625.930611040803, 4736.076465089309, 4781.139394908915, 4786.7845946932475, 4826.686265392738, 4883.02339532095, 4880.853574392774, 4939.604831613462, 4939.876503087416, 4962.776675049631, 4977.377827771528, 4553.612942899825, 4556.134334476439, 4557.977210113928, 4593.632509399274, 4652.651051171108, 4833.4441539222735, 4852.17513022787, 4855.393075865517, 5013.623978201649, 5019.29729837823, 4767.4517430495935, 4812.1578723723205, 4816.157172494799, 4841.878953026203, 4892.363992681, 4888.535589119028, 4888.608911287089, 4890.926636100461, 4899.730514821719, 4949.554540091337, 4722.220833562424, 4846.055019271208, 4862.149123903303, 4900.681455705368, 4902.460729319772, 4709.128811169944, 4823.1800593898415, 4827.444843842933, 4830.130576496194, 4833.275008748716, 4180.3102488089735, 4196.664266858705, 4199.2441360554785, 4209.894752631209, 4213.578642135762, 3706.6108058653454, 3733.0667333166707, 3739.439084137401, 3760.7179461539945, 3761.9811900940867, 4267.210566045292, 4269.082147338338, 4269.4449721536, 4298.677599180011, 4307.65538756905, 4778.354922085474, 4995.900081998339, 4999.475055119233, 5005.074061298671, 5052.141136006888, 4181.080162364275, 4184.309588917856, 4193.35003074524, 4194.853180138742, 4199.223143718361, 4446.021875187454, 4458.866234012985, 4459.620932220732, 4461.665375096881, 4461.687681862303, 4563.703359281636, 4606.032733126014, 4606.677532572822, 4610.147122782296, 4611.377464042312, 4883.731394773322, 4890.535399137077, 4895.461499235153, 4900.607951363811, 4903.5586797188425, 4579.175748365326, 4599.425071866017, 4603.608693261111, 4604.309353596987, 4609.124266389375, 4818.734969576707, 4851.078295123915, 4894.535019173173, 4907.950920490892, 4970.8757281068265, 4988.12707776145, 4989.501049894981, 4990.750462476789, 4993.15116430215, 5029.4216165140015, 4859.562639362474, 4860.465348811698, 4862.294967229803, 4868.586170175433, 4894.19245824435, 4631.4905360411, 4705.55297246761, 4736.905261894812, 4767.523247675204, 4893.0458560581765, 4717.622590192845, 4726.645501587326, 4732.97633511844, 4759.833405830779, 4780.378550788375, 4835.734034628129, 4835.782389792397, 4836.202026665702, 4839.322494850653, 4869.415670119608, 4517.119161763556, 4559.658025648156, 4703.905921881612, 4734.07685501324, 4771.66598338113], "value": 4517.973291971483, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [541.1828139509342, 544.6024402186405, 550.7576666266845, 553.5599198637082, 566.4562020460361, 27316.45367092657, 30347.089587312388, 37097.81451092748, 38370.42444363337, 38438.807805961, 38452.42321365182, 38821.80589097051, 38827.0, 38878.61121388785, 38888.80555597218, 7455.366293865014, 7590.620468976556, 7604.315611594955, 7613.162552119263, 7617.619119044053, 7380.704771809121, 7587.317141457268, 9608.951955240249, 9841.852372214422, 9844.803103937917, 9941.701748947544, 9980.20158387331, 9990.350627209244, 10003.499825008721, 10059.748506287366, 9773.07155820196, 9826.06652368024, 9839.47488139336, 9840.557174927073, 9905.851412228822, 9702.805943881154, 9763.023697630251, 9782.706518804447, 9790.1678357339, 9798.90201097987, 36977.0, 37077.629223707954, 37127.4430883537, 37140.44289335662, 37509.24981500382, 3045.2082458560712, 3092.922676933072, 3115.7818952673324, 3325.8004519728893, 3533.0990597397754, 27698.169054928385, 28137.0, 28298.858505707547, 28845.42309153826, 29592.0, 3470.0804286864, 3485.4771784232566, 3522.452538543862, 3584.2831433713363, 3610.3681855675413, 238366.0, 238603.80698096572, 239330.0, 239420.0, 239785.0, 50496.747516262185, 50813.0, 50986.0, 50990.74504627453, 51040.234396484084, 53673.731631341594, 53710.73144634252, 53790.46209537933, 53795.46204537905, 53871.0, 14347.78478322826, 14638.341274642667, 14647.487337943121, 14668.193249371174, 14681.01806256163, 9788.119069283655, 10442.269041167197, 10513.632022879163, 10530.894691053145, 10532.15742740579, 13394.062415630813, 15372.692546149237, 15998.360065597246, 16005.0, 16012.67974640524, 6111.5110791137495, 6221.720022598994, 6225.097360882737, 6287.779927702509, 6292.779752708633, 778.4006315137312, 913.6528119314618, 943.9993606776839, 959.640134949394, 1001.2990906365428, 26046.218613441626, 27375.315617109332, 27611.72388276132, 27710.783137348964, 27784.722152778617, 941.6657086734248, 966.8888077870994, 975.40987702439, 980.1423754215061, 1052.3370276725766, 14309.713805723828, 14545.0, 14633.268336583342, 14661.85338146605, 14663.71452967681, 114984.42507787407, 115122.42438787753, 115186.0, 115364.0, 115842.0, 41450.585494144674, 42231.577684223375, 46680.5331946683, 48228.27657585139, 48293.75853120712, 1095.6439157273917, 1119.3731510354228, 1142.87999760024, 1167.8481797366458, 1179.3690375649157, 26855.597166042917, 27694.307642308297, 28415.715842842135, 28449.573256400756, 29085.0, 41266.79366603148, 41954.79022604867, 41990.0, 42017.57982420137, 42032.78983605062, 313779.0, 315367.0, 315391.0, 316072.0, 316229.0, 34083.82958085194, 34524.13689657779, 34653.653463465045, 34829.825850871595, 34855.12862178466, 39472.0, 39556.20887582174, 40143.39784903287, 40447.79776101218, 40904.38643420291, 34154.0, 34889.12777180591, 35061.29877402387, 35087.122821928635, 35569.28861422809, 34617.480737789454, 35185.296294073465, 35321.47017794684, 35511.82244088763, 35542.64457355497, 34951.30097397987, 35046.12384690403, 35297.29405411929, 35460.46809297811, 35857.82071089628, 29262.561061583667, 32057.51913721343, 32098.67901320957, 34230.0, 34292.48561271533, 23919.641205381584, 24757.0, 24792.628110577996, 24804.255872323858, 25034.62448063317], "value": 17023.718664656793, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.23231799179877, 342.6350936252891, 347.26380074242593, 355.1937102776696, 374.6534455628543, 12377.443015064322, 15508.294087650349, 15703.685926281467, 17026.74459883103, 17167.227474763633, 16384.590385240346, 16443.8756636239, 16658.750118748227, 16769.91615041926, 16820.747688784646, 4847.1517484440255, 5075.3909530856345, 5158.8710282243055, 5388.272583201277, 5429.104197807357, 3423.8801641942537, 3570.553680789901, 5439.809606663767, 5482.451754824526, 5483.8080667176655, 5074.974625126869, 5295.735213239342, 5313.282706834586, 5379.946200537984, 5387.164989426626, 5367.892642147155, 5380.91928621071, 5381.165919282478, 5540.141278101901, 5867.911981320283, 5299.54953828925, 5312.73436328182, 5316.9734151329385, 5337.733113344318, 5345.251664766935, 11847.466863991054, 13537.45850166002, 19571.315003974934, 19730.30943916956, 19730.309439169705, 1807.8734488585803, 1837.9081045947648, 1911.3310341380545, 2070.440980935154, 2299.5056062946546, 8977.910220897773, 9225.12361325673, 9351.859722104175, 11790.0, 12431.191972521758, 1636.6317578544852, 1664.5588918936492, 1691.501007202878, 1731.5151757507917, 1789.105447276362, 65337.85270062195, 65484.345156548305, 66326.0, 67304.0, 67950.0, 9439.24486041115, 9554.14012738843, 9730.513474326255, 9751.463669498246, 10045.949770251102, 13317.667058323426, 13323.533676321282, 13332.0, 13346.399412026482, 13360.93319533396, 6502.804915852532, 6654.76886775948, 6739.730410783513, 6759.053732477457, 6918.0, 6181.690915454209, 6251.156093927261, 6295.181626388632, 6372.84067898297, 6385.48916086712, 4030.899227519277, 4057.33054046085, 4182.393552934807, 4289.378040184156, 4301.182775272689, 1732.8786984911187, 1736.2360561352964, 1769.5929936114508, 1796.7304904264204, 1800.9009504477117, 772.6252767407802, 820.7004443378124, 846.7764080903036, 906.1436942089794, 906.2704522859161, 15765.763513547307, 15988.440404585785, 16313.265903034391, 16703.0, 16792.0, 817.7751118442357, 830.5862903466747, 849.0321034021221, 863.5336918064176, 908.927285817133, 8912.485356065652, 8966.282697384193, 9392.95303523478, 9406.341556091145, 9510.619575217052, 129008.0, 129169.0, 129230.35384823015, 129595.0, 130424.0, 51223.0, 68489.0, 73482.74039276667, 75006.0, 76824.0, 874.4796845876693, 877.6006916852945, 911.832853946949, 914.9634014639473, 917.40368760305, 10315.638952636622, 13067.738645227233, 13229.0, 13645.658858528615, 13647.11293765902, 34566.30867382588, 35412.82293588515, 35599.64400356067, 35960.64039359573, 36579.63420365869, 47176.528234718586, 47296.29055564238, 47362.763186183845, 47563.52436475591, 47637.0, 7286.271372862883, 7318.3047610476915, 7347.889781653386, 7376.520526165782, 7835.608219589112, 8037.839243214986, 10610.734731631463, 10767.192460565333, 11084.501197446296, 11802.350870702194, 8468.602680557638, 10256.282060255711, 10310.0, 10452.790944181226, 10842.783144337227, 10298.433586152834, 10457.320274182459, 10565.418901960158, 10590.470476475992, 10601.098906593026, 10407.271490995558, 10465.267431279737, 10643.308184967953, 10671.679849604525, 11130.220884538005, 7522.849543009, 7632.692804483101, 7813.960930195312, 7830.373570114263, 7946.284834364935, 8024.679012839654, 9306.441613503212, 10296.227782916461, 10366.170706343626, 10438.11276041545], "value": 7660.012554739294, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1316.5721140629296, 1359.2116572388015, 1405.7188562287538, 1594.6651203247318, 1615.095546493964, 6021.126936594192, 6216.627002379861, 6594.769183078587, 7044.682989265482, 7053.0, 6340.4927605791545, 6545.672716364186, 6545.869082618345, 6707.295733947938, 6715.731370745164, 2011.1653663729571, 2044.5297581556251, 2045.1921491011042, 2045.4886278430392, 2046.2122082998078, 1678.0938293321592, 1734.3322820714052, 1986.1856638778104, 2027.4525878012928, 2036.541778099923, 1967.301607929186, 2041.1121162294448, 2042.1831267492973, 2057.567910738739, 2060.0420804325986, 2022.3427386099577, 2024.0486971123548, 2039.0926037913134, 2042.4689580708973, 2048.9590208195755, 2022.5550378916614, 2033.298512013353, 2033.6237796007786, 2036.3076553971573, 2042.8365730741655, 6755.324467553254, 6809.250982391933, 6814.965925170342, 6818.318168183192, 6820.0, 4065.308897487434, 4165.166966606691, 4181.351890456984, 4185.414042034117, 4187.979060104711, 2516.886740096682, 2759.434315965222, 2760.2823265950797, 2766.8616569171663, 2767.1560174146875, 817.4808996287401, 871.9825603487894, 895.7447127568677, 899.7660608241839, 908.318760929303, 9066.818663626756, 9071.501067441288, 9103.954480227623, 9155.0, 9158.084191580856, 3549.8047607381327, 3768.2840260350995, 3836.0985168485386, 3862.208247309295, 3949.3878448840474, 7915.406344524184, 7927.722529711433, 7927.722529711547, 7928.0, 7945.523268603903, 4260.936085958713, 4283.571642835754, 4287.09970906107, 4325.52419233884, 4332.415123958288, 3726.4224045273027, 3924.823382947774, 3942.250972315251, 3945.861894833667, 3949.624785645359, 3146.7797254191987, 3187.9362412751616, 3226.951595726066, 3308.801471911693, 3353.3293341331832, 987.6740675577042, 1017.99491002546, 1123.775244951013, 1126.1272513801869, 1145.9025982791388, 588.5350573047244, 607.1408956326749, 633.439406125573, 690.9566554502636, 714.9571025738472, 4337.8264869404875, 4537.500874903758, 4586.610138138229, 4594.379758732595, 4658.790354434059, 430.9396684464177, 433.15318552230315, 448.4148186616497, 458.41552021172606, 581.9214406055213, 3249.77251592391, 3281.52417899408, 3314.419976504102, 3323.3353329333745, 3432.1934345428804, 7888.881666775003, 8374.162583741578, 8380.58097095155, 8384.706535271236, 8394.370422218359, 8313.0, 8345.707900223462, 8353.749387518385, 8359.164083591713, 8359.8328033439, 6392.552521323462, 6512.05575191604, 6589.670516474253, 6598.802035938929, 6603.372679595431, 4554.271316589462, 4582.495925448131, 4614.077184563033, 4703.647226458098, 4764.118638051833, 7384.37232835215, 7470.4023678106705, 7560.508566943131, 7603.0, 7660.80847978805, 7592.278733520307, 7625.542467451971, 7667.884981725167, 7672.501287416523, 7714.1128770192145, 5746.827595172152, 5866.3547009828035, 5867.589268751147, 5877.823665290048, 5879.088741245114, 6335.841603959938, 6397.392247736458, 6405.7117429714845, 6410.294867564471, 6411.5832470889245, 5853.1220316952795, 5889.882202356014, 5945.672987985702, 5958.076498142795, 6032.90950635732, 5766.365699772938, 5838.805970149254, 5885.970570147122, 5903.498202652822, 5957.553183511167, 5302.761375738024, 5403.405625381126, 5416.729163541886, 5417.702026388429, 5424.430434804289, 4038.939415908705, 4062.8374865005067, 4076.9592304076577, 4119.196756632428, 4200.894977625461, 4026.6979976501293, 4060.1067765091634, 4089.079957009649, 4130.215259100762, 4223.9017855357215], "value": 3632.412875286028, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.4226019091912, 293.59777105365646, 297.2924439833197, 299.1176030709408, 302.455579956079, 4669.7198168109935, 4717.245240761479, 4836.371271734678, 4840.6369522285795, 4873.22028475444, 4635.860924172272, 4670.206064968955, 4711.740854253015, 4745.430548334196, 4749.4775574686755, 3765.6610905018542, 3769.09541709989, 3771.3400154972906, 3776.584575696671, 3782.2624588205313, 3751.3247615429214, 3780.6786423154067, 3782.4326351047425, 3797.2974999625158, 3801.3537698591167, 3413.822231330187, 3565.4830049642787, 3669.981650091746, 3740.8129593520353, 3748.9502939177073, 3744.850205991757, 3753.428901202671, 3755.455458958463, 3755.7746535207975, 3763.604821493731, 3347.129746265988, 3353.3293341331832, 3355.8154301513405, 3360.7647464677484, 3369.7135743461836, 4511.2406161597, 4692.906141877177, 4693.7653117344, 4700.5064468230685, 4703.2474804031535, 4291.35629655551, 4294.592013758688, 4295.312749959991, 4301.74189548625, 4310.935335969963, 4988.800447982077, 5000.799968001275, 5004.949950500485, 5010.248462730583, 5017.247412888059, 3649.160693040589, 3652.6712595866234, 3660.359437098524, 3660.5058317127114, 3666.4866918631415, 5006.874828129289, 5169.810943482982, 5189.896202075937, 5190.948090519122, 5196.142636465017, 3714.9628503715157, 3726.8136593170234, 3728.2357116790995, 3734.234481931252, 3741.073347226181, 3755.117547376364, 3776.9244615108096, 3786.6024067473068, 3790.677792387678, 3793.981030094887, 4155.480564929384, 4227.788610569459, 4276.615104640598, 4297.9369902447, 4298.720583162084, 4952.4057113146655, 4953.281774142729, 4969.552740253394, 4975.303457515951, 4975.701457912464, 1218.3542722357165, 1220.2434490615874, 1233.7409144079663, 1262.5959692898184, 1281.2824818101706, 869.2090197919863, 880.1858281089966, 890.4123278636199, 890.808476177612, 892.8437673213205, 4169.749815011109, 4170.937435938464, 4197.4753155855515, 4232.936505952413, 4242.4272723181975, 4902.90194196114, 4903.215485522299, 4903.436104847917, 4929.0, 4978.178600530872, 4167.708260421741, 4172.7079104463, 4211.557786432441, 4217.8787697104535, 4229.91540169201, 2548.2737419835257, 2635.420207554335, 2713.077553631735, 2714.83710977342, 2726.922865468129, 4676.462206846189, 4716.551927566876, 4727.83452579165, 4781.426228852491, 4787.832425865078, 5120.231965205175, 5133.460986596354, 5134.2298655201275, 5175.689458632494, 5188.9740551297, 4490.595846373842, 4692.3576748137875, 4702.1536123496735, 4711.74085425298, 4736.242201247784, 4994.350734404504, 5002.574781143643, 5040.2198351236575, 5040.974795126001, 5064.0, 4927.310176575354, 4964.652474326763, 4966.627502937366, 4978.4025916890205, 5001.799928002984, 4483.730976141442, 4664.183767840682, 4696.600788932979, 4702.52974702527, 4712.481627021093, 3482.373172828814, 3502.772319799205, 3521.207728261223, 3530.011596752913, 3532.64673532655, 4945.901081978413, 4966.013594562204, 4999.550040496373, 5030.245463180552, 5036.287662194872, 4874.805007799649, 4954.702717836942, 4991.775370108281, 5008.549230569266, 5016.398032236155, 4992.800287988585, 4994.700317980933, 4996.950030499794, 4998.375203099613, 5029.1953287473825, 4814.301926220608, 4904.362432883702, 4934.235193545006, 4955.603551715926, 4964.801407943642, 5019.297298378157, 5026.296318515484, 5045.612456574471, 5047.091523525801, 5048.318477005557, 4880.6095512358215, 4889.755512224446, 4912.361393018885, 4923.286123512143, 4928.137575924127], "value": 3744.6443926038046, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [601.8856417280716, 650.8080116365671, 683.4668958212594, 686.1971493352777, 691.7475121580621, 11016.339019658815, 11445.256058356212, 12178.08664350175, 12264.386780660954, 12361.443735031922, 11102.944485277561, 11225.32648041116, 11269.718257043578, 11295.152863535248, 11466.025387842023, 742.191011797141, 763.1071646173962, 763.6945221911252, 763.7746864674906, 764.6520833020962, 614.7356636646263, 632.8006677896448, 734.2180577684749, 762.0, 762.1996903251592, 796.0566728426804, 798.1340245833278, 799.8080460689422, 800.2837460472873, 800.7998000499875, 795.6300320351036, 797.3302425962162, 797.4457751862458, 797.6410615223115, 797.9601019949008, 474.04716519795113, 482.2332491338788, 563.4140493886354, 582.4990508162977, 583.7314835175824, 11972.461239244254, 11981.161318707695, 12013.038956883429, 12039.759204815942, 12046.397680116046, 11034.944825275823, 11150.776984460266, 11280.32318060919, 11321.830172547336, 11597.304161750237, 10244.385336879812, 10316.432596207205, 10360.48197590125, 10445.895541044569, 10466.738331541696, 3764.190698999701, 3764.623537646241, 3773.415120656275, 3779.811009449544, 3829.17672700368, 47675.0, 47825.282620760714, 48085.51914480845, 48810.0, 51006.7449662753, 9044.0, 9212.170904618482, 9257.90742092584, 9284.0, 9349.205317548085, 16958.152092395576, 17008.149592520323, 17033.063181525136, 17047.573810654583, 17315.91342043282, 6026.0, 6112.786052488142, 6119.571629985859, 6350.428461438492, 6375.936240637627, 3557.8932632021083, 3558.0749005258303, 3575.213453040327, 3583.0146709655055, 3644.9635503645154, 2494.9376265593505, 2560.641510188575, 2579.948401031969, 2581.2127301172945, 2581.5611346071214, 432.275937804183, 433.1467009990314, 442.0628268071644, 442.3409120410565, 443.16463466366133, 429.27452605097284, 511.1719015195333, 532.0795024607373, 545.1876703711441, 546.1698218707543, 6718.93281067183, 6776.288489708608, 6938.6138613861385, 7333.97324374588, 7496.287852653989, 517.5807595847376, 520.3131865936926, 526.9262303277544, 537.4341245833842, 546.9261649677322, 3346.9330613387597, 3540.592831824373, 3564.0, 3619.4208926571623, 3714.888553343404, 67092.0, 67539.3246067533, 69100.30899691039, 69219.65390173017, 69246.65376673185, 60852.0, 63110.68444657747, 63491.36508634947, 63698.36301637017, 63765.0, 45998.5400146001, 48578.999999999294, 50811.0, 53951.730241348545, 56594.15108773372, 6657.667116644052, 6679.628731800141, 6999.965000174967, 7940.285374316109, 8777.736667899973, 33910.15224619404, 35462.82268588641, 35587.0, 35889.46165807567, 38778.6122138775, 32022.6797732029, 33597.66402335945, 34262.31475370429, 49249.753751231015, 50807.74596126996, 8284.46151000183, 8285.792855178428, 8318.0, 8387.790305242417, 8845.027047024694, 9084.591193396445, 9357.812843742951, 9456.527173641429, 9460.195883349717, 9550.665726699532, 8796.648134074565, 8838.867416988878, 8929.73210803677, 9049.502277374808, 9192.402493837879, 9093.545322733704, 9176.128267814547, 9277.1650551448, 9465.100815422524, 9470.384425012353, 8743.38796284254, 8861.424007439497, 8911.187062187926, 8995.190432861074, 9174.26605871542, 7392.186859445349, 7524.811879703051, 7527.585982771, 7569.772906812805, 7903.407244456804, 7438.73964411243, 7563.432742544442, 7715.614219289126, 7846.0976987647155, 8029.919700802917], "value": 5609.46031002289, "unit": "score"}], "name": "dromaeo_css", "value": 5963.045483930812, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 116.0, 115.0, 117.0, 115.0, 119.0, 115.0, 116.0, 117.0, 115.0], "value": 115.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 127.0, 132.0, 185.0, 129.0, 129.0, 132.0, 134.0, 153.0, 133.0], "value": 141.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 161.0, 161.0, 161.0, 162.0, 162.0, 161.0, 162.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 77.0, 110.0, 77.0, 78.0, 77.0, 76.0, 103.0, 76.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 107.0, 84.0, 84.0, 83.0, 109.0, 83.0, 83.0, 107.0], "value": 90.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 148.0, 148.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 73.0, 64.0, 75.0, 67.0, 66.0, 67.0, 66.0, 66.0], "value": 67.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 66.0, 65.0, 66.0, 66.0, 70.0, 66.0], "value": 66.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 84.0, 86.0, 85.0, 85.0, 84.0, 86.0, 84.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 160.0, 154.0, 141.0, 159.0, 141.0, 141.0, 144.0, 196.0, 153.0], "value": 153.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 176.0, 181.0, 181.0, 175.0, 178.0, 181.0, 181.0, 175.0, 178.0], "value": 178.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 71.0, 69.0, 68.0, 68.0, 68.0, 72.0, 72.0, 72.0], "value": 69.5, "unit": "score"}], "name": "kraken", "value": 1572.6, "alertThreshold": 2.0}]} 22:57:46 INFO - Return code: 0 22:57:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:57:46 INFO - # TBPL SUCCESS # 22:57:46 INFO - Running post-action listener: _resource_record_post_action 22:57:46 INFO - [mozharness: 2016-11-26 06:57:46.074481Z] Finished run-tests step (success) 22:57:46 INFO - Running post-run listener: _resource_record_post_run 22:57:46 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 4096; Write bytes: 400961536; Read time: 12; Write time: 205572 22:57:46 INFO - TinderboxPrint: CPU usage
13.1% 22:57:46 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 22:57:46 INFO - TinderboxPrint: I/O write bytes / time
400,961,536 / 205,572 22:57:46 INFO - TinderboxPrint: CPU idle
8,353.8 (86.9%) 22:57:46 INFO - TinderboxPrint: CPU user
1,211.0 (12.6%) 22:57:46 INFO - TinderboxPrint: Swap in / out
0 / 0 22:57:46 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99315712; Read time: 0; Write time: 54868 22:57:46 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 289726464; Read time: 0; Write time: 149280 22:57:46 INFO - Running post-run listener: _upload_blobber_files 22:57:46 INFO - Blob upload gear active. 22:57:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:57:46 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:46 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:46 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:47 INFO - (blobuploader) - INFO - Open directory for files ... 22:57:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:57:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:57:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:57:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.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/dromaeojs_raw.log ... 22:57:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:57:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:57:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:57:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:57:48 INFO - (blobuploader) - INFO - Done attempting. 22:57:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:57:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:57:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:57:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:57:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:57:51 INFO - (blobuploader) - INFO - Done attempting. 22:57:51 INFO - (blobuploader) - INFO - Iteration through files over. 22:57:51 INFO - Return code: 0 22:57:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:57:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:57:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9eb4b5674ef5faa6efa9794cc60ce493f5729a1367fa8d3d04a78f5592ab93bcf7154cf9ae5b1248c6afddb36cdbd93b015618441cf8a1d987b471d59129bc7a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cfd8e4691af922d7fc5df9144a8781c6564df914db3fe4101430a2795db75a5b3e98632a26363541d0fcf7261204b44be6467241e49910bee34c9b665f5f7d15", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cfb0a93df38a418d9061aa8b4064e2e860a55e97ff4508e6ed700bb5c6329272c43d9caa98c88e43241bd328a524f6770426b9b6817efb0a6eedd7d865869f49"} 22:57:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:57:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:57:51 INFO - Contents: 22:57:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9eb4b5674ef5faa6efa9794cc60ce493f5729a1367fa8d3d04a78f5592ab93bcf7154cf9ae5b1248c6afddb36cdbd93b015618441cf8a1d987b471d59129bc7a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cfd8e4691af922d7fc5df9144a8781c6564df914db3fe4101430a2795db75a5b3e98632a26363541d0fcf7261204b44be6467241e49910bee34c9b665f5f7d15", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cfb0a93df38a418d9061aa8b4064e2e860a55e97ff4508e6ed700bb5c6329272c43d9caa98c88e43241bd328a524f6770426b9b6817efb0a6eedd7d865869f49"} 22:57:51 INFO - Running post-run listener: copy_logs_to_upload_dir 22:57:51 INFO - Copying logs to upload dir... 22:57:51 INFO - mkdir: /builds/slave/test/build/upload/logs 22:57:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.000223 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-11-25 22:57:51.487562) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-25 22:57:51.492064) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1480141982.947840-964587317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9eb4b5674ef5faa6efa9794cc60ce493f5729a1367fa8d3d04a78f5592ab93bcf7154cf9ae5b1248c6afddb36cdbd93b015618441cf8a1d987b471d59129bc7a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cfd8e4691af922d7fc5df9144a8781c6564df914db3fe4101430a2795db75a5b3e98632a26363541d0fcf7261204b44be6467241e49910bee34c9b665f5f7d15", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cfb0a93df38a418d9061aa8b4064e2e860a55e97ff4508e6ed700bb5c6329272c43d9caa98c88e43241bd328a524f6770426b9b6817efb0a6eedd7d865869f49"} 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.011735 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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9eb4b5674ef5faa6efa9794cc60ce493f5729a1367fa8d3d04a78f5592ab93bcf7154cf9ae5b1248c6afddb36cdbd93b015618441cf8a1d987b471d59129bc7a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cfd8e4691af922d7fc5df9144a8781c6564df914db3fe4101430a2795db75a5b3e98632a26363541d0fcf7261204b44be6467241e49910bee34c9b665f5f7d15", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cfb0a93df38a418d9061aa8b4064e2e860a55e97ff4508e6ed700bb5c6329272c43d9caa98c88e43241bd328a524f6770426b9b6817efb0a6eedd7d865869f49"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-25 22:57:51.520933) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 22:57:51.521276) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1480141982.947840-964587317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004587 ========= master_lag: 0.25 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 22:57:51.775922) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-25 22:57:51.776293) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-25 22:57:51.779639) ========= ========= Total master_lag: 0.37 =========