builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-009 starttime: 1476980859.55 results: success (0) buildid: 20161020075250 builduid: 69400d2cf9c945099d771cad988378f8 revision: 11ae641575dcfe43941a7cc72d852a2cedd5710f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 09:27:39.549106) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 09:27:39.549578) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 09:27:39.549901) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 09:27:39.564533) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 09:27:39.564893) ========= 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=17051fcd5208b27b50bedfeb000001dd-1476980859.38851-223743630 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-20 09:27:39-- 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% 15.1M=0.001s 2016-10-20 09:27:39 (15.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.087579 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 09:27:39.666130) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 09:27:39.666436) ========= 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=17051fcd5208b27b50bedfeb000001dd-1476980859.38851-223743630 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019490 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 09:27:39.715381) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 09:27:39.715734) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 11ae641575dcfe43941a7cc72d852a2cedd5710f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 11ae641575dcfe43941a7cc72d852a2cedd5710f --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=17051fcd5208b27b50bedfeb000001dd-1476980859.38851-223743630 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-20 09:27:40,080 truncating revision to first 12 chars 2016-10-20 09:27:40,080 Setting DEBUG logging. 2016-10-20 09:27:40,080 attempt 1/10 2016-10-20 09:27:40,080 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/11ae641575dc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-20 09:27:40,447 unpacking tar archive at: fx-team-11ae641575dc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.681536 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 09:27:40.410649) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 09:27:40.410963) ========= script_repo_revision: 11ae641575dcfe43941a7cc72d852a2cedd5710f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 09:27:40.411375) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 09:27:40.411648) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 09:27:40.421206) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-10-20 09:27:40.421562) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=17051fcd5208b27b50bedfeb000001dd-1476980859.38851-223743630 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:27:40 INFO - MultiFileLogger online at 20161020 09:27:40 in /builds/slave/test 09:27:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 09:27:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:27:40 INFO - {'append_to_log': False, 09:27:40 INFO - 'base_work_dir': '/builds/slave/test', 09:27:40 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:27:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:27:40 INFO - 'branch': 'Fx-Team-Non-PGO', 09:27:40 INFO - 'buildbot_json_path': 'buildprops.json', 09:27:40 INFO - 'config_files': ('talos/linux_config.py',), 09:27:40 INFO - 'default_actions': ('clobber', 09:27:40 INFO - 'read-buildbot-config', 09:27:40 INFO - 'download-and-extract', 09:27:40 INFO - 'populate-webroot', 09:27:40 INFO - 'create-virtualenv', 09:27:40 INFO - 'install', 09:27:40 INFO - 'run-tests'), 09:27:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:27:40 INFO - 'download_minidump_stackwalk': True, 09:27:40 INFO - 'download_symbols': 'ondemand', 09:27:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:27:40 INFO - 'tooltool.py': '/tools/tooltool.py', 09:27:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:27:40 INFO - '/tools/misc-python/virtualenv.py')}, 09:27:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:27:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:27:40 INFO - 'installer_path': 'installer.exe', 09:27:40 INFO - 'log_level': 'info', 09:27:40 INFO - 'log_name': 'talos', 09:27:40 INFO - 'log_to_console': True, 09:27:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:27:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:27:40 INFO - 'opt_config_files': (), 09:27:40 INFO - 'pip_index': False, 09:27:40 INFO - 'sps_profile': False, 09:27:40 INFO - 'sps_profile_interval': 0, 09:27:40 INFO - 'suite': 'dromaeojs', 09:27:40 INFO - 'system_bits': '32', 09:27:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:27:40 INFO - 'title': 'talos-linux64-ix-009', 09:27:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:27:40 INFO - 'use_talos_json': True, 09:27:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:27:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:27:40 INFO - 'work_dir': 'build'} 09:27:40 INFO - [mozharness: 2016-10-20 16:27:40.888483Z] Running clobber step. 09:27:40 INFO - Running pre-action listener: _resource_record_pre_action 09:27:40 INFO - Running main action method: clobber 09:27:40 INFO - rmtree: /builds/slave/test/build 09:27:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:27:41 INFO - Running post-action listener: _resource_record_post_action 09:27:41 INFO - [mozharness: 2016-10-20 16:27:41.377852Z] Finished clobber step (success) 09:27:41 INFO - [mozharness: 2016-10-20 16:27:41.377953Z] Running read-buildbot-config step. 09:27:41 INFO - Running pre-action listener: _resource_record_pre_action 09:27:41 INFO - Running main action method: read_buildbot_config 09:27:41 INFO - Using buildbot properties: 09:27:41 INFO - { 09:27:41 INFO - "project": "", 09:27:41 INFO - "product": "firefox", 09:27:41 INFO - "script_repo_revision": "production", 09:27:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:27:41 INFO - "repository": "", 09:27:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 09:27:41 INFO - "buildid": "20161020075250", 09:27:41 INFO - "pgo_build": "False", 09:27:41 INFO - "basedir": "/builds/slave/test", 09:27:41 INFO - "buildnumber": 3398, 09:27:41 INFO - "slavename": "talos-linux64-ix-009", 09:27:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:27:41 INFO - "platform": "ubuntu64_hw", 09:27:41 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:27:41 INFO - "branch": "fx-team", 09:27:41 INFO - "repo_path": "integration/fx-team", 09:27:41 INFO - "revision": "11ae641575dcfe43941a7cc72d852a2cedd5710f", 09:27:41 INFO - "stage_platform": "linux64", 09:27:41 INFO - "builduid": "69400d2cf9c945099d771cad988378f8", 09:27:41 INFO - "slavebuilddir": "test" 09:27:41 INFO - } 09:27:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/Pfria87bSZ6TCwsBmjCPcg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 09:27:41 INFO - Running post-action listener: _resource_record_post_action 09:27:41 INFO - [mozharness: 2016-10-20 16:27:41.380366Z] Finished read-buildbot-config step (success) 09:27:41 INFO - [mozharness: 2016-10-20 16:27:41.380452Z] Running download-and-extract step. 09:27:41 INFO - Running pre-action listener: _resource_record_pre_action 09:27:41 INFO - Running main action method: download_and_extract 09:27:41 INFO - mkdir: /builds/slave/test/build/tests 09:27: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')]} 09:27:41 INFO - trying https://queue.taskcluster.net/v1/task/Pfria87bSZ6TCwsBmjCPcg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:27:41 INFO - Downloading https://queue.taskcluster.net/v1/task/Pfria87bSZ6TCwsBmjCPcg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:27:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Pfria87bSZ6TCwsBmjCPcg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:27:42 INFO - Downloaded 1361 bytes. 09:27:42 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:27:42 INFO - Using the following test package requirements: 09:27:42 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:27:42 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:27:42 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:27:42 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:27:42 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:27:42 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:27:42 INFO - u'jsshell-linux-x86_64.zip'], 09:27:42 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:27:42 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:27:42 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:27:42 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:27:42 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:27:42 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:27:42 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:27:42 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:27:42 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:27:42 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:27:42 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:27:42 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:27:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Pfria87bSZ6TCwsBmjCPcg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:27:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pfria87bSZ6TCwsBmjCPcg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:27:42 INFO - Fetch https://queue.taskcluster.net/v1/task/Pfria87bSZ6TCwsBmjCPcg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:27:42 INFO - Http code: 200 09:27:42 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 09:27:42 INFO - x-amz-cf-id: kU0WvpRLjrdYbMy3P0YTD5RnAffFJSaX8XQzJCFu6JtTqSZNzovx_A== 09:27:42 INFO - x-amz-version-id: AKoUJWxeUU26CgWteGqV3rLYhcholJjF 09:27:43 INFO - Expected file size: 20549955 09:27:43 INFO - Obtained file size: 20549955 09:27:47 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:27:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Pfria87bSZ6TCwsBmjCPcg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:27:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pfria87bSZ6TCwsBmjCPcg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:27:47 INFO - Fetch https://queue.taskcluster.net/v1/task/Pfria87bSZ6TCwsBmjCPcg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:27:48 INFO - Http code: 200 09:27:48 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 09:27:48 INFO - x-amz-cf-id: R_3x2VTt4wyRp0Zr2AtTtIyiION540p_WEKNkFWU3rBZtOzVuIGmXQ== 09:27:48 INFO - x-amz-version-id: AKoUJWxeUU26CgWteGqV3rLYhcholJjF 09:27:48 INFO - Expected file size: 20549955 09:27:48 INFO - Obtained file size: 20549955 09:27:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Pfria87bSZ6TCwsBmjCPcg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 09:27:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pfria87bSZ6TCwsBmjCPcg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:27:53 INFO - Fetch https://queue.taskcluster.net/v1/task/Pfria87bSZ6TCwsBmjCPcg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 09:27:53 INFO - Http code: 200 09:27:53 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 09:27:53 INFO - x-amz-cf-id: AGHmm7qJ2kBDkjnouUleFGZxggVHJ9HGdgCjBb7jr78v6sjAaxLQqA== 09:27:53 INFO - x-amz-version-id: HYrb7AwPHWSLmYN0iPR.c9ZqqXoe8CLh 09:27:54 INFO - Expected file size: 14409028 09:27:54 INFO - Obtained file size: 14409028 09:27:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:27:54 INFO - trying https://queue.taskcluster.net/v1/task/Pfria87bSZ6TCwsBmjCPcg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:27:54 INFO - Downloading https://queue.taskcluster.net/v1/task/Pfria87bSZ6TCwsBmjCPcg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:27:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Pfria87bSZ6TCwsBmjCPcg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:27:56 INFO - Downloaded 55527760 bytes. 09:27:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Pfria87bSZ6TCwsBmjCPcg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:27:56 INFO - mkdir: /builds/slave/test/properties 09:27:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:27:56 INFO - Writing to file /builds/slave/test/properties/build_url 09:27:56 INFO - Contents: 09:27:56 INFO - build_url:https://queue.taskcluster.net/v1/task/Pfria87bSZ6TCwsBmjCPcg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:27:57 INFO - Running post-action listener: _resource_record_post_action 09:27:57 INFO - Running post-action listener: set_extra_try_arguments 09:27:57 INFO - [mozharness: 2016-10-20 16:27:57.600740Z] Finished download-and-extract step (success) 09:27:57 INFO - [mozharness: 2016-10-20 16:27:57.600965Z] Running populate-webroot step. 09:27:57 INFO - Running pre-action listener: _resource_record_pre_action 09:27:57 INFO - Running main action method: populate_webroot 09:27:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:27:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:27:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:27:57 INFO - '--tppagecycles', 09:27:57 INFO - '7'], 09:27:57 INFO - 'tests': ['tsvgm']}}, 09:27:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:27:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:27:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:27:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:27:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:27:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:27:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:27:57 INFO - 'talos_options': ['--disable-e10s'], 09:27:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:27:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:27:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:27:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:27:57 INFO - 'talos_options': ['--disable-e10s'], 09:27:57 INFO - 'tests': ['damp', 'tps']}, 09:27:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:27:57 INFO - 'tests': ['damp', 'tps']}, 09:27:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:27:57 INFO - 'tests': ['dromaeo_dom']}, 09:27:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:27:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:27:57 INFO - 'tests': ['basic_compositor_video']}, 09:27:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:27:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:27:57 INFO - 'tests': ['a11yr', 09:27:57 INFO - 'ts_paint', 09:27:57 INFO - 'tpaint', 09:27:57 INFO - 'sessionrestore', 09:27:57 INFO - 'sessionrestore_no_auto_restore', 09:27:57 INFO - 'tabpaint']}, 09:27:57 INFO - 'other-e10s': {'tests': ['a11yr', 09:27:57 INFO - 'ts_paint', 09:27:57 INFO - 'tpaint', 09:27:57 INFO - 'sessionrestore', 09:27:57 INFO - 'sessionrestore_no_auto_restore', 09:27:57 INFO - 'tabpaint']}, 09:27:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:27:57 INFO - 'ts_paint', 09:27:57 INFO - 'tpaint', 09:27:57 INFO - 'sessionrestore', 09:27:57 INFO - 'sessionrestore_no_auto_restore', 09:27:57 INFO - 'tabpaint']}, 09:27:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:27:57 INFO - 'ts_paint', 09:27:57 INFO - 'tpaint', 09:27:57 INFO - 'sessionrestore', 09:27:57 INFO - 'sessionrestore_no_auto_restore', 09:27:57 INFO - 'tabpaint']}, 09:27:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:27:57 INFO - 'tests': ['a11yr', 09:27:57 INFO - 'ts_paint', 09:27:57 INFO - 'tpaint', 09:27:57 INFO - 'sessionrestore', 09:27:57 INFO - 'sessionrestore_no_auto_restore', 09:27:57 INFO - 'tabpaint']}, 09:27:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:27:57 INFO - 'tests': ['a11yr', 09:27:57 INFO - 'ts_paint', 09:27:57 INFO - 'tpaint', 09:27:57 INFO - 'sessionrestore', 09:27:57 INFO - 'sessionrestore_no_auto_restore', 09:27:57 INFO - 'tabpaint']}, 09:27:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:27:57 INFO - 'tests': ['tsvgx', 09:27:57 INFO - 'tsvgr_opacity', 09:27:57 INFO - 'tart', 09:27:57 INFO - 'tscrollx', 09:27:57 INFO - 'cart']}, 09:27:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:27:57 INFO - 'tsvgr_opacity', 09:27:57 INFO - 'tart', 09:27:57 INFO - 'tscrollx', 09:27:57 INFO - 'cart']}, 09:27:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:27:57 INFO - 'talos_options': ['--disable-e10s'], 09:27:57 INFO - 'tests': ['tp5o']}, 09:27:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:27:57 INFO - 'tests': ['tp5o']}, 09:27:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:27:57 INFO - 'talos_options': ['--disable-e10s', 09:27:57 INFO - '--xperf_path', 09:27:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:27:57 INFO - 'tests': ['tp5n']}, 09:27:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:27:57 INFO - 'talos_options': ['--xperf_path', 09:27:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:27:57 INFO - 'tests': ['tp5n']}}, 09:27:57 INFO - 'talos.zip': {'path': '', 09:27:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:27:57 INFO - Running post-action listener: _resource_record_post_action 09:27:57 INFO - [mozharness: 2016-10-20 16:27:57.622086Z] Finished populate-webroot step (success) 09:27:57 INFO - [mozharness: 2016-10-20 16:27:57.622173Z] Running create-virtualenv step. 09:27:57 INFO - Running pre-action listener: _resource_record_pre_action 09:27:57 INFO - Running main action method: create_virtualenv 09:27:57 INFO - Creating virtualenv /builds/slave/test/build/venv 09:27:57 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 09:27:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:27:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:27:57 INFO - Using real prefix '/usr' 09:27:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:27:58 INFO - Installing distribute.............................................................................................................................................................................................done. 09:28:00 INFO - Installing pip.................done. 09:28:00 INFO - Return code: 0 09:28:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:28:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:28:00 INFO - Reading from file tmpfile_stdout 09:28:00 INFO - Output received: 09:28:00 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) 09:28:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:28:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:28:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:28:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5d9f473f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b33ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b30f60>, '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 0x2b31d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b321d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1476980859.38851-223743630', '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 09:28:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:28:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:28:00 INFO - Using env: {'DISPLAY': ':0', 09:28:00 INFO - 'HOME': '/home/cltbld', 09:28:00 INFO - 'LANG': 'en_US.UTF-8', 09:28:00 INFO - 'LANGUAGE': 'en_US:en', 09:28:00 INFO - 'LOGNAME': 'cltbld', 09:28:00 INFO - 'MAIL': '/var/mail/cltbld', 09:28:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:28:00 INFO - 'MOZ_NO_REMOTE': '1', 09:28:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:28:00 INFO - 'NO_EM_RESTART': '1', 09:28:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:28:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:28:00 INFO - 'PWD': '/builds/slave/test', 09:28:00 INFO - 'SHELL': '/bin/bash', 09:28:00 INFO - 'SHLVL': '1', 09:28:00 INFO - 'TERM': 'linux', 09:28:00 INFO - 'TMOUT': '86400', 09:28:00 INFO - 'USER': 'cltbld', 09:28:00 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1476980859.38851-223743630', 09:28:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:28:00 INFO - '_': '/tools/buildbot/bin/python'} 09:28:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:28:00 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 09:28:00 INFO - Cleaning up... 09:28:00 INFO - Return code: 0 09:28:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:28:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:28:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:28:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5d9f473f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b33ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b30f60>, '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 0x2b31d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b321d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1476980859.38851-223743630', '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 09:28:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:28:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:28:00 INFO - Using env: {'DISPLAY': ':0', 09:28:00 INFO - 'HOME': '/home/cltbld', 09:28:00 INFO - 'LANG': 'en_US.UTF-8', 09:28:00 INFO - 'LANGUAGE': 'en_US:en', 09:28:00 INFO - 'LOGNAME': 'cltbld', 09:28:00 INFO - 'MAIL': '/var/mail/cltbld', 09:28:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:28:00 INFO - 'MOZ_NO_REMOTE': '1', 09:28:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:28:00 INFO - 'NO_EM_RESTART': '1', 09:28:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:28:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:28:00 INFO - 'PWD': '/builds/slave/test', 09:28:00 INFO - 'SHELL': '/bin/bash', 09:28:00 INFO - 'SHLVL': '1', 09:28:00 INFO - 'TERM': 'linux', 09:28:00 INFO - 'TMOUT': '86400', 09:28:00 INFO - 'USER': 'cltbld', 09:28:00 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1476980859.38851-223743630', 09:28:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:28:00 INFO - '_': '/tools/buildbot/bin/python'} 09:28:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:28:00 INFO - Downloading/unpacking psutil>=3.1.1 09:28:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:28:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:28:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:28:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:28:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:28:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:28:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:28:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:28:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:28:02 INFO - Installing collected packages: psutil 09:28:02 INFO - Running setup.py install for psutil 09:28:02 INFO - building 'psutil._psutil_linux' extension 09:28:02 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 09:28:03 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 09:28:03 INFO - building 'psutil._psutil_posix' extension 09:28:03 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 09:28:03 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 09:28:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:28:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:28:03 INFO - Successfully installed psutil 09:28:03 INFO - Cleaning up... 09:28:03 INFO - Return code: 0 09:28:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:28:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:28:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:28:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:03 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 0x7f5d9f473f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b33ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b30f60>, '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 0x2b31d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b321d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1476980859.38851-223743630', '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 09:28:03 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 09:28:03 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 09:28:03 INFO - Using env: {'DISPLAY': ':0', 09:28:03 INFO - 'HOME': '/home/cltbld', 09:28:03 INFO - 'LANG': 'en_US.UTF-8', 09:28:03 INFO - 'LANGUAGE': 'en_US:en', 09:28:03 INFO - 'LOGNAME': 'cltbld', 09:28:03 INFO - 'MAIL': '/var/mail/cltbld', 09:28:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:28:03 INFO - 'MOZ_NO_REMOTE': '1', 09:28:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:28:03 INFO - 'NO_EM_RESTART': '1', 09:28:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:28:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:28:03 INFO - 'PWD': '/builds/slave/test', 09:28:03 INFO - 'SHELL': '/bin/bash', 09:28:03 INFO - 'SHLVL': '1', 09:28:03 INFO - 'TERM': 'linux', 09:28:03 INFO - 'TMOUT': '86400', 09:28:03 INFO - 'USER': 'cltbld', 09:28:03 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1476980859.38851-223743630', 09:28:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:28:03 INFO - '_': '/tools/buildbot/bin/python'} 09:28:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:28:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:28:03 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 09:28:03 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 09:28:03 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 09:28:03 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 09:28:03 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 09:28:03 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 09:28:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:28:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:28:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:28:05 INFO - Installing collected packages: mozsystemmonitor 09:28:05 INFO - Running setup.py install for mozsystemmonitor 09:28:05 INFO - Successfully installed mozsystemmonitor 09:28:05 INFO - Cleaning up... 09:28:05 INFO - Return code: 0 09:28:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:28:05 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')]} 09:28:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:28:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:05 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')]} 09:28:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:28:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:05 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 0x7f5d9f473f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b33ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b30f60>, '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 0x2b31d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b321d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1476980859.38851-223743630', '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 09:28:05 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 09:28:05 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 09:28:05 INFO - Using env: {'DISPLAY': ':0', 09:28:05 INFO - 'HOME': '/home/cltbld', 09:28:05 INFO - 'LANG': 'en_US.UTF-8', 09:28:05 INFO - 'LANGUAGE': 'en_US:en', 09:28:05 INFO - 'LOGNAME': 'cltbld', 09:28:05 INFO - 'MAIL': '/var/mail/cltbld', 09:28:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:28:05 INFO - 'MOZ_NO_REMOTE': '1', 09:28:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:28:05 INFO - 'NO_EM_RESTART': '1', 09:28:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:28:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:28:05 INFO - 'PWD': '/builds/slave/test', 09:28:05 INFO - 'SHELL': '/bin/bash', 09:28:05 INFO - 'SHLVL': '1', 09:28:05 INFO - 'TERM': 'linux', 09:28:05 INFO - 'TMOUT': '86400', 09:28:05 INFO - 'USER': 'cltbld', 09:28:05 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1476980859.38851-223743630', 09:28:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:28:05 INFO - '_': '/tools/buildbot/bin/python'} 09:28:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:28:06 INFO - Downloading/unpacking jsonschema==2.5.1 09:28:06 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 09:28:06 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 09:28:06 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 09:28:06 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 09:28:06 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 09:28:06 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 09:28:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:28:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:28:07 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 09:28:07 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 09:28:07 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 09:28:07 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 09:28:07 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 09:28:07 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 09:28:08 INFO - Downloading functools32-3.2.3-2.tar.gz 09:28:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:28:08 INFO - warning: no files found matching '*.txt' 09:28:08 INFO - no previously-included directories found matching 'build' 09:28:08 INFO - no previously-included directories found matching 'dist' 09:28:08 INFO - no previously-included directories found matching '.git*' 09:28:08 INFO - Installing collected packages: jsonschema, functools32 09:28:08 INFO - Running setup.py install for functools32 09:28:08 INFO - warning: no files found matching '*.txt' 09:28:08 INFO - no previously-included directories found matching 'build' 09:28:08 INFO - no previously-included directories found matching 'dist' 09:28:08 INFO - no previously-included directories found matching '.git*' 09:28:08 INFO - Successfully installed jsonschema functools32 09:28:08 INFO - Cleaning up... 09:28:08 INFO - Return code: 0 09:28:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:28:08 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')]} 09:28:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:28:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:08 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')]} 09:28:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:28:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:08 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 0x7f5d9f473f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b33ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b30f60>, '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 0x2b31d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b321d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1476980859.38851-223743630', '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 09:28:08 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 09:28:08 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 09:28:08 INFO - Using env: {'DISPLAY': ':0', 09:28:08 INFO - 'HOME': '/home/cltbld', 09:28:08 INFO - 'LANG': 'en_US.UTF-8', 09:28:08 INFO - 'LANGUAGE': 'en_US:en', 09:28:08 INFO - 'LOGNAME': 'cltbld', 09:28:08 INFO - 'MAIL': '/var/mail/cltbld', 09:28:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:28:08 INFO - 'MOZ_NO_REMOTE': '1', 09:28:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:28:08 INFO - 'NO_EM_RESTART': '1', 09:28:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:28:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:28:08 INFO - 'PWD': '/builds/slave/test', 09:28:08 INFO - 'SHELL': '/bin/bash', 09:28:08 INFO - 'SHLVL': '1', 09:28:08 INFO - 'TERM': 'linux', 09:28:08 INFO - 'TMOUT': '86400', 09:28:08 INFO - 'USER': 'cltbld', 09:28:08 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1476980859.38851-223743630', 09:28:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:28:08 INFO - '_': '/tools/buildbot/bin/python'} 09:28:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:28:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:28:08 INFO - Cleaning up... 09:28:08 INFO - Return code: 0 09:28:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:28:08 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')]} 09:28:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:28:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:08 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')]} 09:28:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:28:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:08 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 0x7f5d9f473f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b33ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b30f60>, '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 0x2b31d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b321d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1476980859.38851-223743630', '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 09:28:08 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 09:28:08 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 09:28:08 INFO - Using env: {'DISPLAY': ':0', 09:28:08 INFO - 'HOME': '/home/cltbld', 09:28:08 INFO - 'LANG': 'en_US.UTF-8', 09:28:08 INFO - 'LANGUAGE': 'en_US:en', 09:28:08 INFO - 'LOGNAME': 'cltbld', 09:28:08 INFO - 'MAIL': '/var/mail/cltbld', 09:28:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:28:08 INFO - 'MOZ_NO_REMOTE': '1', 09:28:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:28:08 INFO - 'NO_EM_RESTART': '1', 09:28:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:28:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:28:08 INFO - 'PWD': '/builds/slave/test', 09:28:08 INFO - 'SHELL': '/bin/bash', 09:28:08 INFO - 'SHLVL': '1', 09:28:08 INFO - 'TERM': 'linux', 09:28:08 INFO - 'TMOUT': '86400', 09:28:08 INFO - 'USER': 'cltbld', 09:28:08 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1476980859.38851-223743630', 09:28:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:28:08 INFO - '_': '/tools/buildbot/bin/python'} 09:28:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:28:08 INFO - Downloading/unpacking blobuploader==1.2.4 09:28:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:28:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:28:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:28:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:28:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:28:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:28:10 INFO - Downloading blobuploader-1.2.4.tar.gz 09:28:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:28:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:28:10 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 09:28:10 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 09:28:10 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 09:28:10 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 09:28:10 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 09:28:10 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 09:28:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:28:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:28:11 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 09:28:11 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 09:28:11 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 09:28:11 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 09:28:11 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 09:28:11 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 09:28:11 INFO - Downloading docopt-0.6.1.tar.gz 09:28:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:28:11 INFO - Installing collected packages: blobuploader, requests, docopt 09:28:11 INFO - Running setup.py install for blobuploader 09:28:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:28:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:28:11 INFO - Running setup.py install for requests 09:28:12 INFO - Running setup.py install for docopt 09:28:12 INFO - Successfully installed blobuploader requests docopt 09:28:12 INFO - Cleaning up... 09:28:12 INFO - Return code: 0 09:28:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:28:12 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')]} 09:28:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:28:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:12 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')]} 09:28:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:28:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:12 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 0x7f5d9f473f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b33ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b30f60>, '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 0x2b31d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b321d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1476980859.38851-223743630', '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 09:28:12 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 09:28:12 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 09:28:12 INFO - Using env: {'DISPLAY': ':0', 09:28:12 INFO - 'HOME': '/home/cltbld', 09:28:12 INFO - 'LANG': 'en_US.UTF-8', 09:28:12 INFO - 'LANGUAGE': 'en_US:en', 09:28:12 INFO - 'LOGNAME': 'cltbld', 09:28:12 INFO - 'MAIL': '/var/mail/cltbld', 09:28:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:28:12 INFO - 'MOZ_NO_REMOTE': '1', 09:28:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:28:12 INFO - 'NO_EM_RESTART': '1', 09:28:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:28:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:28:12 INFO - 'PWD': '/builds/slave/test', 09:28:12 INFO - 'SHELL': '/bin/bash', 09:28:12 INFO - 'SHLVL': '1', 09:28:12 INFO - 'TERM': 'linux', 09:28:12 INFO - 'TMOUT': '86400', 09:28:12 INFO - 'USER': 'cltbld', 09:28:12 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1476980859.38851-223743630', 09:28:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:28:12 INFO - '_': '/tools/buildbot/bin/python'} 09:28:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:28:12 INFO - Running setup.py (path:/tmp/pip-jt4Hgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:28:12 INFO - Running setup.py (path:/tmp/pip-ua7tSU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:28:12 INFO - Running setup.py (path:/tmp/pip-tWMdhz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:28:12 INFO - Running setup.py (path:/tmp/pip-j4Oww_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:28:12 INFO - Running setup.py (path:/tmp/pip-YA73MZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:28:12 INFO - Running setup.py (path:/tmp/pip-ST1Qad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:28:12 INFO - Running setup.py (path:/tmp/pip-AAhrJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:28:12 INFO - Running setup.py (path:/tmp/pip-Ndlhw4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:28:12 INFO - Running setup.py (path:/tmp/pip-dNKvH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:28:13 INFO - Running setup.py (path:/tmp/pip-fcq2o4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:28:13 INFO - Running setup.py (path:/tmp/pip-EwxwO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:28:13 INFO - Running setup.py (path:/tmp/pip-oJhRbX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:28:13 INFO - Running setup.py (path:/tmp/pip-FykD23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:28:13 INFO - Running setup.py (path:/tmp/pip-p3EYFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:28:13 INFO - Running setup.py (path:/tmp/pip-7KErt1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:28:13 INFO - Running setup.py (path:/tmp/pip-iwD5hQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:28:13 INFO - Running setup.py (path:/tmp/pip-Hgl4zK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:28:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:28:13 INFO - Running setup.py install for manifestparser 09:28:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:28:13 INFO - Running setup.py install for mozcrash 09:28:13 INFO - Running setup.py install for mozdebug 09:28:13 INFO - Running setup.py install for mozdevice 09:28:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:28:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:28:14 INFO - Running setup.py install for mozfile 09:28:14 INFO - Running setup.py install for mozhttpd 09:28:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:28:14 INFO - Running setup.py install for mozinfo 09:28:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:28:14 INFO - Running setup.py install for mozInstall 09:28:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:28:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:28:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:28:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:28:14 INFO - Running setup.py install for mozleak 09:28:14 INFO - Running setup.py install for mozlog 09:28:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:28:14 INFO - Running setup.py install for moznetwork 09:28:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:28:14 INFO - Running setup.py install for mozprocess 09:28:14 INFO - Running setup.py install for mozprofile 09:28:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:28:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:28:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:28:15 INFO - Running setup.py install for mozrunner 09:28:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:28:15 INFO - Running setup.py install for mozscreenshot 09:28:15 INFO - Running setup.py install for moztest 09:28:15 INFO - Running setup.py install for mozversion 09:28:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:28:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:28:15 INFO - Cleaning up... 09:28:15 INFO - Return code: 0 09:28:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:28:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:28:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:28:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:15 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 0x7f5d9f473f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b33ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b30f60>, '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 0x2b31d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b321d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1476980859.38851-223743630', '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 09:28:15 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 09:28:15 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 09:28:15 INFO - Using env: {'DISPLAY': ':0', 09:28:15 INFO - 'HOME': '/home/cltbld', 09:28:15 INFO - 'LANG': 'en_US.UTF-8', 09:28:15 INFO - 'LANGUAGE': 'en_US:en', 09:28:15 INFO - 'LOGNAME': 'cltbld', 09:28:15 INFO - 'MAIL': '/var/mail/cltbld', 09:28:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:28:15 INFO - 'MOZ_NO_REMOTE': '1', 09:28:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:28:15 INFO - 'NO_EM_RESTART': '1', 09:28:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:28:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:28:15 INFO - 'PWD': '/builds/slave/test', 09:28:15 INFO - 'SHELL': '/bin/bash', 09:28:15 INFO - 'SHLVL': '1', 09:28:15 INFO - 'TERM': 'linux', 09:28:15 INFO - 'TMOUT': '86400', 09:28:15 INFO - 'USER': 'cltbld', 09:28:15 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1476980859.38851-223743630', 09:28:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:28:15 INFO - '_': '/tools/buildbot/bin/python'} 09:28:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:28:15 INFO - Running setup.py (path:/tmp/pip-_usgnj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:28:15 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)) 09:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:28:15 INFO - Running setup.py (path:/tmp/pip-0DJQ23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:28:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 09:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:28:15 INFO - Running setup.py (path:/tmp/pip-YTfD9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:28:15 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)) 09:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:28:15 INFO - Running setup.py (path:/tmp/pip-CSFx_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:28:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:28:16 INFO - Running setup.py (path:/tmp/pip-juGOSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:28:16 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)) 09:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:28:16 INFO - Running setup.py (path:/tmp/pip-RLSBei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:28:16 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)) 09:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:28:16 INFO - Running setup.py (path:/tmp/pip-83i1xk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:28:16 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)) 09:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:28:16 INFO - Running setup.py (path:/tmp/pip-FsTmK_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:28:16 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)) 09:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:28:16 INFO - Running setup.py (path:/tmp/pip-Mb3gbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:28:16 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)) 09:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:28:16 INFO - Running setup.py (path:/tmp/pip-O58QA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:28:16 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)) 09:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:28:16 INFO - Running setup.py (path:/tmp/pip-VdyAt1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:28:16 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)) 09:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:28:16 INFO - Running setup.py (path:/tmp/pip-UIwil5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:28:16 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)) 09:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:28:16 INFO - Running setup.py (path:/tmp/pip-PaBmZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:28:16 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)) 09:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:28:16 INFO - Running setup.py (path:/tmp/pip-PHWJoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:28:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 09:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:28:16 INFO - Running setup.py (path:/tmp/pip-v6Yy9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:28:16 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)) 09:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:28:16 INFO - Running setup.py (path:/tmp/pip-b_494u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:28:16 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)) 09:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:28:16 INFO - Running setup.py (path:/tmp/pip-1wLSyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:28:16 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)) 09:28:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:28:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:28:16 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)) 09:28:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:28:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:28:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:28:16 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 09:28:16 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 09:28:16 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 09:28:16 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 09:28:16 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 09:28:16 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 09:28:18 INFO - Downloading blessings-1.6.tar.gz 09:28:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:28:18 INFO - Installing collected packages: blessings 09:28:18 INFO - Running setup.py install for blessings 09:28:19 INFO - Successfully installed blessings 09:28:19 INFO - Cleaning up... 09:28:19 INFO - Return code: 0 09:28:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:28:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:28:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:28:19 INFO - Reading from file tmpfile_stdout 09:28:19 INFO - Current package versions: 09:28:19 INFO - argparse == 1.2.1 09:28:19 INFO - blessings == 1.6 09:28:19 INFO - blobuploader == 1.2.4 09:28:19 INFO - docopt == 0.6.1 09:28:19 INFO - functools32 == 3.2.3-2 09:28:19 INFO - jsonschema == 2.5.1 09:28:19 INFO - manifestparser == 1.1 09:28:19 INFO - mozInstall == 1.12 09:28:19 INFO - mozcrash == 0.17 09:28:19 INFO - mozdebug == 0.1 09:28:19 INFO - mozdevice == 0.48 09:28:19 INFO - mozfile == 1.2 09:28:19 INFO - mozhttpd == 0.7 09:28:19 INFO - mozinfo == 0.9 09:28:19 INFO - mozleak == 0.1 09:28:19 INFO - mozlog == 3.4 09:28:19 INFO - moznetwork == 0.27 09:28:19 INFO - mozprocess == 0.23 09:28:19 INFO - mozprofile == 0.28 09:28:19 INFO - mozrunner == 6.12 09:28:19 INFO - mozscreenshot == 0.1 09:28:19 INFO - mozsystemmonitor == 0.3 09:28:19 INFO - moztest == 0.7 09:28:19 INFO - mozversion == 1.4 09:28:19 INFO - psutil == 3.1.1 09:28:19 INFO - requests == 1.2.3 09:28:19 INFO - wsgiref == 0.1.2 09:28:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:28:19 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')]} 09:28:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:28:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:19 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')]} 09:28:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:28:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:19 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 0x7f5d9f473f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b33ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b30f60>, '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 0x2b31d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b321d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1476980859.38851-223743630', '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 09:28:19 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 09:28:19 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 09:28:19 INFO - Using env: {'DISPLAY': ':0', 09:28:19 INFO - 'HOME': '/home/cltbld', 09:28:19 INFO - 'LANG': 'en_US.UTF-8', 09:28:19 INFO - 'LANGUAGE': 'en_US:en', 09:28:19 INFO - 'LOGNAME': 'cltbld', 09:28:19 INFO - 'MAIL': '/var/mail/cltbld', 09:28:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:28:19 INFO - 'MOZ_NO_REMOTE': '1', 09:28:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:28:19 INFO - 'NO_EM_RESTART': '1', 09:28:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:28:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:28:19 INFO - 'PWD': '/builds/slave/test', 09:28:19 INFO - 'SHELL': '/bin/bash', 09:28:19 INFO - 'SHLVL': '1', 09:28:19 INFO - 'TERM': 'linux', 09:28:19 INFO - 'TMOUT': '86400', 09:28:19 INFO - 'USER': 'cltbld', 09:28:19 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1476980859.38851-223743630', 09:28:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:28:19 INFO - '_': '/tools/buildbot/bin/python'} 09:28:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:28:19 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)) 09:28:19 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)) 09:28:19 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)) 09:28:19 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)) 09:28:19 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)) 09:28:19 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)) 09:28:19 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)) 09:28:19 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)) 09:28:19 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)) 09:28:19 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)) 09:28:19 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)) 09:28:19 INFO - Cleaning up... 09:28:19 INFO - Return code: 0 09:28:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:28:19 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')]} 09:28:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:28:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:19 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')]} 09:28:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:28:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:19 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 0x7f5d9f473f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b33ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b30f60>, '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 0x2b31d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b321d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1476980859.38851-223743630', '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 09:28:19 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 09:28:19 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 09:28:19 INFO - Using env: {'DISPLAY': ':0', 09:28:19 INFO - 'HOME': '/home/cltbld', 09:28:19 INFO - 'LANG': 'en_US.UTF-8', 09:28:19 INFO - 'LANGUAGE': 'en_US:en', 09:28:19 INFO - 'LOGNAME': 'cltbld', 09:28:19 INFO - 'MAIL': '/var/mail/cltbld', 09:28:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:28:19 INFO - 'MOZ_NO_REMOTE': '1', 09:28:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:28:19 INFO - 'NO_EM_RESTART': '1', 09:28:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:28:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:28:19 INFO - 'PWD': '/builds/slave/test', 09:28:19 INFO - 'SHELL': '/bin/bash', 09:28:19 INFO - 'SHLVL': '1', 09:28:19 INFO - 'TERM': 'linux', 09:28:19 INFO - 'TMOUT': '86400', 09:28:19 INFO - 'USER': 'cltbld', 09:28:19 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1476980859.38851-223743630', 09:28:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:28:19 INFO - '_': '/tools/buildbot/bin/python'} 09:28:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:28:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:28:19 INFO - Cleaning up... 09:28:19 INFO - Return code: 0 09:28:19 INFO - Running post-action listener: _resource_record_post_action 09:28:19 INFO - Running post-action listener: _start_resource_monitoring 09:28:19 INFO - Starting resource monitoring. 09:28:19 INFO - [mozharness: 2016-10-20 16:28:19.841331Z] Finished create-virtualenv step (success) 09:28:19 INFO - [mozharness: 2016-10-20 16:28:19.841859Z] Running install step. 09:28:19 INFO - Running pre-action listener: _resource_record_pre_action 09:28:19 INFO - Running main action method: install 09:28:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:28:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:28:20 INFO - Reading from file tmpfile_stdout 09:28:20 INFO - Detecting whether we're running mozinstall >=1.0... 09:28:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:28:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:28:20 INFO - Reading from file tmpfile_stdout 09:28:20 INFO - Output received: 09:28:20 INFO - Usage: mozinstall [options] installer 09:28:20 INFO - Options: 09:28:20 INFO - -h, --help show this help message and exit 09:28:20 INFO - -d DEST, --destination=DEST 09:28:20 INFO - Directory to install application into. [default: 09:28:20 INFO - "/builds/slave/test"] 09:28:20 INFO - --app=APP Application being installed. [default: firefox] 09:28:20 INFO - mkdir: /builds/slave/test/build/application 09:28:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:28:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:28:36 INFO - Reading from file tmpfile_stdout 09:28:36 INFO - Output received: 09:28:36 INFO - /builds/slave/test/build/application/firefox/firefox 09:28:36 INFO - Running post-action listener: _resource_record_post_action 09:28:36 INFO - [mozharness: 2016-10-20 16:28:36.174155Z] Finished install step (success) 09:28:36 INFO - [mozharness: 2016-10-20 16:28:36.174400Z] Running run-tests step. 09:28:36 INFO - Running pre-action listener: _resource_record_pre_action 09:28:36 INFO - Running main action method: run_tests 09:28:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:28:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:28:36 INFO - Python 2.7.3 09:28:36 INFO - Return code: 0 09:28:36 INFO - grabbing minidump binary from tooltool 09:28:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:36 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 0x2b30f60>, '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 0x2b31d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b321d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:28:36 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 09:28:36 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 09:28:36 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 09:28:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:28:36 INFO - Return code: 0 09:28:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:28:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:28:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:28:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:28:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:28:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Pfria87bSZ6TCwsBmjCPcg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 09:28:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Pfria87bSZ6TCwsBmjCPcg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --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 09:28:36 INFO - Using env: {'DISPLAY': ':0', 09:28:36 INFO - 'HOME': '/home/cltbld', 09:28:36 INFO - 'LANG': 'en_US.UTF-8', 09:28:36 INFO - 'LANGUAGE': 'en_US:en', 09:28:36 INFO - 'LOGNAME': 'cltbld', 09:28:36 INFO - 'MAIL': '/var/mail/cltbld', 09:28:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:28:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:28:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:28:36 INFO - 'MOZ_NO_REMOTE': '1', 09:28:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:28:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:28:36 INFO - 'NO_EM_RESTART': '1', 09:28:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:28:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:28:36 INFO - 'PWD': '/builds/slave/test', 09:28:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:28:36 INFO - 'SHELL': '/bin/bash', 09:28:36 INFO - 'SHLVL': '1', 09:28:36 INFO - 'TERM': 'linux', 09:28:36 INFO - 'TMOUT': '86400', 09:28:36 INFO - 'USER': 'cltbld', 09:28:36 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1476980859.38851-223743630', 09:28:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:28:36 INFO - '_': '/tools/buildbot/bin/python'} 09:28:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Pfria87bSZ6TCwsBmjCPcg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 09:28:36 INFO - mozversion application_buildid: 20161020075250 09:28:36 INFO - mozversion application_changeset: 11ae641575dcfe43941a7cc72d852a2cedd5710f 09:28:36 INFO - mozversion application_display_name: Nightly 09:28:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:28:36 INFO - mozversion application_name: Firefox 09:28:36 INFO - mozversion application_remotingname: firefox 09:28:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:28:36 INFO - mozversion application_vendor: Mozilla 09:28:36 INFO - mozversion application_version: 52.0a1 09:28:36 INFO - mozversion platform_buildid: 20161020075250 09:28:36 INFO - mozversion platform_changeset: 11ae641575dcfe43941a7cc72d852a2cedd5710f 09:28:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:28:36 INFO - mozversion platform_version: 52.0a1 09:28:36 INFO - using testdate: 1476980916 09:28:36 INFO - actual date: 1476980916 09:28:36 INFO - starting webserver on 'localhost:57933' 09:28:36 INFO - SUITE-START | Running 2 tests 09:28:36 INFO - TEST-START | dromaeo_css 09:28:36 INFO - operating with platform_type : linux_ 09:28:36 INFO - Initialising browser for dromaeo_css test... 09:28:36 INFO - TEST-INFO | started process 5195 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOP2IoX/profile http://localhost:57933/getInfo.html) 09:28:40 INFO - PROCESS | 5195 | __metrics Screen width/height:1600/1200 09:28:40 INFO - PROCESS | 5195 | colorDepth:24 09:28:40 INFO - PROCESS | 5195 | Browser inner width/height: 1024/697 09:28:40 INFO - PROCESS | 5195 | __metrics 09:28:41 INFO - PROCESS | 5195 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:28:41 INFO - PROCESS | 5195 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:28:41 INFO - PROCESS | 5195 | console.error: PushService: 09:28:41 INFO - PROCESS | 5195 | stateChangeProcessEnqueue: Error transitioning state 09:28:41 INFO - PROCESS | 5195 | UnknownError 09:28:42 INFO - TEST-INFO | 5195: exit 0 09:28:42 INFO - Browser initialized. 09:28:42 INFO - Running cycle 1/1 for dromaeo_css test... 09:28:42 INFO - TEST-INFO | started process 5278 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOP2IoX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:28:54 INFO - PROCESS | 5278 | RSS: Main: 173355008 09:28:54 INFO - PROCESS | 5278 | 09:29:46 INFO - PROCESS | 5278 | 1476980986498 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] 09:32:00 INFO - PROCESS | 5278 | Cycle 1(1): loaded http://localhost:57933/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57933/tests/dromaeo/cssquery-ext.html) 09:32:01 INFO - PROCESS | 5278 | RSS: Main: 310284288 09:32:01 INFO - PROCESS | 5278 | 09:35:04 INFO - PROCESS | 5278 | Cycle 1(1): loaded http://localhost:57933/tests/dromaeo/cssquery-ext.html (next: http://localhost:57933/tests/dromaeo/cssquery-jquery.html) 09:35:04 INFO - PROCESS | 5278 | RSS: Main: 277643264 09:35:04 INFO - PROCESS | 5278 | 09:38:07 INFO - PROCESS | 5278 | Cycle 1(1): loaded http://localhost:57933/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57933/tests/dromaeo/cssquery-mootools.html) 09:38:07 INFO - PROCESS | 5278 | RSS: Main: 257761280 09:38:07 INFO - PROCESS | 5278 | 09:41:09 INFO - PROCESS | 5278 | Cycle 1(1): loaded http://localhost:57933/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57933/tests/dromaeo/cssquery-prototype.html) 09:41:10 INFO - PROCESS | 5278 | RSS: Main: 220958720 09:41:10 INFO - PROCESS | 5278 | 09:44:13 INFO - PROCESS | 5278 | Cycle 1(1): loaded http://localhost:57933/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57933/tests/dromaeo/cssquery-yui.html) 09:44:14 INFO - PROCESS | 5278 | RSS: Main: 224530432 09:44:14 INFO - PROCESS | 5278 | 09:47:17 INFO - PROCESS | 5278 | Cycle 1(1): loaded http://localhost:57933/tests/dromaeo/cssquery-yui.html (next: http://localhost:57933/tests/dromaeo/cssquery-dojo.html) 09:47:17 INFO - PROCESS | 5278 | RSS: Main: 311791616 09:47:17 INFO - PROCESS | 5278 | 09:47:17 INFO - PROCESS | 5278 | __start_tp_report 09:47:17 INFO - PROCESS | 5278 | _x_x_mozilla_page_load 09:47:17 INFO - PROCESS | 5278 | _x_x_mozilla_page_load_details 09:47:17 INFO - PROCESS | 5278 | |i|pagename|runs| 09:47:17 INFO - PROCESS | 5278 | |0;dojo.html;2564.6409502669626;2583.237944806282;2615.0585789115917;2615.489979454006;2633.84196948183;4492.730436173832;4541.659375546839;4660.044690838378;4661.13768952744;4683.8524561482445;4598.770061496928;4605.078984203156;4615.215413379725;4618.05329907369;4628.120657075162;4211.2630289699255;4238.088810905655;4244.617984381405;4257.76582287974;4281.892952676177;4282.807273672693;4303.8063287152;4309.482862056558;4312.654987601;4314;4296.5273819879785;4296.871093867189;4313.719608225471;4327.437433133704;4386.210482113218;4415.094905544356;4419.845305414295;4425.09285596452;4425.7565833879125;4482.753448560328;4166.729162604421;4214.7681877496725;4218.303979843322;4293.978530107361;4385.473743150842;4621.584057434847;4662;4664.743439110847;4669.859904202879;4682.531746825291;4925.13810083234;4957.107720610289;4979.278004689299;4995.050940321364;5030.446650868402;4830.178869592178;4894.877628059291;5026.321446604735;5030.9245361319245;5082.593392528589;4593.127305811885;4613.723176609347;4655.37152484417;4658.417697787777;4706.529347065266;5109.4379618241965;5115.64190506661;5119.283300337956;5120.692758434506;5190.195519694454;4905.3132561441425;4912.066707325596;4914.410270767531;4915.26271059344;4978.925316120261;4748.311494833299;4783.976080119577;4792.376990991149;4846.733429661332;4854.393200849894;4888.291197776302;4923.852284431473;4956.628252881048;5018.84943451697;5021.4978502150225;4910.337104490919;4946.282788995575;4955.256711493233;5005.024020316004;5018.648694591417;4252.149570085995;4294.420253265769;4299.613034826881;4338.717983331074;4355.303151495746;3611.530501034849;3645.4167333226555;3658.1037645776955;3708.2768860072565;3760.0599850037493;4264.616184543406;4295.892602684896;4300.526942036374;4305.720128191658;4357.54245804186;4992.301077849104;5000.974995125001;5001.474845141281;5007.774650140753;5066.594672426197;4162.521310049323;4283.657307415399;4290.0561876387765;4295.699301048897;4352.630026447788;4413.16149931512;4509.954900450954;4556.88607784808;4560.859785053736;4624.6993945394115;4779.569838714393;4789.44921334051;4792.137415265286;4793.13723529768;4846.684965477232;5032.572231360229;5059.139946209227;5065.848024559269;5085.389753229636;5129.307543481582;4538.319252112209;4581.5189405113315;4585.312203169551;4714.5992590630185;4734.881627959328;4955.306257124078;4961.925571116509;4969.254611808257;5018.5232402921665;5025;5048.268001139741;5049.469805670352;5050.72221027847;5051.62112841531;5112.284280200701;4683.180443422456;4730.432348118248;4835.1296766580945;4864.902701946012;4978.4025916890205;4891.608671306358;4893.486183950634;4901.485344038824;4956.207006879026;4959.553640172402;4836.733979631154;4844.636652251025;4848.17581011236;4849.2726091086615;4894.926576101432;4777.689450185866;4829.7442664906675;4896.1921282987905;4937.7531123444405;4998.02538504988;4763.785629646605;4764.047190561832;4766.094442055998;4771.73755443454;4772.6659133861685 09:47:17 INFO - PROCESS | 5278 | |1;ext.html;543.4755460980153;561.3460318728679;576.9480746732795;577.3706659740882;585.1077107411195;27715.307117322078;28287;39463.40804887925;40399.39400908989;40605.59394406055;40091.39862902059;40481.39277910826;40489.39265911013;40587.391189132184;40635.390469142985;7742.264484873928;7889.092754333239;7892.171322011192;7898.960505197495;7900.881486777703;7749.070111586618;7827.843443131134;7832.334251588622;7837.294643482085;7845.490043147206;7845.058592968851;7885.329746971514;7886.487378320391;7897.328727058207;7901.604919754018;7812.3359514441345;7835.981322428048;7858.68565257389;7872.212778722139;7874.488158269694;7690;7746.264104910081;7756.379489640872;7756.844863102707;7763.534187948741;38154.23691526154;38535.8073209635;38563;38566.61433385658;38620.80689596562;3010.729034386894;3430.588329400463;3477.878274260389;3515.191505953645;3525.6826885580163;28070.298242543897;28315.716842831513;28406.431871362664;29927.700722992708;30095.548566771515;3334.5235261445755;3407.30150319184;3517.9120521986897;3527.2416430467574;3629.5644522657185;236347;236421;236835.99999999828;236949;237753;31887.20281992922;51879.740601296755;52147;52187.73906130521;52281.477185228425;33134.3373132536;33215.66784332174;33275.33449331;33327.16682082919;33339.49879773421;11590.94204528972;11700;11702.648920532398;11705.180637355303;11718.472668729928;9364.15722584957;9427.340086194037;9430.764230894283;9435.820522434695;9443.102905223992;7662.463627546018;7780;7790.220977902164;7834.529928204326;7840.764777056697;2965.866536005885;2998.2804127009363;3039.893603723859;3052.4200401923563;3054.328047829474;879.336101243557;881.2421317666801;913.3880300198882;943.3208090175063;996.1433167475965;27325.726742732317;27977.860110699316;27998.44003119926;28425.28936776597;28584.571231431546;741.8434560943152;872.8490150556486;934.7382732834817;965.1554889471712;978.2418625565101;14570.324412692464;14622.853771462149;14649.92675036618;14861.851381486047;14914.328855201542;361243;365704;366810;367488;368099;48643;48934.265986010236;48955.75522122366;48984.51015489871;49093.75453122712;1033.214756784849;1059.2849826367171;1127.7067962330018;1140.3386036099043;1185.1526158796503;25954;28902.42195156127;29788.702112978594;30000.549991749704;30225.848870755504;41448.58551414447;41801.581984180986;42004.159916802106;42142.57857421509;42248.5775142257;296187;296894;298148;298207;298409;24742.38144046413;25384.873075634503;25637.23088307354;26319;26623.7337626629;41404;41617.37573936333;41643.58356416397;42359;42659;34990.825045874604;35348.64651353556;35475.29049418945;35595;35961;34809;35230.823845881634;35733.28533429369;35751.82124089467;36219.63780362163;34139.14652133716;34703.30593388169;35378.64621353857;35610.64389356177;36300.27399452049;30393.848030759706;32248.516272255467;32410.35179296448;32686.182845428102;33206.83396583002;24771.62842557327;25382.238532844043;25389;25725.485490289717;25851 09:47:17 INFO - PROCESS | 5278 | |2;jquery.html;336.5944037434891;357.6780897192528;365.3989187786092;370.1265014565625;384.281393793606;12185.268883866964;12687.619371418861;12968.703129687026;13233.735325293488;17357.652846943052;12683;12882.806757898616;14167.149971001747;14673.559793206221;14894.180820054893;4615.953840461602;4701.294805779126;4774.7135171889795;4778.474367819537;5138;5121.923171152435;5154.6134039946965;5163.199704045879;5163.66436181647;5167.4574169712205;3427.468742344928;3599.064243296749;5142.228665700138;5192.844214673547;5534.391216966131;5543.889122217553;5572.888542229173;5581.6371935824045;5585.3297604287745;5589;5174.870628234286;5342.145256758939;5360.2763626910255;5367.624266301361;5369.463053694639;12524.436400362005;12604.11771176018;12686.302253376061;19577;19648.607027859507;1705.692975264452;1709.6666150100734;1711.5464401933498;1783.5273652482103;1815.2376002079027;9018.503982280972;9082.046385129599;9638.277129215267;11369.886301137049;13821.930890345584;1692.2046638080083;1756.6925787987052;1769.902655353955;1793.515750747304;1861.5997560524552;63607;65795;66636.6668166661;68170.3182968169;70088.29911700869;9461.90538094624;9643.27675424332;9749.171320437701;9835.508224588742;10126.696199114038;13687.31563421825;13688.247146407044;13691.452341906412;13697.041207115406;13708.86291137076;6543.770968016097;6678.866422671616;6703.932960670429;6785.558938668971;6796.72813087471;6050.788222412194;6080.270367555921;6205.968970155121;6258.280297765724;6309.652969086745;4116.135611521614;4129.174165166979;4179.352200408942;4244.8514301999285;4419.756913369795;1767.5757818123557;1849.8797578157378;1878.4458584717268;1879.2952642758964;1883.5856111655414;748.7416841189781;863.8272345530919;880.1594477274188;892.8839250897341;940.374650857186;15844.781730557732;16298.266578004019;16346;16621.41825036118;17267.3956411525;790.4387884601997;828.747232094217;830.3523251863436;850.0606829453488;866.5753780647437;8929.866052009225;9441.480718560408;9446.669366572138;9558.187554057844;9680.128788408936;337452;339721.54872897145;340944;341891;342234;42214.366784498256;42326.576734232876;66312.00531992024;72142.63928680427;74385;875.8861348024716;878.4290211362666;905.805251870851;906.5603182456504;909.736176508805;14704.41182352694;14826.25868706582;14997.2501374933;15236.771448428504;15392.538223853302;36345.273094537435;37068.44397333988;37380.43929341117;37449.62550374462;38194;48434.515654843;49162.26256606225;49999.75000124976;50045.749771250914;50506.74746626243;10190.694279171637;10378.896211037792;11065.391403472886;11072.833907491555;11151;12509;12531;12783.296918669563;12809.679758005752;12829.61511154667;10911.618093366695;11363.147763917905;11492.367919764492;11524.078073754246;11820.113491488;7374.262573742582;7462.552246865205;7501.512401693873;7802.180771018961;8278.420510564203;7772.45592808498;8082.515049097073;8103.473274237156;8177.550234736908;8242.340612751086;10930.45347732626;11242;11272.66182014541;11420.657380278604;11455.255408398427;10402.47987600632;10464.162866970777;10621.362718236931;10772.676819695422;11314.547418103184 09:47:17 INFO - PROCESS | 5278 | |3;mootools.html;1232.5747617072107;1358.5109360630172;1412.3150272118023;1453.2152637575703;1638.2545941596575;6690.498212634054;7541.773746787591;7794.454388192828;7829.569373684452;7973.202679732039;7774.883376749353;7844.294013538781;7845.80385490363;7849.411294152947;7849.529028258308;2136.5513242219154;2165.566886622674;2169.240765731997;2169.533550286688;2170.468235282358;2070.171931227506;2103.726515552976;2105.84206184536;2110.9577808443823;2118.470382404399;2073.78225286345;2081.2819577245828;2091.9267825626107;2094.790520947908;2147.7207962964794;2023.8279746221515;2071.5028393185676;2074.367317968019;2075.9481012974647;2078.490769761418;2017.5662232619911;2058.433930669063;2059.1454546363393;2063.174730107954;2065.06039751914;7492;7711.884321735179;7802.414818888549;7821.296083352526;7837.921620783776;4402.559744025604;4580.129775342708;4580.312953057035;4586.334981427674;4590.472095709003;2849.829010259391;3029.74247188987;3081.734924830248;3090.7836451448406;3098.1325228935934;921.8018126102853;923.4505469245788;937.12378925704;947.0766003146946;950.8763860698134;10447.84328235077;10507.2644914856;10531.78936421275;10545;10550.314229575053;4020.9195816083516;4121.443605113272;4126.628603425706;4163.91672166555;4235.957640423557;8424.326053915673;8487.745367638981;8488.023877254194;8490.405671603052;8495.27790137833;4504.729716217037;4505.144022635689;4505.279155335196;4505.954940450619;4507.256302710081;3610.458431235283;3691.3909204981414;3812.599677033927;4196.307609244502;4201.432806571135;3111.408832321897;3498.2478767065204;3510.8946731598094;3543.3799085159994;3593.173570078844;1017.6845177994845;1050.5922064433696;1053.1522124689698;1053.3363980692116;1056.0864851903048;783.7335305995989;813.6094674556247;817.7015389382951;818.4271010292819;827.210014436212;4928.926066109011;5022.6233032522705;5064.34163558735;5067.6959382436435;5173.611979101507;404.41965779107073;422.5584264443664;424.2342571658125;427.0668589132693;427.74335398761116;3330.683585059464;3398.966010339914;3427.074689833731;3437.7937323760652;3507.7544571879725;9438.95280523593;9740.756481087888;9827.55775990068;9834.409935403899;9837.55730992107;9772.413655180711;9785.315027947976;9786.5596048178;9797.461139637388;9807;7248.130224373003;7284.271572842674;7362.300581444754;7419.406447484188;7420.480566360303;5076.847694569169;5084.694918304914;5150.562202212854;5171.9482805172975;5253.054450199001;8496.745097647081;8763.3427492937;8903.73288801337;8906.153915378029;8938.553072346227;8932.776680583038;9020.007799141958;9077.95603505579;9082.273418126402;9153.954230228806;6469.126667899962;6513.967430162819;6518;6529.249136349381;6543.640099794557;7573.810654733676;7595.050618672666;7600.657970391235;7644.235576442311;7661.770146895602;6809.795706128626;6908.585484870924;6973.163220413583;6983.406410455168;7005.404540614105;6767.39093481589;6860.382565569123;6865.004574336793;6871.003704462725;6889.689963951534;6029.336772955059;6108.236470441195;6112.32764395925;6117.418845209698;6122.7244773984385;4158.875233742992;4255.382969469471;4264.317709166518;4409.845655402046;4438;4131.834726611022;4339.479262488521;4345.413369195118;4410.647148228199;4446.777136287417 09:47:17 INFO - PROCESS | 5278 | |4;prototype.html;295.18234490461424;295.28099078743264;303.9787214894958;304.5872842298686;305.01328203262426;4786.952130478694;4810.615150787933;4825.107355139302;4842.370491836056;4868.367112275404;4749.501302363254;4757.381540399751;4787.281907713845;4791.640626952975;4802.83190088347;3751.531058617673;3768.5289338832645;3769.18962423079;3790.431435284702;3795.1840354323813;3687.834047467857;3736.6823819975334;3816.293985612657;3820.5033345665024;3826.2921359548573;3770.8868733938025;3777.6788972937197;3800.391937290034;3813.31360355136;3823.426486027104;3750.7186960977765;3792.677622402099;3795.013296542891;3809.2191100824402;3809.4285857121513;3138.8116712997066;3223.2264256578487;3262.869485220612;3341.6491268416707;3358.2779702363864;4640.582347588733;4654.488006319302;4660.324252983332;4672;4691.6481263905;4324.308110702304;4327.221100201962;4328.134373125387;4332.393464914914;4349.804258808361;4635.165670179366;4778.283257511366;4971.975140124312;4997.975010124963;5051;3597.676209141164;3614.9277014459826;3617.366960781853;3619.9095022624383;3622.6271791976296;5194.027168296647;5196.636235463519;5201;5203.557697595709;5206.505381988705;3674.5039419678;3707.258548290353;3735.9813200933822;3752.399616061417;3759.9624003759614;3750.812459377075;3762.3039737648623;3779.13079991598;3782.3380908340932;3782.527184101987;4231.576842315805;4232.534421213664;4236.279832428495;4252.787360631956;4257.510386305553;4940.863601371705;4947.925781113287;4950.232713929347;4958.157113290749;4958.281049247911;1245.5266998540496;1310.8137135891843;1317.1109501086728;1319.6305034590139;1320.5576131995697;822.8066404394963;842.9578521073922;859.2567429173845;867.2368315881984;867.7526904832092;3922.7057970651745;3942.073612701013;3943;3945.940810887839;3965.385365268388;4495.483019452739;4511.263163682006;4536.500984891725;4551.3173024046655;4568.984470249619;3932.2528719543197;3942.679202467148;3943.2507823513442;3945.9937715882265;3947.5460322062754;2302.815774738017;2388.390960305111;2401.9159329423387;2409.19292037166;2416.378229620881;4292.3561465780385;4605.861824145281;4755.07419495105;4755.239161734106;4874.95125048745;5247.475252474722;5271.947280527145;5278.049951008778;5298.576113910878;5301.893962120736;4826.710397376169;4898.2652602109965;4899.265110233422;4901.289313049588;4901.43633482147;4873.561379475864;5097.28637990689;5113.468832927724;5121.974390128025;5148.940423830498;5023.422306434807;5045.470225626256;5051.661309752845;5058.924116138334;5065.8733531662;4715.575598196178;4859.489753575824;4865.099956508057;4874.4150701916;4881.585065269492;3669.541307336583;3709.5919448861146;3735.58908520068;3736.8602576214516;3738.1309345327336;5067.543921047123;5123.487651234846;5123.641345105807;5147.481492959511;5176.171812509981;4970.950290497049;4988.176950803077;5000.349954505891;5013.598912087097;5031.804803949445;4852.708837469763;4932.914758753069;4966.726830024383;4972.477889821661;4982.451930287593;4876.29293752411;4894.363732714724;4903.926441103315;4915.91849793045;4918.655694101379;4987.750612469435;5020.523050310215;5028.773705183203;5037.5214354636255;5040.5382439092255;4694.718316900997;4841.927371089366;4866.9292755595125;4877.317175595491;4898.755062246944 09:47:17 INFO - PROCESS | 5278 | |5;yui.html;668.6021817018874;730.7405870915825;735.5072101691866;756.2135379205627;758.772368289513;12960.675983100415;13558.186508809478;14065.578032659023;14073.08524945879;14622.926885365585;12914.547990820323;13613.863861361384;13615.455381784717;13620.591382258523;13628.454861805516;614.3058344071193;777.102446674091;799.6441583495347;801.707376807464;802.5786462107382;630.4074170279945;770.3452065744128;789.9131095579481;794.7218473534275;802.8474589827944;850.1158794853376;852.3990586636406;852.7484392104313;852.7740148860557;853.0488505316589;634.9492040636784;847.3306088190384;848.5333066813228;848.6647774129216;848.8387206430758;485.88095916500686;589.6373730155923;603.4357875386528;607.5322002058434;612.9203203583505;13326.200427974352;13346.532871349456;13378.264195469244;13379;13381.330933453386;12512.624621261377;12664.430100645493;12971.740565188738;13384.665383365495;13424.328783560783;11341.943290283496;11521.769564608745;11555.248908820984;11964.521419143224;12164.209326393757;4145.2124096421885;4155.355919832431;4187.078842654611;4240.618344349024;4349.369341445473;65831;67664;67836.6608166956;67870.3212967864;67911.320886791;10310.896891030994;10347.379157250589;10645.361278323326;10716.981886720749;10929.56281748721;19381.612367752565;19700.31048913281;19707.704384434244;19722.70415943762;19738.210471580976;6485.7405703772265;6653.101831252816;6854.657267136623;6868;6924.23833378328;3582.265635544707;3663.1025398776937;3678.3930651442747;3729.291434627412;3780.0549862534367;2883.7116288371417;2972.5392564152157;2999.47509185896;3012.4125795470113;3018.9396212075635;486.77608300181606;496.05006412719956;498.50647858619703;501.42336313240065;507.09989768161074;498.5769161873293;544.10223131832;545.1465018935651;551.6882961126951;560.4143669865001;8138.877916831252;8272.545010024385;8615.569221538897;8619.353548483889;8948.776280593038;518.4892880512692;525.1178020924807;586.560079940045;608.3898443412381;615.9353267906895;3997.9400308995387;4002.9199416011515;4046.1503084352616;4211.1998720243055;4353.10761293934;76872.2312776865;98622;99688.50155749175;102329;102815;80772;82473.3043011395;84208.57895710482;86574;87476;60994.39005609976;68709.65645171743;73140;73424.63287683527;76036.61981690057;7925.405594580314;8466;8531.786705332417;8545.102764209669;8610.569471526524;30085.69914300829;33755.83122084374;43494.34758478562;44516.77741611271;45182.32226516671;58465.568787432494;58575;59445.70277148586;60699;61168.38831611627;10379.818509633511;10594.682159535227;10602.575896964036;10719.675650368032;10798.838017429587;11338.09295256361;11431.199816012799;11507.539698411969;11758.882411175779;12449.066320026215;11186;11220.887791121984;11420.31478111316;11818.172727909308;12245.69385765363;11307.151963602928;11587;11807.114466414881;12385.19496232742;12400.441980111096;11341;11486.081113511067;11963.342016189194;11973.221740586834;12210.328431936328;8780.692675756318;8867.290616750774;8927.241184499131;9360.953195234253;9544.188743956563;9128.634854605742;9285.675001374919;9795.412275263507;9816.950915245377;9857.02220378704 09:47:17 INFO - PROCESS | 5278 | __end_tp_report 09:47:17 INFO - PROCESS | 5278 | __start_cc_report 09:47:17 INFO - PROCESS | 5278 | _x_x_mozilla_cycle_collect,1370 09:47:17 INFO - PROCESS | 5278 | __end_cc_report 09:47:17 INFO - PROCESS | 5278 | __startTimestamp1476982037723__endTimestamp 09:47:17 INFO - PROCESS | 5278 | 09:47:17 INFO - PROCESS | 5278 | ------- Summary: start ------- 09:47:17 INFO - PROCESS | 5278 | Number of tests: 6 09:47:17 INFO - PROCESS | 5278 | 09:47:17 INFO - PROCESS | 5278 | [#0] dojo.html Cycles:165 Average:4616.71 Median:4748.31 stddev:485.62 (10.2%) stddev-sans-first:459.65 09:47:17 INFO - PROCESS | 5278 | Values: 2564.6 2583.2 2615.1 2615.5 2633.8 4492.7 4541.7 4660.0 4661.1 4683.9 4598.8 4605.1 4615.2 4618.1 4628.1 4211.3 4238.1 4244.6 4257.8 4281.9 4282.8 4303.8 4309.5 4312.7 4314.0 4296.5 4296.9 4313.7 4327.4 4386.2 4415.1 4419.8 4425.1 4425.8 4482.8 4166.7 4214.8 4218.3 4294.0 4385.5 4621.6 4662.0 4664.7 4669.9 4682.5 4925.1 4957.1 4979.3 4995.1 5030.4 4830.2 4894.9 5026.3 5030.9 5082.6 4593.1 4613.7 4655.4 4658.4 4706.5 5109.4 5115.6 5119.3 5120.7 5190.2 4905.3 4912.1 4914.4 4915.3 4978.9 4748.3 4784.0 4792.4 4846.7 4854.4 4888.3 4923.9 4956.6 5018.8 5021.5 4910.3 4946.3 4955.3 5005.0 5018.6 4252.1 4294.4 4299.6 4338.7 4355.3 3611.5 3645.4 3658.1 3708.3 3760.1 4264.6 4295.9 4300.5 4305.7 4357.5 4992.3 5001.0 5001.5 5007.8 5066.6 4162.5 4283.7 4290.1 4295.7 4352.6 4413.2 4510.0 4556.9 4560.9 4624.7 4779.6 4789.4 4792.1 4793.1 4846.7 5032.6 5059.1 5065.8 5085.4 5129.3 4538.3 4581.5 4585.3 4714.6 4734.9 4955.3 4961.9 4969.3 5018.5 5025.0 5048.3 5049.5 5050.7 5051.6 5112.3 4683.2 4730.4 4835.1 4864.9 4978.4 4891.6 4893.5 4901.5 4956.2 4959.6 4836.7 4844.6 4848.2 4849.3 4894.9 4777.7 4829.7 4896.2 4937.8 4998.0 4763.8 4764.0 4766.1 4771.7 4772.7 09:47:17 INFO - PROCESS | 5278 | 09:47:17 INFO - PROCESS | 5278 | [#1] ext.html Cycles:180 Average:44456.40 Median:198731.32 stddev:80255.59 (40.4%) stddev-sans-first:80413.00 09:47:17 INFO - PROCESS | 5278 | Values: 543.5 561.3 576.9 577.4 585.1 27715.3 28287.0 39463.4 40399.4 40605.6 40091.4 40481.4 40489.4 40587.4 40635.4 7742.3 7889.1 7892.2 7899.0 7900.9 7749.1 7827.8 7832.3 7837.3 7845.5 7845.1 7885.3 7886.5 7897.3 7901.6 7812.3 7836.0 7858.7 7872.2 7874.5 7690.0 7746.3 7756.4 7756.8 7763.5 38154.2 38535.8 38563.0 38566.6 38620.8 3010.7 3430.6 3477.9 3515.2 3525.7 28070.3 28315.7 28406.4 29927.7 30095.5 3334.5 3407.3 3517.9 3527.2 3629.6 236347.0 236421.0 236836.0 236949.0 237753.0 31887.2 51879.7 52147.0 52187.7 52281.5 33134.3 33215.7 33275.3 33327.2 33339.5 11590.9 11700.0 11702.6 11705.2 11718.5 9364.2 9427.3 9430.8 9435.8 9443.1 7662.5 7780.0 7790.2 7834.5 7840.8 2965.9 2998.3 3039.9 3052.4 3054.3 879.3 881.2 913.4 943.3 996.1 27325.7 27977.9 27998.4 28425.3 28584.6 741.8 872.8 934.7 965.2 978.2 14570.3 14622.9 14649.9 14861.9 14914.3 361243.0 365704.0 366810.0 367488.0 368099.0 48643.0 48934.3 48955.8 48984.5 49093.8 1033.2 1059.3 1127.7 1140.3 1185.2 25954.0 28902.4 29788.7 30000.5 30225.8 41448.6 41801.6 42004.2 42142.6 42248.6 296187.0 296894.0 298148.0 298207.0 298409.0 24742.4 25384.9 25637.2 26319.0 26623.7 41404.0 41617.4 41643.6 42359.0 42659.0 34990.8 35348.6 35475.3 35595.0 35961.0 34809.0 35230.8 35733.3 35751.8 36219.6 34139.1 34703.3 35378.6 35610.6 36300.3 30393.8 32248.5 32410.4 32686.2 33206.8 24771.6 25382.2 25389.0 25725.5 25851.0 09:47:17 INFO - PROCESS | 5278 | 09:47:17 INFO - PROCESS | 5278 | [#2] jquery.html Cycles:180 Average:22086.25 Median:4122.65 stddev:56195.44 (1363.1%) stddev-sans-first:56329.35 09:47:17 INFO - PROCESS | 5278 | Values: 336.6 357.7 365.4 370.1 384.3 12185.3 12687.6 12968.7 13233.7 17357.7 12683.0 12882.8 14167.1 14673.6 14894.2 4616.0 4701.3 4774.7 4778.5 5138.0 5121.9 5154.6 5163.2 5163.7 5167.5 3427.5 3599.1 5142.2 5192.8 5534.4 5543.9 5572.9 5581.6 5585.3 5589.0 5174.9 5342.1 5360.3 5367.6 5369.5 12524.4 12604.1 12686.3 19577.0 19648.6 1705.7 1709.7 1711.5 1783.5 1815.2 9018.5 9082.0 9638.3 11369.9 13821.9 1692.2 1756.7 1769.9 1793.5 1861.6 63607.0 65795.0 66636.7 68170.3 70088.3 9461.9 9643.3 9749.2 9835.5 10126.7 13687.3 13688.2 13691.5 13697.0 13708.9 6543.8 6678.9 6703.9 6785.6 6796.7 6050.8 6080.3 6206.0 6258.3 6309.7 4116.1 4129.2 4179.4 4244.9 4419.8 1767.6 1849.9 1878.4 1879.3 1883.6 748.7 863.8 880.2 892.9 940.4 15844.8 16298.3 16346.0 16621.4 17267.4 790.4 828.7 830.4 850.1 866.6 8929.9 9441.5 9446.7 9558.2 9680.1 337452.0 339721.5 340944.0 341891.0 342234.0 42214.4 42326.6 66312.0 72142.6 74385.0 875.9 878.4 905.8 906.6 909.7 14704.4 14826.3 14997.3 15236.8 15392.5 36345.3 37068.4 37380.4 37449.6 38194.0 48434.5 49162.3 49999.8 50045.7 50506.7 10190.7 10378.9 11065.4 11072.8 11151.0 12509.0 12531.0 12783.3 12809.7 12829.6 10911.6 11363.1 11492.4 11524.1 11820.1 7374.3 7462.6 7501.5 7802.2 8278.4 7772.5 8082.5 8103.5 8177.6 8242.3 10930.5 11242.0 11272.7 11420.7 11455.3 10402.5 10464.2 10621.4 10772.7 11314.5 09:47:17 INFO - PROCESS | 5278 | 09:47:17 INFO - PROCESS | 5278 | [#3] mootools.html Cycles:180 Average:5050.35 Median:4975.77 stddev:2904.58 (58.4%) stddev-sans-first:2898.56 09:47:17 INFO - PROCESS | 5278 | Values: 1232.6 1358.5 1412.3 1453.2 1638.3 6690.5 7541.8 7794.5 7829.6 7973.2 7774.9 7844.3 7845.8 7849.4 7849.5 2136.6 2165.6 2169.2 2169.5 2170.5 2070.2 2103.7 2105.8 2111.0 2118.5 2073.8 2081.3 2091.9 2094.8 2147.7 2023.8 2071.5 2074.4 2075.9 2078.5 2017.6 2058.4 2059.1 2063.2 2065.1 7492.0 7711.9 7802.4 7821.3 7837.9 4402.6 4580.1 4580.3 4586.3 4590.5 2849.8 3029.7 3081.7 3090.8 3098.1 921.8 923.5 937.1 947.1 950.9 10447.8 10507.3 10531.8 10545.0 10550.3 4020.9 4121.4 4126.6 4163.9 4236.0 8424.3 8487.7 8488.0 8490.4 8495.3 4504.7 4505.1 4505.3 4506.0 4507.3 3610.5 3691.4 3812.6 4196.3 4201.4 3111.4 3498.2 3510.9 3543.4 3593.2 1017.7 1050.6 1053.2 1053.3 1056.1 783.7 813.6 817.7 818.4 827.2 4928.9 5022.6 5064.3 5067.7 5173.6 404.4 422.6 424.2 427.1 427.7 3330.7 3399.0 3427.1 3437.8 3507.8 9439.0 9740.8 9827.6 9834.4 9837.6 9772.4 9785.3 9786.6 9797.5 9807.0 7248.1 7284.3 7362.3 7419.4 7420.5 5076.8 5084.7 5150.6 5171.9 5253.1 8496.7 8763.3 8903.7 8906.2 8938.6 8932.8 9020.0 9078.0 9082.3 9154.0 6469.1 6514.0 6518.0 6529.2 6543.6 7573.8 7595.1 7600.7 7644.2 7661.8 6809.8 6908.6 6973.2 6983.4 7005.4 6767.4 6860.4 6865.0 6871.0 6889.7 6029.3 6108.2 6112.3 6117.4 6122.7 4158.9 4255.4 4264.3 4409.8 4438.0 4131.8 4339.5 4345.4 4410.6 4446.8 09:47:17 INFO - PROCESS | 5278 | 09:47:17 INFO - PROCESS | 5278 | [#4] prototype.html Cycles:180 Average:4110.75 Median:4666.16 stddev:1194.40 (25.6%) stddev-sans-first:1162.91 09:47:17 INFO - PROCESS | 5278 | Values: 295.2 295.3 304.0 304.6 305.0 4787.0 4810.6 4825.1 4842.4 4868.4 4749.5 4757.4 4787.3 4791.6 4802.8 3751.5 3768.5 3769.2 3790.4 3795.2 3687.8 3736.7 3816.3 3820.5 3826.3 3770.9 3777.7 3800.4 3813.3 3823.4 3750.7 3792.7 3795.0 3809.2 3809.4 3138.8 3223.2 3262.9 3341.6 3358.3 4640.6 4654.5 4660.3 4672.0 4691.6 4324.3 4327.2 4328.1 4332.4 4349.8 4635.2 4778.3 4972.0 4998.0 5051.0 3597.7 3614.9 3617.4 3619.9 3622.6 5194.0 5196.6 5201.0 5203.6 5206.5 3674.5 3707.3 3736.0 3752.4 3760.0 3750.8 3762.3 3779.1 3782.3 3782.5 4231.6 4232.5 4236.3 4252.8 4257.5 4940.9 4947.9 4950.2 4958.2 4958.3 1245.5 1310.8 1317.1 1319.6 1320.6 822.8 843.0 859.3 867.2 867.8 3922.7 3942.1 3943.0 3945.9 3965.4 4495.5 4511.3 4536.5 4551.3 4569.0 3932.3 3942.7 3943.3 3946.0 3947.5 2302.8 2388.4 2401.9 2409.2 2416.4 4292.4 4605.9 4755.1 4755.2 4875.0 5247.5 5271.9 5278.0 5298.6 5301.9 4826.7 4898.3 4899.3 4901.3 4901.4 4873.6 5097.3 5113.5 5122.0 5148.9 5023.4 5045.5 5051.7 5058.9 5065.9 4715.6 4859.5 4865.1 4874.4 4881.6 3669.5 3709.6 3735.6 3736.9 3738.1 5067.5 5123.5 5123.6 5147.5 5176.2 4971.0 4988.2 5000.3 5013.6 5031.8 4852.7 4932.9 4966.7 4972.5 4982.5 4876.3 4894.4 4903.9 4915.9 4918.7 4987.8 5020.5 5028.8 5037.5 5040.5 4694.7 4841.9 4866.9 4877.3 4898.8 09:47:17 INFO - PROCESS | 5278 | 09:47:17 INFO - PROCESS | 5278 | [#5] yui.html Cycles:180 Average:17611.45 Median:498.54 stddev:25019.75 (5018.6%) stddev-sans-first:25057.59 09:47:17 INFO - PROCESS | 5278 | Values: 668.6 730.7 735.5 756.2 758.8 12960.7 13558.2 14065.6 14073.1 14622.9 12914.5 13613.9 13615.5 13620.6 13628.5 614.3 777.1 799.6 801.7 802.6 630.4 770.3 789.9 794.7 802.8 850.1 852.4 852.7 852.8 853.0 634.9 847.3 848.5 848.7 848.8 485.9 589.6 603.4 607.5 612.9 13326.2 13346.5 13378.3 13379.0 13381.3 12512.6 12664.4 12971.7 13384.7 13424.3 11341.9 11521.8 11555.2 11964.5 12164.2 4145.2 4155.4 4187.1 4240.6 4349.4 65831.0 67664.0 67836.7 67870.3 67911.3 10310.9 10347.4 10645.4 10717.0 10929.6 19381.6 19700.3 19707.7 19722.7 19738.2 6485.7 6653.1 6854.7 6868.0 6924.2 3582.3 3663.1 3678.4 3729.3 3780.1 2883.7 2972.5 2999.5 3012.4 3018.9 486.8 496.1 498.5 501.4 507.1 498.6 544.1 545.1 551.7 560.4 8138.9 8272.5 8615.6 8619.4 8948.8 518.5 525.1 586.6 608.4 615.9 3997.9 4002.9 4046.2 4211.2 4353.1 76872.2 98622.0 99688.5 102329.0 102815.0 80772.0 82473.3 84208.6 86574.0 87476.0 60994.4 68709.7 73140.0 73424.6 76036.6 7925.4 8466.0 8531.8 8545.1 8610.6 30085.7 33755.8 43494.3 44516.8 45182.3 58465.6 58575.0 59445.7 60699.0 61168.4 10379.8 10594.7 10602.6 10719.7 10798.8 11338.1 11431.2 11507.5 11758.9 12449.1 11186.0 11220.9 11420.3 11818.2 12245.7 11307.2 11587.0 11807.1 12385.2 12400.4 11341.0 11486.1 11963.3 11973.2 12210.3 8780.7 8867.3 8927.2 9361.0 9544.2 9128.6 9285.7 9795.4 9817.0 9857.0 09:47:17 INFO - PROCESS | 5278 | -------- Summary: end -------- 09:47:17 INFO - PROCESS | 5278 | 09:47:18 INFO - TEST-INFO | 5278: exit 0 09:47:18 INFO - TEST-OK | dromaeo_css | took 1122229ms 09:47:18 INFO - TEST-START | kraken 09:47:18 INFO - operating with platform_type : linux_ 09:47:18 INFO - Initialising browser for kraken test... 09:47:18 INFO - TEST-INFO | started process 5581 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYU_iBA/profile http://localhost:57933/getInfo.html) 09:47:22 INFO - PROCESS | 5581 | __metrics Screen width/height:1600/1200 09:47:22 INFO - PROCESS | 5581 | colorDepth:24 09:47:22 INFO - PROCESS | 5581 | Browser inner width/height: 1024/697 09:47:22 INFO - PROCESS | 5581 | __metrics 09:47:23 INFO - PROCESS | 5581 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:47:23 INFO - PROCESS | 5581 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:47:23 INFO - PROCESS | 5581 | console.error: PushService: 09:47:23 INFO - PROCESS | 5581 | stateChangeProcessEnqueue: Error transitioning state 09:47:23 INFO - PROCESS | 5581 | UnknownError 09:47:24 INFO - TEST-INFO | 5581: exit 0 09:47:24 INFO - Browser initialized. 09:47:24 INFO - Running cycle 1/1 for kraken test... 09:47:24 INFO - TEST-INFO | started process 5664 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYU_iBA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:47:36 INFO - PROCESS | 5664 | RSS: Main: 173432832 09:47:36 INFO - PROCESS | 5664 | 09:47:39 INFO - PROCESS | 5664 | Cycle 1(1): loaded http://localhost:57933/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57933/tests/kraken/driver.html?testName=audio-beat-detection) 09:47:40 INFO - PROCESS | 5664 | RSS: Main: 234684416 09:47:40 INFO - PROCESS | 5664 | 09:47:43 INFO - PROCESS | 5664 | Cycle 1(1): loaded http://localhost:57933/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57933/tests/kraken/driver.html?testName=audio-dft) 09:47:44 INFO - PROCESS | 5664 | RSS: Main: 218087424 09:47:44 INFO - PROCESS | 5664 | 09:47:47 INFO - PROCESS | 5664 | Cycle 1(1): loaded http://localhost:57933/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57933/tests/kraken/driver.html?testName=audio-fft) 09:47:47 INFO - PROCESS | 5664 | RSS: Main: 299094016 09:47:47 INFO - PROCESS | 5664 | 09:47:50 INFO - PROCESS | 5664 | Cycle 1(1): loaded http://localhost:57933/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57933/tests/kraken/driver.html?testName=audio-oscillator) 09:47:50 INFO - PROCESS | 5664 | RSS: Main: 210489344 09:47:50 INFO - PROCESS | 5664 | 09:47:53 INFO - PROCESS | 5664 | Cycle 1(1): loaded http://localhost:57933/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57933/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:47:53 INFO - PROCESS | 5664 | RSS: Main: 213061632 09:47:53 INFO - PROCESS | 5664 | 09:47:56 INFO - PROCESS | 5664 | Cycle 1(1): loaded http://localhost:57933/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57933/tests/kraken/driver.html?testName=imaging-darkroom) 09:47:57 INFO - PROCESS | 5664 | RSS: Main: 248967168 09:47:57 INFO - PROCESS | 5664 | 09:48:00 INFO - PROCESS | 5664 | Cycle 1(1): loaded http://localhost:57933/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57933/tests/kraken/driver.html?testName=imaging-desaturate) 09:48:01 INFO - PROCESS | 5664 | RSS: Main: 248492032 09:48:01 INFO - PROCESS | 5664 | 09:48:04 INFO - PROCESS | 5664 | Cycle 1(1): loaded http://localhost:57933/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57933/tests/kraken/driver.html?testName=json-parse-financial) 09:48:04 INFO - PROCESS | 5664 | RSS: Main: 247504896 09:48:04 INFO - PROCESS | 5664 | 09:48:06 INFO - PROCESS | 5664 | Cycle 1(1): loaded http://localhost:57933/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57933/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:48:07 INFO - PROCESS | 5664 | RSS: Main: 210632704 09:48:07 INFO - PROCESS | 5664 | 09:48:09 INFO - PROCESS | 5664 | Cycle 1(1): loaded http://localhost:57933/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57933/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:48:09 INFO - PROCESS | 5664 | RSS: Main: 218112000 09:48:09 INFO - PROCESS | 5664 | 09:48:11 INFO - PROCESS | 5664 | Cycle 1(1): loaded http://localhost:57933/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57933/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:48:12 INFO - PROCESS | 5664 | RSS: Main: 227049472 09:48:12 INFO - PROCESS | 5664 | 09:48:15 INFO - PROCESS | 5664 | Cycle 1(1): loaded http://localhost:57933/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57933/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:48:16 INFO - PROCESS | 5664 | RSS: Main: 235302912 09:48:16 INFO - PROCESS | 5664 | 09:48:19 INFO - PROCESS | 5664 | Cycle 1(1): loaded http://localhost:57933/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57933/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:48:19 INFO - PROCESS | 5664 | RSS: Main: 232148992 09:48:19 INFO - PROCESS | 5664 | 09:48:21 INFO - PROCESS | 5664 | Cycle 1(1): loaded http://localhost:57933/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57933/tests/kraken/driver.html?testName=ai-astar) 09:48:21 INFO - PROCESS | 5664 | RSS: Main: 283660288 09:48:21 INFO - PROCESS | 5664 | 09:48:21 INFO - PROCESS | 5664 | __start_tp_report 09:48:21 INFO - PROCESS | 5664 | _x_x_mozilla_page_load 09:48:21 INFO - PROCESS | 5664 | _x_x_mozilla_page_load_details 09:48:21 INFO - PROCESS | 5664 | |i|pagename|runs| 09:48:21 INFO - PROCESS | 5664 | |0;ai-astar;108;116;114;115;113;117;114;113;114;114 09:48:21 INFO - PROCESS | 5664 | |1;audio-beat-detection;159;135;126;168;129;130;132;126;169;131 09:48:21 INFO - PROCESS | 5664 | |2;audio-dft;162;164;162;162;162;162;161;164;163;162 09:48:21 INFO - PROCESS | 5664 | |3;audio-fft;76;76;78;113;78;76;77;76;101;75 09:48:21 INFO - PROCESS | 5664 | |4;audio-oscillator;84;84;119;84;83;84;113;83;83;125 09:48:21 INFO - PROCESS | 5664 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;116;116;117 09:48:21 INFO - PROCESS | 5664 | |6;imaging-darkroom;147;146;146;146;147;145;146;146;147;146 09:48:21 INFO - PROCESS | 5664 | |7;imaging-desaturate;85;84;84;85;85;84;84;85;85;85 09:48:21 INFO - PROCESS | 5664 | |8;json-parse-financial;66;65;63;64;64;69;66;65;65;65 09:48:21 INFO - PROCESS | 5664 | |9;json-stringify-tinderbox;67;67;66;67;67;68;67;67;67;67 09:48:21 INFO - PROCESS | 5664 | |10;stanford-crypto-aes;84;84;84;90;84;84;84;84;92;83 09:48:21 INFO - PROCESS | 5664 | |11;stanford-crypto-ccm;143;143;151;142;141;142;141;141;187;147 09:48:21 INFO - PROCESS | 5664 | |12;stanford-crypto-pbkdf2;177;177;176;178;184;179;174;179;177;181 09:48:21 INFO - PROCESS | 5664 | |13;stanford-crypto-sha256-iterative;71;69;71;69;69;71;68;69;69;67 09:48:21 INFO - PROCESS | 5664 | __end_tp_report 09:48:21 INFO - PROCESS | 5664 | __start_cc_report 09:48:21 INFO - PROCESS | 5664 | _x_x_mozilla_cycle_collect,1956 09:48:21 INFO - PROCESS | 5664 | __end_cc_report 09:48:21 INFO - PROCESS | 5664 | __startTimestamp1476982101758__endTimestamp 09:48:21 INFO - PROCESS | 5664 | 09:48:21 INFO - PROCESS | 5664 | ------- Summary: start ------- 09:48:21 INFO - PROCESS | 5664 | Number of tests: 14 09:48:21 INFO - PROCESS | 5664 | 09:48:21 INFO - PROCESS | 5664 | [#0] ai-astar Cycles:10 Average:113.80 Median:114.00 stddev:2.39 (2.1%) stddev-sans-first:1.33 09:48:21 INFO - PROCESS | 5664 | Values: 108.0 116.0 114.0 115.0 113.0 117.0 114.0 113.0 114.0 114.0 09:48:21 INFO - PROCESS | 5664 | 09:48:21 INFO - PROCESS | 5664 | [#1] audio-beat-detection Cycles:10 Average:140.50 Median:133.50 stddev:17.53 (13.1%) stddev-sans-first:17.27 09:48:21 INFO - PROCESS | 5664 | Values: 159.0 135.0 126.0 168.0 129.0 130.0 132.0 126.0 169.0 131.0 09:48:21 INFO - PROCESS | 5664 | 09:48:21 INFO - PROCESS | 5664 | [#2] audio-dft Cycles:10 Average:162.40 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 09:48:21 INFO - PROCESS | 5664 | Values: 162.0 164.0 162.0 162.0 162.0 162.0 161.0 164.0 163.0 162.0 09:48:21 INFO - PROCESS | 5664 | 09:48:21 INFO - PROCESS | 5664 | [#3] audio-fft Cycles:10 Average:82.60 Median:76.00 stddev:13.20 (17.4%) stddev-sans-first:13.78 09:48:21 INFO - PROCESS | 5664 | Values: 76.0 76.0 78.0 113.0 78.0 76.0 77.0 76.0 101.0 75.0 09:48:21 INFO - PROCESS | 5664 | 09:48:21 INFO - PROCESS | 5664 | [#4] audio-oscillator Cycles:10 Average:94.20 Median:83.50 stddev:17.35 (20.8%) stddev-sans-first:18.01 09:48:21 INFO - PROCESS | 5664 | Values: 84.0 84.0 119.0 84.0 83.0 84.0 113.0 83.0 83.0 125.0 09:48:21 INFO - PROCESS | 5664 | 09:48:21 INFO - PROCESS | 5664 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 09:48:21 INFO - PROCESS | 5664 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 09:48:21 INFO - PROCESS | 5664 | 09:48:21 INFO - PROCESS | 5664 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 09:48:21 INFO - PROCESS | 5664 | Values: 147.0 146.0 146.0 146.0 147.0 145.0 146.0 146.0 147.0 146.0 09:48:21 INFO - PROCESS | 5664 | 09:48:21 INFO - PROCESS | 5664 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:0.52 (0.6%) stddev-sans-first:0.53 09:48:21 INFO - PROCESS | 5664 | Values: 85.0 84.0 84.0 85.0 85.0 84.0 84.0 85.0 85.0 85.0 09:48:21 INFO - PROCESS | 5664 | 09:48:21 INFO - PROCESS | 5664 | [#8] json-parse-financial Cycles:10 Average:65.20 Median:65.00 stddev:1.62 (2.5%) stddev-sans-first:1.69 09:48:21 INFO - PROCESS | 5664 | Values: 66.0 65.0 63.0 64.0 64.0 69.0 66.0 65.0 65.0 65.0 09:48:21 INFO - PROCESS | 5664 | 09:48:21 INFO - PROCESS | 5664 | [#9] json-stringify-tinderbox Cycles:10 Average:67.00 Median:67.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 09:48:21 INFO - PROCESS | 5664 | Values: 67.0 67.0 66.0 67.0 67.0 68.0 67.0 67.0 67.0 67.0 09:48:21 INFO - PROCESS | 5664 | 09:48:21 INFO - PROCESS | 5664 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:84.00 stddev:3.06 (3.6%) stddev-sans-first:3.21 09:48:21 INFO - PROCESS | 5664 | Values: 84.0 84.0 84.0 90.0 84.0 84.0 84.0 84.0 92.0 83.0 09:48:21 INFO - PROCESS | 5664 | 09:48:21 INFO - PROCESS | 5664 | [#11] stanford-crypto-ccm Cycles:10 Average:147.80 Median:143.00 stddev:14.14 (9.9%) stddev-sans-first:14.89 09:48:21 INFO - PROCESS | 5664 | Values: 143.0 143.0 151.0 142.0 141.0 142.0 141.0 141.0 187.0 147.0 09:48:21 INFO - PROCESS | 5664 | 09:48:21 INFO - PROCESS | 5664 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.20 Median:178.50 stddev:2.78 (1.6%) stddev-sans-first:2.92 09:48:21 INFO - PROCESS | 5664 | Values: 177.0 177.0 176.0 178.0 184.0 179.0 174.0 179.0 177.0 181.0 09:48:21 INFO - PROCESS | 5664 | 09:48:21 INFO - PROCESS | 5664 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.00 stddev:1.34 (1.9%) stddev-sans-first:1.27 09:48:21 INFO - PROCESS | 5664 | Values: 71.0 69.0 71.0 69.0 69.0 71.0 68.0 69.0 69.0 67.0 09:48:21 INFO - PROCESS | 5664 | -------- Summary: end -------- 09:48:21 INFO - PROCESS | 5664 | 09:48:22 INFO - TEST-INFO | 5664: exit 0 09:48:23 INFO - TEST-OK | kraken | took 64336ms 09:48:23 INFO - SUITE-END | took 1186s 09:48:23 INFO - Completed test suite (00:19:46) 09:48:23 INFO - javascript benchmark 09:48:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2564.6409502669626, 2583.237944806282, 2615.0585789115917, 2615.489979454006, 2633.84196948183, 4492.730436173832, 4541.659375546839, 4660.044690838378, 4661.13768952744, 4683.8524561482445, 4598.770061496928, 4605.078984203156, 4615.215413379725, 4618.05329907369, 4628.120657075162, 4211.2630289699255, 4238.088810905655, 4244.617984381405, 4257.76582287974, 4281.892952676177, 4282.807273672693, 4303.8063287152, 4309.482862056558, 4312.654987601, 4314.0, 4296.5273819879785, 4296.871093867189, 4313.719608225471, 4327.437433133704, 4386.210482113218, 4415.094905544356, 4419.845305414295, 4425.09285596452, 4425.7565833879125, 4482.753448560328, 4166.729162604421, 4214.7681877496725, 4218.303979843322, 4293.978530107361, 4385.473743150842, 4621.584057434847, 4662.0, 4664.743439110847, 4669.859904202879, 4682.531746825291, 4925.13810083234, 4957.107720610289, 4979.278004689299, 4995.050940321364, 5030.446650868402, 4830.178869592178, 4894.877628059291, 5026.321446604735, 5030.9245361319245, 5082.593392528589, 4593.127305811885, 4613.723176609347, 4655.37152484417, 4658.417697787777, 4706.529347065266, 5109.4379618241965, 5115.64190506661, 5119.283300337956, 5120.692758434506, 5190.195519694454, 4905.3132561441425, 4912.066707325596, 4914.410270767531, 4915.26271059344, 4978.925316120261, 4748.311494833299, 4783.976080119577, 4792.376990991149, 4846.733429661332, 4854.393200849894, 4888.291197776302, 4923.852284431473, 4956.628252881048, 5018.84943451697, 5021.4978502150225, 4910.337104490919, 4946.282788995575, 4955.256711493233, 5005.024020316004, 5018.648694591417, 4252.149570085995, 4294.420253265769, 4299.613034826881, 4338.717983331074, 4355.303151495746, 3611.530501034849, 3645.4167333226555, 3658.1037645776955, 3708.2768860072565, 3760.0599850037493, 4264.616184543406, 4295.892602684896, 4300.526942036374, 4305.720128191658, 4357.54245804186, 4992.301077849104, 5000.974995125001, 5001.474845141281, 5007.774650140753, 5066.594672426197, 4162.521310049323, 4283.657307415399, 4290.0561876387765, 4295.699301048897, 4352.630026447788, 4413.16149931512, 4509.954900450954, 4556.88607784808, 4560.859785053736, 4624.6993945394115, 4779.569838714393, 4789.44921334051, 4792.137415265286, 4793.13723529768, 4846.684965477232, 5032.572231360229, 5059.139946209227, 5065.848024559269, 5085.389753229636, 5129.307543481582, 4538.319252112209, 4581.5189405113315, 4585.312203169551, 4714.5992590630185, 4734.881627959328, 4955.306257124078, 4961.925571116509, 4969.254611808257, 5018.5232402921665, 5025.0, 5048.268001139741, 5049.469805670352, 5050.72221027847, 5051.62112841531, 5112.284280200701, 4683.180443422456, 4730.432348118248, 4835.1296766580945, 4864.902701946012, 4978.4025916890205, 4891.608671306358, 4893.486183950634, 4901.485344038824, 4956.207006879026, 4959.553640172402, 4836.733979631154, 4844.636652251025, 4848.17581011236, 4849.2726091086615, 4894.926576101432, 4777.689450185866, 4829.7442664906675, 4896.1921282987905, 4937.7531123444405, 4998.02538504988, 4763.785629646605, 4764.047190561832, 4766.094442055998, 4771.73755443454, 4772.6659133861685], "value": 4585.572913199921, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.4755460980153, 561.3460318728679, 576.9480746732795, 577.3706659740882, 585.1077107411195, 27715.307117322078, 28287.0, 39463.40804887925, 40399.39400908989, 40605.59394406055, 40091.39862902059, 40481.39277910826, 40489.39265911013, 40587.391189132184, 40635.390469142985, 7742.264484873928, 7889.092754333239, 7892.171322011192, 7898.960505197495, 7900.881486777703, 7749.070111586618, 7827.843443131134, 7832.334251588622, 7837.294643482085, 7845.490043147206, 7845.058592968851, 7885.329746971514, 7886.487378320391, 7897.328727058207, 7901.604919754018, 7812.3359514441345, 7835.981322428048, 7858.68565257389, 7872.212778722139, 7874.488158269694, 7690.0, 7746.264104910081, 7756.379489640872, 7756.844863102707, 7763.534187948741, 38154.23691526154, 38535.8073209635, 38563.0, 38566.61433385658, 38620.80689596562, 3010.729034386894, 3430.588329400463, 3477.878274260389, 3515.191505953645, 3525.6826885580163, 28070.298242543897, 28315.716842831513, 28406.431871362664, 29927.700722992708, 30095.548566771515, 3334.5235261445755, 3407.30150319184, 3517.9120521986897, 3527.2416430467574, 3629.5644522657185, 236347.0, 236421.0, 236835.99999999828, 236949.0, 237753.0, 31887.20281992922, 51879.740601296755, 52147.0, 52187.73906130521, 52281.477185228425, 33134.3373132536, 33215.66784332174, 33275.33449331, 33327.16682082919, 33339.49879773421, 11590.94204528972, 11700.0, 11702.648920532398, 11705.180637355303, 11718.472668729928, 9364.15722584957, 9427.340086194037, 9430.764230894283, 9435.820522434695, 9443.102905223992, 7662.463627546018, 7780.0, 7790.220977902164, 7834.529928204326, 7840.764777056697, 2965.866536005885, 2998.2804127009363, 3039.893603723859, 3052.4200401923563, 3054.328047829474, 879.336101243557, 881.2421317666801, 913.3880300198882, 943.3208090175063, 996.1433167475965, 27325.726742732317, 27977.860110699316, 27998.44003119926, 28425.28936776597, 28584.571231431546, 741.8434560943152, 872.8490150556486, 934.7382732834817, 965.1554889471712, 978.2418625565101, 14570.324412692464, 14622.853771462149, 14649.92675036618, 14861.851381486047, 14914.328855201542, 361243.0, 365704.0, 366810.0, 367488.0, 368099.0, 48643.0, 48934.265986010236, 48955.75522122366, 48984.51015489871, 49093.75453122712, 1033.214756784849, 1059.2849826367171, 1127.7067962330018, 1140.3386036099043, 1185.1526158796503, 25954.0, 28902.42195156127, 29788.702112978594, 30000.549991749704, 30225.848870755504, 41448.58551414447, 41801.581984180986, 42004.159916802106, 42142.57857421509, 42248.5775142257, 296187.0, 296894.0, 298148.0, 298207.0, 298409.0, 24742.38144046413, 25384.873075634503, 25637.23088307354, 26319.0, 26623.7337626629, 41404.0, 41617.37573936333, 41643.58356416397, 42359.0, 42659.0, 34990.825045874604, 35348.64651353556, 35475.29049418945, 35595.0, 35961.0, 34809.0, 35230.823845881634, 35733.28533429369, 35751.82124089467, 36219.63780362163, 34139.14652133716, 34703.30593388169, 35378.64621353857, 35610.64389356177, 36300.27399452049, 30393.848030759706, 32248.516272255467, 32410.35179296448, 32686.182845428102, 33206.83396583002, 24771.62842557327, 25382.238532844043, 25389.0, 25725.485490289717, 25851.0], "value": 16131.84888738094, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.5944037434891, 357.6780897192528, 365.3989187786092, 370.1265014565625, 384.281393793606, 12185.268883866964, 12687.619371418861, 12968.703129687026, 13233.735325293488, 17357.652846943052, 12683.0, 12882.806757898616, 14167.149971001747, 14673.559793206221, 14894.180820054893, 4615.953840461602, 4701.294805779126, 4774.7135171889795, 4778.474367819537, 5138.0, 5121.923171152435, 5154.6134039946965, 5163.199704045879, 5163.66436181647, 5167.4574169712205, 3427.468742344928, 3599.064243296749, 5142.228665700138, 5192.844214673547, 5534.391216966131, 5543.889122217553, 5572.888542229173, 5581.6371935824045, 5585.3297604287745, 5589.0, 5174.870628234286, 5342.145256758939, 5360.2763626910255, 5367.624266301361, 5369.463053694639, 12524.436400362005, 12604.11771176018, 12686.302253376061, 19577.0, 19648.607027859507, 1705.692975264452, 1709.6666150100734, 1711.5464401933498, 1783.5273652482103, 1815.2376002079027, 9018.503982280972, 9082.046385129599, 9638.277129215267, 11369.886301137049, 13821.930890345584, 1692.2046638080083, 1756.6925787987052, 1769.902655353955, 1793.515750747304, 1861.5997560524552, 63607.0, 65795.0, 66636.6668166661, 68170.3182968169, 70088.29911700869, 9461.90538094624, 9643.27675424332, 9749.171320437701, 9835.508224588742, 10126.696199114038, 13687.31563421825, 13688.247146407044, 13691.452341906412, 13697.041207115406, 13708.86291137076, 6543.770968016097, 6678.866422671616, 6703.932960670429, 6785.558938668971, 6796.72813087471, 6050.788222412194, 6080.270367555921, 6205.968970155121, 6258.280297765724, 6309.652969086745, 4116.135611521614, 4129.174165166979, 4179.352200408942, 4244.8514301999285, 4419.756913369795, 1767.5757818123557, 1849.8797578157378, 1878.4458584717268, 1879.2952642758964, 1883.5856111655414, 748.7416841189781, 863.8272345530919, 880.1594477274188, 892.8839250897341, 940.374650857186, 15844.781730557732, 16298.266578004019, 16346.0, 16621.41825036118, 17267.3956411525, 790.4387884601997, 828.747232094217, 830.3523251863436, 850.0606829453488, 866.5753780647437, 8929.866052009225, 9441.480718560408, 9446.669366572138, 9558.187554057844, 9680.128788408936, 337452.0, 339721.54872897145, 340944.0, 341891.0, 342234.0, 42214.366784498256, 42326.576734232876, 66312.00531992024, 72142.63928680427, 74385.0, 875.8861348024716, 878.4290211362666, 905.805251870851, 906.5603182456504, 909.736176508805, 14704.41182352694, 14826.25868706582, 14997.2501374933, 15236.771448428504, 15392.538223853302, 36345.273094537435, 37068.44397333988, 37380.43929341117, 37449.62550374462, 38194.0, 48434.515654843, 49162.26256606225, 49999.75000124976, 50045.749771250914, 50506.74746626243, 10190.694279171637, 10378.896211037792, 11065.391403472886, 11072.833907491555, 11151.0, 12509.0, 12531.0, 12783.296918669563, 12809.679758005752, 12829.61511154667, 10911.618093366695, 11363.147763917905, 11492.367919764492, 11524.078073754246, 11820.113491488, 7374.262573742582, 7462.552246865205, 7501.512401693873, 7802.180771018961, 8278.420510564203, 7772.45592808498, 8082.515049097073, 8103.473274237156, 8177.550234736908, 8242.340612751086, 10930.45347732626, 11242.0, 11272.66182014541, 11420.657380278604, 11455.255408398427, 10402.47987600632, 10464.162866970777, 10621.362718236931, 10772.676819695422, 11314.547418103184], "value": 7918.415660776034, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1232.5747617072107, 1358.5109360630172, 1412.3150272118023, 1453.2152637575703, 1638.2545941596575, 6690.498212634054, 7541.773746787591, 7794.454388192828, 7829.569373684452, 7973.202679732039, 7774.883376749353, 7844.294013538781, 7845.80385490363, 7849.411294152947, 7849.529028258308, 2136.5513242219154, 2165.566886622674, 2169.240765731997, 2169.533550286688, 2170.468235282358, 2070.171931227506, 2103.726515552976, 2105.84206184536, 2110.9577808443823, 2118.470382404399, 2073.78225286345, 2081.2819577245828, 2091.9267825626107, 2094.790520947908, 2147.7207962964794, 2023.8279746221515, 2071.5028393185676, 2074.367317968019, 2075.9481012974647, 2078.490769761418, 2017.5662232619911, 2058.433930669063, 2059.1454546363393, 2063.174730107954, 2065.06039751914, 7492.0, 7711.884321735179, 7802.414818888549, 7821.296083352526, 7837.921620783776, 4402.559744025604, 4580.129775342708, 4580.312953057035, 4586.334981427674, 4590.472095709003, 2849.829010259391, 3029.74247188987, 3081.734924830248, 3090.7836451448406, 3098.1325228935934, 921.8018126102853, 923.4505469245788, 937.12378925704, 947.0766003146946, 950.8763860698134, 10447.84328235077, 10507.2644914856, 10531.78936421275, 10545.0, 10550.314229575053, 4020.9195816083516, 4121.443605113272, 4126.628603425706, 4163.91672166555, 4235.957640423557, 8424.326053915673, 8487.745367638981, 8488.023877254194, 8490.405671603052, 8495.27790137833, 4504.729716217037, 4505.144022635689, 4505.279155335196, 4505.954940450619, 4507.256302710081, 3610.458431235283, 3691.3909204981414, 3812.599677033927, 4196.307609244502, 4201.432806571135, 3111.408832321897, 3498.2478767065204, 3510.8946731598094, 3543.3799085159994, 3593.173570078844, 1017.6845177994845, 1050.5922064433696, 1053.1522124689698, 1053.3363980692116, 1056.0864851903048, 783.7335305995989, 813.6094674556247, 817.7015389382951, 818.4271010292819, 827.210014436212, 4928.926066109011, 5022.6233032522705, 5064.34163558735, 5067.6959382436435, 5173.611979101507, 404.41965779107073, 422.5584264443664, 424.2342571658125, 427.0668589132693, 427.74335398761116, 3330.683585059464, 3398.966010339914, 3427.074689833731, 3437.7937323760652, 3507.7544571879725, 9438.95280523593, 9740.756481087888, 9827.55775990068, 9834.409935403899, 9837.55730992107, 9772.413655180711, 9785.315027947976, 9786.5596048178, 9797.461139637388, 9807.0, 7248.130224373003, 7284.271572842674, 7362.300581444754, 7419.406447484188, 7420.480566360303, 5076.847694569169, 5084.694918304914, 5150.562202212854, 5171.9482805172975, 5253.054450199001, 8496.745097647081, 8763.3427492937, 8903.73288801337, 8906.153915378029, 8938.553072346227, 8932.776680583038, 9020.007799141958, 9077.95603505579, 9082.273418126402, 9153.954230228806, 6469.126667899962, 6513.967430162819, 6518.0, 6529.249136349381, 6543.640099794557, 7573.810654733676, 7595.050618672666, 7600.657970391235, 7644.235576442311, 7661.770146895602, 6809.795706128626, 6908.585484870924, 6973.163220413583, 6983.406410455168, 7005.404540614105, 6767.39093481589, 6860.382565569123, 6865.004574336793, 6871.003704462725, 6889.689963951534, 6029.336772955059, 6108.236470441195, 6112.32764395925, 6117.418845209698, 6122.7244773984385, 4158.875233742992, 4255.382969469471, 4264.317709166518, 4409.845655402046, 4438.0, 4131.834726611022, 4339.479262488521, 4345.413369195118, 4410.647148228199, 4446.777136287417], "value": 3970.8015420433703, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.18234490461424, 295.28099078743264, 303.9787214894958, 304.5872842298686, 305.01328203262426, 4786.952130478694, 4810.615150787933, 4825.107355139302, 4842.370491836056, 4868.367112275404, 4749.501302363254, 4757.381540399751, 4787.281907713845, 4791.640626952975, 4802.83190088347, 3751.531058617673, 3768.5289338832645, 3769.18962423079, 3790.431435284702, 3795.1840354323813, 3687.834047467857, 3736.6823819975334, 3816.293985612657, 3820.5033345665024, 3826.2921359548573, 3770.8868733938025, 3777.6788972937197, 3800.391937290034, 3813.31360355136, 3823.426486027104, 3750.7186960977765, 3792.677622402099, 3795.013296542891, 3809.2191100824402, 3809.4285857121513, 3138.8116712997066, 3223.2264256578487, 3262.869485220612, 3341.6491268416707, 3358.2779702363864, 4640.582347588733, 4654.488006319302, 4660.324252983332, 4672.0, 4691.6481263905, 4324.308110702304, 4327.221100201962, 4328.134373125387, 4332.393464914914, 4349.804258808361, 4635.165670179366, 4778.283257511366, 4971.975140124312, 4997.975010124963, 5051.0, 3597.676209141164, 3614.9277014459826, 3617.366960781853, 3619.9095022624383, 3622.6271791976296, 5194.027168296647, 5196.636235463519, 5201.0, 5203.557697595709, 5206.505381988705, 3674.5039419678, 3707.258548290353, 3735.9813200933822, 3752.399616061417, 3759.9624003759614, 3750.812459377075, 3762.3039737648623, 3779.13079991598, 3782.3380908340932, 3782.527184101987, 4231.576842315805, 4232.534421213664, 4236.279832428495, 4252.787360631956, 4257.510386305553, 4940.863601371705, 4947.925781113287, 4950.232713929347, 4958.157113290749, 4958.281049247911, 1245.5266998540496, 1310.8137135891843, 1317.1109501086728, 1319.6305034590139, 1320.5576131995697, 822.8066404394963, 842.9578521073922, 859.2567429173845, 867.2368315881984, 867.7526904832092, 3922.7057970651745, 3942.073612701013, 3943.0, 3945.940810887839, 3965.385365268388, 4495.483019452739, 4511.263163682006, 4536.500984891725, 4551.3173024046655, 4568.984470249619, 3932.2528719543197, 3942.679202467148, 3943.2507823513442, 3945.9937715882265, 3947.5460322062754, 2302.815774738017, 2388.390960305111, 2401.9159329423387, 2409.19292037166, 2416.378229620881, 4292.3561465780385, 4605.861824145281, 4755.07419495105, 4755.239161734106, 4874.95125048745, 5247.475252474722, 5271.947280527145, 5278.049951008778, 5298.576113910878, 5301.893962120736, 4826.710397376169, 4898.2652602109965, 4899.265110233422, 4901.289313049588, 4901.43633482147, 4873.561379475864, 5097.28637990689, 5113.468832927724, 5121.974390128025, 5148.940423830498, 5023.422306434807, 5045.470225626256, 5051.661309752845, 5058.924116138334, 5065.8733531662, 4715.575598196178, 4859.489753575824, 4865.099956508057, 4874.4150701916, 4881.585065269492, 3669.541307336583, 3709.5919448861146, 3735.58908520068, 3736.8602576214516, 3738.1309345327336, 5067.543921047123, 5123.487651234846, 5123.641345105807, 5147.481492959511, 5176.171812509981, 4970.950290497049, 4988.176950803077, 5000.349954505891, 5013.598912087097, 5031.804803949445, 4852.708837469763, 4932.914758753069, 4966.726830024383, 4972.477889821661, 4982.451930287593, 4876.29293752411, 4894.363732714724, 4903.926441103315, 4915.91849793045, 4918.655694101379, 4987.750612469435, 5020.523050310215, 5028.773705183203, 5037.5214354636255, 5040.5382439092255, 4694.718316900997, 4841.927371089366, 4866.9292755595125, 4877.317175595491, 4898.755062246944], "value": 3734.329949542748, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [668.6021817018874, 730.7405870915825, 735.5072101691866, 756.2135379205627, 758.772368289513, 12960.675983100415, 13558.186508809478, 14065.578032659023, 14073.08524945879, 14622.926885365585, 12914.547990820323, 13613.863861361384, 13615.455381784717, 13620.591382258523, 13628.454861805516, 614.3058344071193, 777.102446674091, 799.6441583495347, 801.707376807464, 802.5786462107382, 630.4074170279945, 770.3452065744128, 789.9131095579481, 794.7218473534275, 802.8474589827944, 850.1158794853376, 852.3990586636406, 852.7484392104313, 852.7740148860557, 853.0488505316589, 634.9492040636784, 847.3306088190384, 848.5333066813228, 848.6647774129216, 848.8387206430758, 485.88095916500686, 589.6373730155923, 603.4357875386528, 607.5322002058434, 612.9203203583505, 13326.200427974352, 13346.532871349456, 13378.264195469244, 13379.0, 13381.330933453386, 12512.624621261377, 12664.430100645493, 12971.740565188738, 13384.665383365495, 13424.328783560783, 11341.943290283496, 11521.769564608745, 11555.248908820984, 11964.521419143224, 12164.209326393757, 4145.2124096421885, 4155.355919832431, 4187.078842654611, 4240.618344349024, 4349.369341445473, 65831.0, 67664.0, 67836.6608166956, 67870.3212967864, 67911.320886791, 10310.896891030994, 10347.379157250589, 10645.361278323326, 10716.981886720749, 10929.56281748721, 19381.612367752565, 19700.31048913281, 19707.704384434244, 19722.70415943762, 19738.210471580976, 6485.7405703772265, 6653.101831252816, 6854.657267136623, 6868.0, 6924.23833378328, 3582.265635544707, 3663.1025398776937, 3678.3930651442747, 3729.291434627412, 3780.0549862534367, 2883.7116288371417, 2972.5392564152157, 2999.47509185896, 3012.4125795470113, 3018.9396212075635, 486.77608300181606, 496.05006412719956, 498.50647858619703, 501.42336313240065, 507.09989768161074, 498.5769161873293, 544.10223131832, 545.1465018935651, 551.6882961126951, 560.4143669865001, 8138.877916831252, 8272.545010024385, 8615.569221538897, 8619.353548483889, 8948.776280593038, 518.4892880512692, 525.1178020924807, 586.560079940045, 608.3898443412381, 615.9353267906895, 3997.9400308995387, 4002.9199416011515, 4046.1503084352616, 4211.1998720243055, 4353.10761293934, 76872.2312776865, 98622.0, 99688.50155749175, 102329.0, 102815.0, 80772.0, 82473.3043011395, 84208.57895710482, 86574.0, 87476.0, 60994.39005609976, 68709.65645171743, 73140.0, 73424.63287683527, 76036.61981690057, 7925.405594580314, 8466.0, 8531.786705332417, 8545.102764209669, 8610.569471526524, 30085.69914300829, 33755.83122084374, 43494.34758478562, 44516.77741611271, 45182.32226516671, 58465.568787432494, 58575.0, 59445.70277148586, 60699.0, 61168.38831611627, 10379.818509633511, 10594.682159535227, 10602.575896964036, 10719.675650368032, 10798.838017429587, 11338.09295256361, 11431.199816012799, 11507.539698411969, 11758.882411175779, 12449.066320026215, 11186.0, 11220.887791121984, 11420.31478111316, 11818.172727909308, 12245.69385765363, 11307.151963602928, 11587.0, 11807.114466414881, 12385.19496232742, 12400.441980111096, 11341.0, 11486.081113511067, 11963.342016189194, 11973.221740586834, 12210.328431936328, 8780.692675756318, 8867.290616750774, 8927.241184499131, 9360.953195234253, 9544.188743956563, 9128.634854605742, 9285.675001374919, 9795.412275263507, 9816.950915245377, 9857.02220378704], "value": 6589.573765249363, "unit": "score"}], "name": "dromaeo_css", "value": 6208.005437856479, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 116.0, 114.0, 115.0, 113.0, 117.0, 114.0, 113.0, 114.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 135.0, 126.0, 168.0, 129.0, 130.0, 132.0, 126.0, 169.0, 131.0], "value": 140.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 162.0, 162.0, 162.0, 162.0, 161.0, 164.0, 163.0, 162.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 78.0, 113.0, 78.0, 76.0, 77.0, 76.0, 101.0, 75.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 119.0, 84.0, 83.0, 84.0, 113.0, 83.0, 83.0, 125.0], "value": 94.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 145.0, 146.0, 146.0, 147.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 85.0, 85.0, 84.0, 84.0, 85.0, 85.0, 85.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 63.0, 64.0, 64.0, 69.0, 66.0, 65.0, 65.0, 65.0], "value": 65.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 67.0, 67.0, 68.0, 67.0, 67.0, 67.0, 67.0], "value": 67.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 90.0, 84.0, 84.0, 84.0, 84.0, 92.0, 83.0], "value": 85.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 143.0, 151.0, 142.0, 141.0, 142.0, 141.0, 141.0, 187.0, 147.0], "value": 147.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 177.0, 176.0, 178.0, 184.0, 179.0, 174.0, 179.0, 177.0, 181.0], "value": 178.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 71.0, 69.0, 69.0, 71.0, 68.0, 69.0, 69.0, 67.0], "value": 69.3, "unit": "score"}], "name": "kraken", "value": 1553.8000000000002, "alertThreshold": 2.0}]} 09:48:23 INFO - Return code: 0 09:48:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:48:23 INFO - # TBPL SUCCESS # 09:48:23 INFO - Running post-action listener: _resource_record_post_action 09:48:23 INFO - [mozharness: 2016-10-20 16:48:23.539090Z] Finished run-tests step (success) 09:48:23 INFO - Running post-run listener: _resource_record_post_run 09:48:23 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 0; Write bytes: 392183808; Read time: 0; Write time: 282256 09:48:23 INFO - TinderboxPrint: CPU usage
13.1% 09:48:23 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 09:48:23 INFO - TinderboxPrint: I/O write bytes / time
392,183,808 / 282,256 09:48:23 INFO - TinderboxPrint: CPU idle
8,343.3 (86.9%) 09:48:23 INFO - TinderboxPrint: CPU user
1,207.7 (12.6%) 09:48:23 INFO - TinderboxPrint: Swap in / out
0 / 0 09:48:23 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99491840; Read time: 0; Write time: 81984 09:48:23 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 292691968; Read time: 0; Write time: 200272 09:48:24 INFO - Running post-run listener: _upload_blobber_files 09:48:24 INFO - Blob upload gear active. 09:48:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:48:24 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 09:48:24 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:48:24 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:48:24 INFO - (blobuploader) - INFO - Open directory for files ... 09:48:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:48:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:48:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:48:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:48:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:48:25 INFO - (blobuploader) - INFO - Done attempting. 09:48:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:48:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:48:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:48:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:48:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:48:26 INFO - (blobuploader) - INFO - Done attempting. 09:48:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:48:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:48:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:48:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:48:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:48:29 INFO - (blobuploader) - INFO - Done attempting. 09:48:29 INFO - (blobuploader) - INFO - Iteration through files over. 09:48:29 INFO - Return code: 0 09:48:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:48:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:48:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0b3bf04481422548582a0e24a5b3c6cc4e8eb82aed46fd5e56b5a18d22e6dd6bac629767ac2777545ff36467fbad28302b82223ba5e68338bc6f85ab348121ed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bd1d74b68be22095f01c302c871e7193c53e717331af810baa4ec66e22c00498847ea5bffca6e2c27338a52af24a241c8a5de35315cac78a33426946ee39c127", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/562363f7ab08aea2419a525ca2e4b60c0b1b969ed68a8cb9b3fa07eac2b5432ef25bde9434f242a796aa1f8eabe1677ea7a9ba73c61e70db2a098a030dec78f3"} 09:48:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:48:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:48:29 INFO - Contents: 09:48:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0b3bf04481422548582a0e24a5b3c6cc4e8eb82aed46fd5e56b5a18d22e6dd6bac629767ac2777545ff36467fbad28302b82223ba5e68338bc6f85ab348121ed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bd1d74b68be22095f01c302c871e7193c53e717331af810baa4ec66e22c00498847ea5bffca6e2c27338a52af24a241c8a5de35315cac78a33426946ee39c127", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/562363f7ab08aea2419a525ca2e4b60c0b1b969ed68a8cb9b3fa07eac2b5432ef25bde9434f242a796aa1f8eabe1677ea7a9ba73c61e70db2a098a030dec78f3"} 09:48:29 INFO - Running post-run listener: copy_logs_to_upload_dir 09:48:29 INFO - Copying logs to upload dir... 09:48:29 INFO - mkdir: /builds/slave/test/build/upload/logs 09:48:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.260211 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-10-20 09:48:29.699341) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 09:48:29.703043) ========= 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=17051fcd5208b27b50bedfeb000001dd-1476980859.38851-223743630 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0b3bf04481422548582a0e24a5b3c6cc4e8eb82aed46fd5e56b5a18d22e6dd6bac629767ac2777545ff36467fbad28302b82223ba5e68338bc6f85ab348121ed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bd1d74b68be22095f01c302c871e7193c53e717331af810baa4ec66e22c00498847ea5bffca6e2c27338a52af24a241c8a5de35315cac78a33426946ee39c127", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/562363f7ab08aea2419a525ca2e4b60c0b1b969ed68a8cb9b3fa07eac2b5432ef25bde9434f242a796aa1f8eabe1677ea7a9ba73c61e70db2a098a030dec78f3"} build_url:https://queue.taskcluster.net/v1/task/Pfria87bSZ6TCwsBmjCPcg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011336 build_url: 'https://queue.taskcluster.net/v1/task/Pfria87bSZ6TCwsBmjCPcg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0b3bf04481422548582a0e24a5b3c6cc4e8eb82aed46fd5e56b5a18d22e6dd6bac629767ac2777545ff36467fbad28302b82223ba5e68338bc6f85ab348121ed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bd1d74b68be22095f01c302c871e7193c53e717331af810baa4ec66e22c00498847ea5bffca6e2c27338a52af24a241c8a5de35315cac78a33426946ee39c127", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/562363f7ab08aea2419a525ca2e4b60c0b1b969ed68a8cb9b3fa07eac2b5432ef25bde9434f242a796aa1f8eabe1677ea7a9ba73c61e70db2a098a030dec78f3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 09:48:29.727949) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 09:48:29.728268) ========= 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=17051fcd5208b27b50bedfeb000001dd-1476980859.38851-223743630 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004440 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 09:48:29.813531) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 09:48:29.813858) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 09:48:29.814143) ========= ========= Total master_lag: 0.17 =========