builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-037 starttime: 1476953937.94 results: success (0) buildid: 20161020002550 builduid: daa0991a81fb43c0bde5182983ed0a33 revision: 99a239e1866a57f987b08dad796528e4ea30e622 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 01:58:57.942327) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 01:58:57.943345) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 01:58:57.944060) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 01:58:57.957129) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 01:58:57.957460) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1476953937.544698-203492881 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-20 01:58:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 22.9M=0.001s 2016-10-20 01:58:58 (22.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.155834 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 01:58:58.124954) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 01:58:58.125289) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1476953937.544698-203492881 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019193 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 01:58:58.174456) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 01:58:58.174932) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 99a239e1866a57f987b08dad796528e4ea30e622 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 99a239e1866a57f987b08dad796528e4ea30e622 --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=56c518bb7cbc29fb3c9463e2000001c4-1476953937.544698-203492881 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-20 01:58:58,580 truncating revision to first 12 chars 2016-10-20 01:58:58,580 Setting DEBUG logging. 2016-10-20 01:58:58,581 attempt 1/10 2016-10-20 01:58:58,581 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/99a239e1866a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-20 01:58:58,899 unpacking tar archive at: mozilla-central-99a239e1866a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.644666 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 01:58:58.835754) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 01:58:58.836403) ========= script_repo_revision: 99a239e1866a57f987b08dad796528e4ea30e622 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 01:58:58.837226) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 01:58:58.837810) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 01:58:58.849820) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-10-20 01:58:58.850138) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=56c518bb7cbc29fb3c9463e2000001c4-1476953937.544698-203492881 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:58:59 INFO - MultiFileLogger online at 20161020 01:58:59 in /builds/slave/test 01:58:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 01:58:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:58:59 INFO - {'append_to_log': False, 01:58:59 INFO - 'base_work_dir': '/builds/slave/test', 01:58:59 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 01:58:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:58:59 INFO - 'branch': 'Firefox-Non-PGO', 01:58:59 INFO - 'buildbot_json_path': 'buildprops.json', 01:58:59 INFO - 'config_files': ('talos/linux_config.py',), 01:58:59 INFO - 'default_actions': ('clobber', 01:58:59 INFO - 'read-buildbot-config', 01:58:59 INFO - 'download-and-extract', 01:58:59 INFO - 'populate-webroot', 01:58:59 INFO - 'create-virtualenv', 01:58:59 INFO - 'install', 01:58:59 INFO - 'run-tests'), 01:58:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:58:59 INFO - 'download_minidump_stackwalk': True, 01:58:59 INFO - 'download_symbols': 'ondemand', 01:58:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:58:59 INFO - 'tooltool.py': '/tools/tooltool.py', 01:58:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:58:59 INFO - '/tools/misc-python/virtualenv.py')}, 01:58:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:58:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:58:59 INFO - 'installer_path': 'installer.exe', 01:58:59 INFO - 'log_level': 'info', 01:58:59 INFO - 'log_name': 'talos', 01:58:59 INFO - 'log_to_console': True, 01:58:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:58:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:58:59 INFO - 'opt_config_files': (), 01:58:59 INFO - 'pip_index': False, 01:58:59 INFO - 'sps_profile': False, 01:58:59 INFO - 'sps_profile_interval': 0, 01:58:59 INFO - 'suite': 'dromaeojs', 01:58:59 INFO - 'system_bits': '32', 01:58:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:58:59 INFO - 'title': 'talos-linux64-ix-037', 01:58:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:58:59 INFO - 'use_talos_json': True, 01:58:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:58:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:58:59 INFO - 'work_dir': 'build'} 01:58:59 INFO - [mozharness: 2016-10-20 08:58:59.353208Z] Running clobber step. 01:58:59 INFO - Running pre-action listener: _resource_record_pre_action 01:58:59 INFO - Running main action method: clobber 01:58:59 INFO - rmtree: /builds/slave/test/build 01:58:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:58:59 INFO - Running post-action listener: _resource_record_post_action 01:58:59 INFO - [mozharness: 2016-10-20 08:58:59.831223Z] Finished clobber step (success) 01:58:59 INFO - [mozharness: 2016-10-20 08:58:59.831323Z] Running read-buildbot-config step. 01:58:59 INFO - Running pre-action listener: _resource_record_pre_action 01:58:59 INFO - Running main action method: read_buildbot_config 01:58:59 INFO - Using buildbot properties: 01:58:59 INFO - { 01:58:59 INFO - "project": "", 01:58:59 INFO - "product": "firefox", 01:58:59 INFO - "script_repo_revision": "production", 01:58:59 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 01:58:59 INFO - "repository": "", 01:58:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 01:58:59 INFO - "buildid": "20161020002550", 01:58:59 INFO - "pgo_build": "False", 01:58:59 INFO - "basedir": "/builds/slave/test", 01:58:59 INFO - "buildnumber": 685, 01:58:59 INFO - "slavename": "talos-linux64-ix-037", 01:58:59 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:58:59 INFO - "platform": "ubuntu64_hw", 01:58:59 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 01:58:59 INFO - "branch": "mozilla-central", 01:58:59 INFO - "repo_path": "mozilla-central", 01:58:59 INFO - "revision": "99a239e1866a57f987b08dad796528e4ea30e622", 01:58:59 INFO - "stage_platform": "linux64", 01:58:59 INFO - "builduid": "daa0991a81fb43c0bde5182983ed0a33", 01:58:59 INFO - "slavebuilddir": "test" 01:58:59 INFO - } 01:58:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/YIR0RBQlR3qYpcDGfyTUZA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 01:58:59 INFO - Running post-action listener: _resource_record_post_action 01:58:59 INFO - [mozharness: 2016-10-20 08:58:59.833777Z] Finished read-buildbot-config step (success) 01:58:59 INFO - [mozharness: 2016-10-20 08:58:59.833866Z] Running download-and-extract step. 01:58:59 INFO - Running pre-action listener: _resource_record_pre_action 01:58:59 INFO - Running main action method: download_and_extract 01:58:59 INFO - mkdir: /builds/slave/test/build/tests 01:58:59 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')]} 01:58:59 INFO - trying https://queue.taskcluster.net/v1/task/YIR0RBQlR3qYpcDGfyTUZA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 01:58:59 INFO - Downloading https://queue.taskcluster.net/v1/task/YIR0RBQlR3qYpcDGfyTUZA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 01:58:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YIR0RBQlR3qYpcDGfyTUZA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:59:00 INFO - Downloaded 1361 bytes. 01:59:00 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 01:59:00 INFO - Using the following test package requirements: 01:59:00 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 01:59:00 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:59:00 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:59:00 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:59:00 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:59:00 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:59:00 INFO - u'jsshell-linux-x86_64.zip'], 01:59:00 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:59:00 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:59:00 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 01:59:00 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:59:00 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:59:00 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:59:00 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:59:00 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:59:00 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:59:00 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:59:00 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:59:00 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:59:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YIR0RBQlR3qYpcDGfyTUZA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 01:59:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YIR0RBQlR3qYpcDGfyTUZA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:59:00 INFO - Fetch https://queue.taskcluster.net/v1/task/YIR0RBQlR3qYpcDGfyTUZA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 01:59:00 INFO - Http code: 200 01:59:00 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 01:59:00 INFO - x-amz-cf-id: KVxpsO1_VcHABL0DAItHNJtWM3I5cVs0aQwF-GsM4jJavVvJXmHOBQ== 01:59:00 INFO - x-amz-version-id: FsDKZlVoPUIvGvwC0ZRvgF72z5.EhlpP 01:59:01 INFO - Expected file size: 20546446 01:59:01 INFO - Obtained file size: 20546446 01:59:05 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 01:59:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YIR0RBQlR3qYpcDGfyTUZA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 01:59:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YIR0RBQlR3qYpcDGfyTUZA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:59:05 INFO - Fetch https://queue.taskcluster.net/v1/task/YIR0RBQlR3qYpcDGfyTUZA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 01:59:05 INFO - Http code: 200 01:59:05 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 01:59:05 INFO - x-amz-cf-id: ZLDSRHzFBevNtHnLQgspgcPEIz04OSVWVhbA5fSQO2ymK4ORDJ4TGQ== 01:59:05 INFO - x-amz-version-id: FsDKZlVoPUIvGvwC0ZRvgF72z5.EhlpP 01:59:06 INFO - Expected file size: 20546446 01:59:06 INFO - Obtained file size: 20546446 01:59:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YIR0RBQlR3qYpcDGfyTUZA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 01:59:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YIR0RBQlR3qYpcDGfyTUZA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:59:10 INFO - Fetch https://queue.taskcluster.net/v1/task/YIR0RBQlR3qYpcDGfyTUZA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 01:59:11 INFO - Http code: 200 01:59:11 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 01:59:11 INFO - x-amz-cf-id: RyYl8S00v9P6qm1V23sXnpnb-nOJeWdJTToGDGZ1YzXP8ZXCTvRo_g== 01:59:11 INFO - x-amz-version-id: TVqaSqtnyGojhV1xs3GJBS8WMV9IQ0tj 01:59:11 INFO - Expected file size: 14409028 01:59:11 INFO - Obtained file size: 14409028 01:59:11 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')]} 01:59:11 INFO - trying https://queue.taskcluster.net/v1/task/YIR0RBQlR3qYpcDGfyTUZA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 01:59:11 INFO - Downloading https://queue.taskcluster.net/v1/task/YIR0RBQlR3qYpcDGfyTUZA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 01:59:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YIR0RBQlR3qYpcDGfyTUZA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:59:12 INFO - Downloaded 55534216 bytes. 01:59:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YIR0RBQlR3qYpcDGfyTUZA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 01:59:12 INFO - mkdir: /builds/slave/test/properties 01:59:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:59:12 INFO - Writing to file /builds/slave/test/properties/build_url 01:59:12 INFO - Contents: 01:59:12 INFO - build_url:https://queue.taskcluster.net/v1/task/YIR0RBQlR3qYpcDGfyTUZA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 01:59:13 INFO - Running post-action listener: _resource_record_post_action 01:59:13 INFO - Running post-action listener: set_extra_try_arguments 01:59:13 INFO - [mozharness: 2016-10-20 08:59:13.333052Z] Finished download-and-extract step (success) 01:59:13 INFO - [mozharness: 2016-10-20 08:59:13.333316Z] Running populate-webroot step. 01:59:13 INFO - Running pre-action listener: _resource_record_pre_action 01:59:13 INFO - Running main action method: populate_webroot 01:59:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:59:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:59:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:59:13 INFO - '--tppagecycles', 01:59:13 INFO - '7'], 01:59:13 INFO - 'tests': ['tsvgm']}}, 01:59:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:59:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:59:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:59:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:59:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:59:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:59:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:59:13 INFO - 'talos_options': ['--disable-e10s'], 01:59:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:59:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:59:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:59:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:59:13 INFO - 'talos_options': ['--disable-e10s'], 01:59:13 INFO - 'tests': ['damp', 'tps']}, 01:59:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:59:13 INFO - 'tests': ['damp', 'tps']}, 01:59:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:59:13 INFO - 'tests': ['dromaeo_dom']}, 01:59:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:59:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:59:13 INFO - 'tests': ['basic_compositor_video']}, 01:59:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:59:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:59:13 INFO - 'tests': ['a11yr', 01:59:13 INFO - 'ts_paint', 01:59:13 INFO - 'tpaint', 01:59:13 INFO - 'sessionrestore', 01:59:13 INFO - 'sessionrestore_no_auto_restore', 01:59:13 INFO - 'tabpaint']}, 01:59:13 INFO - 'other-e10s': {'tests': ['a11yr', 01:59:13 INFO - 'ts_paint', 01:59:13 INFO - 'tpaint', 01:59:13 INFO - 'sessionrestore', 01:59:13 INFO - 'sessionrestore_no_auto_restore', 01:59:13 INFO - 'tabpaint']}, 01:59:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:59:13 INFO - 'ts_paint', 01:59:13 INFO - 'tpaint', 01:59:13 INFO - 'sessionrestore', 01:59:13 INFO - 'sessionrestore_no_auto_restore', 01:59:13 INFO - 'tabpaint']}, 01:59:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:59:13 INFO - 'ts_paint', 01:59:13 INFO - 'tpaint', 01:59:13 INFO - 'sessionrestore', 01:59:13 INFO - 'sessionrestore_no_auto_restore', 01:59:13 INFO - 'tabpaint']}, 01:59:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:59:13 INFO - 'tests': ['a11yr', 01:59:13 INFO - 'ts_paint', 01:59:13 INFO - 'tpaint', 01:59:13 INFO - 'sessionrestore', 01:59:13 INFO - 'sessionrestore_no_auto_restore', 01:59:13 INFO - 'tabpaint']}, 01:59:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:59:13 INFO - 'tests': ['a11yr', 01:59:13 INFO - 'ts_paint', 01:59:13 INFO - 'tpaint', 01:59:13 INFO - 'sessionrestore', 01:59:13 INFO - 'sessionrestore_no_auto_restore', 01:59:13 INFO - 'tabpaint']}, 01:59:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:59:13 INFO - 'tests': ['tsvgx', 01:59:13 INFO - 'tsvgr_opacity', 01:59:13 INFO - 'tart', 01:59:13 INFO - 'tscrollx', 01:59:13 INFO - 'cart']}, 01:59:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:59:13 INFO - 'tsvgr_opacity', 01:59:13 INFO - 'tart', 01:59:13 INFO - 'tscrollx', 01:59:13 INFO - 'cart']}, 01:59:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:59:13 INFO - 'talos_options': ['--disable-e10s'], 01:59:13 INFO - 'tests': ['tp5o']}, 01:59:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:59:13 INFO - 'tests': ['tp5o']}, 01:59:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:59:13 INFO - 'talos_options': ['--disable-e10s', 01:59:13 INFO - '--xperf_path', 01:59:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:59:13 INFO - 'tests': ['tp5n']}, 01:59:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:59:13 INFO - 'talos_options': ['--xperf_path', 01:59:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:59:13 INFO - 'tests': ['tp5n']}}, 01:59:13 INFO - 'talos.zip': {'path': '', 01:59:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:59:13 INFO - Running post-action listener: _resource_record_post_action 01:59:13 INFO - [mozharness: 2016-10-20 08:59:13.351574Z] Finished populate-webroot step (success) 01:59:13 INFO - [mozharness: 2016-10-20 08:59:13.351662Z] Running create-virtualenv step. 01:59:13 INFO - Running pre-action listener: _resource_record_pre_action 01:59:13 INFO - Running main action method: create_virtualenv 01:59:13 INFO - Creating virtualenv /builds/slave/test/build/venv 01:59:13 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 01:59:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:59:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:59:13 INFO - Using real prefix '/usr' 01:59:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:59:13 INFO - Installing distribute.............................................................................................................................................................................................done. 01:59:15 INFO - Installing pip.................done. 01:59:15 INFO - Return code: 0 01:59:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:59:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:59:16 INFO - Reading from file tmpfile_stdout 01:59:16 INFO - Output received: 01:59:16 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) 01:59:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:59:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:59:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:59:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:59:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:16 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 0x7fcd53bd4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb3f60>, '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 0x1fb4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb51d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1476953937.544698-203492881', '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 01:59:16 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 01:59:16 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 01:59:16 INFO - Using env: {'DISPLAY': ':0', 01:59:16 INFO - 'HOME': '/home/cltbld', 01:59:16 INFO - 'LANG': 'en_US.UTF-8', 01:59:16 INFO - 'LANGUAGE': 'en_US:en', 01:59:16 INFO - 'LOGNAME': 'cltbld', 01:59:16 INFO - 'MAIL': '/var/mail/cltbld', 01:59:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:59:16 INFO - 'MOZ_NO_REMOTE': '1', 01:59:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:59:16 INFO - 'NO_EM_RESTART': '1', 01:59:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:59:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:59:16 INFO - 'PWD': '/builds/slave/test', 01:59:16 INFO - 'SHELL': '/bin/bash', 01:59:16 INFO - 'SHLVL': '1', 01:59:16 INFO - 'TERM': 'linux', 01:59:16 INFO - 'TMOUT': '86400', 01:59:16 INFO - 'USER': 'cltbld', 01:59:16 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1476953937.544698-203492881', 01:59:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:59:16 INFO - '_': '/tools/buildbot/bin/python'} 01:59:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:59:16 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 01:59:16 INFO - Cleaning up... 01:59:16 INFO - Return code: 0 01:59:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:59:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:59:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:59:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:59:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:16 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 0x7fcd53bd4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb3f60>, '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 0x1fb4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb51d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1476953937.544698-203492881', '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 01:59:16 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 01:59:16 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 01:59:16 INFO - Using env: {'DISPLAY': ':0', 01:59:16 INFO - 'HOME': '/home/cltbld', 01:59:16 INFO - 'LANG': 'en_US.UTF-8', 01:59:16 INFO - 'LANGUAGE': 'en_US:en', 01:59:16 INFO - 'LOGNAME': 'cltbld', 01:59:16 INFO - 'MAIL': '/var/mail/cltbld', 01:59:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:59:16 INFO - 'MOZ_NO_REMOTE': '1', 01:59:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:59:16 INFO - 'NO_EM_RESTART': '1', 01:59:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:59:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:59:16 INFO - 'PWD': '/builds/slave/test', 01:59:16 INFO - 'SHELL': '/bin/bash', 01:59:16 INFO - 'SHLVL': '1', 01:59:16 INFO - 'TERM': 'linux', 01:59:16 INFO - 'TMOUT': '86400', 01:59:16 INFO - 'USER': 'cltbld', 01:59:16 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1476953937.544698-203492881', 01:59:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:59:16 INFO - '_': '/tools/buildbot/bin/python'} 01:59:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:59:16 INFO - Downloading/unpacking psutil>=3.1.1 01:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:59:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:59:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:59:18 INFO - Installing collected packages: psutil 01:59:18 INFO - Running setup.py install for psutil 01:59:18 INFO - building 'psutil._psutil_linux' extension 01:59:18 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 01:59:18 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 01:59:18 INFO - building 'psutil._psutil_posix' extension 01:59:18 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 01:59:18 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 01:59:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:59:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:59:19 INFO - Successfully installed psutil 01:59:19 INFO - Cleaning up... 01:59:19 INFO - Return code: 0 01:59:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:59:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:59:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:59:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:59:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd53bd4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb3f60>, '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 0x1fb4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb51d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1476953937.544698-203492881', '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 01:59:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:59:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 01:59:19 INFO - Using env: {'DISPLAY': ':0', 01:59:19 INFO - 'HOME': '/home/cltbld', 01:59:19 INFO - 'LANG': 'en_US.UTF-8', 01:59:19 INFO - 'LANGUAGE': 'en_US:en', 01:59:19 INFO - 'LOGNAME': 'cltbld', 01:59:19 INFO - 'MAIL': '/var/mail/cltbld', 01:59:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:59:19 INFO - 'MOZ_NO_REMOTE': '1', 01:59:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:59:19 INFO - 'NO_EM_RESTART': '1', 01:59:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:59:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:59:19 INFO - 'PWD': '/builds/slave/test', 01:59:19 INFO - 'SHELL': '/bin/bash', 01:59:19 INFO - 'SHLVL': '1', 01:59:19 INFO - 'TERM': 'linux', 01:59:19 INFO - 'TMOUT': '86400', 01:59:19 INFO - 'USER': 'cltbld', 01:59:19 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1476953937.544698-203492881', 01:59:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:59:19 INFO - '_': '/tools/buildbot/bin/python'} 01:59:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:59:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:59:19 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 01:59:19 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 01:59:19 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 01:59:19 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 01:59:19 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 01:59:19 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 01:59:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:59:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:59:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:59:21 INFO - Installing collected packages: mozsystemmonitor 01:59:21 INFO - Running setup.py install for mozsystemmonitor 01:59:21 INFO - Successfully installed mozsystemmonitor 01:59:21 INFO - Cleaning up... 01:59:21 INFO - Return code: 0 01:59:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:59:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:59:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:59:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:59:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:59:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcd53bd4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb3f60>, '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 0x1fb4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb51d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1476953937.544698-203492881', '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 01:59:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:59:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 01:59:21 INFO - Using env: {'DISPLAY': ':0', 01:59:21 INFO - 'HOME': '/home/cltbld', 01:59:21 INFO - 'LANG': 'en_US.UTF-8', 01:59:21 INFO - 'LANGUAGE': 'en_US:en', 01:59:21 INFO - 'LOGNAME': 'cltbld', 01:59:21 INFO - 'MAIL': '/var/mail/cltbld', 01:59:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:59:21 INFO - 'MOZ_NO_REMOTE': '1', 01:59:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:59:21 INFO - 'NO_EM_RESTART': '1', 01:59:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:59:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:59:21 INFO - 'PWD': '/builds/slave/test', 01:59:21 INFO - 'SHELL': '/bin/bash', 01:59:21 INFO - 'SHLVL': '1', 01:59:21 INFO - 'TERM': 'linux', 01:59:21 INFO - 'TMOUT': '86400', 01:59:21 INFO - 'USER': 'cltbld', 01:59:21 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1476953937.544698-203492881', 01:59:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:59:21 INFO - '_': '/tools/buildbot/bin/python'} 01:59:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:59:21 INFO - Downloading/unpacking jsonschema==2.5.1 01:59:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:59:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:59:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:23 INFO - Downloading functools32-3.2.3-2.tar.gz 01:59:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:59:23 INFO - warning: no files found matching '*.txt' 01:59:23 INFO - no previously-included directories found matching 'build' 01:59:23 INFO - no previously-included directories found matching 'dist' 01:59:23 INFO - no previously-included directories found matching '.git*' 01:59:23 INFO - Installing collected packages: jsonschema, functools32 01:59:23 INFO - Running setup.py install for functools32 01:59:24 INFO - warning: no files found matching '*.txt' 01:59:24 INFO - no previously-included directories found matching 'build' 01:59:24 INFO - no previously-included directories found matching 'dist' 01:59:24 INFO - no previously-included directories found matching '.git*' 01:59:24 INFO - Successfully installed jsonschema functools32 01:59:24 INFO - Cleaning up... 01:59:24 INFO - Return code: 0 01:59:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:59:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:59:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:59:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:59:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcd53bd4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb3f60>, '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 0x1fb4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb51d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1476953937.544698-203492881', '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 01:59:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 01:59:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 01:59:24 INFO - Using env: {'DISPLAY': ':0', 01:59:24 INFO - 'HOME': '/home/cltbld', 01:59:24 INFO - 'LANG': 'en_US.UTF-8', 01:59:24 INFO - 'LANGUAGE': 'en_US:en', 01:59:24 INFO - 'LOGNAME': 'cltbld', 01:59:24 INFO - 'MAIL': '/var/mail/cltbld', 01:59:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:59:24 INFO - 'MOZ_NO_REMOTE': '1', 01:59:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:59:24 INFO - 'NO_EM_RESTART': '1', 01:59:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:59:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:59:24 INFO - 'PWD': '/builds/slave/test', 01:59:24 INFO - 'SHELL': '/bin/bash', 01:59:24 INFO - 'SHLVL': '1', 01:59:24 INFO - 'TERM': 'linux', 01:59:24 INFO - 'TMOUT': '86400', 01:59:24 INFO - 'USER': 'cltbld', 01:59:24 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1476953937.544698-203492881', 01:59:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:59:24 INFO - '_': '/tools/buildbot/bin/python'} 01:59:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:59:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:59:24 INFO - Cleaning up... 01:59:24 INFO - Return code: 0 01:59:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:59:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:59:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:59:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:59:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcd53bd4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb3f60>, '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 0x1fb4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb51d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1476953937.544698-203492881', '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 01:59:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:59:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:59:24 INFO - Using env: {'DISPLAY': ':0', 01:59:24 INFO - 'HOME': '/home/cltbld', 01:59:24 INFO - 'LANG': 'en_US.UTF-8', 01:59:24 INFO - 'LANGUAGE': 'en_US:en', 01:59:24 INFO - 'LOGNAME': 'cltbld', 01:59:24 INFO - 'MAIL': '/var/mail/cltbld', 01:59:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:59:24 INFO - 'MOZ_NO_REMOTE': '1', 01:59:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:59:24 INFO - 'NO_EM_RESTART': '1', 01:59:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:59:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:59:24 INFO - 'PWD': '/builds/slave/test', 01:59:24 INFO - 'SHELL': '/bin/bash', 01:59:24 INFO - 'SHLVL': '1', 01:59:24 INFO - 'TERM': 'linux', 01:59:24 INFO - 'TMOUT': '86400', 01:59:24 INFO - 'USER': 'cltbld', 01:59:24 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1476953937.544698-203492881', 01:59:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:59:24 INFO - '_': '/tools/buildbot/bin/python'} 01:59:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:59:24 INFO - Downloading/unpacking blobuploader==1.2.4 01:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:26 INFO - Downloading blobuploader-1.2.4.tar.gz 01:59:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:59:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:59:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:27 INFO - Downloading docopt-0.6.1.tar.gz 01:59:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:59:27 INFO - Installing collected packages: blobuploader, requests, docopt 01:59:27 INFO - Running setup.py install for blobuploader 01:59:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:59:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:59:27 INFO - Running setup.py install for requests 01:59:27 INFO - Running setup.py install for docopt 01:59:27 INFO - Successfully installed blobuploader requests docopt 01:59:27 INFO - Cleaning up... 01:59:27 INFO - Return code: 0 01:59:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:59:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:59:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:59:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:59:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:59:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:27 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 0x7fcd53bd4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb3f60>, '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 0x1fb4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb51d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1476953937.544698-203492881', '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 01:59:27 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 01:59:27 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 01:59:27 INFO - Using env: {'DISPLAY': ':0', 01:59:27 INFO - 'HOME': '/home/cltbld', 01:59:27 INFO - 'LANG': 'en_US.UTF-8', 01:59:27 INFO - 'LANGUAGE': 'en_US:en', 01:59:27 INFO - 'LOGNAME': 'cltbld', 01:59:27 INFO - 'MAIL': '/var/mail/cltbld', 01:59:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:59:27 INFO - 'MOZ_NO_REMOTE': '1', 01:59:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:59:27 INFO - 'NO_EM_RESTART': '1', 01:59:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:59:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:59:27 INFO - 'PWD': '/builds/slave/test', 01:59:27 INFO - 'SHELL': '/bin/bash', 01:59:27 INFO - 'SHLVL': '1', 01:59:27 INFO - 'TERM': 'linux', 01:59:27 INFO - 'TMOUT': '86400', 01:59:27 INFO - 'USER': 'cltbld', 01:59:27 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1476953937.544698-203492881', 01:59:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:59:27 INFO - '_': '/tools/buildbot/bin/python'} 01:59:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:59:28 INFO - Running setup.py (path:/tmp/pip-8821g9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:59:28 INFO - Running setup.py (path:/tmp/pip-h5WHCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:59:28 INFO - Running setup.py (path:/tmp/pip-rrA58v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:59:28 INFO - Running setup.py (path:/tmp/pip-d901Vp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:59:28 INFO - Running setup.py (path:/tmp/pip-wLTXiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:59:28 INFO - Running setup.py (path:/tmp/pip-BWiqiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:59:28 INFO - Running setup.py (path:/tmp/pip-Xfew71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:59:28 INFO - Running setup.py (path:/tmp/pip-fNHKoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:59:28 INFO - Running setup.py (path:/tmp/pip-6qBaT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:59:28 INFO - Running setup.py (path:/tmp/pip-xwwJAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:59:28 INFO - Running setup.py (path:/tmp/pip-rK__9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:59:28 INFO - Running setup.py (path:/tmp/pip-rEbe1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:59:28 INFO - Running setup.py (path:/tmp/pip-2P0kL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:59:29 INFO - Running setup.py (path:/tmp/pip-ZaUysZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:59:29 INFO - Running setup.py (path:/tmp/pip-L70VkM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:59:29 INFO - Running setup.py (path:/tmp/pip-r7_0jp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:59:29 INFO - Running setup.py (path:/tmp/pip-nIsqBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:59:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:59:29 INFO - Running setup.py install for manifestparser 01:59:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:59:29 INFO - Running setup.py install for mozcrash 01:59:29 INFO - Running setup.py install for mozdebug 01:59:29 INFO - Running setup.py install for mozdevice 01:59:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:59:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:59:29 INFO - Running setup.py install for mozfile 01:59:29 INFO - Running setup.py install for mozhttpd 01:59:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:59:29 INFO - Running setup.py install for mozinfo 01:59:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:59:30 INFO - Running setup.py install for mozInstall 01:59:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:59:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:59:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:59:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:59:30 INFO - Running setup.py install for mozleak 01:59:30 INFO - Running setup.py install for mozlog 01:59:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:59:30 INFO - Running setup.py install for moznetwork 01:59:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:59:30 INFO - Running setup.py install for mozprocess 01:59:30 INFO - Running setup.py install for mozprofile 01:59:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:59:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:59:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:59:30 INFO - Running setup.py install for mozrunner 01:59:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:59:30 INFO - Running setup.py install for mozscreenshot 01:59:30 INFO - Running setup.py install for moztest 01:59:31 INFO - Running setup.py install for mozversion 01:59:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:59:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:59:31 INFO - Cleaning up... 01:59:31 INFO - Return code: 0 01:59:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:59: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')]} 01:59:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:59:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59: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')]} 01:59:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:59:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:31 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 0x7fcd53bd4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb3f60>, '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 0x1fb4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb51d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1476953937.544698-203492881', '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 01:59:31 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 01:59:31 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 01:59:31 INFO - Using env: {'DISPLAY': ':0', 01:59:31 INFO - 'HOME': '/home/cltbld', 01:59:31 INFO - 'LANG': 'en_US.UTF-8', 01:59:31 INFO - 'LANGUAGE': 'en_US:en', 01:59:31 INFO - 'LOGNAME': 'cltbld', 01:59:31 INFO - 'MAIL': '/var/mail/cltbld', 01:59:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:59:31 INFO - 'MOZ_NO_REMOTE': '1', 01:59:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:59:31 INFO - 'NO_EM_RESTART': '1', 01:59:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:59:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:59:31 INFO - 'PWD': '/builds/slave/test', 01:59:31 INFO - 'SHELL': '/bin/bash', 01:59:31 INFO - 'SHLVL': '1', 01:59:31 INFO - 'TERM': 'linux', 01:59:31 INFO - 'TMOUT': '86400', 01:59:31 INFO - 'USER': 'cltbld', 01:59:31 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1476953937.544698-203492881', 01:59:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:59:31 INFO - '_': '/tools/buildbot/bin/python'} 01:59:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:59:31 INFO - Running setup.py (path:/tmp/pip-XZxgpK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:59:31 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)) 01:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:59:31 INFO - Running setup.py (path:/tmp/pip-fQDljb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:59:31 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)) 01:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:59:31 INFO - Running setup.py (path:/tmp/pip-SEIo3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:59:31 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)) 01:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:59:31 INFO - Running setup.py (path:/tmp/pip-MgChOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:59:31 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)) 01:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:59:31 INFO - Running setup.py (path:/tmp/pip-WUco30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:59:31 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)) 01:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:59:31 INFO - Running setup.py (path:/tmp/pip-gcA6Fg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:59:31 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)) 01:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:59:31 INFO - Running setup.py (path:/tmp/pip-Axhddv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:59:31 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)) 01:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:59:31 INFO - Running setup.py (path:/tmp/pip-7eepB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:59:31 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)) 01:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:59:31 INFO - Running setup.py (path:/tmp/pip-HhraSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:59:32 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)) 01:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:59:32 INFO - Running setup.py (path:/tmp/pip-3gEw6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:59:32 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)) 01:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:59:32 INFO - Running setup.py (path:/tmp/pip-8MdFsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:59:32 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)) 01:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:59:32 INFO - Running setup.py (path:/tmp/pip-G07MZj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:59:32 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)) 01:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:59:32 INFO - Running setup.py (path:/tmp/pip-jA39Ai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:59:32 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)) 01:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:59:32 INFO - Running setup.py (path:/tmp/pip-7IlYc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:59:32 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)) 01:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:59:32 INFO - Running setup.py (path:/tmp/pip-Dw6fLm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:59:32 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)) 01:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:59:32 INFO - Running setup.py (path:/tmp/pip-Ew2Fku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:59:32 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)) 01:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:59:32 INFO - Running setup.py (path:/tmp/pip-_m13Py-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:59:32 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)) 01:59:32 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)) 01:59:32 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)) 01:59:32 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)) 01:59:32 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)) 01:59:32 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)) 01:59:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:34 INFO - Downloading blessings-1.6.tar.gz 01:59:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:59:34 INFO - Installing collected packages: blessings 01:59:34 INFO - Running setup.py install for blessings 01:59:34 INFO - Successfully installed blessings 01:59:34 INFO - Cleaning up... 01:59:34 INFO - Return code: 0 01:59:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:59:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:59:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:59:35 INFO - Reading from file tmpfile_stdout 01:59:35 INFO - Current package versions: 01:59:35 INFO - argparse == 1.2.1 01:59:35 INFO - blessings == 1.6 01:59:35 INFO - blobuploader == 1.2.4 01:59:35 INFO - docopt == 0.6.1 01:59:35 INFO - functools32 == 3.2.3-2 01:59:35 INFO - jsonschema == 2.5.1 01:59:35 INFO - manifestparser == 1.1 01:59:35 INFO - mozInstall == 1.12 01:59:35 INFO - mozcrash == 0.17 01:59:35 INFO - mozdebug == 0.1 01:59:35 INFO - mozdevice == 0.48 01:59:35 INFO - mozfile == 1.2 01:59:35 INFO - mozhttpd == 0.7 01:59:35 INFO - mozinfo == 0.9 01:59:35 INFO - mozleak == 0.1 01:59:35 INFO - mozlog == 3.4 01:59:35 INFO - moznetwork == 0.27 01:59:35 INFO - mozprocess == 0.23 01:59:35 INFO - mozprofile == 0.28 01:59:35 INFO - mozrunner == 6.12 01:59:35 INFO - mozscreenshot == 0.1 01:59:35 INFO - mozsystemmonitor == 0.3 01:59:35 INFO - moztest == 0.7 01:59:35 INFO - mozversion == 1.4 01:59:35 INFO - psutil == 3.1.1 01:59:35 INFO - requests == 1.2.3 01:59:35 INFO - wsgiref == 0.1.2 01:59:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:59:35 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')]} 01:59:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:59:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:35 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')]} 01:59:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:59:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:35 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 0x7fcd53bd4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb3f60>, '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 0x1fb4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb51d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1476953937.544698-203492881', '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 01:59:35 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 01:59:35 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 01:59:35 INFO - Using env: {'DISPLAY': ':0', 01:59:35 INFO - 'HOME': '/home/cltbld', 01:59:35 INFO - 'LANG': 'en_US.UTF-8', 01:59:35 INFO - 'LANGUAGE': 'en_US:en', 01:59:35 INFO - 'LOGNAME': 'cltbld', 01:59:35 INFO - 'MAIL': '/var/mail/cltbld', 01:59:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:59:35 INFO - 'MOZ_NO_REMOTE': '1', 01:59:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:59:35 INFO - 'NO_EM_RESTART': '1', 01:59:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:59:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:59:35 INFO - 'PWD': '/builds/slave/test', 01:59:35 INFO - 'SHELL': '/bin/bash', 01:59:35 INFO - 'SHLVL': '1', 01:59:35 INFO - 'TERM': 'linux', 01:59:35 INFO - 'TMOUT': '86400', 01:59:35 INFO - 'USER': 'cltbld', 01:59:35 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1476953937.544698-203492881', 01:59:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:59:35 INFO - '_': '/tools/buildbot/bin/python'} 01:59:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:59:35 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)) 01:59:35 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)) 01:59:35 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)) 01:59:35 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)) 01:59:35 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)) 01:59:35 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)) 01:59:35 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)) 01:59:35 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)) 01:59:35 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)) 01:59:35 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)) 01:59:35 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)) 01:59:35 INFO - Cleaning up... 01:59:35 INFO - Return code: 0 01:59:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:59:35 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')]} 01:59:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:59:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:35 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')]} 01:59:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:59:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:35 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 0x7fcd53bd4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb3f60>, '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 0x1fb4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb51d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1476953937.544698-203492881', '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 01:59:35 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 01:59:35 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 01:59:35 INFO - Using env: {'DISPLAY': ':0', 01:59:35 INFO - 'HOME': '/home/cltbld', 01:59:35 INFO - 'LANG': 'en_US.UTF-8', 01:59:35 INFO - 'LANGUAGE': 'en_US:en', 01:59:35 INFO - 'LOGNAME': 'cltbld', 01:59:35 INFO - 'MAIL': '/var/mail/cltbld', 01:59:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:59:35 INFO - 'MOZ_NO_REMOTE': '1', 01:59:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:59:35 INFO - 'NO_EM_RESTART': '1', 01:59:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:59:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:59:35 INFO - 'PWD': '/builds/slave/test', 01:59:35 INFO - 'SHELL': '/bin/bash', 01:59:35 INFO - 'SHLVL': '1', 01:59:35 INFO - 'TERM': 'linux', 01:59:35 INFO - 'TMOUT': '86400', 01:59:35 INFO - 'USER': 'cltbld', 01:59:35 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1476953937.544698-203492881', 01:59:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:59:35 INFO - '_': '/tools/buildbot/bin/python'} 01:59:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:59:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:59:35 INFO - Cleaning up... 01:59:35 INFO - Return code: 0 01:59:35 INFO - Running post-action listener: _resource_record_post_action 01:59:35 INFO - Running post-action listener: _start_resource_monitoring 01:59:35 INFO - Starting resource monitoring. 01:59:35 INFO - [mozharness: 2016-10-20 08:59:35.519561Z] Finished create-virtualenv step (success) 01:59:35 INFO - [mozharness: 2016-10-20 08:59:35.520072Z] Running install step. 01:59:35 INFO - Running pre-action listener: _resource_record_pre_action 01:59:35 INFO - Running main action method: install 01:59:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:59:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:59:35 INFO - Reading from file tmpfile_stdout 01:59:35 INFO - Detecting whether we're running mozinstall >=1.0... 01:59:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:59:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:59:35 INFO - Reading from file tmpfile_stdout 01:59:35 INFO - Output received: 01:59:35 INFO - Usage: mozinstall [options] installer 01:59:35 INFO - Options: 01:59:35 INFO - -h, --help show this help message and exit 01:59:35 INFO - -d DEST, --destination=DEST 01:59:35 INFO - Directory to install application into. [default: 01:59:35 INFO - "/builds/slave/test"] 01:59:35 INFO - --app=APP Application being installed. [default: firefox] 01:59:35 INFO - mkdir: /builds/slave/test/build/application 01:59:35 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'] 01:59:35 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 01:59:52 INFO - Reading from file tmpfile_stdout 01:59:52 INFO - Output received: 01:59:52 INFO - /builds/slave/test/build/application/firefox/firefox 01:59:52 INFO - Running post-action listener: _resource_record_post_action 01:59:52 INFO - [mozharness: 2016-10-20 08:59:52.189310Z] Finished install step (success) 01:59:52 INFO - [mozharness: 2016-10-20 08:59:52.189557Z] Running run-tests step. 01:59:52 INFO - Running pre-action listener: _resource_record_pre_action 01:59:52 INFO - Running main action method: run_tests 01:59:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:59:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:59:52 INFO - Python 2.7.3 01:59:52 INFO - Return code: 0 01:59:52 INFO - grabbing minidump binary from tooltool 01:59:52 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')]} 01:59:52 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 0x1fb3f60>, '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 0x1fb4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb51d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:59:52 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 01:59:52 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 01:59:52 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 01:59:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:59:52 INFO - Return code: 0 01:59:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:59:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:59:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:59:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:59:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:59:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YIR0RBQlR3qYpcDGfyTUZA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 01:59:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YIR0RBQlR3qYpcDGfyTUZA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --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 01:59:52 INFO - Using env: {'DISPLAY': ':0', 01:59:52 INFO - 'HOME': '/home/cltbld', 01:59:52 INFO - 'LANG': 'en_US.UTF-8', 01:59:52 INFO - 'LANGUAGE': 'en_US:en', 01:59:52 INFO - 'LOGNAME': 'cltbld', 01:59:52 INFO - 'MAIL': '/var/mail/cltbld', 01:59:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:59:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:59:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:59:52 INFO - 'MOZ_NO_REMOTE': '1', 01:59:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:59:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:59:52 INFO - 'NO_EM_RESTART': '1', 01:59:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:59:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:59:52 INFO - 'PWD': '/builds/slave/test', 01:59:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:59:52 INFO - 'SHELL': '/bin/bash', 01:59:52 INFO - 'SHLVL': '1', 01:59:52 INFO - 'TERM': 'linux', 01:59:52 INFO - 'TMOUT': '86400', 01:59:52 INFO - 'USER': 'cltbld', 01:59:52 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1476953937.544698-203492881', 01:59:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:59:52 INFO - '_': '/tools/buildbot/bin/python'} 01:59:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YIR0RBQlR3qYpcDGfyTUZA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 01:59:52 INFO - mozversion application_buildid: 20161020002550 01:59:52 INFO - mozversion application_changeset: 99a239e1866a57f987b08dad796528e4ea30e622 01:59:52 INFO - mozversion application_display_name: Nightly 01:59:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:59:52 INFO - mozversion application_name: Firefox 01:59:52 INFO - mozversion application_remotingname: firefox 01:59:52 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 01:59:52 INFO - mozversion application_vendor: Mozilla 01:59:52 INFO - mozversion application_version: 52.0a1 01:59:52 INFO - mozversion platform_buildid: 20161020002550 01:59:52 INFO - mozversion platform_changeset: 99a239e1866a57f987b08dad796528e4ea30e622 01:59:52 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 01:59:52 INFO - mozversion platform_version: 52.0a1 01:59:52 INFO - using testdate: 1476953992 01:59:52 INFO - actual date: 1476953992 01:59:52 INFO - starting webserver on 'localhost:36012' 01:59:52 INFO - SUITE-START | Running 2 tests 01:59:52 INFO - TEST-START | dromaeo_css 01:59:52 INFO - operating with platform_type : linux_ 01:59:52 INFO - Initialising browser for dromaeo_css test... 01:59:52 INFO - TEST-INFO | started process 19566 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTwTJW8/profile http://localhost:36012/getInfo.html) 01:59:56 INFO - PROCESS | 19566 | __metrics Screen width/height:1600/1200 01:59:56 INFO - PROCESS | 19566 | colorDepth:24 01:59:56 INFO - PROCESS | 19566 | Browser inner width/height: 1024/697 01:59:56 INFO - PROCESS | 19566 | __metrics 01:59:57 INFO - PROCESS | 19566 | 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" 01:59:57 INFO - PROCESS | 19566 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:59:57 INFO - PROCESS | 19566 | console.error: PushService: 01:59:57 INFO - PROCESS | 19566 | stateChangeProcessEnqueue: Error transitioning state 01:59:57 INFO - PROCESS | 19566 | UnknownError 01:59:58 INFO - TEST-INFO | 19566: exit 0 01:59:58 INFO - Browser initialized. 01:59:58 INFO - Running cycle 1/1 for dromaeo_css test... 01:59:58 INFO - TEST-INFO | started process 19648 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTwTJW8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:00:10 INFO - PROCESS | 19648 | RSS: Main: 173314048 02:00:10 INFO - PROCESS | 19648 | 02:01:01 INFO - PROCESS | 19648 | 1476954061603 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] 02:03:14 INFO - PROCESS | 19648 | Cycle 1(1): loaded http://localhost:36012/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36012/tests/dromaeo/cssquery-ext.html) 02:03:16 INFO - PROCESS | 19648 | RSS: Main: 366870528 02:03:16 INFO - PROCESS | 19648 | 02:06:19 INFO - PROCESS | 19648 | Cycle 1(1): loaded http://localhost:36012/tests/dromaeo/cssquery-ext.html (next: http://localhost:36012/tests/dromaeo/cssquery-jquery.html) 02:06:20 INFO - PROCESS | 19648 | RSS: Main: 275525632 02:06:20 INFO - PROCESS | 19648 | 02:09:22 INFO - PROCESS | 19648 | Cycle 1(1): loaded http://localhost:36012/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36012/tests/dromaeo/cssquery-mootools.html) 02:09:23 INFO - PROCESS | 19648 | RSS: Main: 218456064 02:09:23 INFO - PROCESS | 19648 | 02:12:25 INFO - PROCESS | 19648 | Cycle 1(1): loaded http://localhost:36012/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36012/tests/dromaeo/cssquery-prototype.html) 02:12:26 INFO - PROCESS | 19648 | RSS: Main: 219361280 02:12:26 INFO - PROCESS | 19648 | 02:15:29 INFO - PROCESS | 19648 | Cycle 1(1): loaded http://localhost:36012/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36012/tests/dromaeo/cssquery-yui.html) 02:15:29 INFO - PROCESS | 19648 | RSS: Main: 220909568 02:15:29 INFO - PROCESS | 19648 | 02:18:32 INFO - PROCESS | 19648 | Cycle 1(1): loaded http://localhost:36012/tests/dromaeo/cssquery-yui.html (next: http://localhost:36012/tests/dromaeo/cssquery-dojo.html) 02:18:32 INFO - PROCESS | 19648 | RSS: Main: 305868800 02:18:32 INFO - PROCESS | 19648 | 02:18:32 INFO - PROCESS | 19648 | __start_tp_report 02:18:32 INFO - PROCESS | 19648 | _x_x_mozilla_page_load 02:18:32 INFO - PROCESS | 19648 | _x_x_mozilla_page_load_details 02:18:32 INFO - PROCESS | 19648 | |i|pagename|runs| 02:18:32 INFO - PROCESS | 19648 | |0;dojo.html;2591.6371707960884;2606.153000274911;2608.1393140263713;2647.5499165141937;2656.402309480366;4563.338315944186;4658.813647454098;4740.691855029425;4745.762711864406;4767.737774422405;4628.606568441678;4665.9766701166445;4677.368555245041;4681.976590117053;4751.524847515247;4306.095719898825;4324.870253892373;4351.390805287262;4374.256376416001;4394.846180383687;4292.484901811787;4357.760323182224;4360.25875601147;4431.113777244548;4438.023634800339;4374.03771170342;4387.363832244323;4392.956070439287;4416.138852923681;4441.133978874104;4218.7679677618025;4261.74429534229;4275.273203555372;4318.352247162919;4349.260625693608;4319.049809042006;4323.351497275403;4331.826726930919;4383.232934236527;4400.163968845909;4725.810967561293;4757.452892917324;4767.189577771787;4769.499202583748;4810.687305325143;4876.463589005242;4949.232868905289;5071.847844564669;5078.492150784892;5122.641415100945;5007.073691367109;5016.172331565287;5017.096922553938;5018.146915024455;5024.824131155428;4652.860414187579;4685.742284174369;4689.648276379286;4702.95297047032;4706.882327941828;5101.081805275012;5120.385553733501;5137.486251374833;5170.586353091744;5174.560162386164;4901.730404827768;4908.705477671351;4932.383452068491;4932.7286999215385;4984.850454486371;4897.583705385011;4910.656254062182;4950.034743225036;4968.552830245295;5036.043151801146;4937.851864444073;4986.127427700138;4990.750462476862;5024.673396229234;5090.643654944192;4994.051130285234;5016.322796422509;5019.949800502021;5025.045241404122;5082.720450375191;4174.686898482565;4187.539370669224;4187.706860519735;4194.224068547267;4233.957660423356;3559.555055618048;3585.1216451969435;3589.0847833802213;3617.9276414471565;3651.1419816343137;4374;4379.912401751947;4422.204003279377;4426.690131690815;4439.489458712224;5076.82231121909;5086.618503612244;5089.694618322913;5090.9236361454605;5131.281620573122;4234.491860976703;4382.868513944587;4384.145091707086;4389.517153113155;4442.911141777146;4426.734395936254;4472.776361181928;4525.140223357617;4570.634349252118;4582.679212455163;4805.207140821725;4809.0862736080035;4811.927821082617;4848.733319667382;4861.854144375674;5094.337736094284;5129.461406552258;5134.024535338273;5140.537351638221;5176.456472070529;4577.061702350943;4691.5308469152815;4811.398575178103;4817.0606731686985;4876.658633895735;4943.2585112233455;4943.975280123576;4944.703317800943;4949.604031677529;4951.158303088411;4982.601391888713;5009.423916249678;5009.5491405773655;5013.874653133701;5017.37282839645;4891.33966914462;4907.460179380337;4908.8772780680765;4909.533594308535;4915;4867.7322747249245;4899.681520701143;4901.50984901507;4903.754812259302;4907.460179380194;4796.56830885222;4833.685810422311;4865.5864251539015;4873.439554451284;4912.508749125059;4964.3298154748645;4970.552650261494;4971.726555039363;5014.147594908947;5027.170516864677;4849.054434385402;4863.756812159307;4863.95136048635;4865.367502224688;4893.070316639827 02:18:32 INFO - PROCESS | 19648 | |1;ext.html;547.2912578211217;560.7084316155599;566.7789562070791;568.292475867545;594.1355327997763;38947;40956.18087638245;41075;44914.55085449145;45002.549974500245;41738.373924391155;42239.788801055955;42278.36582451258;42289.57710422895;42294.36558451618;7350.632468376586;7676.501027433213;7816.531008139501;7818.45270831042;7820.139784623687;5871.8532036699;6028.4574388305045;6034.396560343953;6041.184440100574;9829.65596204133;9953;10352.844707329396;10376.584936602527;10392.896071039306;10400.47997600117;10258.846117308209;10291.176705863512;10314.845277320846;10316.381017138996;10327.948360258226;10037.146842518394;10070.34542754726;10081.395116293046;10101.444420556867;10104.292699511037;38485;38734;38867.22265554701;38882;38953.22093558141;2888.595596616475;3126.9830959031524;3145.944603154888;3325.218573635194;3431.227973705921;28717.85641071802;28787.42425151485;28879;28961;29031.564526532118;3405.625381208065;3473.4616134499192;3658.396364599838;3669.046048027532;3686;254393;255112;255322.72338638373;255474;256740;53819.73090134524;53999.46000540023;54161;54215;54278.18582721183;50707.47877563679;50726.239106413435;50734.238986415236;55548.72225638846;55559;12587.37063146839;12617.747645047048;12670.239785612892;12682.80975785364;12809.871901281054;9507.524623768784;9563.856542151872;9565.521723913776;9566.90433095674;9573.425594464354;14545.709085818437;14973;16439.91780041092;17073.658526829393;17193.7420938686;5098.566621837185;6162.845928851814;6218.347073557302;6279.937200627935;6319.24169099711;798.2137594469443;881.2949640287744;894.5310941800677;919.9448033118034;922.520289449496;25684.229473115836;26583.468330633277;26781.464370712478;27123;27246.318842029108;913.3834661603391;940.6566603189787;955.4028732042474;957.6121670723368;1008.8991100889853;13963.930180349033;14093.540668661404;14224.502142424966;14564.198969056804;14660.780088298685;345846;347286;350334;350675;351365;43434.56565434305;44606;48560.27159592609;49888;50074.749626251636;1141.3095077478172;1150.4707834396104;1172.800623893923;1187.0029175492627;1195.7548702515962;27887.16338509848;28780.424391511635;28903.710962890942;29183.124506264845;29477;42773.57226427696;43268.56731432645;43327;43369;43380.34929476123;354013;359286;359625;529975;530321;24315.270541883772;24319.756802431748;24696;24716.13493527718;24752.50494990054;40319;40465.1906961865;40936.79531602323;41465.37801933034;42219;34630.6147754087;34782.82608586941;34906;35209.647903520636;35297.47053794144;34888.47667284942;35062.47406288959;35121.82439087788;35421.11447213737;35883.641163589076;34386;34663.826680866434;34977.47533787046;35260;35451.46822797608;29530.409391812474;31766.205844854063;32117.51823722599;32196.11195257177;32385.514217286287;24750;24823.379415514035;24826;24963.12629057974;25004.249872503853 02:18:32 INFO - PROCESS | 19648 | |2;jquery.html;340.8244753951717;348.1053692011531;366.53633154060117;369.52885071533797;380.18640110164256;12688;15884.205789710511;16283.185840707976;16323.918380408111;17399.304027838873;14518.733448932044;14852.257387130654;15102;15221.162836044014;15281.617959551017;4913.5823455006275;5177.87055323618;5180.222966555009;5217.478252174771;5393.325834270716;5057.115004874151;5538.252335934638;5571.6378435401775;5575.107982722765;5576.553875689935;5283.577313814905;5401.189821526763;5410.48600382963;5412.134058550632;5412.972935135319;5218.634695571312;5358.303420555342;5365.785368585232;5368.62419630626;5405.756740946647;5282.709450980195;5288.2596436498925;5291.973540132313;5295.417504074549;5311.814086506954;12085.395730213455;12359.196652217577;18757.34349297768;19571;19746.605067898563;1756.5081777102432;1875.946135808206;1884.9340273090513;2026.9695954560693;2329.650552417134;9028.277737781027;9316.8602470963;9538.046195380475;11549.422528873607;11977.64067077989;1631.9428819991244;1660.4935494674119;1676.1535424610615;1688.4174959638906;1794.692737430165;66508.33491665118;67594.32405675978;67603;70116.6494167526;70481;9723.708288751348;9764.218862490983;9903.950480247697;9977.80044399108;10119.913426405017;13734.244616545986;13762.449502019806;13766.862331376558;13773.931130344285;13781.310934453237;6523.543351965317;6710.228323742735;6736.764213252611;6863.519553631198;6956.860862782716;6180.351063138396;6186.536009799193;6400.967995159995;6401.263854656774;6450.354964503512;4195.496540415109;4223.72545784523;4252.808623611945;4282.957170428318;4349.695521313478;1708.487453763866;1790.444962061765;1793.4529968359775;1835.8347748702681;1867.2810967777502;746.637880627895;779.0301075161346;810.9472884262505;872.9781755456164;926.3839546701369;16405;16503.17484125813;16739;16788.748168777478;17511.73732394015;852.808118173406;857.3698331726176;858.7037472072125;861.5003298087095;915.8305713443034;9122.680706175252;9426.622935082658;9632.27757918159;9743.65897193609;9781.657641982496;365393;380204;381292;382230;382752;67997.3200267991;70854.2914570858;71649.64175179091;72263.63868180626;73620;867.9739607811775;903.823754367905;905.1039470923738;911.1162172692477;917.3257655623112;15335.156566388956;15390.307436165624;15858.762118568462;16250.187490625658;16559.751603725712;26057.08800191984;26745;35071.93345530491;36098.27803443969;37372;45221.54778452305;50824.23763643622;51689.224661630855;51969;51982.74008630084;6695.196576410862;7348.154962179204;7474.318278387319;7752.302292793675;8250.793730156794;10674.199435042558;10688.465576721288;10898.727531811768;11149.275297105662;11427.200095993201;9645.951770241103;9687.41875487473;9705.603038936599;10056.748581285527;10466.947665261625;9214.216791572791;9851.211903047883;10114.291999560255;10413.843792343272;10737.409442480739;9217.815643687223;9719.9028009719;9959.900400996186;10041.49792510357;10626.89373106259;7480.476366654282;7669.1947345527915;7876.72431464896;7907.84184316322;7919.287264146024;8884.866726998971;9480.57337419804;9528.666496672584;9815.55829987638;10255.692329230134 02:18:32 INFO - PROCESS | 19648 | |3;mootools.html;1234.9320787356692;1370.9862901370986;1404.368034384527;1485.5320574019183;1685.679720853038;6779.932200677992;7260.636968151598;7541.358984486318;7549.698012079511;7552;7405.666744996474;7577.77266681999;7580.583067931261;7781.805454863631;7789.104253010905;2001.4295925661154;2031.1570698160247;2039.7960203979633;2041;2053.743282089739;2094.759102703186;2102.358780571925;2120.416885356524;2179.1610230061383;2181.8472706910525;2015.3752336775574;2025.281025236042;2026.685863691123;2027.9493012674654;2030.4923769057737;2077.1898959405844;2090.937271881846;2096.8532202745814;2102.4218339956633;2104.2529901884764;1967.4589487890944;1974.6149500847341;2002.3792624286518;2008.638445079885;2009.4674911148556;7578.166401695809;7636.350910172642;7740.419468539826;7754.263344982218;7802.804929876742;4269.124829409963;4390.121975604892;4394.055278115188;4396;4402.405675233835;2809.7190280971945;2952.46855565998;2990.177701132184;3012.186709588399;3012.29211135383;941.7739742461829;963.802420503795;966.1642679082543;970.5341436110635;993.6522217223986;10477.26659133861;10744.194185436123;10762.946185269024;10763.677089687244;10765.30025548337;4096.754194748325;4160.417541544186;4282;4284.271673815459;4304.160688665743;8368.58157092143;8450.408471407065;8480.872786908201;8501.95749021251;8519.872201916976;4300.6129448349175;4304.870853874389;4326.199653064194;4331.5018772840895;4336.1978034063795;3442.586889573217;3627.6735093841153;3741.2704522618374;4044.4539987101953;4050.3519436890547;3099.767517436201;3474.617792042873;3487.2502411981545;3510.508528805969;3525.9118522037156;974.7465658928729;1014.9492525373702;1016.1210552871861;1020.0972139656458;1025.5743866295552;801.7995501124719;810.5420437452821;814.951102933814;823.074041703084;826.3843436639622;4970.801167953241;5124.205748109049;5139.229115632685;5185.637005409661;5215.374155101412;393.3352634048449;397.4554859841977;399.69623086454504;403.0628788067754;403.49764543143976;3381.9492707609406;3501.5798104227656;3533.646635336497;3543.574771027493;3628.38317486028;9321.347505674537;9561.139497445263;9655.324127311162;9698;9720.125188733047;9636.277279203947;9693.951530242304;9704.70885873425;9706;9710.6115755369;7195.46034047438;7294.1247050354295;7417.072865891763;7423.369013633902;7427.925720742724;5089.261260363957;5104.846854594368;5122.137177824241;5226.11156103471;5281.735913204401;8833.955830220808;8861.468311901306;8872.112788721077;8873.112688731075;8921.776955575902;8153.959230203811;8751.824963500567;8878.822423551623;8886.200241978253;8908.55457227123;5999;6246.156768836149;6422.550421470639;6450.064740612679;6557.803265902031;7468.9626551866895;7483.176850546327;7540.622968851645;7550.131734850563;7573.962130189314;6793.796186114425;6824.215215250111;6827.112475378169;7003.089598352181;7029.718811247697;6641.900371494335;6694.129763130762;6752.662366881538;6827.351401616838;6949.4440444765305;6232.25212974446;6233.719482623203;6325.177726895658;6333.20834895638;6342.682865856781;4269.701120921506;4346.934795978;4373.978130109329;4456.131054444352;4494.415725955736;4317.892052698708;4336.826526938887;4358;4413.644888639033;4561.954380456153 02:18:32 INFO - PROCESS | 19648 | |4;prototype.html;293.2551319648094;297.3280386326901;304.8034018058352;305.6744567036105;307.075702136569;4754.956827630319;4766.57100860922;4772.90454190916;4790.137775200463;4815.759212039393;4712.952870471294;4723.409573803275;4740.241561350184;4741.478437371887;4767.594754445876;3755.1224387806096;3760.3231418344685;3761.1913438610627;3771.528558930134;3780.111673756665;3657.3965295726175;3682.926341473182;3762.2663580601793;3765.548134223883;3810.2189051244427;3669.724770642199;3671.779693218402;3721.4231794071825;3728.403455447129;3735.2156047230114;3697.3899306614376;3699.593044765087;3707.721920855947;3713.851445942159;3720.330340538702;3103.6896310368784;3171.8414079295944;3190.4416727072903;3286.4413049781597;3303.339332133583;4559.544045595447;4577.748223847687;4585.335126406686;4587.151376995266;4595.425571803525;4198.9370159447635;4214.599613036757;4216.873493795191;4220.725652832556;4231.42875711778;4589.462530052437;4660.464046634646;4881.829135980223;4896.730679812609;4897.804087836482;3552.1652411683235;3564.946525802115;3567.7502574819773;3568.6966607838367;3579.713622910161;5143.717095559743;5144.588432925357;5145.974270128625;5154.896902061975;5157.819476318348;3600.7839529628304;3666.5783434904793;3668.3580373434543;3671.5594128704724;3706.240220754739;3686.760360576554;3691.593924668284;3699.68661125302;3704.870329538507;3706.814659267026;4197.887559796656;4198.328267477189;4202.558731333227;4203;4236.661067114624;4907.0617106242835;4925.1873440881855;4942.308076869242;4946.925796113062;4953.380827396575;1220.5239956417004;1262.5707259531803;1271.1864406779669;1276.5723482633236;1284.9527634977464;816.3877092180865;823.2549542663899;829.7344849648175;832.2676045080411;843.1568431568431;3931.5649787827238;3956.248312820555;3965.521549031855;3967.761934283952;3971.900702482461;4507.233770259064;4511.481179664381;4518.593326600621;4521.321801729701;4526.977365113154;3866.7679939203736;3937.8031098444962;3950.822213000422;3958.426028225949;3960.32674445345;2382.857028578256;2409.5903696371306;2458.4099816044377;2707.9593806092926;2712.186344096763;4556.268617925233;4697.318888761179;4698.543451530037;4814.975925120352;4833.564979151894;5221.55616772571;5223.608229382736;5226.895462090737;5231.215317702375;5236.816711415158;4808.2547205183255;4830.488146163905;4835.597676673796;4839.41926968759;4848.0788650156355;4995.975020124876;5045.974770126126;5079.314292570456;5134.5635620972635;5140.511651393112;5012.6240531960975;5020.15554989437;5033.949660503348;5039.866030143188;5041.42023667283;4811.855644330676;4818.337673502636;4822.927656085091;4846.200376937766;4868;3432.9313413732084;3558.9288214235053;3567.964320356763;3586.9282614347044;3592.802395868148;5094.5160209780015;5099.184130539096;5101.362329708786;5118.257852611425;5122.871928201825;4975.5819591416275;4982.252662100714;4991.450940396481;5001;5002.449730529712;4754.263089221176;4935.901281974268;4952.133376659142;4953.455119936732;4982.227754698028;4876.5854902333695;4896.363472748662;4897.41231052276;4904.656674032926;4917.9016419672125;5009.273655320031;5010.348654674869;5014.194889839728;5020.096382651158;5030.874228144326;4760.904781904412;4819.180739274261;4848.369711937426;4861.9546797438725;4870.610351171827 02:18:32 INFO - PROCESS | 19648 | |5;yui.html;585.9414058594141;702.5363260248237;712.8681193979114;727.9781606551802;742.3430264216171;12351.752964940708;12831.16597421168;12836.743265134692;13243.337833108355;13251.337433128354;13457.798133028013;14083.718325633481;14202.644933876658;14810.925945370258;14835.925820370883;773.3928865840317;797.8563858505466;801.5551368990208;802.638812534359;803.120582961656;618.4464903910997;638.3584497579926;771.6064806948441;800.5116878703986;807.0315621254518;842.8272204198155;843.8860753798251;844.4300097434208;844.8099177685033;845.0957475501216;842.9578521073953;845.649055641911;847.4152834544207;847.6609356257485;848.9957550212271;479.5300605406686;491.263105341987;592.848823549992;613.6471528870873;616.4913945994573;13164.539241126611;13179.011574131882;13191.142575732547;13200;13200.141990770666;11729.53081876724;12173.330466824322;12281.447334869952;12395.814062789066;12671.683207919783;9938.552765125587;10342.586296548128;10494.160467162608;12122.757544849053;12174.939125304405;3324.6841550052704;3394.032700680319;3473.8436770345397;3475.3744326021306;3533.5583052118486;63751.36248637501;64162.67918660423;65142.3485765141;65323.3467665322;65775.67112164457;9367.859482107773;9487.47818869955;9654.71035868911;9698.224142068617;10187.274142991142;17268.395606153725;18075.36736214226;19128.426147215607;19298.22807087729;19404.708929366072;6905.102336696197;6911.89632155518;6947.409470194989;6994.965025174944;7076.716931322792;3674.6325367463573;3831.674307683878;3841.9231615367535;3848.172642881738;3868.497095377639;2973.3012742005612;3066.386722655478;3073.969260307413;3077.092257783959;3084.568160457538;501.64884580792864;512.4900723779789;517.1157320981164;525.9421463638996;532.946705329464;524.2110623511667;525.9211118332281;544.4446664402287;545.6944111297686;559.6009975062344;8193.180681931759;8269.29710974562;8480.321574274043;8801.38390312672;9174.67888623895;587.5358466811257;608.5101493297938;616.4947023083815;619.662284055191;629.4052120745943;3809.4285857121654;4129.97935010323;4147.087640719037;4190.434291370687;4272.5086615039045;49595.50404495981;49868;51963.740181298854;89948.5502572483;92846.0715392851;46602.53397465982;46771;72275.2772472279;79002.6049869747;79190;42238.366424503656;53787.73106134523;68410.31589684139;70357.64821175861;72944;7767.223277672188;7808.843823123392;7918.802029949297;7953.443258971816;8110.675572977251;41144;41624.375634366115;41732;41906.161876762904;43946.560534394244;34567;34891.65108348884;35471.46792798162;52457;54982;11141.387223702774;11311.208215424842;11436.19946603763;11549.36478493691;11682.415879206175;12955.676108097374;13262.469501219843;13336.799948000982;13617.659558511117;14269.500567480089;11603;12081.75836483283;12472;12492.25046497213;12608.74782504363;11337;12136.150469467053;12656.11407201487;12712.173708708904;12745;11232.4383780809;11696.415179240834;12420.937895310466;12425.37873106359;12432.937835310766;9579.281553883347;9897.25770567196;9927.553260103457;9987.60049598008;10356.430396327973;8910.732678019669;9422.194834689095;9660.468674222704;9716.708498745049;9942.453165075991 02:18:32 INFO - PROCESS | 19648 | __end_tp_report 02:18:32 INFO - PROCESS | 19648 | __start_cc_report 02:18:32 INFO - PROCESS | 19648 | _x_x_mozilla_cycle_collect,2236 02:18:32 INFO - PROCESS | 19648 | __end_cc_report 02:18:32 INFO - PROCESS | 19648 | __startTimestamp1476955112913__endTimestamp 02:18:32 INFO - PROCESS | 19648 | 02:18:32 INFO - PROCESS | 19648 | ------- Summary: start ------- 02:18:32 INFO - PROCESS | 19648 | Number of tests: 6 02:18:32 INFO - PROCESS | 19648 | 02:18:32 INFO - PROCESS | 19648 | [#0] dojo.html Cycles:165 Average:4656.97 Median:4817.06 stddev:496.21 (10.3%) stddev-sans-first:470.53 02:18:32 INFO - PROCESS | 19648 | Values: 2591.6 2606.2 2608.1 2647.5 2656.4 4563.3 4658.8 4740.7 4745.8 4767.7 4628.6 4666.0 4677.4 4682.0 4751.5 4306.1 4324.9 4351.4 4374.3 4394.8 4292.5 4357.8 4360.3 4431.1 4438.0 4374.0 4387.4 4393.0 4416.1 4441.1 4218.8 4261.7 4275.3 4318.4 4349.3 4319.0 4323.4 4331.8 4383.2 4400.2 4725.8 4757.5 4767.2 4769.5 4810.7 4876.5 4949.2 5071.8 5078.5 5122.6 5007.1 5016.2 5017.1 5018.1 5024.8 4652.9 4685.7 4689.6 4703.0 4706.9 5101.1 5120.4 5137.5 5170.6 5174.6 4901.7 4908.7 4932.4 4932.7 4984.9 4897.6 4910.7 4950.0 4968.6 5036.0 4937.9 4986.1 4990.8 5024.7 5090.6 4994.1 5016.3 5019.9 5025.0 5082.7 4174.7 4187.5 4187.7 4194.2 4234.0 3559.6 3585.1 3589.1 3617.9 3651.1 4374.0 4379.9 4422.2 4426.7 4439.5 5076.8 5086.6 5089.7 5090.9 5131.3 4234.5 4382.9 4384.1 4389.5 4442.9 4426.7 4472.8 4525.1 4570.6 4582.7 4805.2 4809.1 4811.9 4848.7 4861.9 5094.3 5129.5 5134.0 5140.5 5176.5 4577.1 4691.5 4811.4 4817.1 4876.7 4943.3 4944.0 4944.7 4949.6 4951.2 4982.6 5009.4 5009.5 5013.9 5017.4 4891.3 4907.5 4908.9 4909.5 4915.0 4867.7 4899.7 4901.5 4903.8 4907.5 4796.6 4833.7 4865.6 4873.4 4912.5 4964.3 4970.6 4971.7 5014.1 5027.2 4849.1 4863.8 4864.0 4865.4 4893.1 02:18:32 INFO - PROCESS | 19648 | 02:18:32 INFO - PROCESS | 19648 | [#1] ext.html Cycles:180 Average:49370.59 Median:193287.32 stddev:93742.04 (48.5%) stddev-sans-first:93933.33 02:18:32 INFO - PROCESS | 19648 | Values: 547.3 560.7 566.8 568.3 594.1 38947.0 40956.2 41075.0 44914.6 45002.5 41738.4 42239.8 42278.4 42289.6 42294.4 7350.6 7676.5 7816.5 7818.5 7820.1 5871.9 6028.5 6034.4 6041.2 9829.7 9953.0 10352.8 10376.6 10392.9 10400.5 10258.8 10291.2 10314.8 10316.4 10327.9 10037.1 10070.3 10081.4 10101.4 10104.3 38485.0 38734.0 38867.2 38882.0 38953.2 2888.6 3127.0 3145.9 3325.2 3431.2 28717.9 28787.4 28879.0 28961.0 29031.6 3405.6 3473.5 3658.4 3669.0 3686.0 254393.0 255112.0 255322.7 255474.0 256740.0 53819.7 53999.5 54161.0 54215.0 54278.2 50707.5 50726.2 50734.2 55548.7 55559.0 12587.4 12617.7 12670.2 12682.8 12809.9 9507.5 9563.9 9565.5 9566.9 9573.4 14545.7 14973.0 16439.9 17073.7 17193.7 5098.6 6162.8 6218.3 6279.9 6319.2 798.2 881.3 894.5 919.9 922.5 25684.2 26583.5 26781.5 27123.0 27246.3 913.4 940.7 955.4 957.6 1008.9 13963.9 14093.5 14224.5 14564.2 14660.8 345846.0 347286.0 350334.0 350675.0 351365.0 43434.6 44606.0 48560.3 49888.0 50074.7 1141.3 1150.5 1172.8 1187.0 1195.8 27887.2 28780.4 28903.7 29183.1 29477.0 42773.6 43268.6 43327.0 43369.0 43380.3 354013.0 359286.0 359625.0 529975.0 530321.0 24315.3 24319.8 24696.0 24716.1 24752.5 40319.0 40465.2 40936.8 41465.4 42219.0 34630.6 34782.8 34906.0 35209.6 35297.5 34888.5 35062.5 35121.8 35421.1 35883.6 34386.0 34663.8 34977.5 35260.0 35451.5 29530.4 31766.2 32117.5 32196.1 32385.5 24750.0 24823.4 24826.0 24963.1 25004.2 02:18:32 INFO - PROCESS | 19648 | 02:18:32 INFO - PROCESS | 19648 | [#2] jquery.html Cycles:180 Average:23395.59 Median:5218.06 stddev:62434.26 (1196.5%) stddev-sans-first:62585.40 02:18:32 INFO - PROCESS | 19648 | Values: 340.8 348.1 366.5 369.5 380.2 12688.0 15884.2 16283.2 16323.9 17399.3 14518.7 14852.3 15102.0 15221.2 15281.6 4913.6 5177.9 5180.2 5217.5 5393.3 5057.1 5538.3 5571.6 5575.1 5576.6 5283.6 5401.2 5410.5 5412.1 5413.0 5218.6 5358.3 5365.8 5368.6 5405.8 5282.7 5288.3 5292.0 5295.4 5311.8 12085.4 12359.2 18757.3 19571.0 19746.6 1756.5 1875.9 1884.9 2027.0 2329.7 9028.3 9316.9 9538.0 11549.4 11977.6 1631.9 1660.5 1676.2 1688.4 1794.7 66508.3 67594.3 67603.0 70116.6 70481.0 9723.7 9764.2 9904.0 9977.8 10119.9 13734.2 13762.4 13766.9 13773.9 13781.3 6523.5 6710.2 6736.8 6863.5 6956.9 6180.4 6186.5 6401.0 6401.3 6450.4 4195.5 4223.7 4252.8 4283.0 4349.7 1708.5 1790.4 1793.5 1835.8 1867.3 746.6 779.0 810.9 873.0 926.4 16405.0 16503.2 16739.0 16788.7 17511.7 852.8 857.4 858.7 861.5 915.8 9122.7 9426.6 9632.3 9743.7 9781.7 365393.0 380204.0 381292.0 382230.0 382752.0 67997.3 70854.3 71649.6 72263.6 73620.0 868.0 903.8 905.1 911.1 917.3 15335.2 15390.3 15858.8 16250.2 16559.8 26057.1 26745.0 35071.9 36098.3 37372.0 45221.5 50824.2 51689.2 51969.0 51982.7 6695.2 7348.2 7474.3 7752.3 8250.8 10674.2 10688.5 10898.7 11149.3 11427.2 9646.0 9687.4 9705.6 10056.7 10466.9 9214.2 9851.2 10114.3 10413.8 10737.4 9217.8 9719.9 9959.9 10041.5 10626.9 7480.5 7669.2 7876.7 7907.8 7919.3 8884.9 9480.6 9528.7 9815.6 10255.7 02:18:32 INFO - PROCESS | 19648 | 02:18:32 INFO - PROCESS | 19648 | [#3] mootools.html Cycles:180 Average:5012.57 Median:5097.05 stddev:2885.71 (56.6%) stddev-sans-first:2879.84 02:18:32 INFO - PROCESS | 19648 | Values: 1234.9 1371.0 1404.4 1485.5 1685.7 6779.9 7260.6 7541.4 7549.7 7552.0 7405.7 7577.8 7580.6 7781.8 7789.1 2001.4 2031.2 2039.8 2041.0 2053.7 2094.8 2102.4 2120.4 2179.2 2181.8 2015.4 2025.3 2026.7 2027.9 2030.5 2077.2 2090.9 2096.9 2102.4 2104.3 1967.5 1974.6 2002.4 2008.6 2009.5 7578.2 7636.4 7740.4 7754.3 7802.8 4269.1 4390.1 4394.1 4396.0 4402.4 2809.7 2952.5 2990.2 3012.2 3012.3 941.8 963.8 966.2 970.5 993.7 10477.3 10744.2 10762.9 10763.7 10765.3 4096.8 4160.4 4282.0 4284.3 4304.2 8368.6 8450.4 8480.9 8502.0 8519.9 4300.6 4304.9 4326.2 4331.5 4336.2 3442.6 3627.7 3741.3 4044.5 4050.4 3099.8 3474.6 3487.3 3510.5 3525.9 974.7 1014.9 1016.1 1020.1 1025.6 801.8 810.5 815.0 823.1 826.4 4970.8 5124.2 5139.2 5185.6 5215.4 393.3 397.5 399.7 403.1 403.5 3381.9 3501.6 3533.6 3543.6 3628.4 9321.3 9561.1 9655.3 9698.0 9720.1 9636.3 9694.0 9704.7 9706.0 9710.6 7195.5 7294.1 7417.1 7423.4 7427.9 5089.3 5104.8 5122.1 5226.1 5281.7 8834.0 8861.5 8872.1 8873.1 8921.8 8154.0 8751.8 8878.8 8886.2 8908.6 5999.0 6246.2 6422.6 6450.1 6557.8 7469.0 7483.2 7540.6 7550.1 7574.0 6793.8 6824.2 6827.1 7003.1 7029.7 6641.9 6694.1 6752.7 6827.4 6949.4 6232.3 6233.7 6325.2 6333.2 6342.7 4269.7 4346.9 4374.0 4456.1 4494.4 4317.9 4336.8 4358.0 4413.6 4562.0 02:18:32 INFO - PROCESS | 19648 | 02:18:32 INFO - PROCESS | 19648 | [#4] prototype.html Cycles:180 Average:4078.20 Median:4592.44 stddev:1189.24 (25.9%) stddev-sans-first:1158.15 02:18:32 INFO - PROCESS | 19648 | Values: 293.3 297.3 304.8 305.7 307.1 4755.0 4766.6 4772.9 4790.1 4815.8 4713.0 4723.4 4740.2 4741.5 4767.6 3755.1 3760.3 3761.2 3771.5 3780.1 3657.4 3682.9 3762.3 3765.5 3810.2 3669.7 3671.8 3721.4 3728.4 3735.2 3697.4 3699.6 3707.7 3713.9 3720.3 3103.7 3171.8 3190.4 3286.4 3303.3 4559.5 4577.7 4585.3 4587.2 4595.4 4198.9 4214.6 4216.9 4220.7 4231.4 4589.5 4660.5 4881.8 4896.7 4897.8 3552.2 3564.9 3567.8 3568.7 3579.7 5143.7 5144.6 5146.0 5154.9 5157.8 3600.8 3666.6 3668.4 3671.6 3706.2 3686.8 3691.6 3699.7 3704.9 3706.8 4197.9 4198.3 4202.6 4203.0 4236.7 4907.1 4925.2 4942.3 4946.9 4953.4 1220.5 1262.6 1271.2 1276.6 1285.0 816.4 823.3 829.7 832.3 843.2 3931.6 3956.2 3965.5 3967.8 3971.9 4507.2 4511.5 4518.6 4521.3 4527.0 3866.8 3937.8 3950.8 3958.4 3960.3 2382.9 2409.6 2458.4 2708.0 2712.2 4556.3 4697.3 4698.5 4815.0 4833.6 5221.6 5223.6 5226.9 5231.2 5236.8 4808.3 4830.5 4835.6 4839.4 4848.1 4996.0 5046.0 5079.3 5134.6 5140.5 5012.6 5020.2 5033.9 5039.9 5041.4 4811.9 4818.3 4822.9 4846.2 4868.0 3432.9 3558.9 3568.0 3586.9 3592.8 5094.5 5099.2 5101.4 5118.3 5122.9 4975.6 4982.3 4991.5 5001.0 5002.4 4754.3 4935.9 4952.1 4953.5 4982.2 4876.6 4896.4 4897.4 4904.7 4917.9 5009.3 5010.3 5014.2 5020.1 5030.9 4760.9 4819.2 4848.4 4862.0 4870.6 02:18:32 INFO - PROCESS | 19648 | 02:18:32 INFO - PROCESS | 19648 | [#5] yui.html Cycles:180 Average:15541.78 Median:25184.82 stddev:20356.49 (80.8%) stddev-sans-first:20382.61 02:18:32 INFO - PROCESS | 19648 | Values: 585.9 702.5 712.9 728.0 742.3 12351.8 12831.2 12836.7 13243.3 13251.3 13457.8 14083.7 14202.6 14810.9 14835.9 773.4 797.9 801.6 802.6 803.1 618.4 638.4 771.6 800.5 807.0 842.8 843.9 844.4 844.8 845.1 843.0 845.6 847.4 847.7 849.0 479.5 491.3 592.8 613.6 616.5 13164.5 13179.0 13191.1 13200.0 13200.1 11729.5 12173.3 12281.4 12395.8 12671.7 9938.6 10342.6 10494.2 12122.8 12174.9 3324.7 3394.0 3473.8 3475.4 3533.6 63751.4 64162.7 65142.3 65323.3 65775.7 9367.9 9487.5 9654.7 9698.2 10187.3 17268.4 18075.4 19128.4 19298.2 19404.7 6905.1 6911.9 6947.4 6995.0 7076.7 3674.6 3831.7 3841.9 3848.2 3868.5 2973.3 3066.4 3074.0 3077.1 3084.6 501.6 512.5 517.1 525.9 532.9 524.2 525.9 544.4 545.7 559.6 8193.2 8269.3 8480.3 8801.4 9174.7 587.5 608.5 616.5 619.7 629.4 3809.4 4130.0 4147.1 4190.4 4272.5 49595.5 49868.0 51963.7 89948.6 92846.1 46602.5 46771.0 72275.3 79002.6 79190.0 42238.4 53787.7 68410.3 70357.6 72944.0 7767.2 7808.8 7918.8 7953.4 8110.7 41144.0 41624.4 41732.0 41906.2 43946.6 34567.0 34891.7 35471.5 52457.0 54982.0 11141.4 11311.2 11436.2 11549.4 11682.4 12955.7 13262.5 13336.8 13617.7 14269.5 11603.0 12081.8 12472.0 12492.3 12608.7 11337.0 12136.2 12656.1 12712.2 12745.0 11232.4 11696.4 12420.9 12425.4 12432.9 9579.3 9897.3 9927.6 9987.6 10356.4 8910.7 9422.2 9660.5 9716.7 9942.5 02:18:32 INFO - PROCESS | 19648 | -------- Summary: end -------- 02:18:32 INFO - PROCESS | 19648 | 02:18:33 INFO - TEST-INFO | 19648: exit 0 02:18:33 INFO - TEST-OK | dromaeo_css | took 1121482ms 02:18:33 INFO - TEST-START | kraken 02:18:33 INFO - operating with platform_type : linux_ 02:18:33 INFO - Initialising browser for kraken test... 02:18:33 INFO - TEST-INFO | started process 19958 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGOTPRc/profile http://localhost:36012/getInfo.html) 02:18:38 INFO - PROCESS | 19958 | __metrics Screen width/height:1600/1200 02:18:38 INFO - PROCESS | 19958 | colorDepth:24 02:18:38 INFO - PROCESS | 19958 | Browser inner width/height: 1024/697 02:18:38 INFO - PROCESS | 19958 | __metrics 02:18:38 INFO - PROCESS | 19958 | 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" 02:18:38 INFO - PROCESS | 19958 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:18:39 INFO - PROCESS | 19958 | console.error: PushService: 02:18:39 INFO - PROCESS | 19958 | stateChangeProcessEnqueue: Error transitioning state 02:18:39 INFO - PROCESS | 19958 | UnknownError 02:18:39 INFO - TEST-INFO | 19958: exit 0 02:18:39 INFO - Browser initialized. 02:18:39 INFO - Running cycle 1/1 for kraken test... 02:18:39 INFO - TEST-INFO | started process 20038 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGOTPRc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:18:52 INFO - PROCESS | 20038 | RSS: Main: 173637632 02:18:52 INFO - PROCESS | 20038 | 02:18:54 INFO - PROCESS | 20038 | Cycle 1(1): loaded http://localhost:36012/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36012/tests/kraken/driver.html?testName=audio-beat-detection) 02:18:55 INFO - PROCESS | 20038 | RSS: Main: 234385408 02:18:55 INFO - PROCESS | 20038 | 02:18:58 INFO - PROCESS | 20038 | Cycle 1(1): loaded http://localhost:36012/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36012/tests/kraken/driver.html?testName=audio-dft) 02:18:59 INFO - PROCESS | 20038 | RSS: Main: 217067520 02:18:59 INFO - PROCESS | 20038 | 02:19:02 INFO - PROCESS | 20038 | Cycle 1(1): loaded http://localhost:36012/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36012/tests/kraken/driver.html?testName=audio-fft) 02:19:03 INFO - PROCESS | 20038 | RSS: Main: 299114496 02:19:03 INFO - PROCESS | 20038 | 02:19:05 INFO - PROCESS | 20038 | Cycle 1(1): loaded http://localhost:36012/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36012/tests/kraken/driver.html?testName=audio-oscillator) 02:19:05 INFO - PROCESS | 20038 | RSS: Main: 210214912 02:19:05 INFO - PROCESS | 20038 | 02:19:08 INFO - PROCESS | 20038 | Cycle 1(1): loaded http://localhost:36012/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36012/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:19:08 INFO - PROCESS | 20038 | RSS: Main: 212697088 02:19:08 INFO - PROCESS | 20038 | 02:19:11 INFO - PROCESS | 20038 | Cycle 1(1): loaded http://localhost:36012/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36012/tests/kraken/driver.html?testName=imaging-darkroom) 02:19:12 INFO - PROCESS | 20038 | RSS: Main: 249249792 02:19:12 INFO - PROCESS | 20038 | 02:19:16 INFO - PROCESS | 20038 | Cycle 1(1): loaded http://localhost:36012/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36012/tests/kraken/driver.html?testName=imaging-desaturate) 02:19:16 INFO - PROCESS | 20038 | RSS: Main: 248184832 02:19:16 INFO - PROCESS | 20038 | 02:19:19 INFO - PROCESS | 20038 | Cycle 1(1): loaded http://localhost:36012/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36012/tests/kraken/driver.html?testName=json-parse-financial) 02:19:20 INFO - PROCESS | 20038 | RSS: Main: 247341056 02:19:20 INFO - PROCESS | 20038 | 02:19:21 INFO - PROCESS | 20038 | Cycle 1(1): loaded http://localhost:36012/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36012/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:19:22 INFO - PROCESS | 20038 | RSS: Main: 209698816 02:19:22 INFO - PROCESS | 20038 | 02:19:24 INFO - PROCESS | 20038 | Cycle 1(1): loaded http://localhost:36012/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36012/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:19:24 INFO - PROCESS | 20038 | RSS: Main: 217485312 02:19:24 INFO - PROCESS | 20038 | 02:19:27 INFO - PROCESS | 20038 | Cycle 1(1): loaded http://localhost:36012/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36012/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:19:27 INFO - PROCESS | 20038 | RSS: Main: 225783808 02:19:27 INFO - PROCESS | 20038 | 02:19:30 INFO - PROCESS | 20038 | Cycle 1(1): loaded http://localhost:36012/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36012/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:19:31 INFO - PROCESS | 20038 | RSS: Main: 234598400 02:19:31 INFO - PROCESS | 20038 | 02:19:34 INFO - PROCESS | 20038 | Cycle 1(1): loaded http://localhost:36012/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36012/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:19:34 INFO - PROCESS | 20038 | RSS: Main: 232153088 02:19:34 INFO - PROCESS | 20038 | 02:19:36 INFO - PROCESS | 20038 | Cycle 1(1): loaded http://localhost:36012/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36012/tests/kraken/driver.html?testName=ai-astar) 02:19:36 INFO - PROCESS | 20038 | RSS: Main: 282980352 02:19:36 INFO - PROCESS | 20038 | 02:19:36 INFO - PROCESS | 20038 | __start_tp_report 02:19:36 INFO - PROCESS | 20038 | _x_x_mozilla_page_load 02:19:36 INFO - PROCESS | 20038 | _x_x_mozilla_page_load_details 02:19:36 INFO - PROCESS | 20038 | |i|pagename|runs| 02:19:36 INFO - PROCESS | 20038 | |0;ai-astar;107;114;115;115;114;114;114;114;115;114 02:19:36 INFO - PROCESS | 20038 | |1;audio-beat-detection;160;133;126;175;126;128;129;130;163;126 02:19:36 INFO - PROCESS | 20038 | |2;audio-dft;162;162;163;163;161;160;162;161;160;162 02:19:36 INFO - PROCESS | 20038 | |3;audio-fft;76;76;75;105;75;77;75;76;100;76 02:19:36 INFO - PROCESS | 20038 | |4;audio-oscillator;84;84;116;84;84;83;116;83;82;118 02:19:36 INFO - PROCESS | 20038 | |5;imaging-gaussian-blur;117;116;116;116;117;118;117;118;117;116 02:19:36 INFO - PROCESS | 20038 | |6;imaging-darkroom;146;146;146;146;147;146;146;146;146;147 02:19:36 INFO - PROCESS | 20038 | |7;imaging-desaturate;85;84;84;84;85;84;84;84;84;85 02:19:36 INFO - PROCESS | 20038 | |8;json-parse-financial;67;66;65;65;67;66;67;65;66;65 02:19:36 INFO - PROCESS | 20038 | |9;json-stringify-tinderbox;67;66;67;67;66;66;67;67;67;67 02:19:36 INFO - PROCESS | 20038 | |10;stanford-crypto-aes;83;83;82;83;84;92;86;83;82;82 02:19:36 INFO - PROCESS | 20038 | |11;stanford-crypto-ccm;162;151;141;146;147;142;141;138;184;139 02:19:36 INFO - PROCESS | 20038 | |12;stanford-crypto-pbkdf2;180;180;175;173;175;175;173;171;171;174 02:19:36 INFO - PROCESS | 20038 | |13;stanford-crypto-sha256-iterative;70;70;71;69;80;70;73;70;69;69 02:19:36 INFO - PROCESS | 20038 | __end_tp_report 02:19:36 INFO - PROCESS | 20038 | __start_cc_report 02:19:36 INFO - PROCESS | 20038 | _x_x_mozilla_cycle_collect,1977 02:19:36 INFO - PROCESS | 20038 | __end_cc_report 02:19:36 INFO - PROCESS | 20038 | __startTimestamp1476955176937__endTimestamp 02:19:36 INFO - PROCESS | 20038 | 02:19:36 INFO - PROCESS | 20038 | ------- Summary: start ------- 02:19:36 INFO - PROCESS | 20038 | Number of tests: 14 02:19:36 INFO - PROCESS | 20038 | 02:19:36 INFO - PROCESS | 20038 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.00 stddev:2.37 (2.1%) stddev-sans-first:0.50 02:19:36 INFO - PROCESS | 20038 | Values: 107.0 114.0 115.0 115.0 114.0 114.0 114.0 114.0 115.0 114.0 02:19:36 INFO - PROCESS | 20038 | 02:19:36 INFO - PROCESS | 20038 | [#1] audio-beat-detection Cycles:10 Average:139.60 Median:131.50 stddev:18.72 (14.2%) stddev-sans-first:18.34 02:19:36 INFO - PROCESS | 20038 | Values: 160.0 133.0 126.0 175.0 126.0 128.0 129.0 130.0 163.0 126.0 02:19:36 INFO - PROCESS | 20038 | 02:19:36 INFO - PROCESS | 20038 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.07 (0.7%) stddev-sans-first:1.13 02:19:36 INFO - PROCESS | 20038 | Values: 162.0 162.0 163.0 163.0 161.0 160.0 162.0 161.0 160.0 162.0 02:19:36 INFO - PROCESS | 20038 | 02:19:36 INFO - PROCESS | 20038 | [#3] audio-fft Cycles:10 Average:81.10 Median:76.00 stddev:11.36 (14.9%) stddev-sans-first:11.90 02:19:36 INFO - PROCESS | 20038 | Values: 76.0 76.0 75.0 105.0 75.0 77.0 75.0 76.0 100.0 76.0 02:19:36 INFO - PROCESS | 20038 | 02:19:36 INFO - PROCESS | 20038 | [#4] audio-oscillator Cycles:10 Average:93.40 Median:83.50 stddev:16.08 (19.3%) stddev-sans-first:16.69 02:19:36 INFO - PROCESS | 20038 | Values: 84.0 84.0 116.0 84.0 84.0 83.0 116.0 83.0 82.0 118.0 02:19:36 INFO - PROCESS | 20038 | 02:19:36 INFO - PROCESS | 20038 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 02:19:36 INFO - PROCESS | 20038 | Values: 117.0 116.0 116.0 116.0 117.0 118.0 117.0 118.0 117.0 116.0 02:19:36 INFO - PROCESS | 20038 | 02:19:36 INFO - PROCESS | 20038 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 02:19:36 INFO - PROCESS | 20038 | Values: 146.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 147.0 02:19:36 INFO - PROCESS | 20038 | 02:19:36 INFO - PROCESS | 20038 | [#7] imaging-desaturate Cycles:10 Average:84.30 Median:84.00 stddev:0.48 (0.6%) stddev-sans-first:0.44 02:19:36 INFO - PROCESS | 20038 | Values: 85.0 84.0 84.0 84.0 85.0 84.0 84.0 84.0 84.0 85.0 02:19:36 INFO - PROCESS | 20038 | 02:19:36 INFO - PROCESS | 20038 | [#8] json-parse-financial Cycles:10 Average:65.90 Median:66.00 stddev:0.88 (1.3%) stddev-sans-first:0.83 02:19:36 INFO - PROCESS | 20038 | Values: 67.0 66.0 65.0 65.0 67.0 66.0 67.0 65.0 66.0 65.0 02:19:36 INFO - PROCESS | 20038 | 02:19:36 INFO - PROCESS | 20038 | [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:67.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 02:19:36 INFO - PROCESS | 20038 | Values: 67.0 66.0 67.0 67.0 66.0 66.0 67.0 67.0 67.0 67.0 02:19:36 INFO - PROCESS | 20038 | 02:19:36 INFO - PROCESS | 20038 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:83.00 stddev:3.06 (3.7%) stddev-sans-first:3.22 02:19:36 INFO - PROCESS | 20038 | Values: 83.0 83.0 82.0 83.0 84.0 92.0 86.0 83.0 82.0 82.0 02:19:36 INFO - PROCESS | 20038 | 02:19:36 INFO - PROCESS | 20038 | [#11] stanford-crypto-ccm Cycles:10 Average:149.10 Median:146.50 stddev:14.18 (9.7%) stddev-sans-first:14.25 02:19:36 INFO - PROCESS | 20038 | Values: 162.0 151.0 141.0 146.0 147.0 142.0 141.0 138.0 184.0 139.0 02:19:36 INFO - PROCESS | 20038 | 02:19:36 INFO - PROCESS | 20038 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.70 Median:175.00 stddev:3.16 (1.8%) stddev-sans-first:2.71 02:19:36 INFO - PROCESS | 20038 | Values: 180.0 180.0 175.0 173.0 175.0 175.0 173.0 171.0 171.0 174.0 02:19:36 INFO - PROCESS | 20038 | 02:19:36 INFO - PROCESS | 20038 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.10 Median:70.00 stddev:3.35 (4.8%) stddev-sans-first:3.53 02:19:36 INFO - PROCESS | 20038 | Values: 70.0 70.0 71.0 69.0 80.0 70.0 73.0 70.0 69.0 69.0 02:19:36 INFO - PROCESS | 20038 | -------- Summary: end -------- 02:19:36 INFO - PROCESS | 20038 | 02:19:38 INFO - TEST-INFO | 20038: exit 0 02:19:38 INFO - TEST-OK | kraken | took 64325ms 02:19:38 INFO - SUITE-END | took 1185s 02:19:38 INFO - Completed test suite (00:19:46) 02:19:38 INFO - javascript benchmark 02:19:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2591.6371707960884, 2606.153000274911, 2608.1393140263713, 2647.5499165141937, 2656.402309480366, 4563.338315944186, 4658.813647454098, 4740.691855029425, 4745.762711864406, 4767.737774422405, 4628.606568441678, 4665.9766701166445, 4677.368555245041, 4681.976590117053, 4751.524847515247, 4306.095719898825, 4324.870253892373, 4351.390805287262, 4374.256376416001, 4394.846180383687, 4292.484901811787, 4357.760323182224, 4360.25875601147, 4431.113777244548, 4438.023634800339, 4374.03771170342, 4387.363832244323, 4392.956070439287, 4416.138852923681, 4441.133978874104, 4218.7679677618025, 4261.74429534229, 4275.273203555372, 4318.352247162919, 4349.260625693608, 4319.049809042006, 4323.351497275403, 4331.826726930919, 4383.232934236527, 4400.163968845909, 4725.810967561293, 4757.452892917324, 4767.189577771787, 4769.499202583748, 4810.687305325143, 4876.463589005242, 4949.232868905289, 5071.847844564669, 5078.492150784892, 5122.641415100945, 5007.073691367109, 5016.172331565287, 5017.096922553938, 5018.146915024455, 5024.824131155428, 4652.860414187579, 4685.742284174369, 4689.648276379286, 4702.95297047032, 4706.882327941828, 5101.081805275012, 5120.385553733501, 5137.486251374833, 5170.586353091744, 5174.560162386164, 4901.730404827768, 4908.705477671351, 4932.383452068491, 4932.7286999215385, 4984.850454486371, 4897.583705385011, 4910.656254062182, 4950.034743225036, 4968.552830245295, 5036.043151801146, 4937.851864444073, 4986.127427700138, 4990.750462476862, 5024.673396229234, 5090.643654944192, 4994.051130285234, 5016.322796422509, 5019.949800502021, 5025.045241404122, 5082.720450375191, 4174.686898482565, 4187.539370669224, 4187.706860519735, 4194.224068547267, 4233.957660423356, 3559.555055618048, 3585.1216451969435, 3589.0847833802213, 3617.9276414471565, 3651.1419816343137, 4374.0, 4379.912401751947, 4422.204003279377, 4426.690131690815, 4439.489458712224, 5076.82231121909, 5086.618503612244, 5089.694618322913, 5090.9236361454605, 5131.281620573122, 4234.491860976703, 4382.868513944587, 4384.145091707086, 4389.517153113155, 4442.911141777146, 4426.734395936254, 4472.776361181928, 4525.140223357617, 4570.634349252118, 4582.679212455163, 4805.207140821725, 4809.0862736080035, 4811.927821082617, 4848.733319667382, 4861.854144375674, 5094.337736094284, 5129.461406552258, 5134.024535338273, 5140.537351638221, 5176.456472070529, 4577.061702350943, 4691.5308469152815, 4811.398575178103, 4817.0606731686985, 4876.658633895735, 4943.2585112233455, 4943.975280123576, 4944.703317800943, 4949.604031677529, 4951.158303088411, 4982.601391888713, 5009.423916249678, 5009.5491405773655, 5013.874653133701, 5017.37282839645, 4891.33966914462, 4907.460179380337, 4908.8772780680765, 4909.533594308535, 4915.0, 4867.7322747249245, 4899.681520701143, 4901.50984901507, 4903.754812259302, 4907.460179380194, 4796.56830885222, 4833.685810422311, 4865.5864251539015, 4873.439554451284, 4912.508749125059, 4964.3298154748645, 4970.552650261494, 4971.726555039363, 5014.147594908947, 5027.170516864677, 4849.054434385402, 4863.756812159307, 4863.95136048635, 4865.367502224688, 4893.070316639827], "value": 4624.585452968429, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.2912578211217, 560.7084316155599, 566.7789562070791, 568.292475867545, 594.1355327997763, 38947.0, 40956.18087638245, 41075.0, 44914.55085449145, 45002.549974500245, 41738.373924391155, 42239.788801055955, 42278.36582451258, 42289.57710422895, 42294.36558451618, 7350.632468376586, 7676.501027433213, 7816.531008139501, 7818.45270831042, 7820.139784623687, 5871.8532036699, 6028.4574388305045, 6034.396560343953, 6041.184440100574, 9829.65596204133, 9953.0, 10352.844707329396, 10376.584936602527, 10392.896071039306, 10400.47997600117, 10258.846117308209, 10291.176705863512, 10314.845277320846, 10316.381017138996, 10327.948360258226, 10037.146842518394, 10070.34542754726, 10081.395116293046, 10101.444420556867, 10104.292699511037, 38485.0, 38734.0, 38867.22265554701, 38882.0, 38953.22093558141, 2888.595596616475, 3126.9830959031524, 3145.944603154888, 3325.218573635194, 3431.227973705921, 28717.85641071802, 28787.42425151485, 28879.0, 28961.0, 29031.564526532118, 3405.625381208065, 3473.4616134499192, 3658.396364599838, 3669.046048027532, 3686.0, 254393.0, 255112.0, 255322.72338638373, 255474.0, 256740.0, 53819.73090134524, 53999.46000540023, 54161.0, 54215.0, 54278.18582721183, 50707.47877563679, 50726.239106413435, 50734.238986415236, 55548.72225638846, 55559.0, 12587.37063146839, 12617.747645047048, 12670.239785612892, 12682.80975785364, 12809.871901281054, 9507.524623768784, 9563.856542151872, 9565.521723913776, 9566.90433095674, 9573.425594464354, 14545.709085818437, 14973.0, 16439.91780041092, 17073.658526829393, 17193.7420938686, 5098.566621837185, 6162.845928851814, 6218.347073557302, 6279.937200627935, 6319.24169099711, 798.2137594469443, 881.2949640287744, 894.5310941800677, 919.9448033118034, 922.520289449496, 25684.229473115836, 26583.468330633277, 26781.464370712478, 27123.0, 27246.318842029108, 913.3834661603391, 940.6566603189787, 955.4028732042474, 957.6121670723368, 1008.8991100889853, 13963.930180349033, 14093.540668661404, 14224.502142424966, 14564.198969056804, 14660.780088298685, 345846.0, 347286.0, 350334.0, 350675.0, 351365.0, 43434.56565434305, 44606.0, 48560.27159592609, 49888.0, 50074.749626251636, 1141.3095077478172, 1150.4707834396104, 1172.800623893923, 1187.0029175492627, 1195.7548702515962, 27887.16338509848, 28780.424391511635, 28903.710962890942, 29183.124506264845, 29477.0, 42773.57226427696, 43268.56731432645, 43327.0, 43369.0, 43380.34929476123, 354013.0, 359286.0, 359625.0, 529975.0, 530321.0, 24315.270541883772, 24319.756802431748, 24696.0, 24716.13493527718, 24752.50494990054, 40319.0, 40465.1906961865, 40936.79531602323, 41465.37801933034, 42219.0, 34630.6147754087, 34782.82608586941, 34906.0, 35209.647903520636, 35297.47053794144, 34888.47667284942, 35062.47406288959, 35121.82439087788, 35421.11447213737, 35883.641163589076, 34386.0, 34663.826680866434, 34977.47533787046, 35260.0, 35451.46822797608, 29530.409391812474, 31766.205844854063, 32117.51823722599, 32196.11195257177, 32385.514217286287, 24750.0, 24823.379415514035, 24826.0, 24963.12629057974, 25004.249872503853], "value": 17602.013023003787, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.8244753951717, 348.1053692011531, 366.53633154060117, 369.52885071533797, 380.18640110164256, 12688.0, 15884.205789710511, 16283.185840707976, 16323.918380408111, 17399.304027838873, 14518.733448932044, 14852.257387130654, 15102.0, 15221.162836044014, 15281.617959551017, 4913.5823455006275, 5177.87055323618, 5180.222966555009, 5217.478252174771, 5393.325834270716, 5057.115004874151, 5538.252335934638, 5571.6378435401775, 5575.107982722765, 5576.553875689935, 5283.577313814905, 5401.189821526763, 5410.48600382963, 5412.134058550632, 5412.972935135319, 5218.634695571312, 5358.303420555342, 5365.785368585232, 5368.62419630626, 5405.756740946647, 5282.709450980195, 5288.2596436498925, 5291.973540132313, 5295.417504074549, 5311.814086506954, 12085.395730213455, 12359.196652217577, 18757.34349297768, 19571.0, 19746.605067898563, 1756.5081777102432, 1875.946135808206, 1884.9340273090513, 2026.9695954560693, 2329.650552417134, 9028.277737781027, 9316.8602470963, 9538.046195380475, 11549.422528873607, 11977.64067077989, 1631.9428819991244, 1660.4935494674119, 1676.1535424610615, 1688.4174959638906, 1794.692737430165, 66508.33491665118, 67594.32405675978, 67603.0, 70116.6494167526, 70481.0, 9723.708288751348, 9764.218862490983, 9903.950480247697, 9977.80044399108, 10119.913426405017, 13734.244616545986, 13762.449502019806, 13766.862331376558, 13773.931130344285, 13781.310934453237, 6523.543351965317, 6710.228323742735, 6736.764213252611, 6863.519553631198, 6956.860862782716, 6180.351063138396, 6186.536009799193, 6400.967995159995, 6401.263854656774, 6450.354964503512, 4195.496540415109, 4223.72545784523, 4252.808623611945, 4282.957170428318, 4349.695521313478, 1708.487453763866, 1790.444962061765, 1793.4529968359775, 1835.8347748702681, 1867.2810967777502, 746.637880627895, 779.0301075161346, 810.9472884262505, 872.9781755456164, 926.3839546701369, 16405.0, 16503.17484125813, 16739.0, 16788.748168777478, 17511.73732394015, 852.808118173406, 857.3698331726176, 858.7037472072125, 861.5003298087095, 915.8305713443034, 9122.680706175252, 9426.622935082658, 9632.27757918159, 9743.65897193609, 9781.657641982496, 365393.0, 380204.0, 381292.0, 382230.0, 382752.0, 67997.3200267991, 70854.2914570858, 71649.64175179091, 72263.63868180626, 73620.0, 867.9739607811775, 903.823754367905, 905.1039470923738, 911.1162172692477, 917.3257655623112, 15335.156566388956, 15390.307436165624, 15858.762118568462, 16250.187490625658, 16559.751603725712, 26057.08800191984, 26745.0, 35071.93345530491, 36098.27803443969, 37372.0, 45221.54778452305, 50824.23763643622, 51689.224661630855, 51969.0, 51982.74008630084, 6695.196576410862, 7348.154962179204, 7474.318278387319, 7752.302292793675, 8250.793730156794, 10674.199435042558, 10688.465576721288, 10898.727531811768, 11149.275297105662, 11427.200095993201, 9645.951770241103, 9687.41875487473, 9705.603038936599, 10056.748581285527, 10466.947665261625, 9214.216791572791, 9851.211903047883, 10114.291999560255, 10413.843792343272, 10737.409442480739, 9217.815643687223, 9719.9028009719, 9959.900400996186, 10041.49792510357, 10626.89373106259, 7480.476366654282, 7669.1947345527915, 7876.72431464896, 7907.84184316322, 7919.287264146024, 8884.866726998971, 9480.57337419804, 9528.666496672584, 9815.55829987638, 10255.692329230134], "value": 7967.056072792229, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1234.9320787356692, 1370.9862901370986, 1404.368034384527, 1485.5320574019183, 1685.679720853038, 6779.932200677992, 7260.636968151598, 7541.358984486318, 7549.698012079511, 7552.0, 7405.666744996474, 7577.77266681999, 7580.583067931261, 7781.805454863631, 7789.104253010905, 2001.4295925661154, 2031.1570698160247, 2039.7960203979633, 2041.0, 2053.743282089739, 2094.759102703186, 2102.358780571925, 2120.416885356524, 2179.1610230061383, 2181.8472706910525, 2015.3752336775574, 2025.281025236042, 2026.685863691123, 2027.9493012674654, 2030.4923769057737, 2077.1898959405844, 2090.937271881846, 2096.8532202745814, 2102.4218339956633, 2104.2529901884764, 1967.4589487890944, 1974.6149500847341, 2002.3792624286518, 2008.638445079885, 2009.4674911148556, 7578.166401695809, 7636.350910172642, 7740.419468539826, 7754.263344982218, 7802.804929876742, 4269.124829409963, 4390.121975604892, 4394.055278115188, 4396.0, 4402.405675233835, 2809.7190280971945, 2952.46855565998, 2990.177701132184, 3012.186709588399, 3012.29211135383, 941.7739742461829, 963.802420503795, 966.1642679082543, 970.5341436110635, 993.6522217223986, 10477.26659133861, 10744.194185436123, 10762.946185269024, 10763.677089687244, 10765.30025548337, 4096.754194748325, 4160.417541544186, 4282.0, 4284.271673815459, 4304.160688665743, 8368.58157092143, 8450.408471407065, 8480.872786908201, 8501.95749021251, 8519.872201916976, 4300.6129448349175, 4304.870853874389, 4326.199653064194, 4331.5018772840895, 4336.1978034063795, 3442.586889573217, 3627.6735093841153, 3741.2704522618374, 4044.4539987101953, 4050.3519436890547, 3099.767517436201, 3474.617792042873, 3487.2502411981545, 3510.508528805969, 3525.9118522037156, 974.7465658928729, 1014.9492525373702, 1016.1210552871861, 1020.0972139656458, 1025.5743866295552, 801.7995501124719, 810.5420437452821, 814.951102933814, 823.074041703084, 826.3843436639622, 4970.801167953241, 5124.205748109049, 5139.229115632685, 5185.637005409661, 5215.374155101412, 393.3352634048449, 397.4554859841977, 399.69623086454504, 403.0628788067754, 403.49764543143976, 3381.9492707609406, 3501.5798104227656, 3533.646635336497, 3543.574771027493, 3628.38317486028, 9321.347505674537, 9561.139497445263, 9655.324127311162, 9698.0, 9720.125188733047, 9636.277279203947, 9693.951530242304, 9704.70885873425, 9706.0, 9710.6115755369, 7195.46034047438, 7294.1247050354295, 7417.072865891763, 7423.369013633902, 7427.925720742724, 5089.261260363957, 5104.846854594368, 5122.137177824241, 5226.11156103471, 5281.735913204401, 8833.955830220808, 8861.468311901306, 8872.112788721077, 8873.112688731075, 8921.776955575902, 8153.959230203811, 8751.824963500567, 8878.822423551623, 8886.200241978253, 8908.55457227123, 5999.0, 6246.156768836149, 6422.550421470639, 6450.064740612679, 6557.803265902031, 7468.9626551866895, 7483.176850546327, 7540.622968851645, 7550.131734850563, 7573.962130189314, 6793.796186114425, 6824.215215250111, 6827.112475378169, 7003.089598352181, 7029.718811247697, 6641.900371494335, 6694.129763130762, 6752.662366881538, 6827.351401616838, 6949.4440444765305, 6232.25212974446, 6233.719482623203, 6325.177726895658, 6333.20834895638, 6342.682865856781, 4269.701120921506, 4346.934795978, 4373.978130109329, 4456.131054444352, 4494.415725955736, 4317.892052698708, 4336.826526938887, 4358.0, 4413.644888639033, 4561.954380456153], "value": 3937.0792842006076, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.2551319648094, 297.3280386326901, 304.8034018058352, 305.6744567036105, 307.075702136569, 4754.956827630319, 4766.57100860922, 4772.90454190916, 4790.137775200463, 4815.759212039393, 4712.952870471294, 4723.409573803275, 4740.241561350184, 4741.478437371887, 4767.594754445876, 3755.1224387806096, 3760.3231418344685, 3761.1913438610627, 3771.528558930134, 3780.111673756665, 3657.3965295726175, 3682.926341473182, 3762.2663580601793, 3765.548134223883, 3810.2189051244427, 3669.724770642199, 3671.779693218402, 3721.4231794071825, 3728.403455447129, 3735.2156047230114, 3697.3899306614376, 3699.593044765087, 3707.721920855947, 3713.851445942159, 3720.330340538702, 3103.6896310368784, 3171.8414079295944, 3190.4416727072903, 3286.4413049781597, 3303.339332133583, 4559.544045595447, 4577.748223847687, 4585.335126406686, 4587.151376995266, 4595.425571803525, 4198.9370159447635, 4214.599613036757, 4216.873493795191, 4220.725652832556, 4231.42875711778, 4589.462530052437, 4660.464046634646, 4881.829135980223, 4896.730679812609, 4897.804087836482, 3552.1652411683235, 3564.946525802115, 3567.7502574819773, 3568.6966607838367, 3579.713622910161, 5143.717095559743, 5144.588432925357, 5145.974270128625, 5154.896902061975, 5157.819476318348, 3600.7839529628304, 3666.5783434904793, 3668.3580373434543, 3671.5594128704724, 3706.240220754739, 3686.760360576554, 3691.593924668284, 3699.68661125302, 3704.870329538507, 3706.814659267026, 4197.887559796656, 4198.328267477189, 4202.558731333227, 4203.0, 4236.661067114624, 4907.0617106242835, 4925.1873440881855, 4942.308076869242, 4946.925796113062, 4953.380827396575, 1220.5239956417004, 1262.5707259531803, 1271.1864406779669, 1276.5723482633236, 1284.9527634977464, 816.3877092180865, 823.2549542663899, 829.7344849648175, 832.2676045080411, 843.1568431568431, 3931.5649787827238, 3956.248312820555, 3965.521549031855, 3967.761934283952, 3971.900702482461, 4507.233770259064, 4511.481179664381, 4518.593326600621, 4521.321801729701, 4526.977365113154, 3866.7679939203736, 3937.8031098444962, 3950.822213000422, 3958.426028225949, 3960.32674445345, 2382.857028578256, 2409.5903696371306, 2458.4099816044377, 2707.9593806092926, 2712.186344096763, 4556.268617925233, 4697.318888761179, 4698.543451530037, 4814.975925120352, 4833.564979151894, 5221.55616772571, 5223.608229382736, 5226.895462090737, 5231.215317702375, 5236.816711415158, 4808.2547205183255, 4830.488146163905, 4835.597676673796, 4839.41926968759, 4848.0788650156355, 4995.975020124876, 5045.974770126126, 5079.314292570456, 5134.5635620972635, 5140.511651393112, 5012.6240531960975, 5020.15554989437, 5033.949660503348, 5039.866030143188, 5041.42023667283, 4811.855644330676, 4818.337673502636, 4822.927656085091, 4846.200376937766, 4868.0, 3432.9313413732084, 3558.9288214235053, 3567.964320356763, 3586.9282614347044, 3592.802395868148, 5094.5160209780015, 5099.184130539096, 5101.362329708786, 5118.257852611425, 5122.871928201825, 4975.5819591416275, 4982.252662100714, 4991.450940396481, 5001.0, 5002.449730529712, 4754.263089221176, 4935.901281974268, 4952.133376659142, 4953.455119936732, 4982.227754698028, 4876.5854902333695, 4896.363472748662, 4897.41231052276, 4904.656674032926, 4917.9016419672125, 5009.273655320031, 5010.348654674869, 5014.194889839728, 5020.096382651158, 5030.874228144326, 4760.904781904412, 4819.180739274261, 4848.369711937426, 4861.9546797438725, 4870.610351171827], "value": 3703.3372209327094, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.9414058594141, 702.5363260248237, 712.8681193979114, 727.9781606551802, 742.3430264216171, 12351.752964940708, 12831.16597421168, 12836.743265134692, 13243.337833108355, 13251.337433128354, 13457.798133028013, 14083.718325633481, 14202.644933876658, 14810.925945370258, 14835.925820370883, 773.3928865840317, 797.8563858505466, 801.5551368990208, 802.638812534359, 803.120582961656, 618.4464903910997, 638.3584497579926, 771.6064806948441, 800.5116878703986, 807.0315621254518, 842.8272204198155, 843.8860753798251, 844.4300097434208, 844.8099177685033, 845.0957475501216, 842.9578521073953, 845.649055641911, 847.4152834544207, 847.6609356257485, 848.9957550212271, 479.5300605406686, 491.263105341987, 592.848823549992, 613.6471528870873, 616.4913945994573, 13164.539241126611, 13179.011574131882, 13191.142575732547, 13200.0, 13200.141990770666, 11729.53081876724, 12173.330466824322, 12281.447334869952, 12395.814062789066, 12671.683207919783, 9938.552765125587, 10342.586296548128, 10494.160467162608, 12122.757544849053, 12174.939125304405, 3324.6841550052704, 3394.032700680319, 3473.8436770345397, 3475.3744326021306, 3533.5583052118486, 63751.36248637501, 64162.67918660423, 65142.3485765141, 65323.3467665322, 65775.67112164457, 9367.859482107773, 9487.47818869955, 9654.71035868911, 9698.224142068617, 10187.274142991142, 17268.395606153725, 18075.36736214226, 19128.426147215607, 19298.22807087729, 19404.708929366072, 6905.102336696197, 6911.89632155518, 6947.409470194989, 6994.965025174944, 7076.716931322792, 3674.6325367463573, 3831.674307683878, 3841.9231615367535, 3848.172642881738, 3868.497095377639, 2973.3012742005612, 3066.386722655478, 3073.969260307413, 3077.092257783959, 3084.568160457538, 501.64884580792864, 512.4900723779789, 517.1157320981164, 525.9421463638996, 532.946705329464, 524.2110623511667, 525.9211118332281, 544.4446664402287, 545.6944111297686, 559.6009975062344, 8193.180681931759, 8269.29710974562, 8480.321574274043, 8801.38390312672, 9174.67888623895, 587.5358466811257, 608.5101493297938, 616.4947023083815, 619.662284055191, 629.4052120745943, 3809.4285857121654, 4129.97935010323, 4147.087640719037, 4190.434291370687, 4272.5086615039045, 49595.50404495981, 49868.0, 51963.740181298854, 89948.5502572483, 92846.0715392851, 46602.53397465982, 46771.0, 72275.2772472279, 79002.6049869747, 79190.0, 42238.366424503656, 53787.73106134523, 68410.31589684139, 70357.64821175861, 72944.0, 7767.223277672188, 7808.843823123392, 7918.802029949297, 7953.443258971816, 8110.675572977251, 41144.0, 41624.375634366115, 41732.0, 41906.161876762904, 43946.560534394244, 34567.0, 34891.65108348884, 35471.46792798162, 52457.0, 54982.0, 11141.387223702774, 11311.208215424842, 11436.19946603763, 11549.36478493691, 11682.415879206175, 12955.676108097374, 13262.469501219843, 13336.799948000982, 13617.659558511117, 14269.500567480089, 11603.0, 12081.75836483283, 12472.0, 12492.25046497213, 12608.74782504363, 11337.0, 12136.150469467053, 12656.11407201487, 12712.173708708904, 12745.0, 11232.4383780809, 11696.415179240834, 12420.937895310466, 12425.37873106359, 12432.937835310766, 9579.281553883347, 9897.25770567196, 9927.553260103457, 9987.60049598008, 10356.430396327973, 8910.732678019669, 9422.194834689095, 9660.468674222704, 9716.708498745049, 9942.453165075991], "value": 6399.319045844078, "unit": "score"}], "name": "dromaeo_css", "value": 6265.866584805319, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 114.0, 115.0, 115.0, 114.0, 114.0, 114.0, 114.0, 115.0, 114.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 133.0, 126.0, 175.0, 126.0, 128.0, 129.0, 130.0, 163.0, 126.0], "value": 139.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 163.0, 161.0, 160.0, 162.0, 161.0, 160.0, 162.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 105.0, 75.0, 77.0, 75.0, 76.0, 100.0, 76.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 116.0, 84.0, 84.0, 83.0, 116.0, 83.0, 82.0, 118.0], "value": 93.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 116.0, 117.0, 118.0, 117.0, 118.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 84.0, 85.0, 84.0, 84.0, 84.0, 84.0, 85.0], "value": 84.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 65.0, 65.0, 67.0, 66.0, 67.0, 65.0, 66.0, 65.0], "value": 65.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 67.0, 66.0, 66.0, 67.0, 67.0, 67.0, 67.0], "value": 66.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 82.0, 83.0, 84.0, 92.0, 86.0, 83.0, 82.0, 82.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 151.0, 141.0, 146.0, 147.0, 142.0, 141.0, 138.0, 184.0, 139.0], "value": 149.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 180.0, 175.0, 173.0, 175.0, 175.0, 173.0, 171.0, 171.0, 174.0], "value": 174.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 71.0, 69.0, 80.0, 70.0, 73.0, 70.0, 69.0, 69.0], "value": 71.1, "unit": "score"}], "name": "kraken", "value": 1548.0999999999997, "alertThreshold": 2.0}]} 02:19:38 INFO - Return code: 0 02:19:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:19:38 INFO - # TBPL SUCCESS # 02:19:38 INFO - Running post-action listener: _resource_record_post_action 02:19:38 INFO - [mozharness: 2016-10-20 09:19:38.729639Z] Finished run-tests step (success) 02:19:38 INFO - Running post-run listener: _resource_record_post_run 02:19:38 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 0; Write bytes: 392560640; Read time: 0; Write time: 264100 02:19:38 INFO - TinderboxPrint: CPU usage
13.0% 02:19:38 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 02:19:38 INFO - TinderboxPrint: I/O write bytes / time
392,560,640 / 264,100 02:19:38 INFO - TinderboxPrint: CPU idle
8,345.9 (86.9%) 02:19:38 INFO - TinderboxPrint: CPU user
1,203.9 (12.5%) 02:19:38 INFO - TinderboxPrint: Swap in / out
0 / 0 02:19:38 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 99057664; Read time: 0; Write time: 82020 02:19:38 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 292601856; Read time: 0; Write time: 182056 02:19:39 INFO - Running post-run listener: _upload_blobber_files 02:19:39 INFO - Blob upload gear active. 02:19:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:19:39 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 02:19:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:19:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:19:39 INFO - (blobuploader) - INFO - Open directory for files ... 02:19:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:19:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:19:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:19:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:19:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:19:40 INFO - (blobuploader) - INFO - Done attempting. 02:19:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:19:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:19:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:19:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:19:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:19:41 INFO - (blobuploader) - INFO - Done attempting. 02:19:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:19:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:19:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:19:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:19:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:19:44 INFO - (blobuploader) - INFO - Done attempting. 02:19:44 INFO - (blobuploader) - INFO - Iteration through files over. 02:19:44 INFO - Return code: 0 02:19:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:19:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:19:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/da19887c106b4ebb85aeeb32afdc05a4b0953ec76309f5b00742bfca0c1f28bceebadb06a2e931f28ef1b13a84cf7012b2864368a632a9d87fb1eefb3fd34bf3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/31682ec303a50113c7cc6b87f98643f2c9e780213ef93ce95cd54c2d8b8b0b8a7d2d94d03db382d8cbfe2ee5c181a7be321d35bc9ae9094f1f83da47fd2717a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f901a4c003661b81ba71a3f834fe311e27865060c624b5315c365ed60255e708e4bad7a72e8783d48ca6518c264825fe5aa886ec6771f89e192bba1b4ea60fc6"} 02:19:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:19:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:19:44 INFO - Contents: 02:19:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/da19887c106b4ebb85aeeb32afdc05a4b0953ec76309f5b00742bfca0c1f28bceebadb06a2e931f28ef1b13a84cf7012b2864368a632a9d87fb1eefb3fd34bf3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/31682ec303a50113c7cc6b87f98643f2c9e780213ef93ce95cd54c2d8b8b0b8a7d2d94d03db382d8cbfe2ee5c181a7be321d35bc9ae9094f1f83da47fd2717a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f901a4c003661b81ba71a3f834fe311e27865060c624b5315c365ed60255e708e4bad7a72e8783d48ca6518c264825fe5aa886ec6771f89e192bba1b4ea60fc6"} 02:19:44 INFO - Running post-run listener: copy_logs_to_upload_dir 02:19:44 INFO - Copying logs to upload dir... 02:19:44 INFO - mkdir: /builds/slave/test/build/upload/logs 02:19:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.315557 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-10-20 02:19:44.186655) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 02:19:44.190109) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1476953937.544698-203492881 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/da19887c106b4ebb85aeeb32afdc05a4b0953ec76309f5b00742bfca0c1f28bceebadb06a2e931f28ef1b13a84cf7012b2864368a632a9d87fb1eefb3fd34bf3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/31682ec303a50113c7cc6b87f98643f2c9e780213ef93ce95cd54c2d8b8b0b8a7d2d94d03db382d8cbfe2ee5c181a7be321d35bc9ae9094f1f83da47fd2717a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f901a4c003661b81ba71a3f834fe311e27865060c624b5315c365ed60255e708e4bad7a72e8783d48ca6518c264825fe5aa886ec6771f89e192bba1b4ea60fc6"} build_url:https://queue.taskcluster.net/v1/task/YIR0RBQlR3qYpcDGfyTUZA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011428 build_url: 'https://queue.taskcluster.net/v1/task/YIR0RBQlR3qYpcDGfyTUZA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/da19887c106b4ebb85aeeb32afdc05a4b0953ec76309f5b00742bfca0c1f28bceebadb06a2e931f28ef1b13a84cf7012b2864368a632a9d87fb1eefb3fd34bf3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/31682ec303a50113c7cc6b87f98643f2c9e780213ef93ce95cd54c2d8b8b0b8a7d2d94d03db382d8cbfe2ee5c181a7be321d35bc9ae9094f1f83da47fd2717a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f901a4c003661b81ba71a3f834fe311e27865060c624b5315c365ed60255e708e4bad7a72e8783d48ca6518c264825fe5aa886ec6771f89e192bba1b4ea60fc6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 02:19:44.215738) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 02:19:44.216066) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1476953937.544698-203492881 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004445 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 02:19:44.297929) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 02:19:44.298380) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 02:19:44.298720) ========= ========= Total master_lag: 0.17 =========