builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-012 starttime: 1477402109.33 results: success (0) buildid: 20161025062825 builduid: 3268cf647b89452080a0d3bfd5fe4966 revision: 78b863e9fcd9d44d75c817b6495b4585167ba255 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-25 06:28:29.333676) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-25 06:28:29.334080) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-25 06:28:29.334531) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-25 06:28:29.734071) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 06:28:29.734330) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1477399700.593707-772652127 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-25 06:28:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 104M=0s 2016-10-25 06:28:29 (104 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.086526 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 06:28:29.837707) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 06:28:29.838053) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1477399700.593707-772652127 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019918 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 06:28:29.891235) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-25 06:28:29.894708) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 78b863e9fcd9d44d75c817b6495b4585167ba255 --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 78b863e9fcd9d44d75c817b6495b4585167ba255 --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=2c5dd2b0a310ecf02fd87158000001b4-1477399700.593707-772652127 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-25 06:28:30,003 truncating revision to first 12 chars 2016-10-25 06:28:30,003 Setting DEBUG logging. 2016-10-25 06:28:30,003 attempt 1/10 2016-10-25 06:28:30,003 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/78b863e9fcd9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-25 06:28:30,724 unpacking tar archive at: fx-team-78b863e9fcd9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.046344 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-25 06:28:30.956743) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-25 06:28:30.957040) ========= script_repo_revision: 78b863e9fcd9d44d75c817b6495b4585167ba255 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-25 06:28:30.957419) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-25 06:28:30.957709) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-25 06:28:30.967009) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-10-25 06:28:30.967287) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=2c5dd2b0a310ecf02fd87158000001b4-1477399700.593707-772652127 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:28:31 INFO - MultiFileLogger online at 20161025 06:28:31 in /builds/slave/test 06:28:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 06:28:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:28:31 INFO - {'append_to_log': False, 06:28:31 INFO - 'base_work_dir': '/builds/slave/test', 06:28:31 INFO - 'blob_upload_branch': 'Fx-Team', 06:28:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:28:31 INFO - 'branch': 'Fx-Team', 06:28:31 INFO - 'buildbot_json_path': 'buildprops.json', 06:28:31 INFO - 'config_files': ('talos/linux_config.py',), 06:28:31 INFO - 'default_actions': ('clobber', 06:28:31 INFO - 'read-buildbot-config', 06:28:31 INFO - 'download-and-extract', 06:28:31 INFO - 'populate-webroot', 06:28:31 INFO - 'create-virtualenv', 06:28:31 INFO - 'install', 06:28:31 INFO - 'run-tests'), 06:28:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:28:31 INFO - 'download_minidump_stackwalk': True, 06:28:31 INFO - 'download_symbols': 'ondemand', 06:28:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:28:31 INFO - 'tooltool.py': '/tools/tooltool.py', 06:28:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:28:31 INFO - '/tools/misc-python/virtualenv.py')}, 06:28:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:28:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:28:31 INFO - 'installer_path': 'installer.exe', 06:28:31 INFO - 'log_level': 'info', 06:28:31 INFO - 'log_name': 'talos', 06:28:31 INFO - 'log_to_console': True, 06:28:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:28:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:28:31 INFO - 'opt_config_files': (), 06:28:31 INFO - 'pip_index': False, 06:28:31 INFO - 'sps_profile': False, 06:28:31 INFO - 'sps_profile_interval': 0, 06:28:31 INFO - 'suite': 'dromaeojs', 06:28:31 INFO - 'system_bits': '32', 06:28:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:28:31 INFO - 'title': 'talos-linux64-ix-012', 06:28:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:28:31 INFO - 'use_talos_json': True, 06:28:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:28:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:28:31 INFO - 'work_dir': 'build'} 06:28:31 INFO - [mozharness: 2016-10-25 13:28:31.171451Z] Running clobber step. 06:28:31 INFO - Running pre-action listener: _resource_record_pre_action 06:28:31 INFO - Running main action method: clobber 06:28:31 INFO - rmtree: /builds/slave/test/build 06:28:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:28:31 INFO - Running post-action listener: _resource_record_post_action 06:28:31 INFO - [mozharness: 2016-10-25 13:28:31.630849Z] Finished clobber step (success) 06:28:31 INFO - [mozharness: 2016-10-25 13:28:31.630977Z] Running read-buildbot-config step. 06:28:31 INFO - Running pre-action listener: _resource_record_pre_action 06:28:31 INFO - Running main action method: read_buildbot_config 06:28:31 INFO - Using buildbot properties: 06:28:31 INFO - { 06:28:31 INFO - "project": "", 06:28:31 INFO - "product": "firefox", 06:28:31 INFO - "script_repo_revision": "production", 06:28:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:28:31 INFO - "repository": "", 06:28:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 06:28:31 INFO - "buildid": "20161025062825", 06:28:31 INFO - "stage_platform": "linux64-pgo", 06:28:31 INFO - "basedir": "/builds/slave/test", 06:28:31 INFO - "buildnumber": 1166, 06:28:31 INFO - "platform": "ubuntu64_hw", 06:28:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:28:31 INFO - "slavebuilddir": "test", 06:28:31 INFO - "branch": "fx-team", 06:28:31 INFO - "revision": "78b863e9fcd9d44d75c817b6495b4585167ba255", 06:28:31 INFO - "slavename": "talos-linux64-ix-012", 06:28:31 INFO - "builduid": "3268cf647b89452080a0d3bfd5fe4966", 06:28:31 INFO - "repo_path": "integration/fx-team" 06:28:31 INFO - } 06:28:31 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477391404/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 06:28:31 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477391404/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 06:28:31 INFO - Running post-action listener: _resource_record_post_action 06:28:31 INFO - [mozharness: 2016-10-25 13:28:31.633362Z] Finished read-buildbot-config step (success) 06:28:31 INFO - [mozharness: 2016-10-25 13:28:31.633451Z] Running download-and-extract step. 06:28:31 INFO - Running pre-action listener: _resource_record_pre_action 06:28:31 INFO - Running main action method: download_and_extract 06:28:31 INFO - mkdir: /builds/slave/test/build/tests 06:28:31 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')]} 06:28:31 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477391404/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:28:31 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477391404/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 06:28:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477391404/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 06:28:31 INFO - Downloaded 1361 bytes. 06:28:31 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:28:31 INFO - Using the following test package requirements: 06:28:31 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:28:31 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:28:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:28:31 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:28:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:28:31 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:28:31 INFO - u'jsshell-linux-x86_64.zip'], 06:28:31 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:28:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:28:31 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:28:31 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:28:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:28:31 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:28:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:28:31 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:28:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:28:31 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:28:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:28:31 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:28:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477391404/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:28:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477391404/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:28:31 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477391404/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:28:31 INFO - Http code: 200 06:28:31 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 06:28:31 INFO - x-amz-cf-id: Gryw2bZGNj-DdgUHBfOrTSQDp-0Zz5s2uGh2vRowvWXG8yB87QwwyQ== 06:28:31 INFO - x-amz-replication-status: COMPLETED 06:28:31 INFO - x-amz-version-id: NnebP.b6.8LovvTNplPa9bFXtYazM1UK 06:28:31 INFO - Expected file size: 22036043 06:28:31 INFO - Obtained file size: 22036043 06:28:36 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 06:28:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477391404/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:28:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477391404/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:28:36 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477391404/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:28:36 INFO - Http code: 200 06:28:36 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 06:28:36 INFO - x-amz-cf-id: aQdLgkSf4WQ2k26CZdfRehV6W-M4ZB0AFZb5KsCnRGqaET4t7mmSxw== 06:28:36 INFO - x-amz-replication-status: COMPLETED 06:28:36 INFO - x-amz-version-id: NnebP.b6.8LovvTNplPa9bFXtYazM1UK 06:28:36 INFO - Expected file size: 22036043 06:28:36 INFO - Obtained file size: 22036043 06:28:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477391404/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 06:28:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477391404/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:28:40 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477391404/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 06:28:40 INFO - Http code: 200 06:28:40 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 06:28:40 INFO - x-amz-cf-id: 0I9zApUMHLlI38sskSl8fiMX4mxq8Mb9zVXZODzP_GRYBEWfReBC-w== 06:28:40 INFO - x-amz-replication-status: COMPLETED 06:28:40 INFO - x-amz-version-id: cs.EQQIbI08T9ellsjquWkU6r90u07CN 06:28:41 INFO - Expected file size: 14409028 06:28:41 INFO - Obtained file size: 14409028 06:28: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')]} 06:28:41 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477391404/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:28:41 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477391404/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 06:28:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477391404/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 06:28:41 INFO - Downloaded 59323139 bytes. 06:28:41 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477391404/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:28:41 INFO - mkdir: /builds/slave/test/properties 06:28:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:28:41 INFO - Writing to file /builds/slave/test/properties/build_url 06:28:41 INFO - Contents: 06:28:41 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477391404/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:28:42 INFO - Running post-action listener: _resource_record_post_action 06:28:42 INFO - Running post-action listener: set_extra_try_arguments 06:28:42 INFO - [mozharness: 2016-10-25 13:28:42.355676Z] Finished download-and-extract step (success) 06:28:42 INFO - [mozharness: 2016-10-25 13:28:42.355905Z] Running populate-webroot step. 06:28:42 INFO - Running pre-action listener: _resource_record_pre_action 06:28:42 INFO - Running main action method: populate_webroot 06:28:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:28:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:28:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:28:42 INFO - '--tppagecycles', 06:28:42 INFO - '7'], 06:28:42 INFO - 'tests': ['tsvgm']}}, 06:28:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:28:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:28:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:28:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:28:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:28:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:28:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:42 INFO - 'talos_options': ['--disable-e10s'], 06:28:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:28:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:28:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:42 INFO - 'talos_options': ['--disable-e10s'], 06:28:42 INFO - 'tests': ['damp', 'tps']}, 06:28:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:42 INFO - 'tests': ['damp', 'tps']}, 06:28:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:28:42 INFO - 'tests': ['dromaeo_dom']}, 06:28:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:28:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:28:42 INFO - 'tests': ['basic_compositor_video']}, 06:28:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:28:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:28:42 INFO - 'tests': ['a11yr', 06:28:42 INFO - 'ts_paint', 06:28:42 INFO - 'tpaint', 06:28:42 INFO - 'sessionrestore', 06:28:42 INFO - 'sessionrestore_no_auto_restore', 06:28:42 INFO - 'tabpaint']}, 06:28:42 INFO - 'other-e10s': {'tests': ['a11yr', 06:28:42 INFO - 'ts_paint', 06:28:42 INFO - 'tpaint', 06:28:42 INFO - 'sessionrestore', 06:28:42 INFO - 'sessionrestore_no_auto_restore', 06:28:42 INFO - 'tabpaint']}, 06:28:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:28:42 INFO - 'ts_paint', 06:28:42 INFO - 'tpaint', 06:28:42 INFO - 'sessionrestore', 06:28:42 INFO - 'sessionrestore_no_auto_restore', 06:28:42 INFO - 'tabpaint']}, 06:28:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:28:42 INFO - 'ts_paint', 06:28:42 INFO - 'tpaint', 06:28:42 INFO - 'sessionrestore', 06:28:42 INFO - 'sessionrestore_no_auto_restore', 06:28:42 INFO - 'tabpaint']}, 06:28:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:28:42 INFO - 'tests': ['a11yr', 06:28:42 INFO - 'ts_paint', 06:28:42 INFO - 'tpaint', 06:28:42 INFO - 'sessionrestore', 06:28:42 INFO - 'sessionrestore_no_auto_restore', 06:28:42 INFO - 'tabpaint']}, 06:28:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:28:42 INFO - 'tests': ['a11yr', 06:28:42 INFO - 'ts_paint', 06:28:42 INFO - 'tpaint', 06:28:42 INFO - 'sessionrestore', 06:28:42 INFO - 'sessionrestore_no_auto_restore', 06:28:42 INFO - 'tabpaint']}, 06:28:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:28:42 INFO - 'tests': ['tsvgx', 06:28:42 INFO - 'tsvgr_opacity', 06:28:42 INFO - 'tart', 06:28:42 INFO - 'tscrollx', 06:28:42 INFO - 'cart']}, 06:28:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:28:42 INFO - 'tsvgr_opacity', 06:28:42 INFO - 'tart', 06:28:42 INFO - 'tscrollx', 06:28:42 INFO - 'cart']}, 06:28:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:42 INFO - 'talos_options': ['--disable-e10s'], 06:28:42 INFO - 'tests': ['tp5o']}, 06:28:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:42 INFO - 'tests': ['tp5o']}, 06:28:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:42 INFO - 'talos_options': ['--disable-e10s', 06:28:42 INFO - '--xperf_path', 06:28:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:28:42 INFO - 'tests': ['tp5n']}, 06:28:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:42 INFO - 'talos_options': ['--xperf_path', 06:28:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:28:42 INFO - 'tests': ['tp5n']}}, 06:28:42 INFO - 'talos.zip': {'path': '', 06:28:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:28:42 INFO - Running post-action listener: _resource_record_post_action 06:28:42 INFO - [mozharness: 2016-10-25 13:28:42.373788Z] Finished populate-webroot step (success) 06:28:42 INFO - [mozharness: 2016-10-25 13:28:42.373877Z] Running create-virtualenv step. 06:28:42 INFO - Running pre-action listener: _resource_record_pre_action 06:28:42 INFO - Running main action method: create_virtualenv 06:28:42 INFO - Creating virtualenv /builds/slave/test/build/venv 06:28:42 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 06:28:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:28:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:28:42 INFO - Using real prefix '/usr' 06:28:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:28:42 INFO - Installing distribute.............................................................................................................................................................................................done. 06:28:44 INFO - Installing pip.................done. 06:28:44 INFO - Return code: 0 06:28:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:28:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:28:45 INFO - Reading from file tmpfile_stdout 06:28:45 INFO - Output received: 06:28:45 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) 06:28:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:28:45 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')]} 06:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:45 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')]} 06:28:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:45 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 0x7f332c466f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x264e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264b930>, '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 0x264c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x264ccc0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1477399700.593707-772652127', '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 06:28:45 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 06:28:45 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 06:28:45 INFO - Using env: {'DISPLAY': ':0', 06:28:45 INFO - 'HOME': '/home/cltbld', 06:28:45 INFO - 'LANG': 'en_US.UTF-8', 06:28:45 INFO - 'LANGUAGE': 'en_US:en', 06:28:45 INFO - 'LOGNAME': 'cltbld', 06:28:45 INFO - 'MAIL': '/var/mail/cltbld', 06:28:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:45 INFO - 'MOZ_NO_REMOTE': '1', 06:28:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:45 INFO - 'NO_EM_RESTART': '1', 06:28:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:45 INFO - 'PWD': '/builds/slave/test', 06:28:45 INFO - 'SHELL': '/bin/bash', 06:28:45 INFO - 'SHLVL': '1', 06:28:45 INFO - 'TERM': 'linux', 06:28:45 INFO - 'TMOUT': '86400', 06:28:45 INFO - 'USER': 'cltbld', 06:28:45 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1477399700.593707-772652127', 06:28:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:45 INFO - '_': '/tools/buildbot/bin/python'} 06:28:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:45 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 06:28:45 INFO - Cleaning up... 06:28:45 INFO - Return code: 0 06:28:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:28:45 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')]} 06:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:45 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')]} 06:28:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:45 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 0x7f332c466f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x264e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264b930>, '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 0x264c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x264ccc0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1477399700.593707-772652127', '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 06:28:45 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 06:28:45 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 06:28:45 INFO - Using env: {'DISPLAY': ':0', 06:28:45 INFO - 'HOME': '/home/cltbld', 06:28:45 INFO - 'LANG': 'en_US.UTF-8', 06:28:45 INFO - 'LANGUAGE': 'en_US:en', 06:28:45 INFO - 'LOGNAME': 'cltbld', 06:28:45 INFO - 'MAIL': '/var/mail/cltbld', 06:28:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:45 INFO - 'MOZ_NO_REMOTE': '1', 06:28:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:45 INFO - 'NO_EM_RESTART': '1', 06:28:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:45 INFO - 'PWD': '/builds/slave/test', 06:28:45 INFO - 'SHELL': '/bin/bash', 06:28:45 INFO - 'SHLVL': '1', 06:28:45 INFO - 'TERM': 'linux', 06:28:45 INFO - 'TMOUT': '86400', 06:28:45 INFO - 'USER': 'cltbld', 06:28:45 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1477399700.593707-772652127', 06:28:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:45 INFO - '_': '/tools/buildbot/bin/python'} 06:28:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:45 INFO - Downloading/unpacking psutil>=3.1.1 06:28:45 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 06:28:45 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 06:28:45 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 06:28:45 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 06:28:45 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 06:28:45 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 06:28:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:28:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:28:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:28:48 INFO - Installing collected packages: psutil 06:28:48 INFO - Running setup.py install for psutil 06:28:48 INFO - building 'psutil._psutil_linux' extension 06:28:48 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 06:28:48 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 06:28:48 INFO - building 'psutil._psutil_posix' extension 06:28:48 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 06:28:49 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 06:28:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:28:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:28:49 INFO - Successfully installed psutil 06:28:49 INFO - Cleaning up... 06:28:49 INFO - Return code: 0 06:28:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:28:49 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')]} 06:28:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:49 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')]} 06:28:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:49 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 0x7f332c466f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x264e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264b930>, '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 0x264c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x264ccc0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1477399700.593707-772652127', '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 06:28:49 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 06:28:49 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 06:28:49 INFO - Using env: {'DISPLAY': ':0', 06:28:49 INFO - 'HOME': '/home/cltbld', 06:28:49 INFO - 'LANG': 'en_US.UTF-8', 06:28:49 INFO - 'LANGUAGE': 'en_US:en', 06:28:49 INFO - 'LOGNAME': 'cltbld', 06:28:49 INFO - 'MAIL': '/var/mail/cltbld', 06:28:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:49 INFO - 'MOZ_NO_REMOTE': '1', 06:28:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:49 INFO - 'NO_EM_RESTART': '1', 06:28:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:49 INFO - 'PWD': '/builds/slave/test', 06:28:49 INFO - 'SHELL': '/bin/bash', 06:28:49 INFO - 'SHLVL': '1', 06:28:49 INFO - 'TERM': 'linux', 06:28:49 INFO - 'TMOUT': '86400', 06:28:49 INFO - 'USER': 'cltbld', 06:28:49 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1477399700.593707-772652127', 06:28:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:49 INFO - '_': '/tools/buildbot/bin/python'} 06:28:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:28:49 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 06:28:49 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 06:28:49 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 06:28:49 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 06:28:49 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 06:28:49 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 06:28:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:28:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:28:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:28:51 INFO - Installing collected packages: mozsystemmonitor 06:28:51 INFO - Running setup.py install for mozsystemmonitor 06:28:51 INFO - Successfully installed mozsystemmonitor 06:28:51 INFO - Cleaning up... 06:28:51 INFO - Return code: 0 06:28:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:28:51 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')]} 06:28:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:51 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')]} 06:28:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:51 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 0x7f332c466f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x264e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264b930>, '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 0x264c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x264ccc0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1477399700.593707-772652127', '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 06:28:51 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 06:28:51 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 06:28:51 INFO - Using env: {'DISPLAY': ':0', 06:28:51 INFO - 'HOME': '/home/cltbld', 06:28:51 INFO - 'LANG': 'en_US.UTF-8', 06:28:51 INFO - 'LANGUAGE': 'en_US:en', 06:28:51 INFO - 'LOGNAME': 'cltbld', 06:28:51 INFO - 'MAIL': '/var/mail/cltbld', 06:28:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:51 INFO - 'MOZ_NO_REMOTE': '1', 06:28:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:51 INFO - 'NO_EM_RESTART': '1', 06:28:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:51 INFO - 'PWD': '/builds/slave/test', 06:28:51 INFO - 'SHELL': '/bin/bash', 06:28:51 INFO - 'SHLVL': '1', 06:28:51 INFO - 'TERM': 'linux', 06:28:51 INFO - 'TMOUT': '86400', 06:28:51 INFO - 'USER': 'cltbld', 06:28:51 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1477399700.593707-772652127', 06:28:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:51 INFO - '_': '/tools/buildbot/bin/python'} 06:28:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:51 INFO - Downloading/unpacking jsonschema==2.5.1 06:28:51 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 06:28:51 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 06:28:51 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 06:28:51 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 06:28:51 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 06:28:51 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 06:28:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:28:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:28:53 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 06:28:53 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 06:28:53 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 06:28:53 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 06:28:53 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 06:28:53 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 06:28:53 INFO - Downloading functools32-3.2.3-2.tar.gz 06:28:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:28:54 INFO - warning: no files found matching '*.txt' 06:28:54 INFO - no previously-included directories found matching 'build' 06:28:54 INFO - no previously-included directories found matching 'dist' 06:28:54 INFO - no previously-included directories found matching '.git*' 06:28:54 INFO - Installing collected packages: jsonschema, functools32 06:28:54 INFO - Running setup.py install for functools32 06:28:54 INFO - warning: no files found matching '*.txt' 06:28:54 INFO - no previously-included directories found matching 'build' 06:28:54 INFO - no previously-included directories found matching 'dist' 06:28:54 INFO - no previously-included directories found matching '.git*' 06:28:54 INFO - Successfully installed jsonschema functools32 06:28:54 INFO - Cleaning up... 06:28:54 INFO - Return code: 0 06:28:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:28: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')]} 06:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28: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')]} 06:28:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:54 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 0x7f332c466f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x264e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264b930>, '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 0x264c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x264ccc0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1477399700.593707-772652127', '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 06:28:54 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 06:28:54 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 06:28:54 INFO - Using env: {'DISPLAY': ':0', 06:28:54 INFO - 'HOME': '/home/cltbld', 06:28:54 INFO - 'LANG': 'en_US.UTF-8', 06:28:54 INFO - 'LANGUAGE': 'en_US:en', 06:28:54 INFO - 'LOGNAME': 'cltbld', 06:28:54 INFO - 'MAIL': '/var/mail/cltbld', 06:28:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:54 INFO - 'MOZ_NO_REMOTE': '1', 06:28:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:54 INFO - 'NO_EM_RESTART': '1', 06:28:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:54 INFO - 'PWD': '/builds/slave/test', 06:28:54 INFO - 'SHELL': '/bin/bash', 06:28:54 INFO - 'SHLVL': '1', 06:28:54 INFO - 'TERM': 'linux', 06:28:54 INFO - 'TMOUT': '86400', 06:28:54 INFO - 'USER': 'cltbld', 06:28:54 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1477399700.593707-772652127', 06:28:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:54 INFO - '_': '/tools/buildbot/bin/python'} 06:28:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:28:54 INFO - Cleaning up... 06:28:54 INFO - Return code: 0 06:28:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:28: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')]} 06:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28: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')]} 06:28:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:54 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 0x7f332c466f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x264e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264b930>, '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 0x264c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x264ccc0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1477399700.593707-772652127', '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 06:28:54 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 06:28:54 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 06:28:54 INFO - Using env: {'DISPLAY': ':0', 06:28:54 INFO - 'HOME': '/home/cltbld', 06:28:54 INFO - 'LANG': 'en_US.UTF-8', 06:28:54 INFO - 'LANGUAGE': 'en_US:en', 06:28:54 INFO - 'LOGNAME': 'cltbld', 06:28:54 INFO - 'MAIL': '/var/mail/cltbld', 06:28:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:54 INFO - 'MOZ_NO_REMOTE': '1', 06:28:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:54 INFO - 'NO_EM_RESTART': '1', 06:28:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:54 INFO - 'PWD': '/builds/slave/test', 06:28:54 INFO - 'SHELL': '/bin/bash', 06:28:54 INFO - 'SHLVL': '1', 06:28:54 INFO - 'TERM': 'linux', 06:28:54 INFO - 'TMOUT': '86400', 06:28:54 INFO - 'USER': 'cltbld', 06:28:54 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1477399700.593707-772652127', 06:28:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:54 INFO - '_': '/tools/buildbot/bin/python'} 06:28:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:54 INFO - Downloading/unpacking blobuploader==1.2.4 06:28:54 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 06:28:54 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 06:28:54 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 06:28:54 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 06:28:54 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 06:28:54 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 06:28:56 INFO - Downloading blobuploader-1.2.4.tar.gz 06:28:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:28:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:28:56 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 06:28:56 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 06:28:56 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 06:28:56 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 06:28:56 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 06:28:56 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 06:28:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:28:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:28:57 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 06:28:57 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 06:28:57 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 06:28:57 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 06:28:57 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 06:28:57 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 06:28:57 INFO - Downloading docopt-0.6.1.tar.gz 06:28:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:28:57 INFO - Installing collected packages: blobuploader, requests, docopt 06:28:57 INFO - Running setup.py install for blobuploader 06:28:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:28:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:28:57 INFO - Running setup.py install for requests 06:28:57 INFO - Running setup.py install for docopt 06:28:57 INFO - Successfully installed blobuploader requests docopt 06:28:57 INFO - Cleaning up... 06:28:57 INFO - Return code: 0 06:28:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:28:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:28:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:57 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 0x7f332c466f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x264e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264b930>, '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 0x264c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x264ccc0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1477399700.593707-772652127', '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 06:28:57 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 06:28:57 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 06:28:57 INFO - Using env: {'DISPLAY': ':0', 06:28:57 INFO - 'HOME': '/home/cltbld', 06:28:57 INFO - 'LANG': 'en_US.UTF-8', 06:28:57 INFO - 'LANGUAGE': 'en_US:en', 06:28:57 INFO - 'LOGNAME': 'cltbld', 06:28:57 INFO - 'MAIL': '/var/mail/cltbld', 06:28:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:57 INFO - 'MOZ_NO_REMOTE': '1', 06:28:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:57 INFO - 'NO_EM_RESTART': '1', 06:28:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:57 INFO - 'PWD': '/builds/slave/test', 06:28:57 INFO - 'SHELL': '/bin/bash', 06:28:57 INFO - 'SHLVL': '1', 06:28:57 INFO - 'TERM': 'linux', 06:28:57 INFO - 'TMOUT': '86400', 06:28:57 INFO - 'USER': 'cltbld', 06:28:57 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1477399700.593707-772652127', 06:28:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:57 INFO - '_': '/tools/buildbot/bin/python'} 06:28:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:28:58 INFO - Running setup.py (path:/tmp/pip-NXOh3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:28:58 INFO - Running setup.py (path:/tmp/pip-VCVBqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:28:58 INFO - Running setup.py (path:/tmp/pip-JB_7LL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:28:58 INFO - Running setup.py (path:/tmp/pip-gKj_e2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:28:58 INFO - Running setup.py (path:/tmp/pip-i4bS3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:28:58 INFO - Running setup.py (path:/tmp/pip-i5RymQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:28:58 INFO - Running setup.py (path:/tmp/pip-G5SY2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:28:58 INFO - Running setup.py (path:/tmp/pip-HeOSTI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:28:58 INFO - Running setup.py (path:/tmp/pip-9m5A1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:28:58 INFO - Running setup.py (path:/tmp/pip-uQ1ShZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:28:58 INFO - Running setup.py (path:/tmp/pip-g8CPOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:28:58 INFO - Running setup.py (path:/tmp/pip-C0ByBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:28:59 INFO - Running setup.py (path:/tmp/pip-pfbyNP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:28:59 INFO - Running setup.py (path:/tmp/pip-f6zzZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:28:59 INFO - Running setup.py (path:/tmp/pip-1JbiBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:28:59 INFO - Running setup.py (path:/tmp/pip-574c_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:28:59 INFO - Running setup.py (path:/tmp/pip-HYczmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:28:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:28:59 INFO - Running setup.py install for manifestparser 06:28:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:28:59 INFO - Running setup.py install for mozcrash 06:28:59 INFO - Running setup.py install for mozdebug 06:28:59 INFO - Running setup.py install for mozdevice 06:28:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:28:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:28:59 INFO - Running setup.py install for mozfile 06:28:59 INFO - Running setup.py install for mozhttpd 06:29:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:29:00 INFO - Running setup.py install for mozinfo 06:29:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:29:00 INFO - Running setup.py install for mozInstall 06:29:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:29:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:29:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:29:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:29:00 INFO - Running setup.py install for mozleak 06:29:00 INFO - Running setup.py install for mozlog 06:29:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:29:00 INFO - Running setup.py install for moznetwork 06:29:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:29:00 INFO - Running setup.py install for mozprocess 06:29:00 INFO - Running setup.py install for mozprofile 06:29:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:29:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:29:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:29:00 INFO - Running setup.py install for mozrunner 06:29:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:29:00 INFO - Running setup.py install for mozscreenshot 06:29:00 INFO - Running setup.py install for moztest 06:29:01 INFO - Running setup.py install for mozversion 06:29:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:29:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:29:01 INFO - Cleaning up... 06:29:01 INFO - Return code: 0 06:29:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:29:01 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')]} 06:29:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:01 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')]} 06:29:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:01 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 0x7f332c466f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x264e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264b930>, '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 0x264c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x264ccc0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1477399700.593707-772652127', '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 06:29:01 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 06:29:01 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 06:29:01 INFO - Using env: {'DISPLAY': ':0', 06:29:01 INFO - 'HOME': '/home/cltbld', 06:29:01 INFO - 'LANG': 'en_US.UTF-8', 06:29:01 INFO - 'LANGUAGE': 'en_US:en', 06:29:01 INFO - 'LOGNAME': 'cltbld', 06:29:01 INFO - 'MAIL': '/var/mail/cltbld', 06:29:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:01 INFO - 'MOZ_NO_REMOTE': '1', 06:29:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:29:01 INFO - 'NO_EM_RESTART': '1', 06:29:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:29:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:01 INFO - 'PWD': '/builds/slave/test', 06:29:01 INFO - 'SHELL': '/bin/bash', 06:29:01 INFO - 'SHLVL': '1', 06:29:01 INFO - 'TERM': 'linux', 06:29:01 INFO - 'TMOUT': '86400', 06:29:01 INFO - 'USER': 'cltbld', 06:29:01 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1477399700.593707-772652127', 06:29:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:01 INFO - '_': '/tools/buildbot/bin/python'} 06:29:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:29:01 INFO - Running setup.py (path:/tmp/pip-DS9AlQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:29:01 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)) 06:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:29:01 INFO - Running setup.py (path:/tmp/pip-hCv0y7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:29:01 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)) 06:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:29:01 INFO - Running setup.py (path:/tmp/pip-cW5pmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:29:01 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)) 06:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:29:01 INFO - Running setup.py (path:/tmp/pip-VfE6QW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:29:01 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)) 06:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:29:01 INFO - Running setup.py (path:/tmp/pip-57Q6c8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:29:01 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)) 06:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:29:01 INFO - Running setup.py (path:/tmp/pip-nqa_di-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:29:01 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)) 06:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:29:01 INFO - Running setup.py (path:/tmp/pip-67Msa1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:29:01 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)) 06:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:29:01 INFO - Running setup.py (path:/tmp/pip-2JpiF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:29:02 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)) 06:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:29:02 INFO - Running setup.py (path:/tmp/pip-Rv9sZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:29:02 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)) 06:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:29:02 INFO - Running setup.py (path:/tmp/pip-ineoNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:29:02 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)) 06:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:29:02 INFO - Running setup.py (path:/tmp/pip-P8kCwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:29:02 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)) 06:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:29:02 INFO - Running setup.py (path:/tmp/pip-JCWrdn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:29:02 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)) 06:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:29:02 INFO - Running setup.py (path:/tmp/pip-crVY3I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:29:02 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)) 06:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:29:02 INFO - Running setup.py (path:/tmp/pip-zVBFY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:29:02 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)) 06:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:29:02 INFO - Running setup.py (path:/tmp/pip-c_KRNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:29:02 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)) 06:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:29:02 INFO - Running setup.py (path:/tmp/pip-o4ss2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:29:02 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)) 06:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:29:02 INFO - Running setup.py (path:/tmp/pip-QsYKRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:29:02 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)) 06:29:02 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)) 06:29:02 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)) 06:29:02 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)) 06:29:02 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)) 06:29:02 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)) 06:29:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:29:02 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 06:29:02 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 06:29:02 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 06:29:02 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 06:29:02 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 06:29:02 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 06:29:04 INFO - Downloading blessings-1.6.tar.gz 06:29:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:29:04 INFO - Installing collected packages: blessings 06:29:04 INFO - Running setup.py install for blessings 06:29:04 INFO - Successfully installed blessings 06:29:04 INFO - Cleaning up... 06:29:04 INFO - Return code: 0 06:29:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:29:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:29:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:29:05 INFO - Reading from file tmpfile_stdout 06:29:05 INFO - Current package versions: 06:29:05 INFO - argparse == 1.2.1 06:29:05 INFO - blessings == 1.6 06:29:05 INFO - blobuploader == 1.2.4 06:29:05 INFO - docopt == 0.6.1 06:29:05 INFO - functools32 == 3.2.3-2 06:29:05 INFO - jsonschema == 2.5.1 06:29:05 INFO - manifestparser == 1.1 06:29:05 INFO - mozInstall == 1.12 06:29:05 INFO - mozcrash == 0.17 06:29:05 INFO - mozdebug == 0.1 06:29:05 INFO - mozdevice == 0.48 06:29:05 INFO - mozfile == 1.2 06:29:05 INFO - mozhttpd == 0.7 06:29:05 INFO - mozinfo == 0.9 06:29:05 INFO - mozleak == 0.1 06:29:05 INFO - mozlog == 3.4 06:29:05 INFO - moznetwork == 0.27 06:29:05 INFO - mozprocess == 0.23 06:29:05 INFO - mozprofile == 0.28 06:29:05 INFO - mozrunner == 6.12 06:29:05 INFO - mozscreenshot == 0.1 06:29:05 INFO - mozsystemmonitor == 0.3 06:29:05 INFO - moztest == 0.7 06:29:05 INFO - mozversion == 1.4 06:29:05 INFO - psutil == 3.1.1 06:29:05 INFO - requests == 1.2.3 06:29:05 INFO - wsgiref == 0.1.2 06:29:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:29: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')]} 06:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29: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')]} 06:29:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:05 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 0x7f332c466f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x264e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264b930>, '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 0x264c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x264ccc0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1477399700.593707-772652127', '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 06:29:05 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 06:29:05 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 06:29:05 INFO - Using env: {'DISPLAY': ':0', 06:29:05 INFO - 'HOME': '/home/cltbld', 06:29:05 INFO - 'LANG': 'en_US.UTF-8', 06:29:05 INFO - 'LANGUAGE': 'en_US:en', 06:29:05 INFO - 'LOGNAME': 'cltbld', 06:29:05 INFO - 'MAIL': '/var/mail/cltbld', 06:29:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:05 INFO - 'MOZ_NO_REMOTE': '1', 06:29:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:29:05 INFO - 'NO_EM_RESTART': '1', 06:29:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:29:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:05 INFO - 'PWD': '/builds/slave/test', 06:29:05 INFO - 'SHELL': '/bin/bash', 06:29:05 INFO - 'SHLVL': '1', 06:29:05 INFO - 'TERM': 'linux', 06:29:05 INFO - 'TMOUT': '86400', 06:29:05 INFO - 'USER': 'cltbld', 06:29:05 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1477399700.593707-772652127', 06:29:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:05 INFO - '_': '/tools/buildbot/bin/python'} 06:29:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:05 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)) 06:29:05 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)) 06:29:05 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)) 06:29:05 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)) 06:29:05 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)) 06:29:05 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)) 06:29:05 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)) 06:29:05 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)) 06:29:05 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)) 06:29:05 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)) 06:29:05 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)) 06:29:05 INFO - Cleaning up... 06:29:05 INFO - Return code: 0 06:29:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:29: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')]} 06:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29: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')]} 06:29:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f332c466f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x264e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264b930>, '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 0x264c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x264ccc0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1477399700.593707-772652127', '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 06:29: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'] in /builds/slave/test/build 06:29: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 06:29:05 INFO - Using env: {'DISPLAY': ':0', 06:29:05 INFO - 'HOME': '/home/cltbld', 06:29:05 INFO - 'LANG': 'en_US.UTF-8', 06:29:05 INFO - 'LANGUAGE': 'en_US:en', 06:29:05 INFO - 'LOGNAME': 'cltbld', 06:29:05 INFO - 'MAIL': '/var/mail/cltbld', 06:29:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:05 INFO - 'MOZ_NO_REMOTE': '1', 06:29:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:29:05 INFO - 'NO_EM_RESTART': '1', 06:29:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:29:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:05 INFO - 'PWD': '/builds/slave/test', 06:29:05 INFO - 'SHELL': '/bin/bash', 06:29:05 INFO - 'SHLVL': '1', 06:29:05 INFO - 'TERM': 'linux', 06:29:05 INFO - 'TMOUT': '86400', 06:29:05 INFO - 'USER': 'cltbld', 06:29:05 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1477399700.593707-772652127', 06:29:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:05 INFO - '_': '/tools/buildbot/bin/python'} 06:29:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:29:05 INFO - Cleaning up... 06:29:05 INFO - Return code: 0 06:29:05 INFO - Running post-action listener: _resource_record_post_action 06:29:05 INFO - Running post-action listener: _start_resource_monitoring 06:29:05 INFO - Starting resource monitoring. 06:29:05 INFO - [mozharness: 2016-10-25 13:29:05.561108Z] Finished create-virtualenv step (success) 06:29:05 INFO - [mozharness: 2016-10-25 13:29:05.561563Z] Running install step. 06:29:05 INFO - Running pre-action listener: _resource_record_pre_action 06:29:05 INFO - Running main action method: install 06:29:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:29:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:29:05 INFO - Reading from file tmpfile_stdout 06:29:05 INFO - Detecting whether we're running mozinstall >=1.0... 06:29:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:29:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:29:05 INFO - Reading from file tmpfile_stdout 06:29:05 INFO - Output received: 06:29:05 INFO - Usage: mozinstall [options] installer 06:29:05 INFO - Options: 06:29:05 INFO - -h, --help show this help message and exit 06:29:05 INFO - -d DEST, --destination=DEST 06:29:05 INFO - Directory to install application into. [default: 06:29:05 INFO - "/builds/slave/test"] 06:29:05 INFO - --app=APP Application being installed. [default: firefox] 06:29:05 INFO - mkdir: /builds/slave/test/build/application 06:29:05 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'] 06:29:05 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 06:29:22 INFO - Reading from file tmpfile_stdout 06:29:22 INFO - Output received: 06:29:22 INFO - /builds/slave/test/build/application/firefox/firefox 06:29:22 INFO - Running post-action listener: _resource_record_post_action 06:29:22 INFO - [mozharness: 2016-10-25 13:29:22.729301Z] Finished install step (success) 06:29:22 INFO - [mozharness: 2016-10-25 13:29:22.729575Z] Running run-tests step. 06:29:22 INFO - Running pre-action listener: _resource_record_pre_action 06:29:22 INFO - Running main action method: run_tests 06:29:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:29:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:29:22 INFO - Python 2.7.3 06:29:22 INFO - Return code: 0 06:29:22 INFO - grabbing minidump binary from tooltool 06:29:22 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')]} 06:29:22 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 0x264b930>, '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 0x264c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x264ccc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:29:22 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 06:29:22 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 06:29:22 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 06:29:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:29:22 INFO - Return code: 0 06:29:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:29:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:29:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:29:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:29:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:29:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477391404/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 06:29:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477391404/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --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 06:29:22 INFO - Using env: {'DISPLAY': ':0', 06:29:22 INFO - 'HOME': '/home/cltbld', 06:29:22 INFO - 'LANG': 'en_US.UTF-8', 06:29:22 INFO - 'LANGUAGE': 'en_US:en', 06:29:22 INFO - 'LOGNAME': 'cltbld', 06:29:22 INFO - 'MAIL': '/var/mail/cltbld', 06:29:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:29:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:29:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:22 INFO - 'MOZ_NO_REMOTE': '1', 06:29:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:29:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:29:22 INFO - 'NO_EM_RESTART': '1', 06:29:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:29:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:22 INFO - 'PWD': '/builds/slave/test', 06:29:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:29:22 INFO - 'SHELL': '/bin/bash', 06:29:22 INFO - 'SHLVL': '1', 06:29:22 INFO - 'TERM': 'linux', 06:29:22 INFO - 'TMOUT': '86400', 06:29:22 INFO - 'USER': 'cltbld', 06:29:22 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1477399700.593707-772652127', 06:29:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:22 INFO - '_': '/tools/buildbot/bin/python'} 06:29:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477391404/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 06:29:23 INFO - mozversion application_buildid: 20161025033004 06:29:23 INFO - mozversion application_changeset: 78b863e9fcd9d44d75c817b6495b4585167ba255 06:29:23 INFO - mozversion application_display_name: Nightly 06:29:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:29:23 INFO - mozversion application_name: Firefox 06:29:23 INFO - mozversion application_remotingname: firefox 06:29:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:29:23 INFO - mozversion application_vendor: Mozilla 06:29:23 INFO - mozversion application_version: 52.0a1 06:29:23 INFO - mozversion platform_buildid: 20161025033004 06:29:23 INFO - mozversion platform_changeset: 78b863e9fcd9d44d75c817b6495b4585167ba255 06:29:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:29:23 INFO - mozversion platform_version: 52.0a1 06:29:23 INFO - using testdate: 1477402163 06:29:23 INFO - actual date: 1477402163 06:29:23 INFO - starting webserver on 'localhost:50583' 06:29:23 INFO - SUITE-START | Running 2 tests 06:29:23 INFO - TEST-START | dromaeo_css 06:29:23 INFO - operating with platform_type : linux_ 06:29:23 INFO - Initialising browser for dromaeo_css test... 06:29:23 INFO - TEST-INFO | started process 13147 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6UJlKy/profile http://localhost:50583/getInfo.html) 06:29:26 INFO - PROCESS | 13147 | __metrics Screen width/height:1600/1200 06:29:26 INFO - PROCESS | 13147 | colorDepth:24 06:29:26 INFO - PROCESS | 13147 | Browser inner width/height: 1024/697 06:29:26 INFO - PROCESS | 13147 | __metrics 06:29:27 INFO - PROCESS | 13147 | 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" 06:29:27 INFO - PROCESS | 13147 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:29:27 INFO - PROCESS | 13147 | console.error: PushService: 06:29:27 INFO - PROCESS | 13147 | stateChangeProcessEnqueue: Error transitioning state 06:29:27 INFO - PROCESS | 13147 | UnknownError 06:29:28 INFO - TEST-INFO | 13147: exit 0 06:29:28 INFO - Browser initialized. 06:29:28 INFO - Running cycle 1/1 for dromaeo_css test... 06:29:28 INFO - TEST-INFO | started process 13231 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6UJlKy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:29:40 INFO - PROCESS | 13231 | RSS: Main: 172400640 06:29:40 INFO - PROCESS | 13231 | 06:30:32 INFO - PROCESS | 13231 | 1477402232353 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] 06:32:42 INFO - PROCESS | 13231 | Cycle 1(1): loaded http://localhost:50583/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50583/tests/dromaeo/cssquery-ext.html) 06:32:45 INFO - PROCESS | 13231 | RSS: Main: 432476160 06:32:45 INFO - PROCESS | 13231 | 06:35:47 INFO - PROCESS | 13231 | Cycle 1(1): loaded http://localhost:50583/tests/dromaeo/cssquery-ext.html (next: http://localhost:50583/tests/dromaeo/cssquery-jquery.html) 06:35:48 INFO - PROCESS | 13231 | RSS: Main: 280363008 06:35:48 INFO - PROCESS | 13231 | 06:38:50 INFO - PROCESS | 13231 | Cycle 1(1): loaded http://localhost:50583/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50583/tests/dromaeo/cssquery-mootools.html) 06:38:51 INFO - PROCESS | 13231 | RSS: Main: 217792512 06:38:51 INFO - PROCESS | 13231 | 06:41:53 INFO - PROCESS | 13231 | Cycle 1(1): loaded http://localhost:50583/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50583/tests/dromaeo/cssquery-prototype.html) 06:41:53 INFO - PROCESS | 13231 | RSS: Main: 257363968 06:41:53 INFO - PROCESS | 13231 | 06:44:56 INFO - PROCESS | 13231 | Cycle 1(1): loaded http://localhost:50583/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50583/tests/dromaeo/cssquery-yui.html) 06:44:57 INFO - PROCESS | 13231 | RSS: Main: 215523328 06:44:57 INFO - PROCESS | 13231 | 06:47:59 INFO - PROCESS | 13231 | Cycle 1(1): loaded http://localhost:50583/tests/dromaeo/cssquery-yui.html (next: http://localhost:50583/tests/dromaeo/cssquery-dojo.html) 06:48:00 INFO - PROCESS | 13231 | RSS: Main: 305618944 06:48:00 INFO - PROCESS | 13231 | 06:48:00 INFO - PROCESS | 13231 | __start_tp_report 06:48:00 INFO - PROCESS | 13231 | _x_x_mozilla_page_load 06:48:00 INFO - PROCESS | 13231 | _x_x_mozilla_page_load_details 06:48:00 INFO - PROCESS | 13231 | |i|pagename|runs| 06:48:00 INFO - PROCESS | 13231 | |0;dojo.html;3088.2433803718086;3107.642621098574;3139.513375426809;3150.0234927172564;3152.36952609478;5196.688198708071;5264.078786212417;5333.146696528552;5407.351117865856;5434.891302173949;5326.467353264671;5329.360476742796;5436.401995780471;5443.510084092431;5459.454054594538;4804.495527969565;4851.733154676492;4912.950870491285;4913.385826771653;4939.43196532398;4897;5026;5036.068327359432;5045.545900868921;5097.745112744348;4849.102915960523;4992.900141997176;4996.775145118479;5027.572656324217;5104.106781313274;4843.878903027453;4844.7819848106565;4854.17479028566;4887;4954.5540901319055;4828.589569886564;4836.806527738886;4839.2983017462275;4859;4917.4344950330815;5349.652272602308;5360.571154307646;5364.463553644643;5368.865778355534;5377.059014672456;5601.383847776741;5650.152477128422;5657.264555607786;5672.40439753824;5715.571332150105;5731.312242530881;5815.21494598228;5820.039693450575;5872.765089396462;5873.676947767871;5384.91922621161;5387.919181212285;5388.973055134699;5398.433164517748;5399.568034557226;5607.775688972395;5616.5787565932715;5892.204552385459;5897.557683173779;5906;5467.917981230285;5523.613347065667;5577.44225577439;5595.524380427709;5600.943990560042;5557.166425036277;5608.46719561641;5619.129034999582;5625.943740562542;5626.662400255997;5571.331440227199;5577.721113944368;5581.134924086773;5589.608727389125;5656.85857853557;5512.751926163332;5606.103023516218;5609.298837645294;5695.629784064023;5698.31620205578;4356.106998065389;4381.16757816014;4391.6486681065435;4431.401760762255;4440.62254708347;3890.4164375343926;3906.3945088511327;3921.686265098785;3938.6455219029854;3971.4837071180564;5470.316210473691;5482.17767334895;5485.341758988867;5487.725613719298;5540.584456165723;5630.577706672016;5690;5693.117566777156;5731.426857314235;5792;5507.669539827623;5514.200440936042;5520.365158006881;5522.944770552243;5586.162075688598;5021.447640759514;5032.345795046621;5036.823711170092;5043.697378157322;5097.158968770185;5825.592208545361;5833.941660583339;5901.822945311647;5988.580799344004;5997.730102145414;5764.308283006066;5780.208135478016;5782.85542861415;5792.247007888947;5813.069908814569;5894.941050589611;5955.464008239279;5957.434043765836;5963.344032156546;5968.940310596839;5679.261695979496;5684.0621297487105;5686.573506987075;5690.658560486384;5691.203231547669;5785.132230165509;5792.797252096157;5795.768169273182;5798.043322851851;5802.941970580409;5635.239242702182;5672.2058911751565;5676.943230567642;5677.943220567741;5678.630888992202;5591.860203494945;5595.188697638901;5619.7752089917585;5649.293838270216;5660.603757736919;5624.606277560531;5652.660840349592;5655.830325090254;5658.773649053992;5679.5172410345585;5518.117101263939;5571.60998730085;5697.971510142588;5721.685307308138;5723.599348045597;5502.779888804403;5534.972325138348;5535.308086489189;5576.33084029919;5639.859003524781 06:48:00 INFO - PROCESS | 13231 | |1;ext.html;547.3923944421691;578.5545130249708;581.8050952930768;594.5867622002708;596.2040675697943;31102.377952440966;42605;43550.782246088806;43566.34650480245;47272;45230.77384613072;45772.542274577245;45773.0845383093;45806.7709661452;45866.77066614671;8629.180227878373;8756.649734010663;8791.736247912573;8792.47245165289;8796.42823216492;7968.9601551992155;8179.631916563739;10341.276110672256;10581.947090264577;10611;10764.461776911163;10887.292325998786;10888;10891.455427228646;10893.346399216032;8062.717804876801;10675.572977080907;10734.624288149877;10744.033037026627;10749.086327662159;7934.603269836485;10096.848547271797;10420.426876521788;10436;10743.40911249881;42549;42886;42937.141257174684;42959.785201074104;42995.570044299784;3030.3939212157657;3109.67348428414;3165.4618714818534;3286.342731453719;3351.8491667875005;31949;32650.836745816356;32685.6731432685;33092.83453582741;33478.1630459238;4043;4220.2192594370135;4307.655387568987;4309.208243702709;4389.429374181368;330996;334000;334749;335228.99999999756;335875;33131.3373732524;57320.71339643275;57610;57705.422945770006;57788;34829;35412.82293588567;35416.114597135274;35502.28995420077;35708.82145589307;12334.81497777534;12427.565035223724;12450.937745311398;12451.439685214187;12463.376831158406;9736.318457707892;9868.259880508991;9891.901080989099;9942.502874856229;9951.751206219902;8012.278894899487;8057.31512821405;8141.837163256701;8192.057913339922;8200.507969521848;3035.5446682997726;3046.161836086547;3062.38752249551;3098.1170366445454;3150.1179669692524;980.1815484070738;995.5171741705267;1022.7340891368298;1055.034643301386;1085.609180694965;31410.874601075673;32197.35605287881;32312.838435808142;32337.838310808296;32435.35129297401;982.7739619887323;1001.1090129784498;1009.3388830316155;1017.4810846468206;1019.7042857571221;16063.357465701474;16941;16973.575660608585;17069.7439538407;17145.571360716083;530270;534754;538057;540374;540577;56916;57282.42717572771;57303.42696572981;57433.42566574364;57459.13811292834;1180.734334774669;1204.9457774400173;1264.5321231144535;1285.774989376874;1286.9742605148033;31046;33032.50451243281;33450.83274583612;33660;34094;49410;50167.74916125396;50225.497745023546;50233.24650130178;50249.24626130538;379722;380588;381505;382393;383439.3248540166;27324.180274591796;28190.154295371172;28672.13983580496;28899.422011560073;28915.85542072276;46311.76844115893;46528.06943861172;46979.53020469751;46986.76506617445;47565.76217118892;39483;39778.403323949584;40577;41373.37939930963;41750;39778.801105995444;39993.60006399899;40458;40819.183616328104;42088.158236835705;40760.59239407568;41508.377374340016;41565;41733;41831.37252941269;32702.50946235856;35372.82313588416;36192.81903590465;36597.45103823498;36887;27918.44163116767;28008.859955700093;28253.858730707037;28369.29076773097;28425.573616395355 06:48:00 INFO - PROCESS | 13231 | |2;jquery.html;366.22177872021956;382.743561813585;383.30047663015006;390.50405984399805;411.5390762346171;14284;18091.366802161927;18230.361937332196;18652.25390984359;19692.212311507523;16813.243404046818;17151.05669188197;17235.82764172358;17264.22310996005;17516.824831751677;5382.085045542258;5659.830205093854;5660.377358490563;5663.631863928852;5675.9432405675825;3990.511097738669;4079.470728148552;5544.362398324184;5641.746121424525;5646.124850648156;5571.777128914839;6280.528960327971;6282.403171698681;6282.811515654537;6295.370462953691;6003.189569408118;6273.215848018997;6311.842203944915;6315.242170939494;6355;5675.148727690879;5675.489205971441;5678.858028549278;5685.8009969651275;5687.658740475544;22911.42721431961;22962.54074918509;23111.191108311297;23119.306420807403;23239.53520929589;2291.7764498841757;2328.4528135888054;2436.756324367567;2759.503289407906;2790.734880186379;9799.804003919953;10024.849627255524;10436.895631043668;10613.5223914924;11559.248648837884;1880.971785423206;1908.8186622270862;1912.2064343297516;1977.7527809023873;2033.3594917601056;77706.6114669423;83398.58300708457;85441.57279213626;85681;87630.56184719036;10183.592656293666;10779.35323880554;10832.458377081115;10895.673129806119;11062.170337224741;15334.616634584001;15370.615734606501;15382;15393.846061539241;15402.306896189699;6750.257471678112;7005.54463959841;7079;7176.174739904874;7272.63636818157;6509.7396104155305;6521;6720.193576770721;6727.461803055744;6740.258571557125;4521.502634710245;4638.95361046392;4664.370310008173;4690.460597031317;4715.95284047162;1783.8751287410016;1935.1485346447519;1940.5148712821795;1962.6663467210608;1965;827.6896163938524;961.7547525380983;965.675873966414;980.9068138526828;1069.2301542889106;17651.19094473469;19253;19325.806741932684;19413.708794368096;19452.22191112368;943.7216021273741;949.0746522140857;952.3619175152664;955.8518429643277;990.6631745206664;10209.693709188736;10840;10957.726056848642;10964.506597203144;10974.725631859268;389188;391761;400818;409331;410424;87686;87800.56099719588;88122;88725;89270.55364723135;946.5598496699068;952.6522819171091;959.3859929644893;972.4457059476172;975.4391225045628;15383.461578845134;15520.5343839685;16269.837301627305;16328.591785205464;17483;38422.276101681535;38758.224835502566;40008.399874001334;43674.12651746884;45833.77083114563;55127;56073;56315.71842140763;57210.14184787315;59089.70455147697;8271.627776750182;8460.661573537236;8713.085126061673;8721.694740684046;8811.735647930573;11922;13235.338233088114;13261.469541218243;13430.597082087554;13446.865531344562;11172.217944744116;11541.192116551762;11543.422828858691;11889.702757431134;12025.759484810429;10903.945480272865;11402;11432.142589306002;11651.88348116542;11723.765524689628;11655.18413711032;11783.351915644722;12212.877871221173;12249;12395.814062789246;7404.555726656418;7596;8386.874196886929;8587.91412085896;8748.168923952215;10882.347059176474;11167.664970050912;11426.714332141762;11895.643130706092;11969.521219151486 06:48:00 INFO - PROCESS | 13231 | |3;mootools.html;1272;1451.7822326651005;1466.6773309871828;1564.8356922523135;1749.947501574953;7260.092488438945;8333.458325208865;8563.314934805208;8590.699325523608;8754.824903501925;8607;8638.481691098523;8643.178898004695;8675.089115642846;8675.52284624347;2230.297456301264;2254.5603607296584;2258.06290389489;2262.0273282488524;2262.683224348584;2242.8317876159354;2299.4251437140715;2302.182725132579;2303.2974942642572;2305.6195727704994;2208.1277895231456;2210.3810932938804;2212.4026512841524;2218.1681869299014;2250.3923940536047;2200.3179014505554;2240.350298413458;2243.9102435902546;2246.2587346175724;2247.449374903143;2204.647256438962;2205.8786766727985;2206.8675879447283;2214.767449417804;2217.246136313645;8355.95822020892;8401.579921003986;8403.831923361498;8404.663813447454;8419.789505262355;4917.459079501288;5039.899202015976;5054.115529782273;5121.590272778169;5126.384833819928;3219.275662975812;3364.6971772540346;3402.1494626343415;3464.9307013859834;3476.548048753671;996.8604395384652;1023.6519583341625;1066.6480061579737;1077.6766969909074;1079.4225089577117;11920;11945.104117191158;11963.282203067756;11985;12076.637700868989;4042.312806822847;4329.826806927751;4387.407699960465;4390.078083602415;4405.801738921757;9349.065093490597;9367.672131475501;9376.718698439057;9376.906230937604;9387.061293870694;4990.226514890125;4997.575206107449;4998.075356059141;5025.221090730943;5035.647504674637;4099.8975025624595;4218.746875187438;4375.212461756914;4467.553244675506;4666.8133274668635;3558.822058897045;3590.958621999591;3702.426123950792;3737.5514938207043;3743.794091324949;1099.8790133085354;1113.471101226927;1114.164376717462;1124.746931940307;1131.479519421059;608.4797498139116;808.5674164322177;868.5092922498894;872.9825403491894;916.5793020817706;5228.63399562027;5429.53848922846;5480.945190548044;5623.240862483594;5634.239377684042;873.2620935309653;887.627196577439;903.9548022598843;924.6994726713845;929.2333824594737;3563.55455568054;3619.7647152934974;3651.835667394974;3657.213699054716;3770.0951771574623;10340;10762.677119686421;10764.515596798163;10794.190435717353;10794.298370605886;10679.519421626046;10680.252382333161;10682.73293167677;10684.198685098649;10723.83914241287;7676.53940763556;8004.599770011592;8172.6322315495945;8173.550454724928;8178.386621003448;5408.8647783804145;5589.664620122806;5667.121596152603;5703.828885133453;5810;9954.402735835873;9954.850677239992;9956.20350371954;9957.701268961942;9996.800063998824;9469.573869175765;9950.751231219278;9955.352902061342;9962.352447090916;9964.202863771026;7420.777376678709;7545.622718864144;7555.811104722206;7586.468947173645;7638.961805190938;8064.193580642123;8140.348772098337;8219.54792486419;8259.587020648823;8328.208820162075;7252.963735181291;7377.151627562899;7382.2617738225745;7493.587852667937;7563.508371955805;7280.0535930328715;7380.114386273682;7383.335499804828;7416.480846340704;7442.404607631484;6531.972836358428;6555.967220163869;6571.211454625475;6629.834254143685;6638.269790322964;4733.810647574059;4795.088933102699;4803.303520989367;4865.5864251539015;4964.230544265644;4616.422947131608;4626.7455289958025;4704.1062198182235;4709.882252943704;4721.22099853534 06:48:00 INFO - PROCESS | 13231 | |4;prototype.html;319.1574243995851;329.231245042825;332.29553346904567;332.5958959863765;338.2980315844623;5049.873753156173;5166.63833531652;5257;5304.867378315544;5307.45242283704;5079.568236699875;5198.68807871527;5238.790448382069;5240.2401651760565;5252.870632813944;4108;4116.897077573055;4126.174765046988;4127.772972486512;4152.190322887038;4009.398590211477;4118.105671391164;4118.835246590133;4127.7204066739405;4128.422020917059;4050.392441133839;4077.3068578341754;4085.816138273785;4094.8362065517344;4095.344744840826;4055.45892560825;4059.3099173140636;4062.7765472898977;4063.512378514597;4096.1193343431005;3605;3605.837737301828;3606.170580766412;3610.765300255475;3622.3117607654463;5068.898622027576;5102.36220472441;5121.948780512184;5132.307138536287;5137.2037334213255;4618.690654672664;4636.327732478771;4657.69724967876;4666.859994200179;4677.462091859412;5454.181872719084;5464.9180262296095;5470.261514695505;5506.80726174586;5528.087865502187;3751.624837516254;3922.9019274518364;3953.4069889516513;3966.86115985942;3974.8012599370204;5719.6854173020465;5722.37053924068;5754.136879468071;5765.913511297334;5783.190353350535;4038.5759495252573;4058.4723985882238;4061.329880569732;4077.347624380085;4088.2232375848494;3860.8224491530354;4021.8391264349684;4036.1120553478186;4057.837686492507;4124.463819703419;4626.86119416418;4631.9536804631525;4639.257718764981;4645.372874661945;4651;5550.8057217997175;5555.333359996826;5567.387587365387;5574.804881829116;5589.804356847572;1295.8509771376412;1306.144475368635;1368.6509939965244;1382.1776043254247;1395.7138786548733;872.9916945927464;894.9686760963335;903.3450748207497;906.3927168796922;916.9821498137062;4675.29870519418;4679.672422930362;4681.227597446451;4686.414198225222;4695.849516868389;4877.512248775094;4903.436104847917;4921.203760627417;4928.383952005999;4935.580475659537;4589.334546490807;4635.536446355338;4639.605633521121;4640.211164102043;4658.557437043475;2787.679416867046;2982.492976194052;3011.7200189919195;3024.1532370936175;3025.1529571719952;5779.913301300484;5841.269841269841;5846.912296315559;5863.618864773862;5878.764849406061;5549.1676248563035;5751.971240143773;5761.308642962871;5765.423457654201;5808.128780682847;5761.423857614289;5772.0562513117775;5774.451427114417;5781.306243250837;5791.218185544982;5592.608517403743;5627.184058311604;5635.464630860061;5643.915341269802;5707.686077265625;5319.973400133129;5564.527015203753;5600.775968961196;5617.382087970402;5640.71796410186;5803.65178089316;5841.50347220491;5846.152307915413;5881.73532191061;5887.146363777314;3937.3503371944453;4030;4039.4142849287277;4041.4139949707715;4047.57500462459;5458.645188062763;5656.830295091154;5686.914696279477;5714.79998200061;5740.425957404226;5466.480684334982;5487.670739755627;5544.7782088716;5576.665400076008;5584.776608935759;5579.302587176603;5579.358373787067;5596;5611.158326250932;5626.749300279921;5271.683698978073;5486.588505861996;5517.586181036519;5567.32768271224;5579.939811435815;5586.742982828831;5588.776448941997;5594.804181853616;5608.308012154107;5610.410906854721;5425.755840987086;5440.129579267298;5460.372057213472;5475.534579560782;5485.396606373216 06:48:00 INFO - PROCESS | 13231 | |5;yui.html;620.7237779188263;624.229077089794;680.3060877904537;703.3739971425432;766.7278116268723;13305;14361;14398.06412583184;14415.765556338758;14735.48425805097;12093.758124837497;12327.753444931095;12352.444140013698;12380.319082450484;12420.751584968295;790.490133863659;802.4182467710921;807.9030516338048;810.116972499975;810.3679130278392;800.9118996910364;802.3019972623825;802.5305196460077;802.9678812847479;803.0443771911407;688.3116883116883;706.3854446631412;816.5713000674634;840.5377042626561;844.5903736687701;831.8419500294924;831.8585840407115;832.4547421438967;832.8084540555676;833.5040650812757;605.8879107365152;609.4149616368292;609.7713357490941;610.2768219659717;610.4231501231338;9548.236141108695;9874.456904870229;12449.128561000734;12599.18105323151;12744.745105097938;13616;13913.373898174606;14266.714665706628;14761.55715328542;14816.703665926621;11109.388983605899;11167.72080697989;11250.3812290324;11275.590551181102;11545.653630391102;3694.07648087978;3708;3729.6829769469628;3750.362438385481;3798.506194194737;62216.37783622151;62395.71305030297;62453.687731561506;63507.68246158786;64545.67727161381;10735.731606709738;10779.838302425469;10818.188635852342;11082.445877706083;11184.60853870127;20355.592888142153;20450;21333.14667413317;21391.358259252247;21450.678239826415;6586.670666466657;6983.580985140908;7100.934859771076;7239.457040721967;7374.262573742582;4082.632563069338;4167.2082304362075;4270.829166833292;4285.6785741068925;4312.805923733376;3193.409219294438;3224.2261857154112;3289.473684210515;3328.084776686382;3333.5499707539657;589.4623645207423;599.3137857153534;603.1977469964936;605.0953824033098;618.7494064903631;643.1895811277731;652.3900153356627;658.275896513831;662.2053535757111;671.7850287907822;8119.837603247902;8687.956560217159;8990.145936136056;9107.134822192014;9288.535573221312;550.2489102375229;584.6813486649786;588.5644622978965;610.1823556434399;647.6049609738056;4087.6729861611;4284.293091639907;4361.694681372273;4517.5708307711375;4622.560856718606;74186;78169.60915195387;78605.60697196478;80438;80443;67504.66247668829;68445.65777171082;68493.3150668497;69203;69445.65277173683;42006.789966049975;60247.69876150679;62906.68546657237;63074.369256307764;64289;8468.153184681483;8557.700480483154;8729.170728780755;8795.472271663464;8875.955620221857;41290;42147.57852421559;42212.577874220864;42432.5756742441;42556.78721606372;52800.47199527956;53089.734551327;54067.45932540624;59439.70280148571;61815.381846180964;12219.205751626116;12353.497960741084;12459.626211213677;12538.93730531378;12542.749145016865;12738.87261127377;13037.869621304046;13375.398107085399;13472.720091591284;13534.526291579747;12815.871841281469;12834.871651283367;13060.738785224432;13566.79649805234;13568.253746043667;12897.355132243538;13098.339061277658;13257.204567725967;13318.200907945167;13653.590392288248;12860.742785144432;13188.670283242996;13356.065075444625;13406.865931340562;13906.721865562835;9615.326927115315;10037.799244014932;10430.895691042992;10482.63310784119;10807.621733239614;9045.68340108093;10073.546690399096;10240.641577545048;10296.279260451696;10304.330218535772 06:48:00 INFO - PROCESS | 13231 | __end_tp_report 06:48:00 INFO - PROCESS | 13231 | __start_cc_report 06:48:00 INFO - PROCESS | 13231 | _x_x_mozilla_cycle_collect,2720 06:48:00 INFO - PROCESS | 13231 | __end_cc_report 06:48:00 INFO - PROCESS | 13231 | __startTimestamp1477403280154__endTimestamp 06:48:00 INFO - PROCESS | 13231 | 06:48:00 INFO - PROCESS | 13231 | ------- Summary: start ------- 06:48:00 INFO - PROCESS | 13231 | Number of tests: 6 06:48:00 INFO - PROCESS | 13231 | 06:48:00 INFO - PROCESS | 13231 | [#0] dojo.html Cycles:165 Average:5341.43 Median:5571.33 stddev:591.42 (10.6%) stddev-sans-first:566.21 06:48:00 INFO - PROCESS | 13231 | Values: 3088.2 3107.6 3139.5 3150.0 3152.4 5196.7 5264.1 5333.1 5407.4 5434.9 5326.5 5329.4 5436.4 5443.5 5459.5 4804.5 4851.7 4913.0 4913.4 4939.4 4897.0 5026.0 5036.1 5045.5 5097.7 4849.1 4992.9 4996.8 5027.6 5104.1 4843.9 4844.8 4854.2 4887.0 4954.6 4828.6 4836.8 4839.3 4859.0 4917.4 5349.7 5360.6 5364.5 5368.9 5377.1 5601.4 5650.2 5657.3 5672.4 5715.6 5731.3 5815.2 5820.0 5872.8 5873.7 5384.9 5387.9 5389.0 5398.4 5399.6 5607.8 5616.6 5892.2 5897.6 5906.0 5467.9 5523.6 5577.4 5595.5 5600.9 5557.2 5608.5 5619.1 5625.9 5626.7 5571.3 5577.7 5581.1 5589.6 5656.9 5512.8 5606.1 5609.3 5695.6 5698.3 4356.1 4381.2 4391.6 4431.4 4440.6 3890.4 3906.4 3921.7 3938.6 3971.5 5470.3 5482.2 5485.3 5487.7 5540.6 5630.6 5690.0 5693.1 5731.4 5792.0 5507.7 5514.2 5520.4 5522.9 5586.2 5021.4 5032.3 5036.8 5043.7 5097.2 5825.6 5833.9 5901.8 5988.6 5997.7 5764.3 5780.2 5782.9 5792.2 5813.1 5894.9 5955.5 5957.4 5963.3 5968.9 5679.3 5684.1 5686.6 5690.7 5691.2 5785.1 5792.8 5795.8 5798.0 5802.9 5635.2 5672.2 5676.9 5677.9 5678.6 5591.9 5595.2 5619.8 5649.3 5660.6 5624.6 5652.7 5655.8 5658.8 5679.5 5518.1 5571.6 5698.0 5721.7 5723.6 5502.8 5535.0 5535.3 5576.3 5639.9 06:48:00 INFO - PROCESS | 13231 | 06:48:00 INFO - PROCESS | 13231 | [#1] ext.html Cycles:180 Average:56908.47 Median:380155.00 stddev:113212.16 (29.8%) stddev-sans-first:113450.66 06:48:00 INFO - PROCESS | 13231 | Values: 547.4 578.6 581.8 594.6 596.2 31102.4 42605.0 43550.8 43566.3 47272.0 45230.8 45772.5 45773.1 45806.8 45866.8 8629.2 8756.6 8791.7 8792.5 8796.4 7969.0 8179.6 10341.3 10581.9 10611.0 10764.5 10887.3 10888.0 10891.5 10893.3 8062.7 10675.6 10734.6 10744.0 10749.1 7934.6 10096.8 10420.4 10436.0 10743.4 42549.0 42886.0 42937.1 42959.8 42995.6 3030.4 3109.7 3165.5 3286.3 3351.8 31949.0 32650.8 32685.7 33092.8 33478.2 4043.0 4220.2 4307.7 4309.2 4389.4 330996.0 334000.0 334749.0 335229.0 335875.0 33131.3 57320.7 57610.0 57705.4 57788.0 34829.0 35412.8 35416.1 35502.3 35708.8 12334.8 12427.6 12450.9 12451.4 12463.4 9736.3 9868.3 9891.9 9942.5 9951.8 8012.3 8057.3 8141.8 8192.1 8200.5 3035.5 3046.2 3062.4 3098.1 3150.1 980.2 995.5 1022.7 1055.0 1085.6 31410.9 32197.4 32312.8 32337.8 32435.4 982.8 1001.1 1009.3 1017.5 1019.7 16063.4 16941.0 16973.6 17069.7 17145.6 530270.0 534754.0 538057.0 540374.0 540577.0 56916.0 57282.4 57303.4 57433.4 57459.1 1180.7 1204.9 1264.5 1285.8 1287.0 31046.0 33032.5 33450.8 33660.0 34094.0 49410.0 50167.7 50225.5 50233.2 50249.2 379722.0 380588.0 381505.0 382393.0 383439.3 27324.2 28190.2 28672.1 28899.4 28915.9 46311.8 46528.1 46979.5 46986.8 47565.8 39483.0 39778.4 40577.0 41373.4 41750.0 39778.8 39993.6 40458.0 40819.2 42088.2 40760.6 41508.4 41565.0 41733.0 41831.4 32702.5 35372.8 36192.8 36597.5 36887.0 27918.4 28008.9 28253.9 28369.3 28425.6 06:48:00 INFO - PROCESS | 13231 | 06:48:00 INFO - PROCESS | 13231 | [#2] jquery.html Cycles:180 Average:26233.84 Median:194789.25 stddev:66612.79 (34.2%) stddev-sans-first:66771.34 06:48:00 INFO - PROCESS | 13231 | Values: 366.2 382.7 383.3 390.5 411.5 14284.0 18091.4 18230.4 18652.3 19692.2 16813.2 17151.1 17235.8 17264.2 17516.8 5382.1 5659.8 5660.4 5663.6 5675.9 3990.5 4079.5 5544.4 5641.7 5646.1 5571.8 6280.5 6282.4 6282.8 6295.4 6003.2 6273.2 6311.8 6315.2 6355.0 5675.1 5675.5 5678.9 5685.8 5687.7 22911.4 22962.5 23111.2 23119.3 23239.5 2291.8 2328.5 2436.8 2759.5 2790.7 9799.8 10024.8 10436.9 10613.5 11559.2 1881.0 1908.8 1912.2 1977.8 2033.4 77706.6 83398.6 85441.6 85681.0 87630.6 10183.6 10779.4 10832.5 10895.7 11062.2 15334.6 15370.6 15382.0 15393.8 15402.3 6750.3 7005.5 7079.0 7176.2 7272.6 6509.7 6521.0 6720.2 6727.5 6740.3 4521.5 4639.0 4664.4 4690.5 4716.0 1783.9 1935.1 1940.5 1962.7 1965.0 827.7 961.8 965.7 980.9 1069.2 17651.2 19253.0 19325.8 19413.7 19452.2 943.7 949.1 952.4 955.9 990.7 10209.7 10840.0 10957.7 10964.5 10974.7 389188.0 391761.0 400818.0 409331.0 410424.0 87686.0 87800.6 88122.0 88725.0 89270.6 946.6 952.7 959.4 972.4 975.4 15383.5 15520.5 16269.8 16328.6 17483.0 38422.3 38758.2 40008.4 43674.1 45833.8 55127.0 56073.0 56315.7 57210.1 59089.7 8271.6 8460.7 8713.1 8721.7 8811.7 11922.0 13235.3 13261.5 13430.6 13446.9 11172.2 11541.2 11543.4 11889.7 12025.8 10903.9 11402.0 11432.1 11651.9 11723.8 11655.2 11783.4 12212.9 12249.0 12395.8 7404.6 7596.0 8386.9 8587.9 8748.2 10882.3 11167.7 11426.7 11895.6 11969.5 06:48:00 INFO - PROCESS | 13231 | 06:48:00 INFO - PROCESS | 13231 | [#3] mootools.html Cycles:180 Average:5548.18 Median:4993.90 stddev:3212.58 (64.3%) stddev-sans-first:3205.52 06:48:00 INFO - PROCESS | 13231 | Values: 1272.0 1451.8 1466.7 1564.8 1749.9 7260.1 8333.5 8563.3 8590.7 8754.8 8607.0 8638.5 8643.2 8675.1 8675.5 2230.3 2254.6 2258.1 2262.0 2262.7 2242.8 2299.4 2302.2 2303.3 2305.6 2208.1 2210.4 2212.4 2218.2 2250.4 2200.3 2240.4 2243.9 2246.3 2247.4 2204.6 2205.9 2206.9 2214.8 2217.2 8356.0 8401.6 8403.8 8404.7 8419.8 4917.5 5039.9 5054.1 5121.6 5126.4 3219.3 3364.7 3402.1 3464.9 3476.5 996.9 1023.7 1066.6 1077.7 1079.4 11920.0 11945.1 11963.3 11985.0 12076.6 4042.3 4329.8 4387.4 4390.1 4405.8 9349.1 9367.7 9376.7 9376.9 9387.1 4990.2 4997.6 4998.1 5025.2 5035.6 4099.9 4218.7 4375.2 4467.6 4666.8 3558.8 3591.0 3702.4 3737.6 3743.8 1099.9 1113.5 1114.2 1124.7 1131.5 608.5 808.6 868.5 873.0 916.6 5228.6 5429.5 5480.9 5623.2 5634.2 873.3 887.6 904.0 924.7 929.2 3563.6 3619.8 3651.8 3657.2 3770.1 10340.0 10762.7 10764.5 10794.2 10794.3 10679.5 10680.3 10682.7 10684.2 10723.8 7676.5 8004.6 8172.6 8173.6 8178.4 5408.9 5589.7 5667.1 5703.8 5810.0 9954.4 9954.9 9956.2 9957.7 9996.8 9469.6 9950.8 9955.4 9962.4 9964.2 7420.8 7545.6 7555.8 7586.5 7639.0 8064.2 8140.3 8219.5 8259.6 8328.2 7253.0 7377.2 7382.3 7493.6 7563.5 7280.1 7380.1 7383.3 7416.5 7442.4 6532.0 6556.0 6571.2 6629.8 6638.3 4733.8 4795.1 4803.3 4865.6 4964.2 4616.4 4626.7 4704.1 4709.9 4721.2 06:48:00 INFO - PROCESS | 13231 | 06:48:00 INFO - PROCESS | 13231 | [#4] prototype.html Cycles:180 Average:4586.41 Median:5134.76 stddev:1358.61 (26.5%) stddev-sans-first:1324.13 06:48:00 INFO - PROCESS | 13231 | Values: 319.2 329.2 332.3 332.6 338.3 5049.9 5166.6 5257.0 5304.9 5307.5 5079.6 5198.7 5238.8 5240.2 5252.9 4108.0 4116.9 4126.2 4127.8 4152.2 4009.4 4118.1 4118.8 4127.7 4128.4 4050.4 4077.3 4085.8 4094.8 4095.3 4055.5 4059.3 4062.8 4063.5 4096.1 3605.0 3605.8 3606.2 3610.8 3622.3 5068.9 5102.4 5121.9 5132.3 5137.2 4618.7 4636.3 4657.7 4666.9 4677.5 5454.2 5464.9 5470.3 5506.8 5528.1 3751.6 3922.9 3953.4 3966.9 3974.8 5719.7 5722.4 5754.1 5765.9 5783.2 4038.6 4058.5 4061.3 4077.3 4088.2 3860.8 4021.8 4036.1 4057.8 4124.5 4626.9 4632.0 4639.3 4645.4 4651.0 5550.8 5555.3 5567.4 5574.8 5589.8 1295.9 1306.1 1368.7 1382.2 1395.7 873.0 895.0 903.3 906.4 917.0 4675.3 4679.7 4681.2 4686.4 4695.8 4877.5 4903.4 4921.2 4928.4 4935.6 4589.3 4635.5 4639.6 4640.2 4658.6 2787.7 2982.5 3011.7 3024.2 3025.2 5779.9 5841.3 5846.9 5863.6 5878.8 5549.2 5752.0 5761.3 5765.4 5808.1 5761.4 5772.1 5774.5 5781.3 5791.2 5592.6 5627.2 5635.5 5643.9 5707.7 5320.0 5564.5 5600.8 5617.4 5640.7 5803.7 5841.5 5846.2 5881.7 5887.1 3937.4 4030.0 4039.4 4041.4 4047.6 5458.6 5656.8 5686.9 5714.8 5740.4 5466.5 5487.7 5544.8 5576.7 5584.8 5579.3 5579.4 5596.0 5611.2 5626.7 5271.7 5486.6 5517.6 5567.3 5579.9 5586.7 5588.8 5594.8 5608.3 5610.4 5425.8 5440.1 5460.4 5475.5 5485.4 06:48:00 INFO - PROCESS | 13231 | 06:48:00 INFO - PROCESS | 13231 | [#5] yui.html Cycles:180 Average:16516.14 Median:4570.07 stddev:21248.94 (465.0%) stddev-sans-first:21275.02 06:48:00 INFO - PROCESS | 13231 | Values: 620.7 624.2 680.3 703.4 766.7 13305.0 14361.0 14398.1 14415.8 14735.5 12093.8 12327.8 12352.4 12380.3 12420.8 790.5 802.4 807.9 810.1 810.4 800.9 802.3 802.5 803.0 803.0 688.3 706.4 816.6 840.5 844.6 831.8 831.9 832.5 832.8 833.5 605.9 609.4 609.8 610.3 610.4 9548.2 9874.5 12449.1 12599.2 12744.7 13616.0 13913.4 14266.7 14761.6 14816.7 11109.4 11167.7 11250.4 11275.6 11545.7 3694.1 3708.0 3729.7 3750.4 3798.5 62216.4 62395.7 62453.7 63507.7 64545.7 10735.7 10779.8 10818.2 11082.4 11184.6 20355.6 20450.0 21333.1 21391.4 21450.7 6586.7 6983.6 7100.9 7239.5 7374.3 4082.6 4167.2 4270.8 4285.7 4312.8 3193.4 3224.2 3289.5 3328.1 3333.5 589.5 599.3 603.2 605.1 618.7 643.2 652.4 658.3 662.2 671.8 8119.8 8688.0 8990.1 9107.1 9288.5 550.2 584.7 588.6 610.2 647.6 4087.7 4284.3 4361.7 4517.6 4622.6 74186.0 78169.6 78605.6 80438.0 80443.0 67504.7 68445.7 68493.3 69203.0 69445.7 42006.8 60247.7 62906.7 63074.4 64289.0 8468.2 8557.7 8729.2 8795.5 8876.0 41290.0 42147.6 42212.6 42432.6 42556.8 52800.5 53089.7 54067.5 59439.7 61815.4 12219.2 12353.5 12459.6 12538.9 12542.7 12738.9 13037.9 13375.4 13472.7 13534.5 12815.9 12834.9 13060.7 13566.8 13568.3 12897.4 13098.3 13257.2 13318.2 13653.6 12860.7 13188.7 13356.1 13406.9 13906.7 9615.3 10037.8 10430.9 10482.6 10807.6 9045.7 10073.5 10240.6 10296.3 10304.3 06:48:00 INFO - PROCESS | 13231 | -------- Summary: end -------- 06:48:00 INFO - PROCESS | 13231 | 06:48:01 INFO - TEST-INFO | 13231: exit 0 06:48:01 INFO - TEST-OK | dromaeo_css | took 1118082ms 06:48:01 INFO - TEST-START | kraken 06:48:01 INFO - operating with platform_type : linux_ 06:48:01 INFO - Initialising browser for kraken test... 06:48:01 INFO - TEST-INFO | started process 13540 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZFa2P2/profile http://localhost:50583/getInfo.html) 06:48:04 INFO - PROCESS | 13540 | __metrics Screen width/height:1600/1200 06:48:04 INFO - PROCESS | 13540 | colorDepth:24 06:48:04 INFO - PROCESS | 13540 | Browser inner width/height: 1024/697 06:48:04 INFO - PROCESS | 13540 | __metrics 06:48:05 INFO - PROCESS | 13540 | 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" 06:48:05 INFO - PROCESS | 13540 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:48:06 INFO - TEST-INFO | 13540: exit 0 06:48:06 INFO - Browser initialized. 06:48:06 INFO - Running cycle 1/1 for kraken test... 06:48:06 INFO - TEST-INFO | started process 13626 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZFa2P2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:48:18 INFO - PROCESS | 13626 | RSS: Main: 171229184 06:48:18 INFO - PROCESS | 13626 | 06:48:21 INFO - PROCESS | 13626 | Cycle 1(1): loaded http://localhost:50583/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50583/tests/kraken/driver.html?testName=audio-beat-detection) 06:48:21 INFO - PROCESS | 13626 | RSS: Main: 228962304 06:48:21 INFO - PROCESS | 13626 | 06:48:24 INFO - PROCESS | 13626 | Cycle 1(1): loaded http://localhost:50583/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50583/tests/kraken/driver.html?testName=audio-dft) 06:48:25 INFO - PROCESS | 13626 | RSS: Main: 215449600 06:48:25 INFO - PROCESS | 13626 | 06:48:28 INFO - PROCESS | 13626 | Cycle 1(1): loaded http://localhost:50583/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50583/tests/kraken/driver.html?testName=audio-fft) 06:48:28 INFO - PROCESS | 13626 | RSS: Main: 296484864 06:48:28 INFO - PROCESS | 13626 | 06:48:30 INFO - PROCESS | 13626 | Cycle 1(1): loaded http://localhost:50583/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50583/tests/kraken/driver.html?testName=audio-oscillator) 06:48:31 INFO - PROCESS | 13626 | RSS: Main: 208629760 06:48:31 INFO - PROCESS | 13626 | 06:48:33 INFO - PROCESS | 13626 | Cycle 1(1): loaded http://localhost:50583/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50583/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:48:34 INFO - PROCESS | 13626 | RSS: Main: 211202048 06:48:34 INFO - PROCESS | 13626 | 06:48:37 INFO - PROCESS | 13626 | Cycle 1(1): loaded http://localhost:50583/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50583/tests/kraken/driver.html?testName=imaging-darkroom) 06:48:37 INFO - PROCESS | 13626 | RSS: Main: 247910400 06:48:37 INFO - PROCESS | 13626 | 06:48:41 INFO - PROCESS | 13626 | Cycle 1(1): loaded http://localhost:50583/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50583/tests/kraken/driver.html?testName=imaging-desaturate) 06:48:41 INFO - PROCESS | 13626 | RSS: Main: 246165504 06:48:41 INFO - PROCESS | 13626 | 06:48:44 INFO - PROCESS | 13626 | Cycle 1(1): loaded http://localhost:50583/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50583/tests/kraken/driver.html?testName=json-parse-financial) 06:48:44 INFO - PROCESS | 13626 | RSS: Main: 246095872 06:48:44 INFO - PROCESS | 13626 | 06:48:46 INFO - PROCESS | 13626 | Cycle 1(1): loaded http://localhost:50583/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50583/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:48:47 INFO - PROCESS | 13626 | RSS: Main: 208273408 06:48:47 INFO - PROCESS | 13626 | 06:48:48 INFO - PROCESS | 13626 | Cycle 1(1): loaded http://localhost:50583/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50583/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:48:49 INFO - PROCESS | 13626 | RSS: Main: 215035904 06:48:49 INFO - PROCESS | 13626 | 06:48:51 INFO - PROCESS | 13626 | Cycle 1(1): loaded http://localhost:50583/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50583/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:48:52 INFO - PROCESS | 13626 | RSS: Main: 224993280 06:48:52 INFO - PROCESS | 13626 | 06:48:54 INFO - PROCESS | 13626 | Cycle 1(1): loaded http://localhost:50583/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50583/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:48:55 INFO - PROCESS | 13626 | RSS: Main: 233488384 06:48:55 INFO - PROCESS | 13626 | 06:48:58 INFO - PROCESS | 13626 | Cycle 1(1): loaded http://localhost:50583/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50583/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:48:58 INFO - PROCESS | 13626 | RSS: Main: 230617088 06:48:58 INFO - PROCESS | 13626 | 06:49:00 INFO - PROCESS | 13626 | Cycle 1(1): loaded http://localhost:50583/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50583/tests/kraken/driver.html?testName=ai-astar) 06:49:00 INFO - PROCESS | 13626 | RSS: Main: 281538560 06:49:00 INFO - PROCESS | 13626 | 06:49:00 INFO - PROCESS | 13626 | __start_tp_report 06:49:00 INFO - PROCESS | 13626 | _x_x_mozilla_page_load 06:49:00 INFO - PROCESS | 13626 | _x_x_mozilla_page_load_details 06:49:00 INFO - PROCESS | 13626 | |i|pagename|runs| 06:49:00 INFO - PROCESS | 13626 | |0;ai-astar;106;112;112;112;110;112;112;113;111;110 06:49:00 INFO - PROCESS | 13626 | |1;audio-beat-detection;149;123;123;170;128;130;124;121;158;122 06:49:00 INFO - PROCESS | 13626 | |2;audio-dft;161;162;161;161;160;160;161;162;162;161 06:49:00 INFO - PROCESS | 13626 | |3;audio-fft;85;76;75;111;78;76;76;76;104;76 06:49:00 INFO - PROCESS | 13626 | |4;audio-oscillator;83;81;130;83;82;82;109;83;82;116 06:49:00 INFO - PROCESS | 13626 | |5;imaging-gaussian-blur;118;117;117;118;117;118;117;117;117;117 06:49:00 INFO - PROCESS | 13626 | |6;imaging-darkroom;146;146;147;145;145;145;145;145;145;146 06:49:00 INFO - PROCESS | 13626 | |7;imaging-desaturate;84;84;84;84;84;85;84;84;84;84 06:49:00 INFO - PROCESS | 13626 | |8;json-parse-financial;55;52;54;52;53;55;53;53;53;52 06:49:00 INFO - PROCESS | 13626 | |9;json-stringify-tinderbox;61;61;61;61;62;60;61;61;62;62 06:49:00 INFO - PROCESS | 13626 | |10;stanford-crypto-aes;80;87;82;85;81;85;78;80;79;79 06:49:00 INFO - PROCESS | 13626 | |11;stanford-crypto-ccm;142;135;146;130;133;128;142;134;175;142 06:49:00 INFO - PROCESS | 13626 | |12;stanford-crypto-pbkdf2;170;166;166;167;165;166;168;168;166;167 06:49:00 INFO - PROCESS | 13626 | |13;stanford-crypto-sha256-iterative;66;66;65;65;66;66;65;65;64;66 06:49:00 INFO - PROCESS | 13626 | __end_tp_report 06:49:00 INFO - PROCESS | 13626 | __start_cc_report 06:49:00 INFO - PROCESS | 13626 | _x_x_mozilla_cycle_collect,1706 06:49:00 INFO - PROCESS | 13626 | __end_cc_report 06:49:00 INFO - PROCESS | 13626 | __startTimestamp1477403340744__endTimestamp 06:49:00 INFO - PROCESS | 13626 | 06:49:00 INFO - PROCESS | 13626 | ------- Summary: start ------- 06:49:00 INFO - PROCESS | 13626 | Number of tests: 14 06:49:00 INFO - PROCESS | 13626 | 06:49:00 INFO - PROCESS | 13626 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:2.00 (1.8%) stddev-sans-first:1.01 06:49:00 INFO - PROCESS | 13626 | Values: 106.0 112.0 112.0 112.0 110.0 112.0 112.0 113.0 111.0 110.0 06:49:00 INFO - PROCESS | 13626 | 06:49:00 INFO - PROCESS | 13626 | [#1] audio-beat-detection Cycles:10 Average:134.80 Median:129.00 stddev:17.63 (13.7%) stddev-sans-first:17.94 06:49:00 INFO - PROCESS | 13626 | Values: 149.0 123.0 123.0 170.0 128.0 130.0 124.0 121.0 158.0 122.0 06:49:00 INFO - PROCESS | 13626 | 06:49:00 INFO - PROCESS | 13626 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 06:49:00 INFO - PROCESS | 13626 | Values: 161.0 162.0 161.0 161.0 160.0 160.0 161.0 162.0 162.0 161.0 06:49:00 INFO - PROCESS | 13626 | 06:49:00 INFO - PROCESS | 13626 | [#3] audio-fft Cycles:10 Average:83.30 Median:76.00 stddev:13.17 (17.3%) stddev-sans-first:13.96 06:49:00 INFO - PROCESS | 13626 | Values: 85.0 76.0 75.0 111.0 78.0 76.0 76.0 76.0 104.0 76.0 06:49:00 INFO - PROCESS | 13626 | 06:49:00 INFO - PROCESS | 13626 | [#4] audio-oscillator Cycles:10 Average:93.10 Median:82.00 stddev:18.14 (22.1%) stddev-sans-first:18.87 06:49:00 INFO - PROCESS | 13626 | Values: 83.0 81.0 130.0 83.0 82.0 82.0 109.0 83.0 82.0 116.0 06:49:00 INFO - PROCESS | 13626 | 06:49:00 INFO - PROCESS | 13626 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 06:49:00 INFO - PROCESS | 13626 | Values: 118.0 117.0 117.0 118.0 117.0 118.0 117.0 117.0 117.0 117.0 06:49:00 INFO - PROCESS | 13626 | 06:49:00 INFO - PROCESS | 13626 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 06:49:00 INFO - PROCESS | 13626 | Values: 146.0 146.0 147.0 145.0 145.0 145.0 145.0 145.0 145.0 146.0 06:49:00 INFO - PROCESS | 13626 | 06:49:00 INFO - PROCESS | 13626 | [#7] imaging-desaturate Cycles:10 Average:84.10 Median:84.00 stddev:0.32 (0.4%) stddev-sans-first:0.33 06:49:00 INFO - PROCESS | 13626 | Values: 84.0 84.0 84.0 84.0 84.0 85.0 84.0 84.0 84.0 84.0 06:49:00 INFO - PROCESS | 13626 | 06:49:00 INFO - PROCESS | 13626 | [#8] json-parse-financial Cycles:10 Average:53.20 Median:53.00 stddev:1.14 (2.1%) stddev-sans-first:1.00 06:49:00 INFO - PROCESS | 13626 | Values: 55.0 52.0 54.0 52.0 53.0 55.0 53.0 53.0 53.0 52.0 06:49:00 INFO - PROCESS | 13626 | 06:49:00 INFO - PROCESS | 13626 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 06:49:00 INFO - PROCESS | 13626 | Values: 61.0 61.0 61.0 61.0 62.0 60.0 61.0 61.0 62.0 62.0 06:49:00 INFO - PROCESS | 13626 | 06:49:00 INFO - PROCESS | 13626 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:81.50 stddev:3.06 (3.8%) stddev-sans-first:3.19 06:49:00 INFO - PROCESS | 13626 | Values: 80.0 87.0 82.0 85.0 81.0 85.0 78.0 80.0 79.0 79.0 06:49:00 INFO - PROCESS | 13626 | 06:49:00 INFO - PROCESS | 13626 | [#11] stanford-crypto-ccm Cycles:10 Average:140.70 Median:142.00 stddev:13.43 (9.5%) stddev-sans-first:14.23 06:49:00 INFO - PROCESS | 13626 | Values: 142.0 135.0 146.0 130.0 133.0 128.0 142.0 134.0 175.0 142.0 06:49:00 INFO - PROCESS | 13626 | 06:49:00 INFO - PROCESS | 13626 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.90 Median:167.00 stddev:1.45 (0.9%) stddev-sans-first:1.01 06:49:00 INFO - PROCESS | 13626 | Values: 170.0 166.0 166.0 167.0 165.0 166.0 168.0 168.0 166.0 167.0 06:49:00 INFO - PROCESS | 13626 | 06:49:00 INFO - PROCESS | 13626 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:66.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 06:49:00 INFO - PROCESS | 13626 | Values: 66.0 66.0 65.0 65.0 66.0 66.0 65.0 65.0 64.0 66.0 06:49:00 INFO - PROCESS | 13626 | -------- Summary: end -------- 06:49:00 INFO - PROCESS | 13626 | 06:49:01 INFO - TEST-INFO | 13626: exit 0 06:49:01 INFO - TEST-OK | kraken | took 60776ms 06:49:01 INFO - SUITE-END | took 1178s 06:49:01 INFO - Completed test suite (00:19:38) 06:49:01 INFO - javascript benchmark 06:49:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3088.2433803718086, 3107.642621098574, 3139.513375426809, 3150.0234927172564, 3152.36952609478, 5196.688198708071, 5264.078786212417, 5333.146696528552, 5407.351117865856, 5434.891302173949, 5326.467353264671, 5329.360476742796, 5436.401995780471, 5443.510084092431, 5459.454054594538, 4804.495527969565, 4851.733154676492, 4912.950870491285, 4913.385826771653, 4939.43196532398, 4897.0, 5026.0, 5036.068327359432, 5045.545900868921, 5097.745112744348, 4849.102915960523, 4992.900141997176, 4996.775145118479, 5027.572656324217, 5104.106781313274, 4843.878903027453, 4844.7819848106565, 4854.17479028566, 4887.0, 4954.5540901319055, 4828.589569886564, 4836.806527738886, 4839.2983017462275, 4859.0, 4917.4344950330815, 5349.652272602308, 5360.571154307646, 5364.463553644643, 5368.865778355534, 5377.059014672456, 5601.383847776741, 5650.152477128422, 5657.264555607786, 5672.40439753824, 5715.571332150105, 5731.312242530881, 5815.21494598228, 5820.039693450575, 5872.765089396462, 5873.676947767871, 5384.91922621161, 5387.919181212285, 5388.973055134699, 5398.433164517748, 5399.568034557226, 5607.775688972395, 5616.5787565932715, 5892.204552385459, 5897.557683173779, 5906.0, 5467.917981230285, 5523.613347065667, 5577.44225577439, 5595.524380427709, 5600.943990560042, 5557.166425036277, 5608.46719561641, 5619.129034999582, 5625.943740562542, 5626.662400255997, 5571.331440227199, 5577.721113944368, 5581.134924086773, 5589.608727389125, 5656.85857853557, 5512.751926163332, 5606.103023516218, 5609.298837645294, 5695.629784064023, 5698.31620205578, 4356.106998065389, 4381.16757816014, 4391.6486681065435, 4431.401760762255, 4440.62254708347, 3890.4164375343926, 3906.3945088511327, 3921.686265098785, 3938.6455219029854, 3971.4837071180564, 5470.316210473691, 5482.17767334895, 5485.341758988867, 5487.725613719298, 5540.584456165723, 5630.577706672016, 5690.0, 5693.117566777156, 5731.426857314235, 5792.0, 5507.669539827623, 5514.200440936042, 5520.365158006881, 5522.944770552243, 5586.162075688598, 5021.447640759514, 5032.345795046621, 5036.823711170092, 5043.697378157322, 5097.158968770185, 5825.592208545361, 5833.941660583339, 5901.822945311647, 5988.580799344004, 5997.730102145414, 5764.308283006066, 5780.208135478016, 5782.85542861415, 5792.247007888947, 5813.069908814569, 5894.941050589611, 5955.464008239279, 5957.434043765836, 5963.344032156546, 5968.940310596839, 5679.261695979496, 5684.0621297487105, 5686.573506987075, 5690.658560486384, 5691.203231547669, 5785.132230165509, 5792.797252096157, 5795.768169273182, 5798.043322851851, 5802.941970580409, 5635.239242702182, 5672.2058911751565, 5676.943230567642, 5677.943220567741, 5678.630888992202, 5591.860203494945, 5595.188697638901, 5619.7752089917585, 5649.293838270216, 5660.603757736919, 5624.606277560531, 5652.660840349592, 5655.830325090254, 5658.773649053992, 5679.5172410345585, 5518.117101263939, 5571.60998730085, 5697.971510142588, 5721.685307308138, 5723.599348045597, 5502.779888804403, 5534.972325138348, 5535.308086489189, 5576.33084029919, 5639.859003524781], "value": 5302.248041950239, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.3923944421691, 578.5545130249708, 581.8050952930768, 594.5867622002708, 596.2040675697943, 31102.377952440966, 42605.0, 43550.782246088806, 43566.34650480245, 47272.0, 45230.77384613072, 45772.542274577245, 45773.0845383093, 45806.7709661452, 45866.77066614671, 8629.180227878373, 8756.649734010663, 8791.736247912573, 8792.47245165289, 8796.42823216492, 7968.9601551992155, 8179.631916563739, 10341.276110672256, 10581.947090264577, 10611.0, 10764.461776911163, 10887.292325998786, 10888.0, 10891.455427228646, 10893.346399216032, 8062.717804876801, 10675.572977080907, 10734.624288149877, 10744.033037026627, 10749.086327662159, 7934.603269836485, 10096.848547271797, 10420.426876521788, 10436.0, 10743.40911249881, 42549.0, 42886.0, 42937.141257174684, 42959.785201074104, 42995.570044299784, 3030.3939212157657, 3109.67348428414, 3165.4618714818534, 3286.342731453719, 3351.8491667875005, 31949.0, 32650.836745816356, 32685.6731432685, 33092.83453582741, 33478.1630459238, 4043.0, 4220.2192594370135, 4307.655387568987, 4309.208243702709, 4389.429374181368, 330996.0, 334000.0, 334749.0, 335228.99999999756, 335875.0, 33131.3373732524, 57320.71339643275, 57610.0, 57705.422945770006, 57788.0, 34829.0, 35412.82293588567, 35416.114597135274, 35502.28995420077, 35708.82145589307, 12334.81497777534, 12427.565035223724, 12450.937745311398, 12451.439685214187, 12463.376831158406, 9736.318457707892, 9868.259880508991, 9891.901080989099, 9942.502874856229, 9951.751206219902, 8012.278894899487, 8057.31512821405, 8141.837163256701, 8192.057913339922, 8200.507969521848, 3035.5446682997726, 3046.161836086547, 3062.38752249551, 3098.1170366445454, 3150.1179669692524, 980.1815484070738, 995.5171741705267, 1022.7340891368298, 1055.034643301386, 1085.609180694965, 31410.874601075673, 32197.35605287881, 32312.838435808142, 32337.838310808296, 32435.35129297401, 982.7739619887323, 1001.1090129784498, 1009.3388830316155, 1017.4810846468206, 1019.7042857571221, 16063.357465701474, 16941.0, 16973.575660608585, 17069.7439538407, 17145.571360716083, 530270.0, 534754.0, 538057.0, 540374.0, 540577.0, 56916.0, 57282.42717572771, 57303.42696572981, 57433.42566574364, 57459.13811292834, 1180.734334774669, 1204.9457774400173, 1264.5321231144535, 1285.774989376874, 1286.9742605148033, 31046.0, 33032.50451243281, 33450.83274583612, 33660.0, 34094.0, 49410.0, 50167.74916125396, 50225.497745023546, 50233.24650130178, 50249.24626130538, 379722.0, 380588.0, 381505.0, 382393.0, 383439.3248540166, 27324.180274591796, 28190.154295371172, 28672.13983580496, 28899.422011560073, 28915.85542072276, 46311.76844115893, 46528.06943861172, 46979.53020469751, 46986.76506617445, 47565.76217118892, 39483.0, 39778.403323949584, 40577.0, 41373.37939930963, 41750.0, 39778.801105995444, 39993.60006399899, 40458.0, 40819.183616328104, 42088.158236835705, 40760.59239407568, 41508.377374340016, 41565.0, 41733.0, 41831.37252941269, 32702.50946235856, 35372.82313588416, 36192.81903590465, 36597.45103823498, 36887.0, 27918.44163116767, 28008.859955700093, 28253.858730707037, 28369.29076773097, 28425.573616395355], "value": 18549.451435796724, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.22177872021956, 382.743561813585, 383.30047663015006, 390.50405984399805, 411.5390762346171, 14284.0, 18091.366802161927, 18230.361937332196, 18652.25390984359, 19692.212311507523, 16813.243404046818, 17151.05669188197, 17235.82764172358, 17264.22310996005, 17516.824831751677, 5382.085045542258, 5659.830205093854, 5660.377358490563, 5663.631863928852, 5675.9432405675825, 3990.511097738669, 4079.470728148552, 5544.362398324184, 5641.746121424525, 5646.124850648156, 5571.777128914839, 6280.528960327971, 6282.403171698681, 6282.811515654537, 6295.370462953691, 6003.189569408118, 6273.215848018997, 6311.842203944915, 6315.242170939494, 6355.0, 5675.148727690879, 5675.489205971441, 5678.858028549278, 5685.8009969651275, 5687.658740475544, 22911.42721431961, 22962.54074918509, 23111.191108311297, 23119.306420807403, 23239.53520929589, 2291.7764498841757, 2328.4528135888054, 2436.756324367567, 2759.503289407906, 2790.734880186379, 9799.804003919953, 10024.849627255524, 10436.895631043668, 10613.5223914924, 11559.248648837884, 1880.971785423206, 1908.8186622270862, 1912.2064343297516, 1977.7527809023873, 2033.3594917601056, 77706.6114669423, 83398.58300708457, 85441.57279213626, 85681.0, 87630.56184719036, 10183.592656293666, 10779.35323880554, 10832.458377081115, 10895.673129806119, 11062.170337224741, 15334.616634584001, 15370.615734606501, 15382.0, 15393.846061539241, 15402.306896189699, 6750.257471678112, 7005.54463959841, 7079.0, 7176.174739904874, 7272.63636818157, 6509.7396104155305, 6521.0, 6720.193576770721, 6727.461803055744, 6740.258571557125, 4521.502634710245, 4638.95361046392, 4664.370310008173, 4690.460597031317, 4715.95284047162, 1783.8751287410016, 1935.1485346447519, 1940.5148712821795, 1962.6663467210608, 1965.0, 827.6896163938524, 961.7547525380983, 965.675873966414, 980.9068138526828, 1069.2301542889106, 17651.19094473469, 19253.0, 19325.806741932684, 19413.708794368096, 19452.22191112368, 943.7216021273741, 949.0746522140857, 952.3619175152664, 955.8518429643277, 990.6631745206664, 10209.693709188736, 10840.0, 10957.726056848642, 10964.506597203144, 10974.725631859268, 389188.0, 391761.0, 400818.0, 409331.0, 410424.0, 87686.0, 87800.56099719588, 88122.0, 88725.0, 89270.55364723135, 946.5598496699068, 952.6522819171091, 959.3859929644893, 972.4457059476172, 975.4391225045628, 15383.461578845134, 15520.5343839685, 16269.837301627305, 16328.591785205464, 17483.0, 38422.276101681535, 38758.224835502566, 40008.399874001334, 43674.12651746884, 45833.77083114563, 55127.0, 56073.0, 56315.71842140763, 57210.14184787315, 59089.70455147697, 8271.627776750182, 8460.661573537236, 8713.085126061673, 8721.694740684046, 8811.735647930573, 11922.0, 13235.338233088114, 13261.469541218243, 13430.597082087554, 13446.865531344562, 11172.217944744116, 11541.192116551762, 11543.422828858691, 11889.702757431134, 12025.759484810429, 10903.945480272865, 11402.0, 11432.142589306002, 11651.88348116542, 11723.765524689628, 11655.18413711032, 11783.351915644722, 12212.877871221173, 12249.0, 12395.814062789246, 7404.555726656418, 7596.0, 8386.874196886929, 8587.91412085896, 8748.168923952215, 10882.347059176474, 11167.664970050912, 11426.714332141762, 11895.643130706092, 11969.521219151486], "value": 8975.76850577204, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1272.0, 1451.7822326651005, 1466.6773309871828, 1564.8356922523135, 1749.947501574953, 7260.092488438945, 8333.458325208865, 8563.314934805208, 8590.699325523608, 8754.824903501925, 8607.0, 8638.481691098523, 8643.178898004695, 8675.089115642846, 8675.52284624347, 2230.297456301264, 2254.5603607296584, 2258.06290389489, 2262.0273282488524, 2262.683224348584, 2242.8317876159354, 2299.4251437140715, 2302.182725132579, 2303.2974942642572, 2305.6195727704994, 2208.1277895231456, 2210.3810932938804, 2212.4026512841524, 2218.1681869299014, 2250.3923940536047, 2200.3179014505554, 2240.350298413458, 2243.9102435902546, 2246.2587346175724, 2247.449374903143, 2204.647256438962, 2205.8786766727985, 2206.8675879447283, 2214.767449417804, 2217.246136313645, 8355.95822020892, 8401.579921003986, 8403.831923361498, 8404.663813447454, 8419.789505262355, 4917.459079501288, 5039.899202015976, 5054.115529782273, 5121.590272778169, 5126.384833819928, 3219.275662975812, 3364.6971772540346, 3402.1494626343415, 3464.9307013859834, 3476.548048753671, 996.8604395384652, 1023.6519583341625, 1066.6480061579737, 1077.6766969909074, 1079.4225089577117, 11920.0, 11945.104117191158, 11963.282203067756, 11985.0, 12076.637700868989, 4042.312806822847, 4329.826806927751, 4387.407699960465, 4390.078083602415, 4405.801738921757, 9349.065093490597, 9367.672131475501, 9376.718698439057, 9376.906230937604, 9387.061293870694, 4990.226514890125, 4997.575206107449, 4998.075356059141, 5025.221090730943, 5035.647504674637, 4099.8975025624595, 4218.746875187438, 4375.212461756914, 4467.553244675506, 4666.8133274668635, 3558.822058897045, 3590.958621999591, 3702.426123950792, 3737.5514938207043, 3743.794091324949, 1099.8790133085354, 1113.471101226927, 1114.164376717462, 1124.746931940307, 1131.479519421059, 608.4797498139116, 808.5674164322177, 868.5092922498894, 872.9825403491894, 916.5793020817706, 5228.63399562027, 5429.53848922846, 5480.945190548044, 5623.240862483594, 5634.239377684042, 873.2620935309653, 887.627196577439, 903.9548022598843, 924.6994726713845, 929.2333824594737, 3563.55455568054, 3619.7647152934974, 3651.835667394974, 3657.213699054716, 3770.0951771574623, 10340.0, 10762.677119686421, 10764.515596798163, 10794.190435717353, 10794.298370605886, 10679.519421626046, 10680.252382333161, 10682.73293167677, 10684.198685098649, 10723.83914241287, 7676.53940763556, 8004.599770011592, 8172.6322315495945, 8173.550454724928, 8178.386621003448, 5408.8647783804145, 5589.664620122806, 5667.121596152603, 5703.828885133453, 5810.0, 9954.402735835873, 9954.850677239992, 9956.20350371954, 9957.701268961942, 9996.800063998824, 9469.573869175765, 9950.751231219278, 9955.352902061342, 9962.352447090916, 9964.202863771026, 7420.777376678709, 7545.622718864144, 7555.811104722206, 7586.468947173645, 7638.961805190938, 8064.193580642123, 8140.348772098337, 8219.54792486419, 8259.587020648823, 8328.208820162075, 7252.963735181291, 7377.151627562899, 7382.2617738225745, 7493.587852667937, 7563.508371955805, 7280.0535930328715, 7380.114386273682, 7383.335499804828, 7416.480846340704, 7442.404607631484, 6531.972836358428, 6555.967220163869, 6571.211454625475, 6629.834254143685, 6638.269790322964, 4733.810647574059, 4795.088933102699, 4803.303520989367, 4865.5864251539015, 4964.230544265644, 4616.422947131608, 4626.7455289958025, 4704.1062198182235, 4709.882252943704, 4721.22099853534], "value": 4404.195521694616, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.1574243995851, 329.231245042825, 332.29553346904567, 332.5958959863765, 338.2980315844623, 5049.873753156173, 5166.63833531652, 5257.0, 5304.867378315544, 5307.45242283704, 5079.568236699875, 5198.68807871527, 5238.790448382069, 5240.2401651760565, 5252.870632813944, 4108.0, 4116.897077573055, 4126.174765046988, 4127.772972486512, 4152.190322887038, 4009.398590211477, 4118.105671391164, 4118.835246590133, 4127.7204066739405, 4128.422020917059, 4050.392441133839, 4077.3068578341754, 4085.816138273785, 4094.8362065517344, 4095.344744840826, 4055.45892560825, 4059.3099173140636, 4062.7765472898977, 4063.512378514597, 4096.1193343431005, 3605.0, 3605.837737301828, 3606.170580766412, 3610.765300255475, 3622.3117607654463, 5068.898622027576, 5102.36220472441, 5121.948780512184, 5132.307138536287, 5137.2037334213255, 4618.690654672664, 4636.327732478771, 4657.69724967876, 4666.859994200179, 4677.462091859412, 5454.181872719084, 5464.9180262296095, 5470.261514695505, 5506.80726174586, 5528.087865502187, 3751.624837516254, 3922.9019274518364, 3953.4069889516513, 3966.86115985942, 3974.8012599370204, 5719.6854173020465, 5722.37053924068, 5754.136879468071, 5765.913511297334, 5783.190353350535, 4038.5759495252573, 4058.4723985882238, 4061.329880569732, 4077.347624380085, 4088.2232375848494, 3860.8224491530354, 4021.8391264349684, 4036.1120553478186, 4057.837686492507, 4124.463819703419, 4626.86119416418, 4631.9536804631525, 4639.257718764981, 4645.372874661945, 4651.0, 5550.8057217997175, 5555.333359996826, 5567.387587365387, 5574.804881829116, 5589.804356847572, 1295.8509771376412, 1306.144475368635, 1368.6509939965244, 1382.1776043254247, 1395.7138786548733, 872.9916945927464, 894.9686760963335, 903.3450748207497, 906.3927168796922, 916.9821498137062, 4675.29870519418, 4679.672422930362, 4681.227597446451, 4686.414198225222, 4695.849516868389, 4877.512248775094, 4903.436104847917, 4921.203760627417, 4928.383952005999, 4935.580475659537, 4589.334546490807, 4635.536446355338, 4639.605633521121, 4640.211164102043, 4658.557437043475, 2787.679416867046, 2982.492976194052, 3011.7200189919195, 3024.1532370936175, 3025.1529571719952, 5779.913301300484, 5841.269841269841, 5846.912296315559, 5863.618864773862, 5878.764849406061, 5549.1676248563035, 5751.971240143773, 5761.308642962871, 5765.423457654201, 5808.128780682847, 5761.423857614289, 5772.0562513117775, 5774.451427114417, 5781.306243250837, 5791.218185544982, 5592.608517403743, 5627.184058311604, 5635.464630860061, 5643.915341269802, 5707.686077265625, 5319.973400133129, 5564.527015203753, 5600.775968961196, 5617.382087970402, 5640.71796410186, 5803.65178089316, 5841.50347220491, 5846.152307915413, 5881.73532191061, 5887.146363777314, 3937.3503371944453, 4030.0, 4039.4142849287277, 4041.4139949707715, 4047.57500462459, 5458.645188062763, 5656.830295091154, 5686.914696279477, 5714.79998200061, 5740.425957404226, 5466.480684334982, 5487.670739755627, 5544.7782088716, 5576.665400076008, 5584.776608935759, 5579.302587176603, 5579.358373787067, 5596.0, 5611.158326250932, 5626.749300279921, 5271.683698978073, 5486.588505861996, 5517.586181036519, 5567.32768271224, 5579.939811435815, 5586.742982828831, 5588.776448941997, 5594.804181853616, 5608.308012154107, 5610.410906854721, 5425.755840987086, 5440.129579267298, 5460.372057213472, 5475.534579560782, 5485.396606373216], "value": 4151.9845499665, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [620.7237779188263, 624.229077089794, 680.3060877904537, 703.3739971425432, 766.7278116268723, 13305.0, 14361.0, 14398.06412583184, 14415.765556338758, 14735.48425805097, 12093.758124837497, 12327.753444931095, 12352.444140013698, 12380.319082450484, 12420.751584968295, 790.490133863659, 802.4182467710921, 807.9030516338048, 810.116972499975, 810.3679130278392, 800.9118996910364, 802.3019972623825, 802.5305196460077, 802.9678812847479, 803.0443771911407, 688.3116883116883, 706.3854446631412, 816.5713000674634, 840.5377042626561, 844.5903736687701, 831.8419500294924, 831.8585840407115, 832.4547421438967, 832.8084540555676, 833.5040650812757, 605.8879107365152, 609.4149616368292, 609.7713357490941, 610.2768219659717, 610.4231501231338, 9548.236141108695, 9874.456904870229, 12449.128561000734, 12599.18105323151, 12744.745105097938, 13616.0, 13913.373898174606, 14266.714665706628, 14761.55715328542, 14816.703665926621, 11109.388983605899, 11167.72080697989, 11250.3812290324, 11275.590551181102, 11545.653630391102, 3694.07648087978, 3708.0, 3729.6829769469628, 3750.362438385481, 3798.506194194737, 62216.37783622151, 62395.71305030297, 62453.687731561506, 63507.68246158786, 64545.67727161381, 10735.731606709738, 10779.838302425469, 10818.188635852342, 11082.445877706083, 11184.60853870127, 20355.592888142153, 20450.0, 21333.14667413317, 21391.358259252247, 21450.678239826415, 6586.670666466657, 6983.580985140908, 7100.934859771076, 7239.457040721967, 7374.262573742582, 4082.632563069338, 4167.2082304362075, 4270.829166833292, 4285.6785741068925, 4312.805923733376, 3193.409219294438, 3224.2261857154112, 3289.473684210515, 3328.084776686382, 3333.5499707539657, 589.4623645207423, 599.3137857153534, 603.1977469964936, 605.0953824033098, 618.7494064903631, 643.1895811277731, 652.3900153356627, 658.275896513831, 662.2053535757111, 671.7850287907822, 8119.837603247902, 8687.956560217159, 8990.145936136056, 9107.134822192014, 9288.535573221312, 550.2489102375229, 584.6813486649786, 588.5644622978965, 610.1823556434399, 647.6049609738056, 4087.6729861611, 4284.293091639907, 4361.694681372273, 4517.5708307711375, 4622.560856718606, 74186.0, 78169.60915195387, 78605.60697196478, 80438.0, 80443.0, 67504.66247668829, 68445.65777171082, 68493.3150668497, 69203.0, 69445.65277173683, 42006.789966049975, 60247.69876150679, 62906.68546657237, 63074.369256307764, 64289.0, 8468.153184681483, 8557.700480483154, 8729.170728780755, 8795.472271663464, 8875.955620221857, 41290.0, 42147.57852421559, 42212.577874220864, 42432.5756742441, 42556.78721606372, 52800.47199527956, 53089.734551327, 54067.45932540624, 59439.70280148571, 61815.381846180964, 12219.205751626116, 12353.497960741084, 12459.626211213677, 12538.93730531378, 12542.749145016865, 12738.87261127377, 13037.869621304046, 13375.398107085399, 13472.720091591284, 13534.526291579747, 12815.871841281469, 12834.871651283367, 13060.738785224432, 13566.79649805234, 13568.253746043667, 12897.355132243538, 13098.339061277658, 13257.204567725967, 13318.200907945167, 13653.590392288248, 12860.742785144432, 13188.670283242996, 13356.065075444625, 13406.865931340562, 13906.721865562835, 9615.326927115315, 10037.799244014932, 10430.895691042992, 10482.63310784119, 10807.621733239614, 9045.68340108093, 10073.546690399096, 10240.641577545048, 10296.279260451696, 10304.330218535772], "value": 6743.626917291714, "unit": "score"}], "name": "dromaeo_css", "value": 6910.14461760453, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 112.0, 112.0, 112.0, 110.0, 112.0, 112.0, 113.0, 111.0, 110.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 123.0, 123.0, 170.0, 128.0, 130.0, 124.0, 121.0, 158.0, 122.0], "value": 134.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 161.0, 160.0, 160.0, 161.0, 162.0, 162.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 76.0, 75.0, 111.0, 78.0, 76.0, 76.0, 76.0, 104.0, 76.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 130.0, 83.0, 82.0, 82.0, 109.0, 83.0, 82.0, 116.0], "value": 93.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 84.0, 84.0, 85.0, 84.0, 84.0, 84.0, 84.0], "value": 84.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 54.0, 52.0, 53.0, 55.0, 53.0, 53.0, 53.0, 52.0], "value": 53.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 62.0, 60.0, 61.0, 61.0, 62.0, 62.0], "value": 61.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 87.0, 82.0, 85.0, 81.0, 85.0, 78.0, 80.0, 79.0, 79.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 135.0, 146.0, 130.0, 133.0, 128.0, 142.0, 134.0, 175.0, 142.0], "value": 140.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 166.0, 166.0, 167.0, 165.0, 166.0, 168.0, 168.0, 166.0, 167.0], "value": 166.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 65.0, 66.0, 66.0, 65.0, 65.0, 64.0, 66.0], "value": 65.4, "unit": "score"}], "name": "kraken", "value": 1499.2, "alertThreshold": 2.0}]} 06:49:01 INFO - Return code: 0 06:49:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:49:02 INFO - # TBPL SUCCESS # 06:49:02 INFO - Running post-action listener: _resource_record_post_action 06:49:02 INFO - [mozharness: 2016-10-25 13:49:02.034101Z] Finished run-tests step (success) 06:49:02 INFO - Running post-run listener: _resource_record_post_run 06:49:02 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 344064; Write bytes: 404721664; Read time: 136; Write time: 261684 06:49:02 INFO - TinderboxPrint: CPU usage
13.1% 06:49:02 INFO - TinderboxPrint: I/O read bytes / time
344,064 / 136 06:49:02 INFO - TinderboxPrint: I/O write bytes / time
404,721,664 / 261,684 06:49:02 INFO - TinderboxPrint: CPU idle
8,295.8 (86.9%) 06:49:02 INFO - TinderboxPrint: CPU user
1,199.2 (12.6%) 06:49:02 INFO - TinderboxPrint: Swap in / out
0 / 0 06:49:02 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 114769920; Read time: 0; Write time: 95348 06:49:02 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 339968; Write bytes: 289587200; Read time: 124; Write time: 166296 06:49:02 INFO - Running post-run listener: _upload_blobber_files 06:49:02 INFO - Blob upload gear active. 06:49:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:49:02 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 06:49:02 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:49:02 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:49:03 INFO - (blobuploader) - INFO - Open directory for files ... 06:49:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:49:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:49:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:49:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:49:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:49:05 INFO - (blobuploader) - INFO - Done attempting. 06:49:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:49:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:49:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:49:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:49:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:49:08 INFO - (blobuploader) - INFO - Done attempting. 06:49:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:49:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:49:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:49:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:49:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:49:09 INFO - (blobuploader) - INFO - Done attempting. 06:49:09 INFO - (blobuploader) - INFO - Iteration through files over. 06:49:09 INFO - Return code: 0 06:49:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:49:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:49:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0b05828659edb4e0dcd187bddf9e7d6f5050266724ada01a461374abba732399a1535a0aab6a925896c1bcb3fd56317e4e3020f3b21b9af45f705d6426402264", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ff761b25963c4f15d7571e6721c2477d4d06754a3ffd1e04c016859da792db3c1b9a86e1b57eec7ce5acd4f547a7e821b763688cfac978c30fde8594f0c82039", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa421db8e38db42406c3d9416a37a89fb80a024d15cb7dede34a2fbd5b01d680b6504d3544d879406f08dd00622d45065b740cfc55b15d38c611ce13d42484ef"} 06:49:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:49:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:49:09 INFO - Contents: 06:49:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0b05828659edb4e0dcd187bddf9e7d6f5050266724ada01a461374abba732399a1535a0aab6a925896c1bcb3fd56317e4e3020f3b21b9af45f705d6426402264", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ff761b25963c4f15d7571e6721c2477d4d06754a3ffd1e04c016859da792db3c1b9a86e1b57eec7ce5acd4f547a7e821b763688cfac978c30fde8594f0c82039", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa421db8e38db42406c3d9416a37a89fb80a024d15cb7dede34a2fbd5b01d680b6504d3544d879406f08dd00622d45065b740cfc55b15d38c611ce13d42484ef"} 06:49:09 INFO - Running post-run listener: copy_logs_to_upload_dir 06:49:09 INFO - Copying logs to upload dir... 06:49:09 INFO - mkdir: /builds/slave/test/build/upload/logs 06:49:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.209129 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-10-25 06:49:09.199894) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-25 06:49:09.204137) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1477399700.593707-772652127 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/sha512/0b05828659edb4e0dcd187bddf9e7d6f5050266724ada01a461374abba732399a1535a0aab6a925896c1bcb3fd56317e4e3020f3b21b9af45f705d6426402264", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ff761b25963c4f15d7571e6721c2477d4d06754a3ffd1e04c016859da792db3c1b9a86e1b57eec7ce5acd4f547a7e821b763688cfac978c30fde8594f0c82039", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa421db8e38db42406c3d9416a37a89fb80a024d15cb7dede34a2fbd5b01d680b6504d3544d879406f08dd00622d45065b740cfc55b15d38c611ce13d42484ef"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477391404/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011338 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477391404/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/sha512/0b05828659edb4e0dcd187bddf9e7d6f5050266724ada01a461374abba732399a1535a0aab6a925896c1bcb3fd56317e4e3020f3b21b9af45f705d6426402264", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ff761b25963c4f15d7571e6721c2477d4d06754a3ffd1e04c016859da792db3c1b9a86e1b57eec7ce5acd4f547a7e821b763688cfac978c30fde8594f0c82039", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa421db8e38db42406c3d9416a37a89fb80a024d15cb7dede34a2fbd5b01d680b6504d3544d879406f08dd00622d45065b740cfc55b15d38c611ce13d42484ef"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-25 06:49:09.237610) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 06:49:09.238138) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1477399700.593707-772652127 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004567 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 06:49:09.318591) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-25 06:49:09.318899) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-25 06:49:09.319181) ========= ========= Total master_lag: 0.19 =========