builder: cedar_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-031 starttime: 1480071958.27 results: success (0) buildid: 20161125015119 builduid: 7ca95eb8e8454b6a86afa2292d008894 revision: 1d31baa686c55268e4ec5364704b8ea5d7c33fe2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-25 03:05:58.266723) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-25 03:05:58.267922) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-25 03:05:58.268186) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-25 03:05:58.298638) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 03:05:58.298902) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db0483c52d987ecb441a263b000001ad-1480071957.308782-1012989989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-25 03:05:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 69.2M=0s 2016-11-25 03:05:58 (69.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.163170 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 03:05:58.476375) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 03:05:58.476670) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db0483c52d987ecb441a263b000001ad-1480071957.308782-1012989989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.148682 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 03:05:58.635561) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 03:05:58.635939) ========= bash -c 'python archiver_client.py mozharness --repo projects/cedar --rev 1d31baa686c55268e4ec5364704b8ea5d7c33fe2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/cedar --rev 1d31baa686c55268e4ec5364704b8ea5d7c33fe2 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db0483c52d987ecb441a263b000001ad-1480071957.308782-1012989989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-25 03:05:58,768 truncating revision to first 12 chars 2016-11-25 03:05:58,768 Setting DEBUG logging. 2016-11-25 03:05:58,768 attempt 1/10 2016-11-25 03:05:58,768 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/cedar/1d31baa686c5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-25 03:05:59,114 unpacking tar archive at: cedar-1d31baa686c5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.694169 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 03:05:59.343657) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-25 03:05:59.343990) ========= script_repo_revision: 1d31baa686c55268e4ec5364704b8ea5d7c33fe2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-25 03:05:59.344367) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-25 03:05:59.344624) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-25 03:05:59.353871) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-11-25 03:05:59.354145) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 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', 'Cedar', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Cedar'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db0483c52d987ecb441a263b000001ad-1480071957.308782-1012989989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:05:59 INFO - MultiFileLogger online at 20161125 03:05:59 in /builds/slave/test 03:05:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 03:05:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:05:59 INFO - {'append_to_log': False, 03:05:59 INFO - 'base_work_dir': '/builds/slave/test', 03:05:59 INFO - 'blob_upload_branch': 'Cedar', 03:05:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:05:59 INFO - 'branch': 'Cedar', 03:05:59 INFO - 'buildbot_json_path': 'buildprops.json', 03:05:59 INFO - 'config_files': ('talos/linux_config.py',), 03:05:59 INFO - 'default_actions': ('clobber', 03:05:59 INFO - 'read-buildbot-config', 03:05:59 INFO - 'download-and-extract', 03:05:59 INFO - 'populate-webroot', 03:05:59 INFO - 'create-virtualenv', 03:05:59 INFO - 'install', 03:05:59 INFO - 'run-tests'), 03:05:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:05:59 INFO - 'download_minidump_stackwalk': True, 03:05:59 INFO - 'download_symbols': 'ondemand', 03:05:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:05:59 INFO - 'tooltool.py': '/tools/tooltool.py', 03:05:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:05:59 INFO - '/tools/misc-python/virtualenv.py')}, 03:05:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:05:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:05:59 INFO - 'installer_path': 'installer.exe', 03:05:59 INFO - 'log_level': 'info', 03:05:59 INFO - 'log_name': 'talos', 03:05:59 INFO - 'log_to_console': True, 03:05:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:05:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:05:59 INFO - 'opt_config_files': (), 03:05:59 INFO - 'pip_index': False, 03:05:59 INFO - 'sps_profile': False, 03:05:59 INFO - 'sps_profile_interval': 0, 03:05:59 INFO - 'suite': 'dromaeojs', 03:05:59 INFO - 'system_bits': '32', 03:05:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:05:59 INFO - 'title': 'talos-linux64-ix-031', 03:05:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:05:59 INFO - 'use_talos_json': True, 03:05:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:05:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:05:59 INFO - 'work_dir': 'build'} 03:05:59 INFO - [mozharness: 2016-11-25 11:05:59.714903Z] Running clobber step. 03:05:59 INFO - Running pre-action listener: _resource_record_pre_action 03:05:59 INFO - Running main action method: clobber 03:05:59 INFO - rmtree: /builds/slave/test/build 03:05:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:06:04 INFO - Running post-action listener: _resource_record_post_action 03:06:04 INFO - [mozharness: 2016-11-25 11:06:04.275779Z] Finished clobber step (success) 03:06:04 INFO - [mozharness: 2016-11-25 11:06:04.275901Z] Running read-buildbot-config step. 03:06:04 INFO - Running pre-action listener: _resource_record_pre_action 03:06:04 INFO - Running main action method: read_buildbot_config 03:06:04 INFO - Using buildbot properties: 03:06:04 INFO - { 03:06:04 INFO - "project": "", 03:06:04 INFO - "product": "firefox", 03:06:04 INFO - "script_repo_revision": "default", 03:06:04 INFO - "builddir": "cedar_ubuntu64_hw_test-dromaeojs", 03:06:04 INFO - "repository": "", 03:06:04 INFO - "buildername": "Ubuntu HW 12.04 x64 cedar talos dromaeojs", 03:06:04 INFO - "buildid": "20161125015119", 03:06:04 INFO - "pgo_build": "False", 03:06:04 INFO - "basedir": "/builds/slave/test", 03:06:04 INFO - "buildnumber": 0, 03:06:04 INFO - "slavename": "talos-linux64-ix-031", 03:06:04 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:06:04 INFO - "platform": "ubuntu64_hw", 03:06:04 INFO - "scheduler": "tests-cedar-linux64-talos", 03:06:04 INFO - "branch": "cedar", 03:06:04 INFO - "repo_path": "projects/cedar", 03:06:04 INFO - "revision": "1d31baa686c55268e4ec5364704b8ea5d7c33fe2", 03:06:04 INFO - "stage_platform": "linux64", 03:06:04 INFO - "builduid": "7ca95eb8e8454b6a86afa2292d008894", 03:06:04 INFO - "slavebuilddir": "test" 03:06:04 INFO - } 03:06:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/NgeyN7yCSBStUQT6Jh0_Pw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 03:06:04 INFO - Running post-action listener: _resource_record_post_action 03:06:04 INFO - [mozharness: 2016-11-25 11:06:04.278390Z] Finished read-buildbot-config step (success) 03:06:04 INFO - [mozharness: 2016-11-25 11:06:04.278478Z] Running download-and-extract step. 03:06:04 INFO - Running pre-action listener: _resource_record_pre_action 03:06:04 INFO - Running main action method: download_and_extract 03:06:04 INFO - mkdir: /builds/slave/test/build/tests 03:06:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:04 INFO - trying https://queue.taskcluster.net/v1/task/NgeyN7yCSBStUQT6Jh0_Pw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 03:06:04 INFO - Downloading https://queue.taskcluster.net/v1/task/NgeyN7yCSBStUQT6Jh0_Pw/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 03:06:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NgeyN7yCSBStUQT6Jh0_Pw/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 03:06:04 INFO - Downloaded 1361 bytes. 03:06:04 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 03:06:04 INFO - Using the following test package requirements: 03:06:04 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 03:06:04 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 03:06:04 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:06:04 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 03:06:04 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:06:04 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 03:06:04 INFO - u'jsshell-linux-x86_64.zip'], 03:06:04 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 03:06:04 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:06:04 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 03:06:04 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 03:06:04 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:06:04 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 03:06:04 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:06:04 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 03:06:04 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:06:04 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 03:06:04 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:06:04 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:06:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NgeyN7yCSBStUQT6Jh0_Pw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 03:06:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NgeyN7yCSBStUQT6Jh0_Pw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:06:04 INFO - Fetch https://queue.taskcluster.net/v1/task/NgeyN7yCSBStUQT6Jh0_Pw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 03:06:05 INFO - Http code: 200 03:06:05 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 03:06:05 INFO - x-amz-cf-id: DR0MSZ4no5-tnFnW63CO9TQ2xGF3rQNzqlZK1UAuxx1v3nOhamc2kw== 03:06:05 INFO - x-amz-version-id: urZwtlPw_JvF3faeCaVm8JYbkOEP.P5_ 03:06:05 INFO - Expected file size: 20203688 03:06:05 INFO - Obtained file size: 20203688 03:06:09 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 03:06:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NgeyN7yCSBStUQT6Jh0_Pw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 03:06:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NgeyN7yCSBStUQT6Jh0_Pw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:06:09 INFO - Fetch https://queue.taskcluster.net/v1/task/NgeyN7yCSBStUQT6Jh0_Pw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 03:06:10 INFO - Http code: 200 03:06:10 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 03:06:10 INFO - x-amz-cf-id: i5jRPLLXe1FnYya4uwTma7fvpSCetuK064S_AVYSVqva0YO4Uf2Byw== 03:06:10 INFO - x-amz-version-id: urZwtlPw_JvF3faeCaVm8JYbkOEP.P5_ 03:06:10 INFO - Expected file size: 20203688 03:06:10 INFO - Obtained file size: 20203688 03:06:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NgeyN7yCSBStUQT6Jh0_Pw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 03:06:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NgeyN7yCSBStUQT6Jh0_Pw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:06:14 INFO - Fetch https://queue.taskcluster.net/v1/task/NgeyN7yCSBStUQT6Jh0_Pw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 03:06:15 INFO - Http code: 200 03:06:15 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 03:06:15 INFO - x-amz-cf-id: PxM7jo6t-hNcFO1F3ZJH2h3W08Dnjpw-NhyXmX323HiauZ4gI5xxoA== 03:06:15 INFO - x-amz-version-id: XZEagM4F.sWqXVgDiNUFqKxg_M.QYVlo 03:06:15 INFO - Expected file size: 14409749 03:06:15 INFO - Obtained file size: 14409749 03:06: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')]} 03:06:15 INFO - trying https://queue.taskcluster.net/v1/task/NgeyN7yCSBStUQT6Jh0_Pw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 03:06:15 INFO - Downloading https://queue.taskcluster.net/v1/task/NgeyN7yCSBStUQT6Jh0_Pw/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 03:06:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NgeyN7yCSBStUQT6Jh0_Pw/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 03:06:17 INFO - Downloaded 55653743 bytes. 03:06:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NgeyN7yCSBStUQT6Jh0_Pw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 03:06:17 INFO - mkdir: /builds/slave/test/properties 03:06:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:06:17 INFO - Writing to file /builds/slave/test/properties/build_url 03:06:17 INFO - Contents: 03:06:17 INFO - build_url:https://queue.taskcluster.net/v1/task/NgeyN7yCSBStUQT6Jh0_Pw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 03:06:17 INFO - Running post-action listener: _resource_record_post_action 03:06:17 INFO - Running post-action listener: set_extra_try_arguments 03:06:17 INFO - [mozharness: 2016-11-25 11:06:17.696489Z] Finished download-and-extract step (success) 03:06:17 INFO - [mozharness: 2016-11-25 11:06:17.696714Z] Running populate-webroot step. 03:06:17 INFO - Running pre-action listener: _resource_record_pre_action 03:06:17 INFO - Running main action method: populate_webroot 03:06:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:06:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:06:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:06:17 INFO - '--tppagecycles', 03:06:17 INFO - '7'], 03:06:17 INFO - 'tests': ['tsvgm']}}, 03:06:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:06:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:06:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:06:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:06:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:06:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:06:17 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:06:17 INFO - 'talos_options': ['--disable-e10s'], 03:06:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:06:17 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:06:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:06:17 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:06:17 INFO - 'talos_options': ['--disable-e10s'], 03:06:17 INFO - 'tests': ['damp', 'tps']}, 03:06:17 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:06:17 INFO - 'tests': ['damp', 'tps']}, 03:06:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:06:17 INFO - 'tests': ['dromaeo_dom']}, 03:06:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:06:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:06:17 INFO - 'tests': ['basic_compositor_video']}, 03:06:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:06:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:06:17 INFO - 'tests': ['a11yr', 03:06:17 INFO - 'ts_paint', 03:06:17 INFO - 'tpaint', 03:06:17 INFO - 'sessionrestore', 03:06:17 INFO - 'sessionrestore_no_auto_restore', 03:06:17 INFO - 'tabpaint']}, 03:06:17 INFO - 'other-e10s': {'tests': ['a11yr', 03:06:17 INFO - 'ts_paint', 03:06:17 INFO - 'tpaint', 03:06:17 INFO - 'sessionrestore', 03:06:17 INFO - 'sessionrestore_no_auto_restore', 03:06:17 INFO - 'tabpaint']}, 03:06:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:06:17 INFO - 'ts_paint', 03:06:17 INFO - 'tpaint', 03:06:17 INFO - 'sessionrestore', 03:06:17 INFO - 'sessionrestore_no_auto_restore', 03:06:17 INFO - 'tabpaint']}, 03:06:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:06:17 INFO - 'ts_paint', 03:06:17 INFO - 'tpaint', 03:06:17 INFO - 'sessionrestore', 03:06:17 INFO - 'sessionrestore_no_auto_restore', 03:06:17 INFO - 'tabpaint']}, 03:06:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:06:17 INFO - 'tests': ['a11yr', 03:06:17 INFO - 'ts_paint', 03:06:17 INFO - 'tpaint', 03:06:17 INFO - 'sessionrestore', 03:06:17 INFO - 'sessionrestore_no_auto_restore', 03:06:17 INFO - 'tabpaint']}, 03:06:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:06:17 INFO - 'tests': ['a11yr', 03:06:17 INFO - 'ts_paint', 03:06:17 INFO - 'tpaint', 03:06:17 INFO - 'sessionrestore', 03:06:17 INFO - 'sessionrestore_no_auto_restore', 03:06:17 INFO - 'tabpaint']}, 03:06:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:06:17 INFO - 'tests': ['tsvgx', 03:06:17 INFO - 'tsvgr_opacity', 03:06:17 INFO - 'tart', 03:06:17 INFO - 'tscrollx', 03:06:17 INFO - 'cart', 03:06:17 INFO - 'tsvg_static']}, 03:06:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:06:17 INFO - 'tsvgr_opacity', 03:06:17 INFO - 'tart', 03:06:17 INFO - 'tscrollx', 03:06:17 INFO - 'cart', 03:06:17 INFO - 'tsvg_static']}, 03:06:17 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:06:17 INFO - 'talos_options': ['--disable-e10s'], 03:06:17 INFO - 'tests': ['tp5o']}, 03:06:17 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:06:17 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:06:17 INFO - 'talos_options': ['--disable-e10s', 03:06:17 INFO - '--xperf_path', 03:06:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:06:17 INFO - 'tests': ['tp5n']}, 03:06:17 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:06:17 INFO - 'talos_options': ['--xperf_path', 03:06:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:06:17 INFO - 'tests': ['tp5n']}}, 03:06:17 INFO - 'talos.zip': {'path': '', 03:06:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:06:17 INFO - Running post-action listener: _resource_record_post_action 03:06:17 INFO - [mozharness: 2016-11-25 11:06:17.715114Z] Finished populate-webroot step (success) 03:06:17 INFO - [mozharness: 2016-11-25 11:06:17.715201Z] Running create-virtualenv step. 03:06:17 INFO - Running pre-action listener: _resource_record_pre_action 03:06:17 INFO - Running main action method: create_virtualenv 03:06:17 INFO - Creating virtualenv /builds/slave/test/build/venv 03:06: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 03:06:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:06:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:06:17 INFO - Using real prefix '/usr' 03:06:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:06:18 INFO - Installing distribute.............................................................................................................................................................................................done. 03:06:20 INFO - Installing pip.................done. 03:06:20 INFO - Return code: 0 03:06:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:06:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:06:21 INFO - Reading from file tmpfile_stdout 03:06:21 INFO - Output received: 03:06:21 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 03:06:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:06:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7e338b6e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141eb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ba130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1648fc0>, '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 0x1649ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x164a350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1480071957.308782-1012989989', '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 03:06:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:06:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:06:21 INFO - Using env: {'DISPLAY': ':0', 03:06:21 INFO - 'HOME': '/home/cltbld', 03:06:21 INFO - 'LANG': 'en_US.UTF-8', 03:06:21 INFO - 'LANGUAGE': 'en_US:en', 03:06:21 INFO - 'LOGNAME': 'cltbld', 03:06:21 INFO - 'MAIL': '/var/mail/cltbld', 03:06:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:21 INFO - 'MOZ_NO_REMOTE': '1', 03:06:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:21 INFO - 'NO_EM_RESTART': '1', 03:06:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:21 INFO - 'PWD': '/builds/slave/test', 03:06:21 INFO - 'SHELL': '/bin/bash', 03:06:21 INFO - 'SHLVL': '1', 03:06:21 INFO - 'TERM': 'linux', 03:06:21 INFO - 'TMOUT': '86400', 03:06:21 INFO - 'USER': 'cltbld', 03:06:21 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1480071957.308782-1012989989', 03:06:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:21 INFO - '_': '/tools/buildbot/bin/python'} 03:06:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:21 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:06:21 INFO - Cleaning up... 03:06:21 INFO - Return code: 0 03:06:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:06:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7e338b6e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141eb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ba130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1648fc0>, '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 0x1649ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x164a350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1480071957.308782-1012989989', '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 03:06:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:06:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:06:21 INFO - Using env: {'DISPLAY': ':0', 03:06:21 INFO - 'HOME': '/home/cltbld', 03:06:21 INFO - 'LANG': 'en_US.UTF-8', 03:06:21 INFO - 'LANGUAGE': 'en_US:en', 03:06:21 INFO - 'LOGNAME': 'cltbld', 03:06:21 INFO - 'MAIL': '/var/mail/cltbld', 03:06:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:21 INFO - 'MOZ_NO_REMOTE': '1', 03:06:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:21 INFO - 'NO_EM_RESTART': '1', 03:06:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:21 INFO - 'PWD': '/builds/slave/test', 03:06:21 INFO - 'SHELL': '/bin/bash', 03:06:21 INFO - 'SHLVL': '1', 03:06:21 INFO - 'TERM': 'linux', 03:06:21 INFO - 'TMOUT': '86400', 03:06:21 INFO - 'USER': 'cltbld', 03:06:21 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1480071957.308782-1012989989', 03:06:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:21 INFO - '_': '/tools/buildbot/bin/python'} 03:06:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:21 INFO - Downloading/unpacking psutil>=3.1.1 03:06: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 03:06: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 03:06: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 03:06: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 03:06: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 03:06: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 03:06:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:06:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:06:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:06:23 INFO - Installing collected packages: psutil 03:06:23 INFO - Running setup.py install for psutil 03:06:23 INFO - building 'psutil._psutil_linux' extension 03:06: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 03:06:24 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:06:24 INFO - building 'psutil._psutil_posix' extension 03:06:24 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 03:06:24 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:06:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:06:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:06:25 INFO - Successfully installed psutil 03:06:25 INFO - Cleaning up... 03:06:25 INFO - Return code: 0 03:06:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:06:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7e338b6e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141eb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ba130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1648fc0>, '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 0x1649ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x164a350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1480071957.308782-1012989989', '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 03:06:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:06:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:06:25 INFO - Using env: {'DISPLAY': ':0', 03:06:25 INFO - 'HOME': '/home/cltbld', 03:06:25 INFO - 'LANG': 'en_US.UTF-8', 03:06:25 INFO - 'LANGUAGE': 'en_US:en', 03:06:25 INFO - 'LOGNAME': 'cltbld', 03:06:25 INFO - 'MAIL': '/var/mail/cltbld', 03:06:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:25 INFO - 'MOZ_NO_REMOTE': '1', 03:06:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:25 INFO - 'NO_EM_RESTART': '1', 03:06:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:25 INFO - 'PWD': '/builds/slave/test', 03:06:25 INFO - 'SHELL': '/bin/bash', 03:06:25 INFO - 'SHLVL': '1', 03:06:25 INFO - 'TERM': 'linux', 03:06:25 INFO - 'TMOUT': '86400', 03:06:25 INFO - 'USER': 'cltbld', 03:06:25 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1480071957.308782-1012989989', 03:06:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:25 INFO - '_': '/tools/buildbot/bin/python'} 03:06:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:06:25 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 03:06:25 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 03:06:25 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 03:06:25 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 03:06:25 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 03:06:25 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 03:06:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:06:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:06:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:06:27 INFO - Installing collected packages: mozsystemmonitor 03:06:27 INFO - Running setup.py install for mozsystemmonitor 03:06:27 INFO - Successfully installed mozsystemmonitor 03:06:27 INFO - Cleaning up... 03:06:27 INFO - Return code: 0 03:06:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:06:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:27 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 0x7f7e338b6e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141eb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ba130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1648fc0>, '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 0x1649ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x164a350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1480071957.308782-1012989989', '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 03:06:27 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 03:06:27 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 03:06:27 INFO - Using env: {'DISPLAY': ':0', 03:06:27 INFO - 'HOME': '/home/cltbld', 03:06:27 INFO - 'LANG': 'en_US.UTF-8', 03:06:27 INFO - 'LANGUAGE': 'en_US:en', 03:06:27 INFO - 'LOGNAME': 'cltbld', 03:06:27 INFO - 'MAIL': '/var/mail/cltbld', 03:06:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:27 INFO - 'MOZ_NO_REMOTE': '1', 03:06:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:27 INFO - 'NO_EM_RESTART': '1', 03:06:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:27 INFO - 'PWD': '/builds/slave/test', 03:06:27 INFO - 'SHELL': '/bin/bash', 03:06:27 INFO - 'SHLVL': '1', 03:06:27 INFO - 'TERM': 'linux', 03:06:27 INFO - 'TMOUT': '86400', 03:06:27 INFO - 'USER': 'cltbld', 03:06:27 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1480071957.308782-1012989989', 03:06:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:27 INFO - '_': '/tools/buildbot/bin/python'} 03:06:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:27 INFO - Downloading/unpacking jsonschema==2.5.1 03:06:27 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 03:06:27 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 03:06:27 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 03:06:27 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 03:06:27 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 03:06:27 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 03:06:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:06:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:06: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 03:06: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 03:06: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 03:06: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 03:06: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 03:06: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 03:06:30 INFO - Downloading functools32-3.2.3-2.tar.gz 03:06:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:06:30 INFO - warning: no files found matching '*.txt' 03:06:30 INFO - no previously-included directories found matching 'build' 03:06:30 INFO - no previously-included directories found matching 'dist' 03:06:30 INFO - no previously-included directories found matching '.git*' 03:06:30 INFO - Installing collected packages: jsonschema, functools32 03:06:30 INFO - Running setup.py install for functools32 03:06:30 INFO - warning: no files found matching '*.txt' 03:06:30 INFO - no previously-included directories found matching 'build' 03:06:30 INFO - no previously-included directories found matching 'dist' 03:06:30 INFO - no previously-included directories found matching '.git*' 03:06:30 INFO - Successfully installed jsonschema functools32 03:06:30 INFO - Cleaning up... 03:06:30 INFO - Return code: 0 03:06:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:06:30 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')]} 03:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:30 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')]} 03:06:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:30 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 0x7f7e338b6e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141eb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ba130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1648fc0>, '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 0x1649ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x164a350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1480071957.308782-1012989989', '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 03:06:30 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 03:06:30 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 03:06:30 INFO - Using env: {'DISPLAY': ':0', 03:06:30 INFO - 'HOME': '/home/cltbld', 03:06:30 INFO - 'LANG': 'en_US.UTF-8', 03:06:30 INFO - 'LANGUAGE': 'en_US:en', 03:06:30 INFO - 'LOGNAME': 'cltbld', 03:06:30 INFO - 'MAIL': '/var/mail/cltbld', 03:06:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:30 INFO - 'MOZ_NO_REMOTE': '1', 03:06:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:30 INFO - 'NO_EM_RESTART': '1', 03:06:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:30 INFO - 'PWD': '/builds/slave/test', 03:06:30 INFO - 'SHELL': '/bin/bash', 03:06:30 INFO - 'SHLVL': '1', 03:06:30 INFO - 'TERM': 'linux', 03:06:30 INFO - 'TMOUT': '86400', 03:06:30 INFO - 'USER': 'cltbld', 03:06:30 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1480071957.308782-1012989989', 03:06:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:30 INFO - '_': '/tools/buildbot/bin/python'} 03:06:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:06:30 INFO - Cleaning up... 03:06:30 INFO - Return code: 0 03:06:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:06:30 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')]} 03:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:30 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')]} 03:06:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:30 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 0x7f7e338b6e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141eb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ba130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1648fc0>, '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 0x1649ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x164a350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1480071957.308782-1012989989', '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 03:06:30 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 03:06:30 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 03:06:30 INFO - Using env: {'DISPLAY': ':0', 03:06:30 INFO - 'HOME': '/home/cltbld', 03:06:30 INFO - 'LANG': 'en_US.UTF-8', 03:06:30 INFO - 'LANGUAGE': 'en_US:en', 03:06:30 INFO - 'LOGNAME': 'cltbld', 03:06:30 INFO - 'MAIL': '/var/mail/cltbld', 03:06:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:30 INFO - 'MOZ_NO_REMOTE': '1', 03:06:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:30 INFO - 'NO_EM_RESTART': '1', 03:06:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:30 INFO - 'PWD': '/builds/slave/test', 03:06:30 INFO - 'SHELL': '/bin/bash', 03:06:30 INFO - 'SHLVL': '1', 03:06:30 INFO - 'TERM': 'linux', 03:06:30 INFO - 'TMOUT': '86400', 03:06:30 INFO - 'USER': 'cltbld', 03:06:30 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1480071957.308782-1012989989', 03:06:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:30 INFO - '_': '/tools/buildbot/bin/python'} 03:06:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:30 INFO - Downloading/unpacking blobuploader==1.2.4 03:06:30 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 03:06:30 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 03:06:30 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 03:06:30 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 03:06:30 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 03:06:30 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 03:06:32 INFO - Downloading blobuploader-1.2.4.tar.gz 03:06:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:06:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:06: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 03:06: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 03:06: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 03:06: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 03:06: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 03:06: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 03:06:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:06:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:06:33 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 03:06:33 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 03:06:33 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 03:06:33 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 03:06:33 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 03:06:33 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 03:06:33 INFO - Downloading docopt-0.6.1.tar.gz 03:06:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:06:33 INFO - Installing collected packages: blobuploader, requests, docopt 03:06:33 INFO - Running setup.py install for blobuploader 03:06:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:06:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:06:33 INFO - Running setup.py install for requests 03:06:34 INFO - Running setup.py install for docopt 03:06:34 INFO - Successfully installed blobuploader requests docopt 03:06:34 INFO - Cleaning up... 03:06:34 INFO - Return code: 0 03:06:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:06:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:34 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 0x7f7e338b6e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141eb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ba130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1648fc0>, '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 0x1649ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x164a350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1480071957.308782-1012989989', '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 03:06:34 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 03:06:34 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 03:06:34 INFO - Using env: {'DISPLAY': ':0', 03:06:34 INFO - 'HOME': '/home/cltbld', 03:06:34 INFO - 'LANG': 'en_US.UTF-8', 03:06:34 INFO - 'LANGUAGE': 'en_US:en', 03:06:34 INFO - 'LOGNAME': 'cltbld', 03:06:34 INFO - 'MAIL': '/var/mail/cltbld', 03:06:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:34 INFO - 'MOZ_NO_REMOTE': '1', 03:06:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:34 INFO - 'NO_EM_RESTART': '1', 03:06:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:34 INFO - 'PWD': '/builds/slave/test', 03:06:34 INFO - 'SHELL': '/bin/bash', 03:06:34 INFO - 'SHLVL': '1', 03:06:34 INFO - 'TERM': 'linux', 03:06:34 INFO - 'TMOUT': '86400', 03:06:34 INFO - 'USER': 'cltbld', 03:06:34 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1480071957.308782-1012989989', 03:06:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:34 INFO - '_': '/tools/buildbot/bin/python'} 03:06:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:06:34 INFO - Running setup.py (path:/tmp/pip-JeZQuE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:06:34 INFO - Running setup.py (path:/tmp/pip-gyaPl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:06:34 INFO - Running setup.py (path:/tmp/pip-J7LQIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:06:34 INFO - Running setup.py (path:/tmp/pip-72HWWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:06:34 INFO - Running setup.py (path:/tmp/pip-ja413C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:06:34 INFO - Running setup.py (path:/tmp/pip-dTg5lr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:06:34 INFO - Running setup.py (path:/tmp/pip-s9_WCJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:06:35 INFO - Running setup.py (path:/tmp/pip-ychFWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:06:35 INFO - Running setup.py (path:/tmp/pip-xQhh8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:06:35 INFO - Running setup.py (path:/tmp/pip-KVKUEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:06:35 INFO - Running setup.py (path:/tmp/pip-SLoKWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:06:35 INFO - Running setup.py (path:/tmp/pip-ufSVLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:06:35 INFO - Running setup.py (path:/tmp/pip-BOVlH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:06:35 INFO - Running setup.py (path:/tmp/pip-wPTaiV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:06:35 INFO - Running setup.py (path:/tmp/pip-eu9wbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:06:35 INFO - Running setup.py (path:/tmp/pip-zi9vQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:06:35 INFO - Running setup.py (path:/tmp/pip-ZVe8v6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:06:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:06:35 INFO - Running setup.py install for manifestparser 03:06:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:06:35 INFO - Running setup.py install for mozcrash 03:06:35 INFO - Running setup.py install for mozdebug 03:06:36 INFO - Running setup.py install for mozdevice 03:06:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:06:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:06:36 INFO - Running setup.py install for mozfile 03:06:36 INFO - Running setup.py install for mozhttpd 03:06:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:06:36 INFO - Running setup.py install for mozinfo 03:06:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:06:36 INFO - Running setup.py install for mozInstall 03:06:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:06:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:06:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:06:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:06:36 INFO - Running setup.py install for mozleak 03:06:36 INFO - Running setup.py install for mozlog 03:06:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:06:36 INFO - Running setup.py install for moznetwork 03:06:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:06:36 INFO - Running setup.py install for mozprocess 03:06:36 INFO - Running setup.py install for mozprofile 03:06:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:06:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:06:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:06:37 INFO - Running setup.py install for mozrunner 03:06:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:06:37 INFO - Running setup.py install for mozscreenshot 03:06:37 INFO - Running setup.py install for moztest 03:06:37 INFO - Running setup.py install for mozversion 03:06:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:06:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:06:37 INFO - Cleaning up... 03:06:37 INFO - Return code: 0 03:06:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:06:37 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')]} 03:06:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:37 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')]} 03:06:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:37 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 0x7f7e338b6e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141eb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ba130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1648fc0>, '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 0x1649ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x164a350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1480071957.308782-1012989989', '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 03:06:37 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 03:06:37 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 03:06:37 INFO - Using env: {'DISPLAY': ':0', 03:06:37 INFO - 'HOME': '/home/cltbld', 03:06:37 INFO - 'LANG': 'en_US.UTF-8', 03:06:37 INFO - 'LANGUAGE': 'en_US:en', 03:06:37 INFO - 'LOGNAME': 'cltbld', 03:06:37 INFO - 'MAIL': '/var/mail/cltbld', 03:06:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:37 INFO - 'MOZ_NO_REMOTE': '1', 03:06:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:37 INFO - 'NO_EM_RESTART': '1', 03:06:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:37 INFO - 'PWD': '/builds/slave/test', 03:06:37 INFO - 'SHELL': '/bin/bash', 03:06:37 INFO - 'SHLVL': '1', 03:06:37 INFO - 'TERM': 'linux', 03:06:37 INFO - 'TMOUT': '86400', 03:06:37 INFO - 'USER': 'cltbld', 03:06:37 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1480071957.308782-1012989989', 03:06:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:37 INFO - '_': '/tools/buildbot/bin/python'} 03:06:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:06:37 INFO - Running setup.py (path:/tmp/pip-rntKCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:06:37 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)) 03:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:06:37 INFO - Running setup.py (path:/tmp/pip-uIavJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:06:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:06:37 INFO - Running setup.py (path:/tmp/pip-Oho4Rl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:06:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:06:37 INFO - Running setup.py (path:/tmp/pip-c25sEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:06:38 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)) 03:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:06:38 INFO - Running setup.py (path:/tmp/pip-kHRPeX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:06:38 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)) 03:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:06:38 INFO - Running setup.py (path:/tmp/pip-zC91pT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:06:38 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)) 03:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:06:38 INFO - Running setup.py (path:/tmp/pip-Ob3t78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:06:38 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)) 03:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:06:38 INFO - Running setup.py (path:/tmp/pip-K64d69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:06:38 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)) 03:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:06:38 INFO - Running setup.py (path:/tmp/pip-rpWojQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:06:38 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)) 03:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:06:38 INFO - Running setup.py (path:/tmp/pip-7fb2Ie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:06:38 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)) 03:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:06:38 INFO - Running setup.py (path:/tmp/pip-hr89p6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:06:38 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)) 03:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:06:38 INFO - Running setup.py (path:/tmp/pip-IQN26k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:06:38 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)) 03:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:06:38 INFO - Running setup.py (path:/tmp/pip-Tm_MhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:06:38 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)) 03:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:06:38 INFO - Running setup.py (path:/tmp/pip-yMagff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:06:38 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)) 03:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:06:38 INFO - Running setup.py (path:/tmp/pip-KbH9TV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:06:38 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)) 03:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:06:38 INFO - Running setup.py (path:/tmp/pip-rsE5Ne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:06:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:06:38 INFO - Running setup.py (path:/tmp/pip-qADs9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:06:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:06:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:06:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:06:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:06:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:06:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:06:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:06:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:06:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:06:40 INFO - Downloading blessings-1.6.tar.gz 03:06:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:06:41 INFO - Installing collected packages: blessings 03:06:41 INFO - Running setup.py install for blessings 03:06:41 INFO - Successfully installed blessings 03:06:41 INFO - Cleaning up... 03:06:41 INFO - Return code: 0 03:06:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:06:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:06:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:06:41 INFO - Reading from file tmpfile_stdout 03:06:41 INFO - Current package versions: 03:06:41 INFO - argparse == 1.2.1 03:06:41 INFO - blessings == 1.6 03:06:41 INFO - blobuploader == 1.2.4 03:06:41 INFO - docopt == 0.6.1 03:06:41 INFO - functools32 == 3.2.3-2 03:06:41 INFO - jsonschema == 2.5.1 03:06:41 INFO - manifestparser == 1.1 03:06:41 INFO - mozInstall == 1.12 03:06:41 INFO - mozcrash == 1.0 03:06:41 INFO - mozdebug == 0.1 03:06:41 INFO - mozdevice == 0.49 03:06:41 INFO - mozfile == 1.2 03:06:41 INFO - mozhttpd == 0.7 03:06:41 INFO - mozinfo == 0.9 03:06:41 INFO - mozleak == 0.1 03:06:41 INFO - mozlog == 3.4 03:06:41 INFO - moznetwork == 0.27 03:06:41 INFO - mozprocess == 0.23 03:06:41 INFO - mozprofile == 0.28 03:06:41 INFO - mozrunner == 6.13 03:06:41 INFO - mozscreenshot == 0.1 03:06:41 INFO - mozsystemmonitor == 0.3 03:06:41 INFO - moztest == 0.7 03:06:41 INFO - mozversion == 1.4 03:06:41 INFO - psutil == 3.1.1 03:06:41 INFO - requests == 1.2.3 03:06:41 INFO - wsgiref == 0.1.2 03:06:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:06:41 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')]} 03:06:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:41 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')]} 03:06:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:41 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 0x7f7e338b6e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141eb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ba130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1648fc0>, '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 0x1649ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x164a350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1480071957.308782-1012989989', '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 03:06:41 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 03:06:41 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 03:06:41 INFO - Using env: {'DISPLAY': ':0', 03:06:41 INFO - 'HOME': '/home/cltbld', 03:06:41 INFO - 'LANG': 'en_US.UTF-8', 03:06:41 INFO - 'LANGUAGE': 'en_US:en', 03:06:41 INFO - 'LOGNAME': 'cltbld', 03:06:41 INFO - 'MAIL': '/var/mail/cltbld', 03:06:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:41 INFO - 'MOZ_NO_REMOTE': '1', 03:06:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:41 INFO - 'NO_EM_RESTART': '1', 03:06:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:41 INFO - 'PWD': '/builds/slave/test', 03:06:41 INFO - 'SHELL': '/bin/bash', 03:06:41 INFO - 'SHLVL': '1', 03:06:41 INFO - 'TERM': 'linux', 03:06:41 INFO - 'TMOUT': '86400', 03:06:41 INFO - 'USER': 'cltbld', 03:06:41 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1480071957.308782-1012989989', 03:06:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:41 INFO - '_': '/tools/buildbot/bin/python'} 03:06:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:41 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)) 03:06:41 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)) 03:06:41 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)) 03:06:41 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)) 03:06:41 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)) 03:06:41 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)) 03:06:41 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)) 03:06:41 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)) 03:06:41 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)) 03:06:41 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)) 03:06:41 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)) 03:06:41 INFO - Cleaning up... 03:06:41 INFO - Return code: 0 03:06:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:06:41 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')]} 03:06:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:41 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')]} 03:06:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:41 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 0x7f7e338b6e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141eb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ba130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1648fc0>, '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 0x1649ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x164a350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1480071957.308782-1012989989', '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 03:06:41 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 03:06:41 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 03:06:41 INFO - Using env: {'DISPLAY': ':0', 03:06:41 INFO - 'HOME': '/home/cltbld', 03:06:41 INFO - 'LANG': 'en_US.UTF-8', 03:06:41 INFO - 'LANGUAGE': 'en_US:en', 03:06:41 INFO - 'LOGNAME': 'cltbld', 03:06:41 INFO - 'MAIL': '/var/mail/cltbld', 03:06:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:41 INFO - 'MOZ_NO_REMOTE': '1', 03:06:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:41 INFO - 'NO_EM_RESTART': '1', 03:06:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:41 INFO - 'PWD': '/builds/slave/test', 03:06:41 INFO - 'SHELL': '/bin/bash', 03:06:41 INFO - 'SHLVL': '1', 03:06:41 INFO - 'TERM': 'linux', 03:06:41 INFO - 'TMOUT': '86400', 03:06:41 INFO - 'USER': 'cltbld', 03:06:41 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1480071957.308782-1012989989', 03:06:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:41 INFO - '_': '/tools/buildbot/bin/python'} 03:06:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:06:41 INFO - Cleaning up... 03:06:41 INFO - Return code: 0 03:06:41 INFO - Running post-action listener: _resource_record_post_action 03:06:41 INFO - Running post-action listener: _start_resource_monitoring 03:06:41 INFO - Starting resource monitoring. 03:06:41 INFO - [mozharness: 2016-11-25 11:06:41.938203Z] Finished create-virtualenv step (success) 03:06:41 INFO - [mozharness: 2016-11-25 11:06:41.938672Z] Running install step. 03:06:41 INFO - Running pre-action listener: _resource_record_pre_action 03:06:41 INFO - Running main action method: install 03:06:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:06:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:06:42 INFO - Reading from file tmpfile_stdout 03:06:42 INFO - Detecting whether we're running mozinstall >=1.0... 03:06:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:06:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:06:42 INFO - Reading from file tmpfile_stdout 03:06:42 INFO - Output received: 03:06:42 INFO - Usage: mozinstall [options] installer 03:06:42 INFO - Options: 03:06:42 INFO - -h, --help show this help message and exit 03:06:42 INFO - -d DEST, --destination=DEST 03:06:42 INFO - Directory to install application into. [default: 03:06:42 INFO - "/builds/slave/test"] 03:06:42 INFO - --app=APP Application being installed. [default: firefox] 03:06:42 INFO - mkdir: /builds/slave/test/build/application 03:06:42 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'] 03:06:42 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 03:06:58 INFO - Reading from file tmpfile_stdout 03:06:58 INFO - Output received: 03:06:58 INFO - /builds/slave/test/build/application/firefox/firefox 03:06:58 INFO - Running post-action listener: _resource_record_post_action 03:06:58 INFO - [mozharness: 2016-11-25 11:06:58.269093Z] Finished install step (success) 03:06:58 INFO - [mozharness: 2016-11-25 11:06:58.269337Z] Running run-tests step. 03:06:58 INFO - Running pre-action listener: _resource_record_pre_action 03:06:58 INFO - Running main action method: run_tests 03:06:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:06:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:06:58 INFO - Python 2.7.3 03:06:58 INFO - Return code: 0 03:06:58 INFO - grabbing minidump binary from tooltool 03:06:58 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')]} 03:06:58 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 0x1648fc0>, '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 0x1649ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x164a350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:06:58 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 03:06:58 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 03:06:58 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 03:06:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:06:58 INFO - Return code: 0 03:06:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:06:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:06:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:06:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:06:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:06:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NgeyN7yCSBStUQT6Jh0_Pw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:06:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Cedar --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NgeyN7yCSBStUQT6Jh0_Pw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:06:58 INFO - Using env: {'DISPLAY': ':0', 03:06:58 INFO - 'HOME': '/home/cltbld', 03:06:58 INFO - 'LANG': 'en_US.UTF-8', 03:06:58 INFO - 'LANGUAGE': 'en_US:en', 03:06:58 INFO - 'LOGNAME': 'cltbld', 03:06:58 INFO - 'MAIL': '/var/mail/cltbld', 03:06:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:06:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:06:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:58 INFO - 'MOZ_NO_REMOTE': '1', 03:06:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:06:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:58 INFO - 'NO_EM_RESTART': '1', 03:06:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:58 INFO - 'PWD': '/builds/slave/test', 03:06:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:06:58 INFO - 'SHELL': '/bin/bash', 03:06:58 INFO - 'SHLVL': '1', 03:06:58 INFO - 'TERM': 'linux', 03:06:58 INFO - 'TMOUT': '86400', 03:06:58 INFO - 'USER': 'cltbld', 03:06:58 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1480071957.308782-1012989989', 03:06:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:58 INFO - '_': '/tools/buildbot/bin/python'} 03:06:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NgeyN7yCSBStUQT6Jh0_Pw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:06:58 INFO - mozversion application_buildid: 20161125015119 03:06:58 INFO - mozversion application_changeset: 1d31baa686c55268e4ec5364704b8ea5d7c33fe2 03:06:58 INFO - mozversion application_display_name: Nightly 03:06:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:06:58 INFO - mozversion application_name: Firefox 03:06:58 INFO - mozversion application_remotingname: firefox 03:06:58 INFO - mozversion application_repository: https://hg.mozilla.org/projects/cedar 03:06:58 INFO - mozversion application_vendor: Mozilla 03:06:58 INFO - mozversion application_version: 53.0a1 03:06:58 INFO - mozversion platform_buildid: 20161125015119 03:06:58 INFO - mozversion platform_changeset: 1d31baa686c55268e4ec5364704b8ea5d7c33fe2 03:06:58 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/cedar 03:06:58 INFO - mozversion platform_version: 53.0a1 03:06:58 INFO - using testdate: 1480072018 03:06:58 INFO - actual date: 1480072018 03:06:58 INFO - starting webserver on 'localhost:44100' 03:06:58 INFO - SUITE-START | Running 2 tests 03:06:58 INFO - TEST-START | dromaeo_css 03:06:58 INFO - operating with platform_type : linux_ 03:06:58 INFO - Initialising browser for dromaeo_css test... 03:06:58 INFO - TEST-INFO | started process 3309 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZYZ4w1/profile http://localhost:44100/getInfo.html) 03:07:04 INFO - PROCESS | 3309 | __metrics Screen width/height:1600/1200 03:07:04 INFO - PROCESS | 3309 | colorDepth:24 03:07:04 INFO - PROCESS | 3309 | Browser inner width/height: 1024/697 03:07:04 INFO - PROCESS | 3309 | __metrics 03:07:05 INFO - PROCESS | 3309 | 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" 03:07:05 INFO - PROCESS | 3309 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:07:06 INFO - TEST-INFO | 3309: exit 0 03:07:06 INFO - Browser initialized. 03:07:06 INFO - Running cycle 1/1 for dromaeo_css test... 03:07:06 INFO - TEST-INFO | started process 3392 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZYZ4w1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:07:19 INFO - PROCESS | 3392 | RSS: Main: 174796800 03:07:19 INFO - PROCESS | 3392 | 03:08:11 INFO - PROCESS | 3392 | 1480072091028 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] 03:10:23 INFO - PROCESS | 3392 | Cycle 1(1): loaded http://localhost:44100/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44100/tests/dromaeo/cssquery-ext.html) 03:10:26 INFO - PROCESS | 3392 | RSS: Main: 391933952 03:10:26 INFO - PROCESS | 3392 | 03:13:29 INFO - PROCESS | 3392 | Cycle 1(1): loaded http://localhost:44100/tests/dromaeo/cssquery-ext.html (next: http://localhost:44100/tests/dromaeo/cssquery-jquery.html) 03:13:29 INFO - PROCESS | 3392 | RSS: Main: 288862208 03:13:29 INFO - PROCESS | 3392 | 03:16:32 INFO - PROCESS | 3392 | Cycle 1(1): loaded http://localhost:44100/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44100/tests/dromaeo/cssquery-mootools.html) 03:16:32 INFO - PROCESS | 3392 | RSS: Main: 218497024 03:16:32 INFO - PROCESS | 3392 | 03:19:34 INFO - PROCESS | 3392 | Cycle 1(1): loaded http://localhost:44100/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44100/tests/dromaeo/cssquery-prototype.html) 03:19:35 INFO - PROCESS | 3392 | RSS: Main: 229838848 03:19:35 INFO - PROCESS | 3392 | 03:22:38 INFO - PROCESS | 3392 | Cycle 1(1): loaded http://localhost:44100/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44100/tests/dromaeo/cssquery-yui.html) 03:22:39 INFO - PROCESS | 3392 | RSS: Main: 221913088 03:22:39 INFO - PROCESS | 3392 | 03:25:42 INFO - PROCESS | 3392 | Cycle 1(1): loaded http://localhost:44100/tests/dromaeo/cssquery-yui.html (next: http://localhost:44100/tests/dromaeo/cssquery-dojo.html) 03:25:42 INFO - PROCESS | 3392 | RSS: Main: 313020416 03:25:42 INFO - PROCESS | 3392 | 03:25:42 INFO - PROCESS | 3392 | __start_tp_report 03:25:42 INFO - PROCESS | 3392 | _x_x_mozilla_page_load 03:25:42 INFO - PROCESS | 3392 | _x_x_mozilla_page_load_details 03:25:42 INFO - PROCESS | 3392 | |i|pagename|runs| 03:25:42 INFO - PROCESS | 3392 | |0;dojo.html;2540.784033357165;2583.6641236639234;2597.870106494676;2612.085769980507;2618.136015115012;4516.480604730457;4547.226971414859;4624.1214169307805;4662.626989840813;4680.6957547759375;4611.285250786125;4624.306354046895;4657.650676199281;4691.624670026398;4746.738929358884;4232.619064284214;4257.340112282585;4297.269464191095;4330.935035974463;4377.737335759864;3947.272382231442;4268.509121451027;4357.4771027476745;4405.207062728708;4444.266695995173;4195.685323600712;4244.533101358848;4337.742054804135;4396.120775844844;4409.228385032622;4242.448481697391;4280.700350975433;4281.721688090264;4285.271503844354;4358.346248062816;4269.615734583871;4276.978615106936;4277.700560960734;4280.101178752466;4323.048929235563;4611.838585649486;4649.418822647169;4655.906881862377;4682.578567928903;4702.905941881178;4818.397700287464;4855.83004594841;4869.269609558559;4881.633877459205;4905.337779399771;4955.801767929279;4963.950360496385;4989.451160372356;4991.4758950310425;5000.549950504472;4636.374089497942;4638.61813205883;4655.650826188049;4663.207254766698;4686.671932964728;4864.246041863516;4951.034548263054;5080.898382032338;5086.54221120101;5127.435982041972;4825.5898248649255;4847.878803029882;4874.171390863562;4899.681520701143;4913.803447862046;4918.065567542156;4935.333729946483;4946.950530494721;4967.801287948514;4981.103401387785;4848.1366275037835;4870.0746858096845;4880.6095512358925;4889.437714662859;4939.654224204343;4721.811127554859;4781.832635857798;4782.52174782519;4841.370621819141;4846.29728689338;4112.300908845504;4140.896477588024;4144.7513149211145;4145;4145.79271036447;3691.427828686558;3701.463287823304;3705.888823335304;3711.1649878777057;3711.6102809205186;4268.146370725867;4269.295566231537;4275.3800698898485;4277.508086570022;4277.978610106929;4884.535969083003;4943.604511639061;4946.1344264753525;4951.356323677899;4968.900621987612;4282.828686852491;4299;4324.070324880166;4330.978345108254;4346.565343465628;4456.844010459618;4459.1304695584695;4463.464384273843;4469.888252793641;4510.323451482304;4681.555252251031;4682.695624784446;4684.273937539687;4687.367205427224;4731.1720448921305;4835.975820120877;4896.902061958812;4897.8285759998225;4961.950380496149;4965.4289756677;4650.069986002745;4670.3695001175765;4682.859514214579;4684.953150468452;4688.132695451352;4885.364902562644;4885.65800393969;4888.388951381077;4889.9022019560125;4890.731009794496;4946.802127914987;4950.158473059517;4952.975235123801;4953.1579631463455;4956.900861982812;4800.3759511263315;4825.276208568603;4826.420829500342;4839.443464001685;4845.733484658378;4863.878403039952;4874.195757700081;4875.8049678012485;4896.143174944442;4915.606751459946;4672.976635116803;4751.809927602857;4765.666403351732;4778.068276686013;4817.325574419514;4700.741459219776;4850.223964165716;4896.828610998598;4897.975510122426;4955.2567114933045;4646.349511068385;4707.411573553306;4721.079389519011;4768.785404656868;4828.517148285144 03:25:42 INFO - PROCESS | 3392 | |1;ext.html;554.7475898466198;556.4435564435564;558.0930987145888;564.4468420947471;567.9943200567994;36056.09859753504;37611.43582846259;37906.431403528935;42759;42788.35817462733;38757.612423875755;38991.22017559647;39068.413973790346;39088.21823563527;39189.60810391895;7292.8906066409045;7502.88745668814;7650.923490765077;7652.31129198372;7653.425993050516;7313.561186328838;9534;9801.803963920718;9817.50912454378;10198.286119971604;9944.850827237597;10003.199744020498;10010.949945250264;10012.449315287657;10019.849702254473;9804.558794854249;9862.90137098627;9866.457344845994;9866.950665246699;9881.752956176082;9783.119519243302;9796.804063918753;9807.509624518745;9865.1614612758;9871.309008369417;36275.81862090699;36675.633243667755;36710;36717.81641091804;36739.81630091859;3010.6838781928022;3152.936941261185;3266;3518.841652125635;3687.9631203687886;27374.315642108908;27563.862180689168;27931.72068279332;27973.580396294074;28065.15804525847;3061.311204978862;3087.922801929947;3103.7361824244967;3213.453712868818;3213.935721285561;167569;168526;168611;168881.15559422123;169063;50420.74789626028;50514;50643;50742;50752;52253.477465225624;52311.73844130831;52348.738256308476;52360;52800.207996880075;14387.712245755236;14700.632484187981;14753.188574628284;14783.852161478248;14803.92598037003;8791.604377803014;8981.730548083568;10966.670999870017;11522.13583981188;11601.303921764722;15248.771268430983;15639.843601563838;15667.608309792346;15668.138252396227;15896.602584935237;6307.590006649553;6321.399467050623;6440;6458.967705161538;6541.443977261891;780.777478418648;872.5724395046382;901.1664210605295;963.9807203855884;1013.2812577839347;26764.732352676223;27065.889789254732;27614.861925690242;27856.582151267747;27937.720622793917;952.7570469530364;953.3421938862163;973.9951300243595;983.8130755156498;1033.5917312661456;13735.24456154921;14408.639784005483;14432.206228657524;14668.413263469554;14679.339429725687;104783;104792;104852;105047;105819.47090264653;47081.29378059332;47296.763516182196;47405.52594474011;47419.76290118528;47491.52508474871;1150.5340337163461;1181.7931861924128;1196.4137572589543;1197.6227488341144;1208.5165933626445;25698;25941.481170376865;26065.348366290993;26447.742406002606;27001.459970800868;41162.38256426096;41475.26722594981;41511.7924410376;41545.37681934834;41552.58447415487;311320;311731;312066;312453;312859;28975.855120725104;30344.54483182798;32402;32972.67027329696;35055.82472087623;36166;38961.41557876577;39401.60598394094;40453.1909361817;40544.594554054085;31850.362992739552;33876.49185262174;34267.82866085654;34323.4851477233;35414.82292588521;33400;33415.66584334125;33909.830450847585;33966.150846229044;34245.486317705756;33612.66387336095;34252.31495370029;34370.48444273288;34415.139621508664;34687.479687804196;30133.547996779627;30643;31008.53487197739;31011.224719382197;31329.53005704962;24099;24545.63181552314;24561.385965351008;24656.87671561631;24769.752302476743 03:25:42 INFO - PROCESS | 3392 | |2;jquery.html;344.4798354484729;350.5582965463515;350.9526213961115;354.3922173472494;366.69564261662805;15551.144687042208;16382.754258686115;17448;17540.649187016254;17714.999999999985;16008.83991160088;16732.916335418337;16762.83237167628;17006.744898826528;17020;4791.51463046455;5119.667221630601;5121.718305493197;5122.590192784568;5123.385193776733;3697.242065376591;3895.357266051112;3896.7272290939645;3940.8226629801584;4983.900321993558;3888.552816426119;5597.748101335429;5908.527317814586;5914.585978981473;6016.4885984691355;5796.420357964212;5978.312494063195;6012.128241404972;6012.398760123996;6016.729247183844;5248.160294352885;5256.316678831766;5257.5005374489365;5258.763355649005;5259.0796610593;19834.305799296955;20216.898915505477;20305.086271117834;20424;20462.79537204624;1731.852792512638;1862.5809192931617;1886.0098448314607;1918.7217853411316;1925.913333899978;8678.970301741472;8844;9149.359544831865;9186;9375.437473751597;1661.858742006931;1714.1172296267432;1728.766616506768;1738.8956662600158;1740.4343588333716;62816.37183628151;64621.353786462474;64688.353116469174;64894;65180;9596.66411675588;9661.323707340418;9888.204220952832;9905.356151850106;10118.848217276747;13390.196588204739;13414.865851341361;13426.865731342561;13432.126911750705;13437.462501500026;7148.106486689164;7414.666340014713;7473.701051957861;7552.8867066994035;7642.7325043623205;7187.748428804966;7223.458240631973;7370.152432470228;7408.481406301507;7502.2122677119205;4085.71400001997;4223;4226.281532139482;4325.870223893288;4376.059147283286;1386.2583517817918;1521.37623574334;1755.5786611213216;1765.2056574541507;1780.2789870102629;811.4887620798859;823.7405217356513;855.4567849415666;861.2998250484775;904.5748498205833;15844.841551584566;16678.66642667164;16727.665446690997;16772.832271677373;17416.825831741775;849.9490030598184;868.4181598329135;870.8780770692108;873.5370253765515;897.6499165325529;9103.271738261055;9614.663486777928;9627.085426884434;9651.90348096524;9862.260330475243;322956;328197;328451;328647;330499;71167.2883271171;72287.63856180686;72483.55032899418;72546.9117963231;72954.63522682458;778.4473024152802;845.4082142500151;862.9870551941726;865.9956700216459;867.4014929698487;13349.399277032362;14662.560123196321;14874.925625372236;15614.531564053097;16243.837561624232;33711.83144084362;34547.48178777371;37739;38510.6148938507;38970.80514597409;48592.271115933996;49259.507404926924;49724.751376242886;49872;50597.24104138367;7001.089858318386;7206.4234861209925;7484.850302993801;7604.12552556441;7663.888736133341;10200.642977495752;11486.483108259981;11636.883631163919;11819.409029548317;12011;6381.4835745351465;8670.523121228392;9663.323567350219;10089.445080520642;10172.08451239392;9675.612975480903;9843.950780246052;10261.486925653538;10442.164626829683;10597.841032384365;9973.850392243978;10010.249231307535;10032.347897386646;10331.741706457398;10375.429351385746;7625.809354766176;7744.6902123914415;7785.299323060952;7859.253370929752;7951.801204969691;8779.912200878165;9383.577739001897;9768.120869121813;9935.701928942144;10166.237532185263 03:25:42 INFO - PROCESS | 3392 | |3;mootools.html;1328.9401976911038;1357.511295933464;1405.5431984605;1618.5144456662997;1642.014791125325;6552.67236638168;6951.860962780754;6961.860762784741;6962;6968.2334943156275;6041.939580604193;6319.684015799203;6525.706343214555;6829;6833.589984600915;2025.3215172917053;2087.9164833406644;2090.341542414142;2090.3728881335614;2091.111277706976;1797.1643185918545;2064.225915281769;2074.195449958538;2083.052211243888;2098.7481502219757;1831.3590243414765;1961.8920959347302;2018.3238615063972;2031.97385320413;2041.9795802042013;2030.4517780199337;2034.1558253324852;2034.562569047647;2037.5721098569318;2038.622854771872;2017.5057111007898;2049.5900819836093;2059.680749483832;2059.804318589732;2068.803463670949;6873.140857392826;6935.861282774366;6936.028955946172;6938.41023512997;6947.166340039177;3937.4290727844586;4073.8370465181356;4074.388841673743;4075.49056367954;4078.775667338295;2496.1388321029217;2607.2438992692096;2672.9331766705795;2678.236702539786;2681.5441374966304;810.3274282345639;820.958952052401;834.649447232164;873.1486800369589;873.4279047224078;8791.340649451316;8821.911780882174;8864.024957254696;8865.778355541162;8909.1536304051;3556.48430977512;3729.813509324523;3805.82873770681;3813.0848596336677;3816.961830381716;7928.524288542706;7930.881036784453;7934.642941067666;7952.602369881482;7964.442489025712;4251.511076226212;4253.064325848309;4255.76593287366;4257.1698518788535;4261.382099595541;3637.1634524059086;3715.6098609646137;3783.564890037681;3784.5836957934607;3788.734788564829;3113.641931177898;3148.464760990637;3167.4140284047526;3178.570892929471;3190.202449387653;988.6737376665683;1016.0398423489731;1022.4734261855151;1037.1339931157568;1050.186105768036;604.6039843902252;687.3470203306879;788.2354116506979;837.7403005068448;841.3185319890908;4565.611922986517;4726.550977657117;4756.738379389098;4826.2278035514855;4872.293517439952;437.0777659139214;440.6276696191713;445.692472194185;450.1739308369114;597.7536835697532;3129.3271946531604;3279.721223695965;3294.456414691549;3324.5345651608795;3448.1552019755322;7852.607369631495;8320.500769953822;8339.20777526134;8387.706430274911;8392.244697977212;8364.079951205362;8365.749027529184;8368.037675667254;8368.832623347498;8374.581270936429;6522.543421960512;6597.901031484532;6614.636195009224;6615.17310336208;6618.933810661832;4712.59942904857;4761.76191190446;4781.545753153445;4855.854324370274;4942.1598328285;7256.600886951268;7566.621668916422;7627.084749830056;7669.271419215165;7685.23147685227;7612.162662107275;7628.351590114902;7678.193789652006;7697.076350837935;7702.191269916578;5878.353381128158;6055.182550355822;6078.939210608014;6081.665508397081;6097.725602347994;6610.074589557562;6614.305497922649;6669.399754022162;6706.6981985811735;6740.056392105012;4778.522147785333;5756.395578464201;5912.556558258234;6102.908456373069;6138.9386106140155;5887.116932460165;5890.911636325544;5911.615744976562;5931.110333450017;5974.701264936649;5296.920546191733;5397.730113494388;5399.703016333982;5426.511613954763;5427.6200665953;4038.394240863894;4076.938845917254;4085.448464457379;4093.3859921012086;4200.789960501902;4043.251998380309;4058.957708376024;4068.7762173080764;4163.500379954425;4224.51418086924 03:25:42 INFO - PROCESS | 3392 | |4;prototype.html;271.53974014046184;274.562073492779;282.04387127637307;282.8967426889185;285.47330175825596;4658.836940707076;4775.522447755223;4794.736289504076;4831.589314908233;4853.320535125085;4575.33657619645;4686.297055441685;4719.85840424787;4722.521874625427;4734.810607575693;3706.9073273168115;3716.7769933803925;3719.702423806096;3734.1411475360546;3736.794476303802;3522.7534072614926;3627.963720362802;3727.4595183698348;3731.141837377405;3737.1591391936868;3597.388443964532;3675.283319752636;3695.224002959382;3695.778253304797;3707.406814909615;3678.1540245743363;3679.558452985632;3683.5948045715218;3688.2296497680995;3696.2792255510053;3255.704728166637;3268;3273.7217336526423;3284.2282063715006;3291.1936575538907;4508.6618503612035;4591.4260717410325;4630.583247507707;4692.366530518405;4705.55297246761;4092.774897380643;4119.773412462313;4128.050548373861;4129.2773764591375;4141;4889.535494128052;4905.362302900636;4913.680610760289;4918.606511479073;4939.3578834751615;3411.954314340878;3456.792592444461;3464.566929133858;3465.475190916014;3468.6531346865363;5115.667481613683;5161.974190129063;5166.984875898403;5176.1459359206065;5187.429382767892;3611.602723700391;3618.565772107311;3627.383344831385;3627.9637203628154;3660.432632941898;3676.5220521332058;3685.9078523037138;3688.4098544232793;3693.1505753676806;3704.7962362070343;4066.9389959150635;4167.166566686675;4172.165566886574;4193.685473589493;4206.936895946563;4913.754312284443;4928.211486162197;4934.55588996992;4937.432195297515;4941.851744447672;1142.491591241906;1168.3982748884332;1191.624638238952;1221.3587866370226;1235.4810979388678;834.2950207075012;851.2508992086924;858.3819649852096;858.8153546987428;867.3668222197831;4230.196262710137;4232.343986682007;4244.490661120685;4250.766207858597;4255.510616279105;4894.192458244421;4923.261510773413;4940.7035577865445;4948.455669876311;4968.701877887338;4263.16868210696;4286.721363111388;4294.141171765659;4295.591918767775;4298.441202643637;2516.8112391570708;2566.7946564275185;2602.3976023976024;2611.516869379133;2641.471705658876;4609.884752881205;4632.4672662644225;4657.790399432034;4663.766811659403;4670.174544400588;4970.304157417964;4993.925091123636;5000.649954503223;5002.199648056294;5014.448410674823;4428.31361139024;4561.931571026437;4606.167207167635;4637.794173514911;4675.322078298627;4875.731834748981;4879.341288926092;4883.215507981343;4885.9022819544125;4908.484609115992;4824.204006338915;4828.37231159947;4832.462956947631;4840.34655321527;4848.781804818862;4611.146937816515;4669.41632295963;4877.414710234794;4883.780229889592;4901.583365413837;3513.6135025147723;3524.207053413064;3528.9647103528637;3540;3541.327147841902;5200.63595548308;5203.401608815035;5248.60635452335;5257.053730328577;5258.947410525846;4704.882377940579;4864.708117512961;4931.827386041471;4983.5763960063805;5011.296159305708;4986.601071914166;5001.974990125172;5002.674826136289;5007.499250074963;5007.949920500749;4800.517683366905;4912.950870491392;4921.8523444296725;4923.532264434873;4925.679830810986;4950.975245123896;4983.825566105169;5009.398872135367;5033.421156567042;5035.194368901105;4907.852764417074;4917.655993924166;4930.359053323045;4930.408350997904;4938.1358262304675 03:25:42 INFO - PROCESS | 3392 | |5;yui.html;607.5443417436923;669.9497537684675;673.4814193071333;726.8473620539686;743.5984568333099;11568.884311156886;12228.205166664184;12250.509979600805;12257.938710306447;12260.386980650976;12186.146969712123;12249.142560020802;12278.508859645626;12323.445444954976;12324.691882702937;613.868018376049;632.7374139732028;731.7036600176937;749.9250074992511;750.4371721209093;749.6476655971685;750.3322043381395;752.5221484357445;753;753.9057617797775;791.8812178173263;792.8810678398257;794.3010151067053;794.3883209928351;794.4161041634394;639.2009987515582;658.9571677840925;660.1055569703079;661.487347305837;785.9096203936534;484.72128526097634;563.8533981164927;577.4254616656411;579.7593998490663;581.3837332427598;11734.178607497479;11748.236364636357;11749.29504229749;11766.352850593214;11769.588064417705;11455.427228638535;11571.363575003372;11694.649160525198;11805.291682499077;12099.697507562294;9141.908580914238;9145.176934075898;9589.18491928187;9667.903320966841;10510.421926794023;3894.1432884765304;3952.505936757905;3973.562908080109;3990.7605543667473;4126.855560055414;46788.53211467876;47020;47470.82873257946;47720.7613961928;48496.99999999965;9422.199113075329;9500.619975201053;9529.237660987104;9559;9759.512024398751;15278.388864445298;15316.693666126615;15527.922360388351;15626.374945002073;15702.921485392728;6299.6850157491945;6350.587211831216;6377.617342959437;6522.510811689142;6592.505562082767;3479.304139172176;3481.9303613928087;3668.211334563082;3673.008287762289;3730.5336832895887;2497.0760818497274;2573.3309339571847;2578.4714133602565;2582.9741702582733;2871.1673614651518;497.1647631978311;504.853592458183;508.88550076232553;525.4981492674563;530.4986787485866;521.4550794419764;525.4325328645054;590.9881802364015;602.6444397805316;612.1429998002832;7056.188538318056;7101.85582653668;7288.271172882775;7613.162552119263;7709.151993280735;571.3286887906776;589.2289348171735;597.745957967862;598.7724664627501;601.6811090122242;3637.1634524059614;3716.572594151653;3756.3614185588517;3819.7135214858995;3860.0735823402742;68791.53912604909;71759.28240717525;73625;75941;76413.23586764061;62351;63194.684026579576;63762.36237637564;64177.35822641807;66998.66500667563;57985;58046.7097664509;58676.41323586795;58879.64481420781;58993.41006589965;6665.566738162198;6908.896366554405;6988.615626140611;7019.543729657556;7091.82270443243;38123.187681231655;38292.61707382891;38988.610113898496;39316;41339.1732165361;47781.76109119432;55392;55581;55685.721571391885;56038;8827.426217296112;9781.608735650494;9782.706518804447;10179.898201017895;10182.287239893432;10987.780244395228;12020.814484161529;12077.57728479499;12788.808167877303;12844.10091293638;10963.122950164126;11038.613648522263;11255.155863310121;11255.887441125484;11333.659990200307;10051.447170405405;10533.4733263335;11123.27698699582;11512.079033677453;11522.481488332878;9791.951040245038;10360.792784144425;10498.580056797642;10532.104771094542;10728.088112510524;8669.783255418664;8672.956635216784;8820.5589720515;8953.597088130919;8972.910270897468;9303.906960930575;9372.531373431437;9567.61729530811;9618.278629102986;9838.508074596099 03:25:42 INFO - PROCESS | 3392 | __end_tp_report 03:25:42 INFO - PROCESS | 3392 | __start_cc_report 03:25:42 INFO - PROCESS | 3392 | _x_x_mozilla_cycle_collect,2471 03:25:42 INFO - PROCESS | 3392 | __end_cc_report 03:25:42 INFO - PROCESS | 3392 | __startTimestamp1480073142509__endTimestamp 03:25:42 INFO - PROCESS | 3392 | 03:25:42 INFO - PROCESS | 3392 | ------- Summary: start ------- 03:25:42 INFO - PROCESS | 3392 | Number of tests: 6 03:25:42 INFO - PROCESS | 3392 | 03:25:42 INFO - PROCESS | 3392 | [#0] dojo.html Cycles:165 Average:4577.39 Median:4688.13 stddev:468.18 (10.0%) stddev-sans-first:441.51 03:25:42 INFO - PROCESS | 3392 | Values: 2540.8 2583.7 2597.9 2612.1 2618.1 4516.5 4547.2 4624.1 4662.6 4680.7 4611.3 4624.3 4657.7 4691.6 4746.7 4232.6 4257.3 4297.3 4330.9 4377.7 3947.3 4268.5 4357.5 4405.2 4444.3 4195.7 4244.5 4337.7 4396.1 4409.2 4242.4 4280.7 4281.7 4285.3 4358.3 4269.6 4277.0 4277.7 4280.1 4323.0 4611.8 4649.4 4655.9 4682.6 4702.9 4818.4 4855.8 4869.3 4881.6 4905.3 4955.8 4964.0 4989.5 4991.5 5000.5 4636.4 4638.6 4655.7 4663.2 4686.7 4864.2 4951.0 5080.9 5086.5 5127.4 4825.6 4847.9 4874.2 4899.7 4913.8 4918.1 4935.3 4947.0 4967.8 4981.1 4848.1 4870.1 4880.6 4889.4 4939.7 4721.8 4781.8 4782.5 4841.4 4846.3 4112.3 4140.9 4144.8 4145.0 4145.8 3691.4 3701.5 3705.9 3711.2 3711.6 4268.1 4269.3 4275.4 4277.5 4278.0 4884.5 4943.6 4946.1 4951.4 4968.9 4282.8 4299.0 4324.1 4331.0 4346.6 4456.8 4459.1 4463.5 4469.9 4510.3 4681.6 4682.7 4684.3 4687.4 4731.2 4836.0 4896.9 4897.8 4962.0 4965.4 4650.1 4670.4 4682.9 4685.0 4688.1 4885.4 4885.7 4888.4 4889.9 4890.7 4946.8 4950.2 4953.0 4953.2 4956.9 4800.4 4825.3 4826.4 4839.4 4845.7 4863.9 4874.2 4875.8 4896.1 4915.6 4673.0 4751.8 4765.7 4778.1 4817.3 4700.7 4850.2 4896.8 4898.0 4955.3 4646.3 4707.4 4721.1 4768.8 4828.5 03:25:42 INFO - PROCESS | 3392 | 03:25:42 INFO - PROCESS | 3392 | [#1] ext.html Cycles:180 Average:36682.49 Median:34260.07 stddev:56222.69 (164.1%) stddev-sans-first:56314.97 03:25:42 INFO - PROCESS | 3392 | Values: 554.7 556.4 558.1 564.4 568.0 36056.1 37611.4 37906.4 42759.0 42788.4 38757.6 38991.2 39068.4 39088.2 39189.6 7292.9 7502.9 7650.9 7652.3 7653.4 7313.6 9534.0 9801.8 9817.5 10198.3 9944.9 10003.2 10010.9 10012.4 10019.8 9804.6 9862.9 9866.5 9867.0 9881.8 9783.1 9796.8 9807.5 9865.2 9871.3 36275.8 36675.6 36710.0 36717.8 36739.8 3010.7 3152.9 3266.0 3518.8 3688.0 27374.3 27563.9 27931.7 27973.6 28065.2 3061.3 3087.9 3103.7 3213.5 3213.9 167569.0 168526.0 168611.0 168881.2 169063.0 50420.7 50514.0 50643.0 50742.0 50752.0 52253.5 52311.7 52348.7 52360.0 52800.2 14387.7 14700.6 14753.2 14783.9 14803.9 8791.6 8981.7 10966.7 11522.1 11601.3 15248.8 15639.8 15667.6 15668.1 15896.6 6307.6 6321.4 6440.0 6459.0 6541.4 780.8 872.6 901.2 964.0 1013.3 26764.7 27065.9 27614.9 27856.6 27937.7 952.8 953.3 974.0 983.8 1033.6 13735.2 14408.6 14432.2 14668.4 14679.3 104783.0 104792.0 104852.0 105047.0 105819.5 47081.3 47296.8 47405.5 47419.8 47491.5 1150.5 1181.8 1196.4 1197.6 1208.5 25698.0 25941.5 26065.3 26447.7 27001.5 41162.4 41475.3 41511.8 41545.4 41552.6 311320.0 311731.0 312066.0 312453.0 312859.0 28975.9 30344.5 32402.0 32972.7 35055.8 36166.0 38961.4 39401.6 40453.2 40544.6 31850.4 33876.5 34267.8 34323.5 35414.8 33400.0 33415.7 33909.8 33966.2 34245.5 33612.7 34252.3 34370.5 34415.1 34687.5 30133.5 30643.0 31008.5 31011.2 31329.5 24099.0 24545.6 24561.4 24656.9 24769.8 03:25:42 INFO - PROCESS | 3392 | 03:25:42 INFO - PROCESS | 3392 | [#2] jquery.html Cycles:180 Average:22130.63 Median:27427.95 stddev:54367.95 (198.2%) stddev-sans-first:54495.86 03:25:42 INFO - PROCESS | 3392 | Values: 344.5 350.6 351.0 354.4 366.7 15551.1 16382.8 17448.0 17540.6 17715.0 16008.8 16732.9 16762.8 17006.7 17020.0 4791.5 5119.7 5121.7 5122.6 5123.4 3697.2 3895.4 3896.7 3940.8 4983.9 3888.6 5597.7 5908.5 5914.6 6016.5 5796.4 5978.3 6012.1 6012.4 6016.7 5248.2 5256.3 5257.5 5258.8 5259.1 19834.3 20216.9 20305.1 20424.0 20462.8 1731.9 1862.6 1886.0 1918.7 1925.9 8679.0 8844.0 9149.4 9186.0 9375.4 1661.9 1714.1 1728.8 1738.9 1740.4 62816.4 64621.4 64688.4 64894.0 65180.0 9596.7 9661.3 9888.2 9905.4 10118.8 13390.2 13414.9 13426.9 13432.1 13437.5 7148.1 7414.7 7473.7 7552.9 7642.7 7187.7 7223.5 7370.2 7408.5 7502.2 4085.7 4223.0 4226.3 4325.9 4376.1 1386.3 1521.4 1755.6 1765.2 1780.3 811.5 823.7 855.5 861.3 904.6 15844.8 16678.7 16727.7 16772.8 17416.8 849.9 868.4 870.9 873.5 897.6 9103.3 9614.7 9627.1 9651.9 9862.3 322956.0 328197.0 328451.0 328647.0 330499.0 71167.3 72287.6 72483.6 72546.9 72954.6 778.4 845.4 863.0 866.0 867.4 13349.4 14662.6 14874.9 15614.5 16243.8 33711.8 34547.5 37739.0 38510.6 38970.8 48592.3 49259.5 49724.8 49872.0 50597.2 7001.1 7206.4 7484.9 7604.1 7663.9 10200.6 11486.5 11636.9 11819.4 12011.0 6381.5 8670.5 9663.3 10089.4 10172.1 9675.6 9844.0 10261.5 10442.2 10597.8 9973.9 10010.2 10032.3 10331.7 10375.4 7625.8 7744.7 7785.3 7859.3 7951.8 8779.9 9383.6 9768.1 9935.7 10166.2 03:25:42 INFO - PROCESS | 3392 | 03:25:42 INFO - PROCESS | 3392 | [#3] mootools.html Cycles:180 Average:4518.76 Median:4841.04 stddev:2451.46 (50.6%) stddev-sans-first:2446.62 03:25:42 INFO - PROCESS | 3392 | Values: 1328.9 1357.5 1405.5 1618.5 1642.0 6552.7 6951.9 6961.9 6962.0 6968.2 6041.9 6319.7 6525.7 6829.0 6833.6 2025.3 2087.9 2090.3 2090.4 2091.1 1797.2 2064.2 2074.2 2083.1 2098.7 1831.4 1961.9 2018.3 2032.0 2042.0 2030.5 2034.2 2034.6 2037.6 2038.6 2017.5 2049.6 2059.7 2059.8 2068.8 6873.1 6935.9 6936.0 6938.4 6947.2 3937.4 4073.8 4074.4 4075.5 4078.8 2496.1 2607.2 2672.9 2678.2 2681.5 810.3 821.0 834.6 873.1 873.4 8791.3 8821.9 8864.0 8865.8 8909.2 3556.5 3729.8 3805.8 3813.1 3817.0 7928.5 7930.9 7934.6 7952.6 7964.4 4251.5 4253.1 4255.8 4257.2 4261.4 3637.2 3715.6 3783.6 3784.6 3788.7 3113.6 3148.5 3167.4 3178.6 3190.2 988.7 1016.0 1022.5 1037.1 1050.2 604.6 687.3 788.2 837.7 841.3 4565.6 4726.6 4756.7 4826.2 4872.3 437.1 440.6 445.7 450.2 597.8 3129.3 3279.7 3294.5 3324.5 3448.2 7852.6 8320.5 8339.2 8387.7 8392.2 8364.1 8365.7 8368.0 8368.8 8374.6 6522.5 6597.9 6614.6 6615.2 6618.9 4712.6 4761.8 4781.5 4855.9 4942.2 7256.6 7566.6 7627.1 7669.3 7685.2 7612.2 7628.4 7678.2 7697.1 7702.2 5878.4 6055.2 6078.9 6081.7 6097.7 6610.1 6614.3 6669.4 6706.7 6740.1 4778.5 5756.4 5912.6 6102.9 6138.9 5887.1 5890.9 5911.6 5931.1 5974.7 5296.9 5397.7 5399.7 5426.5 5427.6 4038.4 4076.9 4085.4 4093.4 4200.8 4043.3 4059.0 4068.8 4163.5 4224.5 03:25:42 INFO - PROCESS | 3392 | 03:25:42 INFO - PROCESS | 3392 | [#4] prototype.html Cycles:180 Average:4077.39 Median:4647.79 stddev:1188.68 (25.6%) stddev-sans-first:1157.19 03:25:42 INFO - PROCESS | 3392 | Values: 271.5 274.6 282.0 282.9 285.5 4658.8 4775.5 4794.7 4831.6 4853.3 4575.3 4686.3 4719.9 4722.5 4734.8 3706.9 3716.8 3719.7 3734.1 3736.8 3522.8 3628.0 3727.5 3731.1 3737.2 3597.4 3675.3 3695.2 3695.8 3707.4 3678.2 3679.6 3683.6 3688.2 3696.3 3255.7 3268.0 3273.7 3284.2 3291.2 4508.7 4591.4 4630.6 4692.4 4705.6 4092.8 4119.8 4128.1 4129.3 4141.0 4889.5 4905.4 4913.7 4918.6 4939.4 3412.0 3456.8 3464.6 3465.5 3468.7 5115.7 5162.0 5167.0 5176.1 5187.4 3611.6 3618.6 3627.4 3628.0 3660.4 3676.5 3685.9 3688.4 3693.2 3704.8 4066.9 4167.2 4172.2 4193.7 4206.9 4913.8 4928.2 4934.6 4937.4 4941.9 1142.5 1168.4 1191.6 1221.4 1235.5 834.3 851.3 858.4 858.8 867.4 4230.2 4232.3 4244.5 4250.8 4255.5 4894.2 4923.3 4940.7 4948.5 4968.7 4263.2 4286.7 4294.1 4295.6 4298.4 2516.8 2566.8 2602.4 2611.5 2641.5 4609.9 4632.5 4657.8 4663.8 4670.2 4970.3 4993.9 5000.6 5002.2 5014.4 4428.3 4561.9 4606.2 4637.8 4675.3 4875.7 4879.3 4883.2 4885.9 4908.5 4824.2 4828.4 4832.5 4840.3 4848.8 4611.1 4669.4 4877.4 4883.8 4901.6 3513.6 3524.2 3529.0 3540.0 3541.3 5200.6 5203.4 5248.6 5257.1 5258.9 4704.9 4864.7 4931.8 4983.6 5011.3 4986.6 5002.0 5002.7 5007.5 5007.9 4800.5 4913.0 4921.9 4923.5 4925.7 4951.0 4983.8 5009.4 5033.4 5035.2 4907.9 4917.7 4930.4 4930.4 4938.1 03:25:42 INFO - PROCESS | 3392 | 03:25:42 INFO - PROCESS | 3392 | [#5] yui.html Cycles:180 Average:14792.46 Median:567.59 stddev:19584.09 (3450.4%) stddev-sans-first:19610.07 03:25:42 INFO - PROCESS | 3392 | Values: 607.5 669.9 673.5 726.8 743.6 11568.9 12228.2 12250.5 12257.9 12260.4 12186.1 12249.1 12278.5 12323.4 12324.7 613.9 632.7 731.7 749.9 750.4 749.6 750.3 752.5 753.0 753.9 791.9 792.9 794.3 794.4 794.4 639.2 659.0 660.1 661.5 785.9 484.7 563.9 577.4 579.8 581.4 11734.2 11748.2 11749.3 11766.4 11769.6 11455.4 11571.4 11694.6 11805.3 12099.7 9141.9 9145.2 9589.2 9667.9 10510.4 3894.1 3952.5 3973.6 3990.8 4126.9 46788.5 47020.0 47470.8 47720.8 48497.0 9422.2 9500.6 9529.2 9559.0 9759.5 15278.4 15316.7 15527.9 15626.4 15702.9 6299.7 6350.6 6377.6 6522.5 6592.5 3479.3 3481.9 3668.2 3673.0 3730.5 2497.1 2573.3 2578.5 2583.0 2871.2 497.2 504.9 508.9 525.5 530.5 521.5 525.4 591.0 602.6 612.1 7056.2 7101.9 7288.3 7613.2 7709.2 571.3 589.2 597.7 598.8 601.7 3637.2 3716.6 3756.4 3819.7 3860.1 68791.5 71759.3 73625.0 75941.0 76413.2 62351.0 63194.7 63762.4 64177.4 66998.7 57985.0 58046.7 58676.4 58879.6 58993.4 6665.6 6908.9 6988.6 7019.5 7091.8 38123.2 38292.6 38988.6 39316.0 41339.2 47781.8 55392.0 55581.0 55685.7 56038.0 8827.4 9781.6 9782.7 10179.9 10182.3 10987.8 12020.8 12077.6 12788.8 12844.1 10963.1 11038.6 11255.2 11255.9 11333.7 10051.4 10533.5 11123.3 11512.1 11522.5 9792.0 10360.8 10498.6 10532.1 10728.1 8669.8 8673.0 8820.6 8953.6 8972.9 9303.9 9372.5 9567.6 9618.3 9838.5 03:25:42 INFO - PROCESS | 3392 | -------- Summary: end -------- 03:25:42 INFO - PROCESS | 3392 | 03:25:43 INFO - TEST-INFO | 3392: exit 0 03:25:43 INFO - TEST-OK | dromaeo_css | took 1124924ms 03:25:43 INFO - TEST-START | kraken 03:25:43 INFO - operating with platform_type : linux_ 03:25:43 INFO - Initialising browser for kraken test... 03:25:43 INFO - TEST-INFO | started process 3728 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWRDSTO/profile http://localhost:44100/getInfo.html) 03:25:47 INFO - PROCESS | 3728 | __metrics Screen width/height:1600/1200 03:25:47 INFO - PROCESS | 3728 | colorDepth:24 03:25:47 INFO - PROCESS | 3728 | Browser inner width/height: 1024/697 03:25:47 INFO - PROCESS | 3728 | __metrics 03:25:48 INFO - PROCESS | 3728 | 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" 03:25:48 INFO - PROCESS | 3728 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:25:49 INFO - PROCESS | 3728 | console.error: PushService: 03:25:49 INFO - PROCESS | 3728 | stateChangeProcessEnqueue: Error transitioning state 03:25:49 INFO - PROCESS | 3728 | UnknownError 03:25:49 INFO - TEST-INFO | 3728: exit 0 03:25:49 INFO - Browser initialized. 03:25:49 INFO - Running cycle 1/1 for kraken test... 03:25:49 INFO - TEST-INFO | started process 3810 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWRDSTO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:26:01 INFO - PROCESS | 3810 | RSS: Main: 174854144 03:26:01 INFO - PROCESS | 3810 | 03:26:04 INFO - PROCESS | 3810 | Cycle 1(1): loaded http://localhost:44100/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44100/tests/kraken/driver.html?testName=audio-beat-detection) 03:26:05 INFO - PROCESS | 3810 | RSS: Main: 235991040 03:26:05 INFO - PROCESS | 3810 | 03:26:08 INFO - PROCESS | 3810 | Cycle 1(1): loaded http://localhost:44100/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44100/tests/kraken/driver.html?testName=audio-dft) 03:26:09 INFO - PROCESS | 3810 | RSS: Main: 218890240 03:26:09 INFO - PROCESS | 3810 | 03:26:12 INFO - PROCESS | 3810 | Cycle 1(1): loaded http://localhost:44100/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44100/tests/kraken/driver.html?testName=audio-fft) 03:26:12 INFO - PROCESS | 3810 | RSS: Main: 300384256 03:26:12 INFO - PROCESS | 3810 | 03:26:15 INFO - PROCESS | 3810 | Cycle 1(1): loaded http://localhost:44100/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44100/tests/kraken/driver.html?testName=audio-oscillator) 03:26:15 INFO - PROCESS | 3810 | RSS: Main: 212025344 03:26:15 INFO - PROCESS | 3810 | 03:26:17 INFO - PROCESS | 3810 | Cycle 1(1): loaded http://localhost:44100/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44100/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:26:18 INFO - PROCESS | 3810 | RSS: Main: 214990848 03:26:18 INFO - PROCESS | 3810 | 03:26:21 INFO - PROCESS | 3810 | Cycle 1(1): loaded http://localhost:44100/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44100/tests/kraken/driver.html?testName=imaging-darkroom) 03:26:22 INFO - PROCESS | 3810 | RSS: Main: 254144512 03:26:22 INFO - PROCESS | 3810 | 03:26:25 INFO - PROCESS | 3810 | Cycle 1(1): loaded http://localhost:44100/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44100/tests/kraken/driver.html?testName=imaging-desaturate) 03:26:26 INFO - PROCESS | 3810 | RSS: Main: 248946688 03:26:26 INFO - PROCESS | 3810 | 03:26:29 INFO - PROCESS | 3810 | Cycle 1(1): loaded http://localhost:44100/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44100/tests/kraken/driver.html?testName=json-parse-financial) 03:26:29 INFO - PROCESS | 3810 | RSS: Main: 249741312 03:26:29 INFO - PROCESS | 3810 | 03:26:31 INFO - PROCESS | 3810 | Cycle 1(1): loaded http://localhost:44100/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44100/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:26:32 INFO - PROCESS | 3810 | RSS: Main: 213467136 03:26:32 INFO - PROCESS | 3810 | 03:26:34 INFO - PROCESS | 3810 | Cycle 1(1): loaded http://localhost:44100/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44100/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:26:35 INFO - PROCESS | 3810 | RSS: Main: 220430336 03:26:35 INFO - PROCESS | 3810 | 03:26:37 INFO - PROCESS | 3810 | Cycle 1(1): loaded http://localhost:44100/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44100/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:26:37 INFO - PROCESS | 3810 | RSS: Main: 229343232 03:26:37 INFO - PROCESS | 3810 | 03:26:41 INFO - PROCESS | 3810 | Cycle 1(1): loaded http://localhost:44100/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44100/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:26:41 INFO - PROCESS | 3810 | RSS: Main: 238239744 03:26:41 INFO - PROCESS | 3810 | 03:26:45 INFO - PROCESS | 3810 | Cycle 1(1): loaded http://localhost:44100/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44100/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:26:45 INFO - PROCESS | 3810 | RSS: Main: 235298816 03:26:45 INFO - PROCESS | 3810 | 03:26:47 INFO - PROCESS | 3810 | Cycle 1(1): loaded http://localhost:44100/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44100/tests/kraken/driver.html?testName=ai-astar) 03:26:47 INFO - PROCESS | 3810 | RSS: Main: 286527488 03:26:47 INFO - PROCESS | 3810 | 03:26:47 INFO - PROCESS | 3810 | __start_tp_report 03:26:47 INFO - PROCESS | 3810 | _x_x_mozilla_page_load 03:26:47 INFO - PROCESS | 3810 | _x_x_mozilla_page_load_details 03:26:47 INFO - PROCESS | 3810 | |i|pagename|runs| 03:26:47 INFO - PROCESS | 3810 | |0;ai-astar;108;117;117;117;116;118;116;117;116;117 03:26:47 INFO - PROCESS | 3810 | |1;audio-beat-detection;161;134;130;177;128;127;130;130;168;129 03:26:47 INFO - PROCESS | 3810 | |2;audio-dft;161;160;162;162;162;161;162;161;162;161 03:26:47 INFO - PROCESS | 3810 | |3;audio-fft;76;85;78;117;77;78;78;76;91;76 03:26:47 INFO - PROCESS | 3810 | |4;audio-oscillator;83;84;105;83;84;84;108;84;85;104 03:26:47 INFO - PROCESS | 3810 | |5;imaging-gaussian-blur;116;116;117;117;117;117;116;117;116;117 03:26:47 INFO - PROCESS | 3810 | |6;imaging-darkroom;146;147;149;147;146;147;148;147;147;146 03:26:47 INFO - PROCESS | 3810 | |7;imaging-desaturate;95;95;95;95;95;95;95;96;95;96 03:26:47 INFO - PROCESS | 3810 | |8;json-parse-financial;66;64;66;65;67;67;69;66;67;67 03:26:47 INFO - PROCESS | 3810 | |9;json-stringify-tinderbox;68;67;66;67;67;66;66;67;66;67 03:26:47 INFO - PROCESS | 3810 | |10;stanford-crypto-aes;87;91;85;85;84;85;86;84;84;85 03:26:47 INFO - PROCESS | 3810 | |11;stanford-crypto-ccm;160;144;141;142;147;144;143;143;206;149 03:26:47 INFO - PROCESS | 3810 | |12;stanford-crypto-pbkdf2;179;186;183;183;180;185;183;179;182;179 03:26:47 INFO - PROCESS | 3810 | |13;stanford-crypto-sha256-iterative;72;70;70;70;70;69;70;69;70;68 03:26:47 INFO - PROCESS | 3810 | __end_tp_report 03:26:47 INFO - PROCESS | 3810 | __start_cc_report 03:26:47 INFO - PROCESS | 3810 | _x_x_mozilla_cycle_collect,1962 03:26:47 INFO - PROCESS | 3810 | __end_cc_report 03:26:47 INFO - PROCESS | 3810 | __startTimestamp1480073207654__endTimestamp 03:26:47 INFO - PROCESS | 3810 | 03:26:47 INFO - PROCESS | 3810 | ------- Summary: start ------- 03:26:47 INFO - PROCESS | 3810 | Number of tests: 14 03:26:47 INFO - PROCESS | 3810 | 03:26:47 INFO - PROCESS | 3810 | [#0] ai-astar Cycles:10 Average:115.90 Median:117.00 stddev:2.85 (2.4%) stddev-sans-first:0.67 03:26:47 INFO - PROCESS | 3810 | Values: 108.0 117.0 117.0 117.0 116.0 118.0 116.0 117.0 116.0 117.0 03:26:47 INFO - PROCESS | 3810 | 03:26:47 INFO - PROCESS | 3810 | [#1] audio-beat-detection Cycles:10 Average:141.40 Median:132.00 stddev:19.28 (14.6%) stddev-sans-first:19.10 03:26:47 INFO - PROCESS | 3810 | Values: 161.0 134.0 130.0 177.0 128.0 127.0 130.0 130.0 168.0 129.0 03:26:47 INFO - PROCESS | 3810 | 03:26:47 INFO - PROCESS | 3810 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:0.70 (0.4%) stddev-sans-first:0.73 03:26:47 INFO - PROCESS | 3810 | Values: 161.0 160.0 162.0 162.0 162.0 161.0 162.0 161.0 162.0 161.0 03:26:47 INFO - PROCESS | 3810 | 03:26:47 INFO - PROCESS | 3810 | [#3] audio-fft Cycles:10 Average:83.20 Median:78.00 stddev:12.83 (16.4%) stddev-sans-first:13.34 03:26:47 INFO - PROCESS | 3810 | Values: 76.0 85.0 78.0 117.0 77.0 78.0 78.0 76.0 91.0 76.0 03:26:47 INFO - PROCESS | 3810 | 03:26:47 INFO - PROCESS | 3810 | [#4] audio-oscillator Cycles:10 Average:90.40 Median:84.00 stddev:10.60 (12.6%) stddev-sans-first:10.89 03:26:47 INFO - PROCESS | 3810 | Values: 83.0 84.0 105.0 83.0 84.0 84.0 108.0 84.0 85.0 104.0 03:26:47 INFO - PROCESS | 3810 | 03:26:47 INFO - PROCESS | 3810 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 03:26:47 INFO - PROCESS | 3810 | Values: 116.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 03:26:47 INFO - PROCESS | 3810 | 03:26:47 INFO - PROCESS | 3810 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.94 (0.6%) stddev-sans-first:0.93 03:26:47 INFO - PROCESS | 3810 | Values: 146.0 147.0 149.0 147.0 146.0 147.0 148.0 147.0 147.0 146.0 03:26:47 INFO - PROCESS | 3810 | 03:26:47 INFO - PROCESS | 3810 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 03:26:47 INFO - PROCESS | 3810 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 96.0 03:26:47 INFO - PROCESS | 3810 | 03:26:47 INFO - PROCESS | 3810 | [#8] json-parse-financial Cycles:10 Average:66.40 Median:67.00 stddev:1.35 (2.0%) stddev-sans-first:1.42 03:26:47 INFO - PROCESS | 3810 | Values: 66.0 64.0 66.0 65.0 67.0 67.0 69.0 66.0 67.0 67.0 03:26:47 INFO - PROCESS | 3810 | 03:26:47 INFO - PROCESS | 3810 | [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:67.00 stddev:0.67 (1.0%) stddev-sans-first:0.53 03:26:47 INFO - PROCESS | 3810 | Values: 68.0 67.0 66.0 67.0 67.0 66.0 66.0 67.0 66.0 67.0 03:26:47 INFO - PROCESS | 3810 | 03:26:47 INFO - PROCESS | 3810 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:85.00 stddev:2.12 (2.5%) stddev-sans-first:2.19 03:26:47 INFO - PROCESS | 3810 | Values: 87.0 91.0 85.0 85.0 84.0 85.0 86.0 84.0 84.0 85.0 03:26:47 INFO - PROCESS | 3810 | 03:26:47 INFO - PROCESS | 3810 | [#11] stanford-crypto-ccm Cycles:10 Average:151.90 Median:145.50 stddev:19.79 (13.6%) stddev-sans-first:20.77 03:26:47 INFO - PROCESS | 3810 | Values: 160.0 144.0 141.0 142.0 147.0 144.0 143.0 143.0 206.0 149.0 03:26:47 INFO - PROCESS | 3810 | 03:26:47 INFO - PROCESS | 3810 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.90 Median:183.00 stddev:2.56 (1.4%) stddev-sans-first:2.49 03:26:47 INFO - PROCESS | 3810 | Values: 179.0 186.0 183.0 183.0 180.0 185.0 183.0 179.0 182.0 179.0 03:26:47 INFO - PROCESS | 3810 | 03:26:47 INFO - PROCESS | 3810 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:70.00 stddev:1.03 (1.5%) stddev-sans-first:0.73 03:26:47 INFO - PROCESS | 3810 | Values: 72.0 70.0 70.0 70.0 70.0 69.0 70.0 69.0 70.0 68.0 03:26:47 INFO - PROCESS | 3810 | -------- Summary: end -------- 03:26:47 INFO - PROCESS | 3810 | 03:26:48 INFO - TEST-INFO | 3810: exit 0 03:26:48 INFO - TEST-OK | kraken | took 65356ms 03:26:48 INFO - SUITE-END | took 1190s 03:26:49 INFO - Completed test suite (00:19:50) 03:26:49 INFO - javascript benchmark 03:26:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2540.784033357165, 2583.6641236639234, 2597.870106494676, 2612.085769980507, 2618.136015115012, 4516.480604730457, 4547.226971414859, 4624.1214169307805, 4662.626989840813, 4680.6957547759375, 4611.285250786125, 4624.306354046895, 4657.650676199281, 4691.624670026398, 4746.738929358884, 4232.619064284214, 4257.340112282585, 4297.269464191095, 4330.935035974463, 4377.737335759864, 3947.272382231442, 4268.509121451027, 4357.4771027476745, 4405.207062728708, 4444.266695995173, 4195.685323600712, 4244.533101358848, 4337.742054804135, 4396.120775844844, 4409.228385032622, 4242.448481697391, 4280.700350975433, 4281.721688090264, 4285.271503844354, 4358.346248062816, 4269.615734583871, 4276.978615106936, 4277.700560960734, 4280.101178752466, 4323.048929235563, 4611.838585649486, 4649.418822647169, 4655.906881862377, 4682.578567928903, 4702.905941881178, 4818.397700287464, 4855.83004594841, 4869.269609558559, 4881.633877459205, 4905.337779399771, 4955.801767929279, 4963.950360496385, 4989.451160372356, 4991.4758950310425, 5000.549950504472, 4636.374089497942, 4638.61813205883, 4655.650826188049, 4663.207254766698, 4686.671932964728, 4864.246041863516, 4951.034548263054, 5080.898382032338, 5086.54221120101, 5127.435982041972, 4825.5898248649255, 4847.878803029882, 4874.171390863562, 4899.681520701143, 4913.803447862046, 4918.065567542156, 4935.333729946483, 4946.950530494721, 4967.801287948514, 4981.103401387785, 4848.1366275037835, 4870.0746858096845, 4880.6095512358925, 4889.437714662859, 4939.654224204343, 4721.811127554859, 4781.832635857798, 4782.52174782519, 4841.370621819141, 4846.29728689338, 4112.300908845504, 4140.896477588024, 4144.7513149211145, 4145.0, 4145.79271036447, 3691.427828686558, 3701.463287823304, 3705.888823335304, 3711.1649878777057, 3711.6102809205186, 4268.146370725867, 4269.295566231537, 4275.3800698898485, 4277.508086570022, 4277.978610106929, 4884.535969083003, 4943.604511639061, 4946.1344264753525, 4951.356323677899, 4968.900621987612, 4282.828686852491, 4299.0, 4324.070324880166, 4330.978345108254, 4346.565343465628, 4456.844010459618, 4459.1304695584695, 4463.464384273843, 4469.888252793641, 4510.323451482304, 4681.555252251031, 4682.695624784446, 4684.273937539687, 4687.367205427224, 4731.1720448921305, 4835.975820120877, 4896.902061958812, 4897.8285759998225, 4961.950380496149, 4965.4289756677, 4650.069986002745, 4670.3695001175765, 4682.859514214579, 4684.953150468452, 4688.132695451352, 4885.364902562644, 4885.65800393969, 4888.388951381077, 4889.9022019560125, 4890.731009794496, 4946.802127914987, 4950.158473059517, 4952.975235123801, 4953.1579631463455, 4956.900861982812, 4800.3759511263315, 4825.276208568603, 4826.420829500342, 4839.443464001685, 4845.733484658378, 4863.878403039952, 4874.195757700081, 4875.8049678012485, 4896.143174944442, 4915.606751459946, 4672.976635116803, 4751.809927602857, 4765.666403351732, 4778.068276686013, 4817.325574419514, 4700.741459219776, 4850.223964165716, 4896.828610998598, 4897.975510122426, 4955.2567114933045, 4646.349511068385, 4707.411573553306, 4721.079389519011, 4768.785404656868, 4828.517148285144], "value": 4548.044313741493, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.7475898466198, 556.4435564435564, 558.0930987145888, 564.4468420947471, 567.9943200567994, 36056.09859753504, 37611.43582846259, 37906.431403528935, 42759.0, 42788.35817462733, 38757.612423875755, 38991.22017559647, 39068.413973790346, 39088.21823563527, 39189.60810391895, 7292.8906066409045, 7502.88745668814, 7650.923490765077, 7652.31129198372, 7653.425993050516, 7313.561186328838, 9534.0, 9801.803963920718, 9817.50912454378, 10198.286119971604, 9944.850827237597, 10003.199744020498, 10010.949945250264, 10012.449315287657, 10019.849702254473, 9804.558794854249, 9862.90137098627, 9866.457344845994, 9866.950665246699, 9881.752956176082, 9783.119519243302, 9796.804063918753, 9807.509624518745, 9865.1614612758, 9871.309008369417, 36275.81862090699, 36675.633243667755, 36710.0, 36717.81641091804, 36739.81630091859, 3010.6838781928022, 3152.936941261185, 3266.0, 3518.841652125635, 3687.9631203687886, 27374.315642108908, 27563.862180689168, 27931.72068279332, 27973.580396294074, 28065.15804525847, 3061.311204978862, 3087.922801929947, 3103.7361824244967, 3213.453712868818, 3213.935721285561, 167569.0, 168526.0, 168611.0, 168881.15559422123, 169063.0, 50420.74789626028, 50514.0, 50643.0, 50742.0, 50752.0, 52253.477465225624, 52311.73844130831, 52348.738256308476, 52360.0, 52800.207996880075, 14387.712245755236, 14700.632484187981, 14753.188574628284, 14783.852161478248, 14803.92598037003, 8791.604377803014, 8981.730548083568, 10966.670999870017, 11522.13583981188, 11601.303921764722, 15248.771268430983, 15639.843601563838, 15667.608309792346, 15668.138252396227, 15896.602584935237, 6307.590006649553, 6321.399467050623, 6440.0, 6458.967705161538, 6541.443977261891, 780.777478418648, 872.5724395046382, 901.1664210605295, 963.9807203855884, 1013.2812577839347, 26764.732352676223, 27065.889789254732, 27614.861925690242, 27856.582151267747, 27937.720622793917, 952.7570469530364, 953.3421938862163, 973.9951300243595, 983.8130755156498, 1033.5917312661456, 13735.24456154921, 14408.639784005483, 14432.206228657524, 14668.413263469554, 14679.339429725687, 104783.0, 104792.0, 104852.0, 105047.0, 105819.47090264653, 47081.29378059332, 47296.763516182196, 47405.52594474011, 47419.76290118528, 47491.52508474871, 1150.5340337163461, 1181.7931861924128, 1196.4137572589543, 1197.6227488341144, 1208.5165933626445, 25698.0, 25941.481170376865, 26065.348366290993, 26447.742406002606, 27001.459970800868, 41162.38256426096, 41475.26722594981, 41511.7924410376, 41545.37681934834, 41552.58447415487, 311320.0, 311731.0, 312066.0, 312453.0, 312859.0, 28975.855120725104, 30344.54483182798, 32402.0, 32972.67027329696, 35055.82472087623, 36166.0, 38961.41557876577, 39401.60598394094, 40453.1909361817, 40544.594554054085, 31850.362992739552, 33876.49185262174, 34267.82866085654, 34323.4851477233, 35414.82292588521, 33400.0, 33415.66584334125, 33909.830450847585, 33966.150846229044, 34245.486317705756, 33612.66387336095, 34252.31495370029, 34370.48444273288, 34415.139621508664, 34687.479687804196, 30133.547996779627, 30643.0, 31008.53487197739, 31011.224719382197, 31329.53005704962, 24099.0, 24545.63181552314, 24561.385965351008, 24656.87671561631, 24769.752302476743], "value": 16732.006145208623, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.4798354484729, 350.5582965463515, 350.9526213961115, 354.3922173472494, 366.69564261662805, 15551.144687042208, 16382.754258686115, 17448.0, 17540.649187016254, 17714.999999999985, 16008.83991160088, 16732.916335418337, 16762.83237167628, 17006.744898826528, 17020.0, 4791.51463046455, 5119.667221630601, 5121.718305493197, 5122.590192784568, 5123.385193776733, 3697.242065376591, 3895.357266051112, 3896.7272290939645, 3940.8226629801584, 4983.900321993558, 3888.552816426119, 5597.748101335429, 5908.527317814586, 5914.585978981473, 6016.4885984691355, 5796.420357964212, 5978.312494063195, 6012.128241404972, 6012.398760123996, 6016.729247183844, 5248.160294352885, 5256.316678831766, 5257.5005374489365, 5258.763355649005, 5259.0796610593, 19834.305799296955, 20216.898915505477, 20305.086271117834, 20424.0, 20462.79537204624, 1731.852792512638, 1862.5809192931617, 1886.0098448314607, 1918.7217853411316, 1925.913333899978, 8678.970301741472, 8844.0, 9149.359544831865, 9186.0, 9375.437473751597, 1661.858742006931, 1714.1172296267432, 1728.766616506768, 1738.8956662600158, 1740.4343588333716, 62816.37183628151, 64621.353786462474, 64688.353116469174, 64894.0, 65180.0, 9596.66411675588, 9661.323707340418, 9888.204220952832, 9905.356151850106, 10118.848217276747, 13390.196588204739, 13414.865851341361, 13426.865731342561, 13432.126911750705, 13437.462501500026, 7148.106486689164, 7414.666340014713, 7473.701051957861, 7552.8867066994035, 7642.7325043623205, 7187.748428804966, 7223.458240631973, 7370.152432470228, 7408.481406301507, 7502.2122677119205, 4085.71400001997, 4223.0, 4226.281532139482, 4325.870223893288, 4376.059147283286, 1386.2583517817918, 1521.37623574334, 1755.5786611213216, 1765.2056574541507, 1780.2789870102629, 811.4887620798859, 823.7405217356513, 855.4567849415666, 861.2998250484775, 904.5748498205833, 15844.841551584566, 16678.66642667164, 16727.665446690997, 16772.832271677373, 17416.825831741775, 849.9490030598184, 868.4181598329135, 870.8780770692108, 873.5370253765515, 897.6499165325529, 9103.271738261055, 9614.663486777928, 9627.085426884434, 9651.90348096524, 9862.260330475243, 322956.0, 328197.0, 328451.0, 328647.0, 330499.0, 71167.2883271171, 72287.63856180686, 72483.55032899418, 72546.9117963231, 72954.63522682458, 778.4473024152802, 845.4082142500151, 862.9870551941726, 865.9956700216459, 867.4014929698487, 13349.399277032362, 14662.560123196321, 14874.925625372236, 15614.531564053097, 16243.837561624232, 33711.83144084362, 34547.48178777371, 37739.0, 38510.6148938507, 38970.80514597409, 48592.271115933996, 49259.507404926924, 49724.751376242886, 49872.0, 50597.24104138367, 7001.089858318386, 7206.4234861209925, 7484.850302993801, 7604.12552556441, 7663.888736133341, 10200.642977495752, 11486.483108259981, 11636.883631163919, 11819.409029548317, 12011.0, 6381.4835745351465, 8670.523121228392, 9663.323567350219, 10089.445080520642, 10172.08451239392, 9675.612975480903, 9843.950780246052, 10261.486925653538, 10442.164626829683, 10597.841032384365, 9973.850392243978, 10010.249231307535, 10032.347897386646, 10331.741706457398, 10375.429351385746, 7625.809354766176, 7744.6902123914415, 7785.299323060952, 7859.253370929752, 7951.801204969691, 8779.912200878165, 9383.577739001897, 9768.120869121813, 9935.701928942144, 10166.237532185263], "value": 7947.503682917525, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1328.9401976911038, 1357.511295933464, 1405.5431984605, 1618.5144456662997, 1642.014791125325, 6552.67236638168, 6951.860962780754, 6961.860762784741, 6962.0, 6968.2334943156275, 6041.939580604193, 6319.684015799203, 6525.706343214555, 6829.0, 6833.589984600915, 2025.3215172917053, 2087.9164833406644, 2090.341542414142, 2090.3728881335614, 2091.111277706976, 1797.1643185918545, 2064.225915281769, 2074.195449958538, 2083.052211243888, 2098.7481502219757, 1831.3590243414765, 1961.8920959347302, 2018.3238615063972, 2031.97385320413, 2041.9795802042013, 2030.4517780199337, 2034.1558253324852, 2034.562569047647, 2037.5721098569318, 2038.622854771872, 2017.5057111007898, 2049.5900819836093, 2059.680749483832, 2059.804318589732, 2068.803463670949, 6873.140857392826, 6935.861282774366, 6936.028955946172, 6938.41023512997, 6947.166340039177, 3937.4290727844586, 4073.8370465181356, 4074.388841673743, 4075.49056367954, 4078.775667338295, 2496.1388321029217, 2607.2438992692096, 2672.9331766705795, 2678.236702539786, 2681.5441374966304, 810.3274282345639, 820.958952052401, 834.649447232164, 873.1486800369589, 873.4279047224078, 8791.340649451316, 8821.911780882174, 8864.024957254696, 8865.778355541162, 8909.1536304051, 3556.48430977512, 3729.813509324523, 3805.82873770681, 3813.0848596336677, 3816.961830381716, 7928.524288542706, 7930.881036784453, 7934.642941067666, 7952.602369881482, 7964.442489025712, 4251.511076226212, 4253.064325848309, 4255.76593287366, 4257.1698518788535, 4261.382099595541, 3637.1634524059086, 3715.6098609646137, 3783.564890037681, 3784.5836957934607, 3788.734788564829, 3113.641931177898, 3148.464760990637, 3167.4140284047526, 3178.570892929471, 3190.202449387653, 988.6737376665683, 1016.0398423489731, 1022.4734261855151, 1037.1339931157568, 1050.186105768036, 604.6039843902252, 687.3470203306879, 788.2354116506979, 837.7403005068448, 841.3185319890908, 4565.611922986517, 4726.550977657117, 4756.738379389098, 4826.2278035514855, 4872.293517439952, 437.0777659139214, 440.6276696191713, 445.692472194185, 450.1739308369114, 597.7536835697532, 3129.3271946531604, 3279.721223695965, 3294.456414691549, 3324.5345651608795, 3448.1552019755322, 7852.607369631495, 8320.500769953822, 8339.20777526134, 8387.706430274911, 8392.244697977212, 8364.079951205362, 8365.749027529184, 8368.037675667254, 8368.832623347498, 8374.581270936429, 6522.543421960512, 6597.901031484532, 6614.636195009224, 6615.17310336208, 6618.933810661832, 4712.59942904857, 4761.76191190446, 4781.545753153445, 4855.854324370274, 4942.1598328285, 7256.600886951268, 7566.621668916422, 7627.084749830056, 7669.271419215165, 7685.23147685227, 7612.162662107275, 7628.351590114902, 7678.193789652006, 7697.076350837935, 7702.191269916578, 5878.353381128158, 6055.182550355822, 6078.939210608014, 6081.665508397081, 6097.725602347994, 6610.074589557562, 6614.305497922649, 6669.399754022162, 6706.6981985811735, 6740.056392105012, 4778.522147785333, 5756.395578464201, 5912.556558258234, 6102.908456373069, 6138.9386106140155, 5887.116932460165, 5890.911636325544, 5911.615744976562, 5931.110333450017, 5974.701264936649, 5296.920546191733, 5397.730113494388, 5399.703016333982, 5426.511613954763, 5427.6200665953, 4038.394240863894, 4076.938845917254, 4085.448464457379, 4093.3859921012086, 4200.789960501902, 4043.251998380309, 4058.957708376024, 4068.7762173080764, 4163.500379954425, 4224.51418086924], "value": 3647.042288644532, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [271.53974014046184, 274.562073492779, 282.04387127637307, 282.8967426889185, 285.47330175825596, 4658.836940707076, 4775.522447755223, 4794.736289504076, 4831.589314908233, 4853.320535125085, 4575.33657619645, 4686.297055441685, 4719.85840424787, 4722.521874625427, 4734.810607575693, 3706.9073273168115, 3716.7769933803925, 3719.702423806096, 3734.1411475360546, 3736.794476303802, 3522.7534072614926, 3627.963720362802, 3727.4595183698348, 3731.141837377405, 3737.1591391936868, 3597.388443964532, 3675.283319752636, 3695.224002959382, 3695.778253304797, 3707.406814909615, 3678.1540245743363, 3679.558452985632, 3683.5948045715218, 3688.2296497680995, 3696.2792255510053, 3255.704728166637, 3268.0, 3273.7217336526423, 3284.2282063715006, 3291.1936575538907, 4508.6618503612035, 4591.4260717410325, 4630.583247507707, 4692.366530518405, 4705.55297246761, 4092.774897380643, 4119.773412462313, 4128.050548373861, 4129.2773764591375, 4141.0, 4889.535494128052, 4905.362302900636, 4913.680610760289, 4918.606511479073, 4939.3578834751615, 3411.954314340878, 3456.792592444461, 3464.566929133858, 3465.475190916014, 3468.6531346865363, 5115.667481613683, 5161.974190129063, 5166.984875898403, 5176.1459359206065, 5187.429382767892, 3611.602723700391, 3618.565772107311, 3627.383344831385, 3627.9637203628154, 3660.432632941898, 3676.5220521332058, 3685.9078523037138, 3688.4098544232793, 3693.1505753676806, 3704.7962362070343, 4066.9389959150635, 4167.166566686675, 4172.165566886574, 4193.685473589493, 4206.936895946563, 4913.754312284443, 4928.211486162197, 4934.55588996992, 4937.432195297515, 4941.851744447672, 1142.491591241906, 1168.3982748884332, 1191.624638238952, 1221.3587866370226, 1235.4810979388678, 834.2950207075012, 851.2508992086924, 858.3819649852096, 858.8153546987428, 867.3668222197831, 4230.196262710137, 4232.343986682007, 4244.490661120685, 4250.766207858597, 4255.510616279105, 4894.192458244421, 4923.261510773413, 4940.7035577865445, 4948.455669876311, 4968.701877887338, 4263.16868210696, 4286.721363111388, 4294.141171765659, 4295.591918767775, 4298.441202643637, 2516.8112391570708, 2566.7946564275185, 2602.3976023976024, 2611.516869379133, 2641.471705658876, 4609.884752881205, 4632.4672662644225, 4657.790399432034, 4663.766811659403, 4670.174544400588, 4970.304157417964, 4993.925091123636, 5000.649954503223, 5002.199648056294, 5014.448410674823, 4428.31361139024, 4561.931571026437, 4606.167207167635, 4637.794173514911, 4675.322078298627, 4875.731834748981, 4879.341288926092, 4883.215507981343, 4885.9022819544125, 4908.484609115992, 4824.204006338915, 4828.37231159947, 4832.462956947631, 4840.34655321527, 4848.781804818862, 4611.146937816515, 4669.41632295963, 4877.414710234794, 4883.780229889592, 4901.583365413837, 3513.6135025147723, 3524.207053413064, 3528.9647103528637, 3540.0, 3541.327147841902, 5200.63595548308, 5203.401608815035, 5248.60635452335, 5257.053730328577, 5258.947410525846, 4704.882377940579, 4864.708117512961, 4931.827386041471, 4983.5763960063805, 5011.296159305708, 4986.601071914166, 5001.974990125172, 5002.674826136289, 5007.499250074963, 5007.949920500749, 4800.517683366905, 4912.950870491392, 4921.8523444296725, 4923.532264434873, 4925.679830810986, 4950.975245123896, 4983.825566105169, 5009.398872135367, 5033.421156567042, 5035.194368901105, 4907.852764417074, 4917.655993924166, 4930.359053323045, 4930.408350997904, 4938.1358262304675], "value": 3694.906837146241, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [607.5443417436923, 669.9497537684675, 673.4814193071333, 726.8473620539686, 743.5984568333099, 11568.884311156886, 12228.205166664184, 12250.509979600805, 12257.938710306447, 12260.386980650976, 12186.146969712123, 12249.142560020802, 12278.508859645626, 12323.445444954976, 12324.691882702937, 613.868018376049, 632.7374139732028, 731.7036600176937, 749.9250074992511, 750.4371721209093, 749.6476655971685, 750.3322043381395, 752.5221484357445, 753.0, 753.9057617797775, 791.8812178173263, 792.8810678398257, 794.3010151067053, 794.3883209928351, 794.4161041634394, 639.2009987515582, 658.9571677840925, 660.1055569703079, 661.487347305837, 785.9096203936534, 484.72128526097634, 563.8533981164927, 577.4254616656411, 579.7593998490663, 581.3837332427598, 11734.178607497479, 11748.236364636357, 11749.29504229749, 11766.352850593214, 11769.588064417705, 11455.427228638535, 11571.363575003372, 11694.649160525198, 11805.291682499077, 12099.697507562294, 9141.908580914238, 9145.176934075898, 9589.18491928187, 9667.903320966841, 10510.421926794023, 3894.1432884765304, 3952.505936757905, 3973.562908080109, 3990.7605543667473, 4126.855560055414, 46788.53211467876, 47020.0, 47470.82873257946, 47720.7613961928, 48496.99999999965, 9422.199113075329, 9500.619975201053, 9529.237660987104, 9559.0, 9759.512024398751, 15278.388864445298, 15316.693666126615, 15527.922360388351, 15626.374945002073, 15702.921485392728, 6299.6850157491945, 6350.587211831216, 6377.617342959437, 6522.510811689142, 6592.505562082767, 3479.304139172176, 3481.9303613928087, 3668.211334563082, 3673.008287762289, 3730.5336832895887, 2497.0760818497274, 2573.3309339571847, 2578.4714133602565, 2582.9741702582733, 2871.1673614651518, 497.1647631978311, 504.853592458183, 508.88550076232553, 525.4981492674563, 530.4986787485866, 521.4550794419764, 525.4325328645054, 590.9881802364015, 602.6444397805316, 612.1429998002832, 7056.188538318056, 7101.85582653668, 7288.271172882775, 7613.162552119263, 7709.151993280735, 571.3286887906776, 589.2289348171735, 597.745957967862, 598.7724664627501, 601.6811090122242, 3637.1634524059614, 3716.572594151653, 3756.3614185588517, 3819.7135214858995, 3860.0735823402742, 68791.53912604909, 71759.28240717525, 73625.0, 75941.0, 76413.23586764061, 62351.0, 63194.684026579576, 63762.36237637564, 64177.35822641807, 66998.66500667563, 57985.0, 58046.7097664509, 58676.41323586795, 58879.64481420781, 58993.41006589965, 6665.566738162198, 6908.896366554405, 6988.615626140611, 7019.543729657556, 7091.82270443243, 38123.187681231655, 38292.61707382891, 38988.610113898496, 39316.0, 41339.1732165361, 47781.76109119432, 55392.0, 55581.0, 55685.721571391885, 56038.0, 8827.426217296112, 9781.608735650494, 9782.706518804447, 10179.898201017895, 10182.287239893432, 10987.780244395228, 12020.814484161529, 12077.57728479499, 12788.808167877303, 12844.10091293638, 10963.122950164126, 11038.613648522263, 11255.155863310121, 11255.887441125484, 11333.659990200307, 10051.447170405405, 10533.4733263335, 11123.27698699582, 11512.079033677453, 11522.481488332878, 9791.951040245038, 10360.792784144425, 10498.580056797642, 10532.104771094542, 10728.088112510524, 8669.783255418664, 8672.956635216784, 8820.5589720515, 8953.597088130919, 8972.910270897468, 9303.906960930575, 9372.531373431437, 9567.61729530811, 9618.278629102986, 9838.508074596099], "value": 5976.60458540337, "unit": "score"}], "name": "dromaeo_css", "value": 6043.326698543291, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 117.0, 117.0, 117.0, 116.0, 118.0, 116.0, 117.0, 116.0, 117.0], "value": 115.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 134.0, 130.0, 177.0, 128.0, 127.0, 130.0, 130.0, 168.0, 129.0], "value": 141.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 162.0, 162.0, 161.0, 162.0, 161.0, 162.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 85.0, 78.0, 117.0, 77.0, 78.0, 78.0, 76.0, 91.0, 76.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 105.0, 83.0, 84.0, 84.0, 108.0, 84.0, 85.0, 104.0], "value": 90.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 149.0, 147.0, 146.0, 147.0, 148.0, 147.0, 147.0, 146.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 66.0, 65.0, 67.0, 67.0, 69.0, 66.0, 67.0, 67.0], "value": 66.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 66.0, 67.0, 67.0, 66.0, 66.0, 67.0, 66.0, 67.0], "value": 66.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 91.0, 85.0, 85.0, 84.0, 85.0, 86.0, 84.0, 84.0, 85.0], "value": 85.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 144.0, 141.0, 142.0, 147.0, 144.0, 143.0, 143.0, 206.0, 149.0], "value": 151.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 186.0, 183.0, 183.0, 180.0, 185.0, 183.0, 179.0, 182.0, 179.0], "value": 181.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 70.0, 70.0, 70.0, 70.0, 69.0, 70.0, 69.0, 70.0, 68.0], "value": 69.8, "unit": "score"}], "name": "kraken", "value": 1573.4, "alertThreshold": 2.0}]} 03:26:49 INFO - Return code: 0 03:26:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:26:49 INFO - # TBPL SUCCESS # 03:26:49 INFO - Running post-action listener: _resource_record_post_action 03:26:49 INFO - [mozharness: 2016-11-25 11:26:49.462613Z] Finished run-tests step (success) 03:26:49 INFO - Running post-run listener: _resource_record_post_run 03:26:49 INFO - Total resource usage - Wall time: 1207s; CPU: 13.0%; Read bytes: 11104256; Write bytes: 421027840; Read time: 3412; Write time: 397276 03:26:49 INFO - TinderboxPrint: CPU usage
13.1% 03:26:49 INFO - TinderboxPrint: I/O read bytes / time
11,104,256 / 3,412 03:26:49 INFO - TinderboxPrint: I/O write bytes / time
421,027,840 / 397,276 03:26:49 INFO - TinderboxPrint: CPU idle
8,367.8 (86.9%) 03:26:49 INFO - TinderboxPrint: CPU user
1,209.1 (12.6%) 03:26:49 INFO - TinderboxPrint: Swap in / out
0 / 0 03:26:49 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 12288; Write bytes: 95174656; Read time: 40; Write time: 63152 03:26:49 INFO - run-tests - Wall time: 1191s; CPU: 13.0%; Read bytes: 8687616; Write bytes: 325853184; Read time: 3064; Write time: 334124 03:26:50 INFO - Running post-run listener: _upload_blobber_files 03:26:50 INFO - Blob upload gear active. 03:26:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:26:50 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 03:26:50 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', 'Cedar', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:26:50 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 Cedar -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:26:50 INFO - (blobuploader) - INFO - Open directory for files ... 03:26:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:26:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:26:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:26:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:26:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:26:55 INFO - (blobuploader) - INFO - Done attempting. 03:26:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:26:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:26:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:26:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:26:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:26:56 INFO - (blobuploader) - INFO - Done attempting. 03:26:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:26:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:26:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:26:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:26:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:26:57 INFO - (blobuploader) - INFO - Done attempting. 03:26:57 INFO - (blobuploader) - INFO - Iteration through files over. 03:26:57 INFO - Return code: 0 03:26:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:26:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:26:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/49ab1152afa67218ec67191e03a739ddb4cc762d2ced49ab7a8ea54fbbb1720e8cd11a488a59d48bafcde5256ee029129f9ddcf0e4cb793f3bfd9731b7139f59", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/6f6cb550f8632a725d2e147bda03d850a8cf6898d2595a37b5f3421b00c8c0b8ce5e50315b756b6741608f6024848687778fcad437841cb3ee1b140552a7178b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/cceeffab1a53c0cb235fd188500f34c906c1928d041a26b4b1bcef7966851ba795ad531a5275968a506aea38ae0ccfbd608d68f50077cf268c99ce158369bfe8"} 03:26:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:26:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:26:57 INFO - Contents: 03:26:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/49ab1152afa67218ec67191e03a739ddb4cc762d2ced49ab7a8ea54fbbb1720e8cd11a488a59d48bafcde5256ee029129f9ddcf0e4cb793f3bfd9731b7139f59", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/6f6cb550f8632a725d2e147bda03d850a8cf6898d2595a37b5f3421b00c8c0b8ce5e50315b756b6741608f6024848687778fcad437841cb3ee1b140552a7178b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/cceeffab1a53c0cb235fd188500f34c906c1928d041a26b4b1bcef7966851ba795ad531a5275968a506aea38ae0ccfbd608d68f50077cf268c99ce158369bfe8"} 03:26:57 INFO - Running post-run listener: copy_logs_to_upload_dir 03:26:57 INFO - Copying logs to upload dir... 03:26:57 INFO - mkdir: /builds/slave/test/build/upload/logs 03:26:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.029912 ========= master_lag: 0.17 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-11-25 03:26:57.552408) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-25 03:26:57.556394) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db0483c52d987ecb441a263b000001ad-1480071957.308782-1012989989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/49ab1152afa67218ec67191e03a739ddb4cc762d2ced49ab7a8ea54fbbb1720e8cd11a488a59d48bafcde5256ee029129f9ddcf0e4cb793f3bfd9731b7139f59", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/6f6cb550f8632a725d2e147bda03d850a8cf6898d2595a37b5f3421b00c8c0b8ce5e50315b756b6741608f6024848687778fcad437841cb3ee1b140552a7178b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/cceeffab1a53c0cb235fd188500f34c906c1928d041a26b4b1bcef7966851ba795ad531a5275968a506aea38ae0ccfbd608d68f50077cf268c99ce158369bfe8"} build_url:https://queue.taskcluster.net/v1/task/NgeyN7yCSBStUQT6Jh0_Pw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011249 build_url: 'https://queue.taskcluster.net/v1/task/NgeyN7yCSBStUQT6Jh0_Pw/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/Cedar/sha512/49ab1152afa67218ec67191e03a739ddb4cc762d2ced49ab7a8ea54fbbb1720e8cd11a488a59d48bafcde5256ee029129f9ddcf0e4cb793f3bfd9731b7139f59", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/6f6cb550f8632a725d2e147bda03d850a8cf6898d2595a37b5f3421b00c8c0b8ce5e50315b756b6741608f6024848687778fcad437841cb3ee1b140552a7178b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/cceeffab1a53c0cb235fd188500f34c906c1928d041a26b4b1bcef7966851ba795ad531a5275968a506aea38ae0ccfbd608d68f50077cf268c99ce158369bfe8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-25 03:26:57.582061) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 03:26:57.582405) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db0483c52d987ecb441a263b000001ad-1480071957.308782-1012989989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004491 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 03:26:57.666285) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-25 03:26:57.667000) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-25 03:26:57.667634) ========= ========= Total master_lag: 0.30 =========