builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-012 starttime: 1480630024.21 results: success (0) buildid: 20161201111744 builduid: 4802fb37b1684970a34a9fe48dfe7340 revision: d59e82481c869123324aa0f25fb03f3dd9c60aad ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-01 14:07:04.206972) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-01 14:07:04.207414) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-01 14:07:04.207700) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-01 14:07:04.223827) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 14:07:04.224310) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1480629053.596644-2050541285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-01 14:07:04-- 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% 45.8M=0s 2016-12-01 14:07:04 (45.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.077436 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 14:07:04.316343) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 14:07:04.316657) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1480629053.596644-2050541285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015074 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 14:07:04.367363) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 14:07:04.367937) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d59e82481c869123324aa0f25fb03f3dd9c60aad --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d59e82481c869123324aa0f25fb03f3dd9c60aad --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1480629053.596644-2050541285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-01 14:07:04,511 truncating revision to first 12 chars 2016-12-01 14:07:04,511 Setting DEBUG logging. 2016-12-01 14:07:04,511 attempt 1/10 2016-12-01 14:07:04,511 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d59e82481c86?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-01 14:07:04,826 unpacking tar archive at: mozilla-aurora-d59e82481c86/testing/mozharness/ program finished with exit code 0 elapsedTime=0.623746 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 14:07:05.006141) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-01 14:07:05.006461) ========= script_repo_revision: d59e82481c869123324aa0f25fb03f3dd9c60aad ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-01 14:07:05.007146) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-01 14:07:05.007418) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-01 14:07:05.016768) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-12-01 14:07:05.017095) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1480629053.596644-2050541285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:07:05 INFO - MultiFileLogger online at 20161201 14:07:05 in /builds/slave/test 14:07:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 14:07:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:07:05 INFO - {'append_to_log': False, 14:07:05 INFO - 'base_work_dir': '/builds/slave/test', 14:07:05 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:07:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:07:05 INFO - 'branch': 'Mozilla-Aurora', 14:07:05 INFO - 'buildbot_json_path': 'buildprops.json', 14:07:05 INFO - 'config_files': ('talos/linux_config.py',), 14:07:05 INFO - 'default_actions': ('clobber', 14:07:05 INFO - 'read-buildbot-config', 14:07:05 INFO - 'download-and-extract', 14:07:05 INFO - 'populate-webroot', 14:07:05 INFO - 'create-virtualenv', 14:07:05 INFO - 'install', 14:07:05 INFO - 'run-tests'), 14:07:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:07:05 INFO - 'download_minidump_stackwalk': True, 14:07:05 INFO - 'download_symbols': 'ondemand', 14:07:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:07:05 INFO - 'tooltool.py': '/tools/tooltool.py', 14:07:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:07:05 INFO - '/tools/misc-python/virtualenv.py')}, 14:07:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:07:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:07:05 INFO - 'installer_path': 'installer.exe', 14:07:05 INFO - 'log_level': 'info', 14:07:05 INFO - 'log_name': 'talos', 14:07:05 INFO - 'log_to_console': True, 14:07:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:07:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:07:05 INFO - 'opt_config_files': (), 14:07:05 INFO - 'pip_index': False, 14:07:05 INFO - 'sps_profile': False, 14:07:05 INFO - 'sps_profile_interval': 0, 14:07:05 INFO - 'suite': 'dromaeojs', 14:07:05 INFO - 'system_bits': '32', 14:07:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:07:05 INFO - 'title': 'talos-linux64-ix-012', 14:07:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:07:05 INFO - 'use_talos_json': True, 14:07:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:07:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:07:05 INFO - 'work_dir': 'build'} 14:07:05 INFO - [mozharness: 2016-12-01 22:07:05.260218Z] Running clobber step. 14:07:05 INFO - Running pre-action listener: _resource_record_pre_action 14:07:05 INFO - Running main action method: clobber 14:07:05 INFO - rmtree: /builds/slave/test/build 14:07:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:07:06 INFO - Running post-action listener: _resource_record_post_action 14:07:06 INFO - [mozharness: 2016-12-01 22:07:06.230307Z] Finished clobber step (success) 14:07:06 INFO - [mozharness: 2016-12-01 22:07:06.230405Z] Running read-buildbot-config step. 14:07:06 INFO - Running pre-action listener: _resource_record_pre_action 14:07:06 INFO - Running main action method: read_buildbot_config 14:07:06 INFO - Using buildbot properties: 14:07:06 INFO - { 14:07:06 INFO - "project": "", 14:07:06 INFO - "product": "firefox", 14:07:06 INFO - "script_repo_revision": "production", 14:07:06 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 14:07:06 INFO - "repository": "", 14:07:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 14:07:06 INFO - "buildid": "20161201111744", 14:07:06 INFO - "pgo_build": "True", 14:07:06 INFO - "basedir": "/builds/slave/test", 14:07:06 INFO - "buildnumber": 946, 14:07:06 INFO - "slavename": "talos-linux64-ix-012", 14:07:06 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:07:06 INFO - "platform": "ubuntu64_hw", 14:07:06 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 14:07:06 INFO - "branch": "mozilla-aurora", 14:07:06 INFO - "repo_path": "releases/mozilla-aurora", 14:07:06 INFO - "revision": "d59e82481c869123324aa0f25fb03f3dd9c60aad", 14:07:06 INFO - "stage_platform": "linux64-pgo", 14:07:06 INFO - "builduid": "4802fb37b1684970a34a9fe48dfe7340", 14:07:06 INFO - "slavebuilddir": "test" 14:07:06 INFO - } 14:07:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/LJSDKVaASkyMyfAxlFofXg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 14:07:06 INFO - Running post-action listener: _resource_record_post_action 14:07:06 INFO - [mozharness: 2016-12-01 22:07:06.232920Z] Finished read-buildbot-config step (success) 14:07:06 INFO - [mozharness: 2016-12-01 22:07:06.233007Z] Running download-and-extract step. 14:07:06 INFO - Running pre-action listener: _resource_record_pre_action 14:07:06 INFO - Running main action method: download_and_extract 14:07:06 INFO - mkdir: /builds/slave/test/build/tests 14:07:06 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')]} 14:07:06 INFO - trying https://queue.taskcluster.net/v1/task/LJSDKVaASkyMyfAxlFofXg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 14:07:06 INFO - Downloading https://queue.taskcluster.net/v1/task/LJSDKVaASkyMyfAxlFofXg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 14:07:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LJSDKVaASkyMyfAxlFofXg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:07:06 INFO - Downloaded 1361 bytes. 14:07:06 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 14:07:06 INFO - Using the following test package requirements: 14:07:06 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 14:07:06 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 14:07:06 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 14:07:06 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 14:07:06 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 14:07:06 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 14:07:06 INFO - u'jsshell-linux-x86_64.zip'], 14:07:06 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 14:07:06 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 14:07:06 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 14:07:06 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 14:07:06 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 14:07:06 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 14:07:06 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 14:07:06 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 14:07:06 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 14:07:06 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 14:07:06 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 14:07:06 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:07:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LJSDKVaASkyMyfAxlFofXg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 14:07:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LJSDKVaASkyMyfAxlFofXg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:07:06 INFO - Fetch https://queue.taskcluster.net/v1/task/LJSDKVaASkyMyfAxlFofXg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 14:07:07 INFO - Http code: 200 14:07:07 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 14:07:07 INFO - x-amz-cf-id: lXbyZMRjeTe6kd3x_uOs4sAHnLe4npbwrudUN4w3owkpIVFecyF_UQ== 14:07:07 INFO - x-amz-version-id: 8ReVcT9V_yCqhsGJgKIRAeunXuDUrVRJ 14:07:07 INFO - Expected file size: 21946684 14:07:07 INFO - Obtained file size: 21946684 14:07:11 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:07:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LJSDKVaASkyMyfAxlFofXg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 14:07:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LJSDKVaASkyMyfAxlFofXg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:07:11 INFO - Fetch https://queue.taskcluster.net/v1/task/LJSDKVaASkyMyfAxlFofXg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 14:07:12 INFO - Http code: 200 14:07:12 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 14:07:12 INFO - x-amz-cf-id: eDTmJ8wXS1Ccwg0ETEmHmf_sZIQUeD18iEIYiU7xXukN_mRiLGl3kg== 14:07:12 INFO - x-amz-version-id: 8ReVcT9V_yCqhsGJgKIRAeunXuDUrVRJ 14:07:12 INFO - Expected file size: 21946684 14:07:12 INFO - Obtained file size: 21946684 14:07:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LJSDKVaASkyMyfAxlFofXg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 14:07:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LJSDKVaASkyMyfAxlFofXg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:07:16 INFO - Fetch https://queue.taskcluster.net/v1/task/LJSDKVaASkyMyfAxlFofXg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 14:07:17 INFO - Http code: 200 14:07:17 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 14:07:17 INFO - x-amz-cf-id: MfY5LOJ-tvQN_SLSWeHbC4Q0UUTD5vmUCgJvER37iWLj4FVXlZfHUw== 14:07:17 INFO - x-amz-version-id: pRQTmeSWsce5UUfHxhntxH1v8GBtVOtQ 14:07:17 INFO - Expected file size: 14409038 14:07:17 INFO - Obtained file size: 14409038 14:07:17 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')]} 14:07:17 INFO - trying https://queue.taskcluster.net/v1/task/LJSDKVaASkyMyfAxlFofXg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 14:07:17 INFO - Downloading https://queue.taskcluster.net/v1/task/LJSDKVaASkyMyfAxlFofXg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 14:07:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LJSDKVaASkyMyfAxlFofXg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:07:19 INFO - Downloaded 64007536 bytes. 14:07:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LJSDKVaASkyMyfAxlFofXg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 14:07:19 INFO - mkdir: /builds/slave/test/properties 14:07:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:07:19 INFO - Writing to file /builds/slave/test/properties/build_url 14:07:19 INFO - Contents: 14:07:19 INFO - build_url:https://queue.taskcluster.net/v1/task/LJSDKVaASkyMyfAxlFofXg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 14:07:19 INFO - Running post-action listener: _resource_record_post_action 14:07:19 INFO - Running post-action listener: set_extra_try_arguments 14:07:19 INFO - [mozharness: 2016-12-01 22:07:19.828313Z] Finished download-and-extract step (success) 14:07:19 INFO - [mozharness: 2016-12-01 22:07:19.828610Z] Running populate-webroot step. 14:07:19 INFO - Running pre-action listener: _resource_record_pre_action 14:07:19 INFO - Running main action method: populate_webroot 14:07:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:07:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:07:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:07:19 INFO - '--tppagecycles', 14:07:19 INFO - '7'], 14:07:19 INFO - 'tests': ['tsvgm']}}, 14:07:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:07:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:07:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:07:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:07:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:07:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:07:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:19 INFO - 'talos_options': ['--disable-e10s'], 14:07:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:07:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:07:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:19 INFO - 'talos_options': ['--disable-e10s'], 14:07:19 INFO - 'tests': ['damp', 'tps']}, 14:07:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:19 INFO - 'tests': ['damp', 'tps']}, 14:07:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:07:19 INFO - 'tests': ['dromaeo_dom']}, 14:07:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:07:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:07:19 INFO - 'tests': ['basic_compositor_video']}, 14:07:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:07:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:07:19 INFO - 'tests': ['a11yr', 14:07:19 INFO - 'ts_paint', 14:07:19 INFO - 'tpaint', 14:07:19 INFO - 'sessionrestore', 14:07:19 INFO - 'sessionrestore_no_auto_restore', 14:07:19 INFO - 'tabpaint']}, 14:07:19 INFO - 'other-e10s': {'tests': ['a11yr', 14:07:19 INFO - 'ts_paint', 14:07:19 INFO - 'tpaint', 14:07:19 INFO - 'sessionrestore', 14:07:19 INFO - 'sessionrestore_no_auto_restore', 14:07:19 INFO - 'tabpaint']}, 14:07:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:07:19 INFO - 'ts_paint', 14:07:19 INFO - 'tpaint', 14:07:19 INFO - 'sessionrestore', 14:07:19 INFO - 'sessionrestore_no_auto_restore', 14:07:19 INFO - 'tabpaint']}, 14:07:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:07:19 INFO - 'ts_paint', 14:07:19 INFO - 'tpaint', 14:07:19 INFO - 'sessionrestore', 14:07:19 INFO - 'sessionrestore_no_auto_restore', 14:07:19 INFO - 'tabpaint']}, 14:07:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:07:19 INFO - 'tests': ['a11yr', 14:07:19 INFO - 'ts_paint', 14:07:19 INFO - 'tpaint', 14:07:19 INFO - 'sessionrestore', 14:07:19 INFO - 'sessionrestore_no_auto_restore', 14:07:19 INFO - 'tabpaint']}, 14:07:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:07:19 INFO - 'tests': ['a11yr', 14:07:19 INFO - 'ts_paint', 14:07:19 INFO - 'tpaint', 14:07:19 INFO - 'sessionrestore', 14:07:19 INFO - 'sessionrestore_no_auto_restore', 14:07:19 INFO - 'tabpaint']}, 14:07:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:07:19 INFO - 'tests': ['tsvgx', 14:07:19 INFO - 'tsvgr_opacity', 14:07:19 INFO - 'tart', 14:07:19 INFO - 'tscrollx', 14:07:19 INFO - 'cart']}, 14:07:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:07:19 INFO - 'tsvgr_opacity', 14:07:19 INFO - 'tart', 14:07:19 INFO - 'tscrollx', 14:07:19 INFO - 'cart']}, 14:07:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:19 INFO - 'talos_options': ['--disable-e10s'], 14:07:19 INFO - 'tests': ['tp5o']}, 14:07:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:19 INFO - 'tests': ['tp5o']}, 14:07:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:19 INFO - 'talos_options': ['--disable-e10s', 14:07:19 INFO - '--xperf_path', 14:07:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:07:19 INFO - 'tests': ['tp5n']}, 14:07:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:19 INFO - 'talos_options': ['--xperf_path', 14:07:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:07:19 INFO - 'tests': ['tp5n']}}, 14:07:19 INFO - 'talos.zip': {'path': '', 14:07:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:07:19 INFO - Running post-action listener: _resource_record_post_action 14:07:19 INFO - [mozharness: 2016-12-01 22:07:19.849074Z] Finished populate-webroot step (success) 14:07:19 INFO - [mozharness: 2016-12-01 22:07:19.849166Z] Running create-virtualenv step. 14:07:19 INFO - Running pre-action listener: _resource_record_pre_action 14:07:19 INFO - Running main action method: create_virtualenv 14:07:19 INFO - Creating virtualenv /builds/slave/test/build/venv 14:07:19 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 14:07:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:07:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:07:19 INFO - Using real prefix '/usr' 14:07:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:07:20 INFO - Installing distribute.............................................................................................................................................................................................done. 14:07:22 INFO - Installing pip.................done. 14:07:22 INFO - Return code: 0 14:07:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:07:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:07:22 INFO - Reading from file tmpfile_stdout 14:07:22 INFO - Output received: 14:07:22 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) 14:07:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:07:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:22 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 0x7fd8920fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x187dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187af60>, '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 0x187bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187c1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480629053.596644-2050541285', '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 14:07:22 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 14:07:22 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 14:07:22 INFO - Using env: {'DISPLAY': ':0', 14:07:22 INFO - 'HOME': '/home/cltbld', 14:07:22 INFO - 'LANG': 'en_US.UTF-8', 14:07:22 INFO - 'LANGUAGE': 'en_US:en', 14:07:22 INFO - 'LOGNAME': 'cltbld', 14:07:22 INFO - 'MAIL': '/var/mail/cltbld', 14:07:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:22 INFO - 'MOZ_NO_REMOTE': '1', 14:07:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:22 INFO - 'NO_EM_RESTART': '1', 14:07:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:22 INFO - 'PWD': '/builds/slave/test', 14:07:22 INFO - 'SHELL': '/bin/bash', 14:07:22 INFO - 'SHLVL': '1', 14:07:22 INFO - 'TERM': 'linux', 14:07:22 INFO - 'TMOUT': '86400', 14:07:22 INFO - 'USER': 'cltbld', 14:07:22 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480629053.596644-2050541285', 14:07:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:22 INFO - '_': '/tools/buildbot/bin/python'} 14:07:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:22 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 14:07:22 INFO - Cleaning up... 14:07:22 INFO - Return code: 0 14:07:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:07:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:22 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 0x7fd8920fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x187dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187af60>, '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 0x187bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187c1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480629053.596644-2050541285', '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 14:07:22 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 14:07:22 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 14:07:22 INFO - Using env: {'DISPLAY': ':0', 14:07:22 INFO - 'HOME': '/home/cltbld', 14:07:22 INFO - 'LANG': 'en_US.UTF-8', 14:07:22 INFO - 'LANGUAGE': 'en_US:en', 14:07:22 INFO - 'LOGNAME': 'cltbld', 14:07:22 INFO - 'MAIL': '/var/mail/cltbld', 14:07:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:22 INFO - 'MOZ_NO_REMOTE': '1', 14:07:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:22 INFO - 'NO_EM_RESTART': '1', 14:07:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:22 INFO - 'PWD': '/builds/slave/test', 14:07:22 INFO - 'SHELL': '/bin/bash', 14:07:22 INFO - 'SHLVL': '1', 14:07:22 INFO - 'TERM': 'linux', 14:07:22 INFO - 'TMOUT': '86400', 14:07:22 INFO - 'USER': 'cltbld', 14:07:22 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480629053.596644-2050541285', 14:07:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:22 INFO - '_': '/tools/buildbot/bin/python'} 14:07:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:23 INFO - Downloading/unpacking psutil>=3.1.1 14:07: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 14:07: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 14:07: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 14:07: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 14:07: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 14:07: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 14:07:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:07:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:07:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:07:25 INFO - Installing collected packages: psutil 14:07:25 INFO - Running setup.py install for psutil 14:07:25 INFO - building 'psutil._psutil_linux' extension 14:07:25 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 14:07:25 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 14:07:25 INFO - building 'psutil._psutil_posix' extension 14:07:25 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 14:07:25 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 14:07:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:07:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:07:25 INFO - Successfully installed psutil 14:07:25 INFO - Cleaning up... 14:07:25 INFO - Return code: 0 14:07:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:07:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8920fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x187dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187af60>, '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 0x187bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187c1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480629053.596644-2050541285', '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 14:07:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:07:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:07:25 INFO - Using env: {'DISPLAY': ':0', 14:07:25 INFO - 'HOME': '/home/cltbld', 14:07:25 INFO - 'LANG': 'en_US.UTF-8', 14:07:25 INFO - 'LANGUAGE': 'en_US:en', 14:07:25 INFO - 'LOGNAME': 'cltbld', 14:07:25 INFO - 'MAIL': '/var/mail/cltbld', 14:07:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:25 INFO - 'MOZ_NO_REMOTE': '1', 14:07:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:25 INFO - 'NO_EM_RESTART': '1', 14:07:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:25 INFO - 'PWD': '/builds/slave/test', 14:07:25 INFO - 'SHELL': '/bin/bash', 14:07:25 INFO - 'SHLVL': '1', 14:07:25 INFO - 'TERM': 'linux', 14:07:25 INFO - 'TMOUT': '86400', 14:07:25 INFO - 'USER': 'cltbld', 14:07:25 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480629053.596644-2050541285', 14:07:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:25 INFO - '_': '/tools/buildbot/bin/python'} 14:07:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:07:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:07:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:07:27 INFO - Installing collected packages: mozsystemmonitor 14:07:27 INFO - Running setup.py install for mozsystemmonitor 14:07:28 INFO - Successfully installed mozsystemmonitor 14:07:28 INFO - Cleaning up... 14:07:28 INFO - Return code: 0 14:07:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:07:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd8920fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x187dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187af60>, '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 0x187bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187c1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480629053.596644-2050541285', '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 14:07:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:07:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:07:28 INFO - Using env: {'DISPLAY': ':0', 14:07:28 INFO - 'HOME': '/home/cltbld', 14:07:28 INFO - 'LANG': 'en_US.UTF-8', 14:07:28 INFO - 'LANGUAGE': 'en_US:en', 14:07:28 INFO - 'LOGNAME': 'cltbld', 14:07:28 INFO - 'MAIL': '/var/mail/cltbld', 14:07:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:28 INFO - 'MOZ_NO_REMOTE': '1', 14:07:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:28 INFO - 'NO_EM_RESTART': '1', 14:07:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:28 INFO - 'PWD': '/builds/slave/test', 14:07:28 INFO - 'SHELL': '/bin/bash', 14:07:28 INFO - 'SHLVL': '1', 14:07:28 INFO - 'TERM': 'linux', 14:07:28 INFO - 'TMOUT': '86400', 14:07:28 INFO - 'USER': 'cltbld', 14:07:28 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480629053.596644-2050541285', 14:07:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:28 INFO - '_': '/tools/buildbot/bin/python'} 14:07:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:28 INFO - Downloading/unpacking jsonschema==2.5.1 14:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:07:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:30 INFO - Downloading functools32-3.2.3-2.tar.gz 14:07:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:07:30 INFO - warning: no files found matching '*.txt' 14:07:30 INFO - no previously-included directories found matching 'build' 14:07:30 INFO - no previously-included directories found matching 'dist' 14:07:30 INFO - no previously-included directories found matching '.git*' 14:07:30 INFO - Installing collected packages: jsonschema, functools32 14:07:30 INFO - Running setup.py install for functools32 14:07:30 INFO - warning: no files found matching '*.txt' 14:07:30 INFO - no previously-included directories found matching 'build' 14:07:30 INFO - no previously-included directories found matching 'dist' 14:07:30 INFO - no previously-included directories found matching '.git*' 14:07:30 INFO - Successfully installed jsonschema functools32 14:07:30 INFO - Cleaning up... 14:07:30 INFO - Return code: 0 14:07:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:07:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8920fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x187dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187af60>, '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 0x187bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187c1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480629053.596644-2050541285', '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 14:07:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:07:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:07:30 INFO - Using env: {'DISPLAY': ':0', 14:07:30 INFO - 'HOME': '/home/cltbld', 14:07:30 INFO - 'LANG': 'en_US.UTF-8', 14:07:30 INFO - 'LANGUAGE': 'en_US:en', 14:07:30 INFO - 'LOGNAME': 'cltbld', 14:07:30 INFO - 'MAIL': '/var/mail/cltbld', 14:07:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:30 INFO - 'MOZ_NO_REMOTE': '1', 14:07:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:30 INFO - 'NO_EM_RESTART': '1', 14:07:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:30 INFO - 'PWD': '/builds/slave/test', 14:07:30 INFO - 'SHELL': '/bin/bash', 14:07:30 INFO - 'SHLVL': '1', 14:07:30 INFO - 'TERM': 'linux', 14:07:30 INFO - 'TMOUT': '86400', 14:07:30 INFO - 'USER': 'cltbld', 14:07:30 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480629053.596644-2050541285', 14:07:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:30 INFO - '_': '/tools/buildbot/bin/python'} 14:07:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:07:30 INFO - Cleaning up... 14:07:30 INFO - Return code: 0 14:07:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:07:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8920fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x187dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187af60>, '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 0x187bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187c1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480629053.596644-2050541285', '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 14:07:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:07:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:07:30 INFO - Using env: {'DISPLAY': ':0', 14:07:30 INFO - 'HOME': '/home/cltbld', 14:07:30 INFO - 'LANG': 'en_US.UTF-8', 14:07:30 INFO - 'LANGUAGE': 'en_US:en', 14:07:30 INFO - 'LOGNAME': 'cltbld', 14:07:30 INFO - 'MAIL': '/var/mail/cltbld', 14:07:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:30 INFO - 'MOZ_NO_REMOTE': '1', 14:07:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:30 INFO - 'NO_EM_RESTART': '1', 14:07:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:30 INFO - 'PWD': '/builds/slave/test', 14:07:30 INFO - 'SHELL': '/bin/bash', 14:07:30 INFO - 'SHLVL': '1', 14:07:30 INFO - 'TERM': 'linux', 14:07:30 INFO - 'TMOUT': '86400', 14:07:30 INFO - 'USER': 'cltbld', 14:07:30 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480629053.596644-2050541285', 14:07:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:30 INFO - '_': '/tools/buildbot/bin/python'} 14:07:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:31 INFO - Downloading/unpacking blobuploader==1.2.4 14:07:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:33 INFO - Downloading blobuploader-1.2.4.tar.gz 14:07:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:07:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:07:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:07:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:07:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:33 INFO - Downloading docopt-0.6.1.tar.gz 14:07:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:07:33 INFO - Installing collected packages: blobuploader, requests, docopt 14:07:33 INFO - Running setup.py install for blobuploader 14:07:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:07:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:07:34 INFO - Running setup.py install for requests 14:07:34 INFO - Running setup.py install for docopt 14:07:34 INFO - Successfully installed blobuploader requests docopt 14:07:34 INFO - Cleaning up... 14:07:34 INFO - Return code: 0 14:07:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:07:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8920fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x187dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187af60>, '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 0x187bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187c1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480629053.596644-2050541285', '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 14:07:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:07:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:07:34 INFO - Using env: {'DISPLAY': ':0', 14:07:34 INFO - 'HOME': '/home/cltbld', 14:07:34 INFO - 'LANG': 'en_US.UTF-8', 14:07:34 INFO - 'LANGUAGE': 'en_US:en', 14:07:34 INFO - 'LOGNAME': 'cltbld', 14:07:34 INFO - 'MAIL': '/var/mail/cltbld', 14:07:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:34 INFO - 'MOZ_NO_REMOTE': '1', 14:07:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:34 INFO - 'NO_EM_RESTART': '1', 14:07:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:34 INFO - 'PWD': '/builds/slave/test', 14:07:34 INFO - 'SHELL': '/bin/bash', 14:07:34 INFO - 'SHLVL': '1', 14:07:34 INFO - 'TERM': 'linux', 14:07:34 INFO - 'TMOUT': '86400', 14:07:34 INFO - 'USER': 'cltbld', 14:07:34 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480629053.596644-2050541285', 14:07:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:34 INFO - '_': '/tools/buildbot/bin/python'} 14:07:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:07:34 INFO - Running setup.py (path:/tmp/pip-rmB7br-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:07:34 INFO - Running setup.py (path:/tmp/pip-waTkQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:07:34 INFO - Running setup.py (path:/tmp/pip-7k29iJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:07:35 INFO - Running setup.py (path:/tmp/pip-4OWP9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:07:35 INFO - Running setup.py (path:/tmp/pip-cZMWX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:07:35 INFO - Running setup.py (path:/tmp/pip-A0nsgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:07:35 INFO - Running setup.py (path:/tmp/pip-IJhjRT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:07:35 INFO - Running setup.py (path:/tmp/pip-zlifNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:07:35 INFO - Running setup.py (path:/tmp/pip-SRZG0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:07:35 INFO - Running setup.py (path:/tmp/pip-Ne4WrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:07:35 INFO - Running setup.py (path:/tmp/pip-C80ep7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:07:35 INFO - Running setup.py (path:/tmp/pip-_PpxXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:07:35 INFO - Running setup.py (path:/tmp/pip-4CqFNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:07:35 INFO - Running setup.py (path:/tmp/pip-S_PK7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:07:35 INFO - Running setup.py (path:/tmp/pip-pguVLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:07:35 INFO - Running setup.py (path:/tmp/pip-drBwit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:07:35 INFO - Running setup.py (path:/tmp/pip-ykBaGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:07:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:07:36 INFO - Running setup.py install for manifestparser 14:07:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:07:36 INFO - Running setup.py install for mozcrash 14:07:36 INFO - Running setup.py install for mozdebug 14:07:36 INFO - Running setup.py install for mozdevice 14:07:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:07:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:07:36 INFO - Running setup.py install for mozfile 14:07:36 INFO - Running setup.py install for mozhttpd 14:07:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:07:36 INFO - Running setup.py install for mozinfo 14:07:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:07:36 INFO - Running setup.py install for mozInstall 14:07:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:07:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:07:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:07:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:07:36 INFO - Running setup.py install for mozleak 14:07:36 INFO - Running setup.py install for mozlog 14:07:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:07:37 INFO - Running setup.py install for moznetwork 14:07:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:07:37 INFO - Running setup.py install for mozprocess 14:07:37 INFO - Running setup.py install for mozprofile 14:07:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:07:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:07:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:07:37 INFO - Running setup.py install for mozrunner 14:07:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:07:37 INFO - Running setup.py install for mozscreenshot 14:07:37 INFO - Running setup.py install for moztest 14:07:37 INFO - Running setup.py install for mozversion 14:07:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:07:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:07:37 INFO - Cleaning up... 14:07:37 INFO - Return code: 0 14:07:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:07:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8920fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x187dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187af60>, '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 0x187bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187c1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480629053.596644-2050541285', '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 14:07:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:07:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:07:37 INFO - Using env: {'DISPLAY': ':0', 14:07:37 INFO - 'HOME': '/home/cltbld', 14:07:37 INFO - 'LANG': 'en_US.UTF-8', 14:07:37 INFO - 'LANGUAGE': 'en_US:en', 14:07:37 INFO - 'LOGNAME': 'cltbld', 14:07:37 INFO - 'MAIL': '/var/mail/cltbld', 14:07:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:37 INFO - 'MOZ_NO_REMOTE': '1', 14:07:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:37 INFO - 'NO_EM_RESTART': '1', 14:07:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:37 INFO - 'PWD': '/builds/slave/test', 14:07:37 INFO - 'SHELL': '/bin/bash', 14:07:37 INFO - 'SHLVL': '1', 14:07:37 INFO - 'TERM': 'linux', 14:07:37 INFO - 'TMOUT': '86400', 14:07:37 INFO - 'USER': 'cltbld', 14:07:37 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480629053.596644-2050541285', 14:07:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:37 INFO - '_': '/tools/buildbot/bin/python'} 14:07:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:07:38 INFO - Running setup.py (path:/tmp/pip-_1fHOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:07:38 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)) 14:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:07:38 INFO - Running setup.py (path:/tmp/pip-iQeYy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:07:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:07:38 INFO - Running setup.py (path:/tmp/pip-XmSMvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:07:38 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)) 14:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:07:38 INFO - Running setup.py (path:/tmp/pip-1KXj1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:07:38 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)) 14:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:07:38 INFO - Running setup.py (path:/tmp/pip-4kxSGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:07:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:07:38 INFO - Running setup.py (path:/tmp/pip-3ZyyZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:07:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:07:38 INFO - Running setup.py (path:/tmp/pip-VPs7yq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:07:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:07:38 INFO - Running setup.py (path:/tmp/pip-5RTpX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:07:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:07:38 INFO - Running setup.py (path:/tmp/pip-RqNjnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:07:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:07:38 INFO - Running setup.py (path:/tmp/pip-ZB3nbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:07:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:07:38 INFO - Running setup.py (path:/tmp/pip-R5AgJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:07:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:07:38 INFO - Running setup.py (path:/tmp/pip-WKKXZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:07:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:07:38 INFO - Running setup.py (path:/tmp/pip-FqRPf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:07:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:07:39 INFO - Running setup.py (path:/tmp/pip-z0qkEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:07:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:07:39 INFO - Running setup.py (path:/tmp/pip-QnhYgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:07:39 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)) 14:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:07:39 INFO - Running setup.py (path:/tmp/pip-spBJzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:07:39 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)) 14:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:07:39 INFO - Running setup.py (path:/tmp/pip-FDm6Lb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:07:39 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)) 14:07:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:07:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:07:39 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)) 14:07:39 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)) 14:07:39 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)) 14:07:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:07:39 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 14:07:39 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 14:07:39 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 14:07:39 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 14:07:39 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 14:07:39 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 14:07:41 INFO - Downloading blessings-1.6.tar.gz 14:07:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:07:41 INFO - Installing collected packages: blessings 14:07:41 INFO - Running setup.py install for blessings 14:07:41 INFO - Successfully installed blessings 14:07:41 INFO - Cleaning up... 14:07:41 INFO - Return code: 0 14:07:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:07:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:07:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:07:41 INFO - Reading from file tmpfile_stdout 14:07:41 INFO - Current package versions: 14:07:41 INFO - argparse == 1.2.1 14:07:41 INFO - blessings == 1.6 14:07:41 INFO - blobuploader == 1.2.4 14:07:41 INFO - docopt == 0.6.1 14:07:41 INFO - functools32 == 3.2.3-2 14:07:41 INFO - jsonschema == 2.5.1 14:07:41 INFO - manifestparser == 1.1 14:07:41 INFO - mozInstall == 1.12 14:07:41 INFO - mozcrash == 1.0 14:07:41 INFO - mozdebug == 0.1 14:07:41 INFO - mozdevice == 0.48 14:07:41 INFO - mozfile == 1.2 14:07:41 INFO - mozhttpd == 0.7 14:07:41 INFO - mozinfo == 0.9 14:07:41 INFO - mozleak == 0.1 14:07:41 INFO - mozlog == 3.4 14:07:41 INFO - moznetwork == 0.27 14:07:41 INFO - mozprocess == 0.23 14:07:41 INFO - mozprofile == 0.28 14:07:41 INFO - mozrunner == 6.13 14:07:41 INFO - mozscreenshot == 0.1 14:07:41 INFO - mozsystemmonitor == 0.3 14:07:41 INFO - moztest == 0.7 14:07:41 INFO - mozversion == 1.4 14:07:41 INFO - psutil == 3.1.1 14:07:41 INFO - requests == 1.2.3 14:07:41 INFO - wsgiref == 0.1.2 14:07:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:07:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8920fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x187dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187af60>, '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 0x187bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187c1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480629053.596644-2050541285', '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 14:07:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:07:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:07:41 INFO - Using env: {'DISPLAY': ':0', 14:07:41 INFO - 'HOME': '/home/cltbld', 14:07:41 INFO - 'LANG': 'en_US.UTF-8', 14:07:41 INFO - 'LANGUAGE': 'en_US:en', 14:07:41 INFO - 'LOGNAME': 'cltbld', 14:07:41 INFO - 'MAIL': '/var/mail/cltbld', 14:07:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:41 INFO - 'MOZ_NO_REMOTE': '1', 14:07:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:41 INFO - 'NO_EM_RESTART': '1', 14:07:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:41 INFO - 'PWD': '/builds/slave/test', 14:07:41 INFO - 'SHELL': '/bin/bash', 14:07:41 INFO - 'SHLVL': '1', 14:07:41 INFO - 'TERM': 'linux', 14:07:41 INFO - 'TMOUT': '86400', 14:07:41 INFO - 'USER': 'cltbld', 14:07:41 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480629053.596644-2050541285', 14:07:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:41 INFO - '_': '/tools/buildbot/bin/python'} 14:07:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:07:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:07:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:07:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:07:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:07:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:07:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:07:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:07:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:07:41 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:07:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:07:41 INFO - Cleaning up... 14:07:41 INFO - Return code: 0 14:07:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:07:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8920fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x187dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187af60>, '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 0x187bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187c1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480629053.596644-2050541285', '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 14:07:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:07:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:07:41 INFO - Using env: {'DISPLAY': ':0', 14:07:41 INFO - 'HOME': '/home/cltbld', 14:07:41 INFO - 'LANG': 'en_US.UTF-8', 14:07:41 INFO - 'LANGUAGE': 'en_US:en', 14:07:41 INFO - 'LOGNAME': 'cltbld', 14:07:41 INFO - 'MAIL': '/var/mail/cltbld', 14:07:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:41 INFO - 'MOZ_NO_REMOTE': '1', 14:07:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:41 INFO - 'NO_EM_RESTART': '1', 14:07:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:41 INFO - 'PWD': '/builds/slave/test', 14:07:41 INFO - 'SHELL': '/bin/bash', 14:07:41 INFO - 'SHLVL': '1', 14:07:41 INFO - 'TERM': 'linux', 14:07:41 INFO - 'TMOUT': '86400', 14:07:41 INFO - 'USER': 'cltbld', 14:07:41 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480629053.596644-2050541285', 14:07:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:41 INFO - '_': '/tools/buildbot/bin/python'} 14:07:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:07:42 INFO - Cleaning up... 14:07:42 INFO - Return code: 0 14:07:42 INFO - Running post-action listener: _resource_record_post_action 14:07:42 INFO - Running post-action listener: _start_resource_monitoring 14:07:42 INFO - Starting resource monitoring. 14:07:42 INFO - [mozharness: 2016-12-01 22:07:42.233813Z] Finished create-virtualenv step (success) 14:07:42 INFO - [mozharness: 2016-12-01 22:07:42.234317Z] Running install step. 14:07:42 INFO - Running pre-action listener: _resource_record_pre_action 14:07:42 INFO - Running main action method: install 14:07:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:07:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:07:42 INFO - Reading from file tmpfile_stdout 14:07:42 INFO - Detecting whether we're running mozinstall >=1.0... 14:07:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:07:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:07:42 INFO - Reading from file tmpfile_stdout 14:07:42 INFO - Output received: 14:07:42 INFO - Usage: mozinstall [options] installer 14:07:42 INFO - Options: 14:07:42 INFO - -h, --help show this help message and exit 14:07:42 INFO - -d DEST, --destination=DEST 14:07:42 INFO - Directory to install application into. [default: 14:07:42 INFO - "/builds/slave/test"] 14:07:42 INFO - --app=APP Application being installed. [default: firefox] 14:07:42 INFO - mkdir: /builds/slave/test/build/application 14:07:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:07:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:07:58 INFO - Reading from file tmpfile_stdout 14:07:58 INFO - Output received: 14:07:58 INFO - /builds/slave/test/build/application/firefox/firefox 14:07:58 INFO - Running post-action listener: _resource_record_post_action 14:07:58 INFO - [mozharness: 2016-12-01 22:07:58.511701Z] Finished install step (success) 14:07:58 INFO - [mozharness: 2016-12-01 22:07:58.511943Z] Running run-tests step. 14:07:58 INFO - Running pre-action listener: _resource_record_pre_action 14:07:58 INFO - Running main action method: run_tests 14:07:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:07:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:07:58 INFO - Python 2.7.3 14:07:58 INFO - Return code: 0 14:07:58 INFO - grabbing minidump binary from tooltool 14:07:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:58 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187af60>, '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 0x187bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187c1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:07:58 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:07:58 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:07:58 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:07:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:07:58 INFO - Return code: 0 14:07:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:07:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:07:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:07:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:07:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:07:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LJSDKVaASkyMyfAxlFofXg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:07:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LJSDKVaASkyMyfAxlFofXg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:07:58 INFO - Using env: {'DISPLAY': ':0', 14:07:58 INFO - 'HOME': '/home/cltbld', 14:07:58 INFO - 'LANG': 'en_US.UTF-8', 14:07:58 INFO - 'LANGUAGE': 'en_US:en', 14:07:58 INFO - 'LOGNAME': 'cltbld', 14:07:58 INFO - 'MAIL': '/var/mail/cltbld', 14:07:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:07:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:07:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:58 INFO - 'MOZ_NO_REMOTE': '1', 14:07:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:07:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:58 INFO - 'NO_EM_RESTART': '1', 14:07:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:58 INFO - 'PWD': '/builds/slave/test', 14:07:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:07:58 INFO - 'SHELL': '/bin/bash', 14:07:58 INFO - 'SHLVL': '1', 14:07:58 INFO - 'TERM': 'linux', 14:07:58 INFO - 'TMOUT': '86400', 14:07:58 INFO - 'USER': 'cltbld', 14:07:58 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1480629053.596644-2050541285', 14:07:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:58 INFO - '_': '/tools/buildbot/bin/python'} 14:07:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LJSDKVaASkyMyfAxlFofXg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:07:58 INFO - mozversion application_buildid: 20161201111744 14:07:58 INFO - mozversion application_changeset: d59e82481c869123324aa0f25fb03f3dd9c60aad 14:07:58 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:07:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:07:58 INFO - mozversion application_name: Firefox 14:07:58 INFO - mozversion application_remotingname: firefox-dev 14:07:58 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:07:58 INFO - mozversion application_vendor: Mozilla 14:07:58 INFO - mozversion application_version: 52.0a2 14:07:58 INFO - mozversion platform_buildid: 20161201111744 14:07:58 INFO - mozversion platform_changeset: d59e82481c869123324aa0f25fb03f3dd9c60aad 14:07:58 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:07:58 INFO - mozversion platform_version: 52.0a2 14:07:58 INFO - using testdate: 1480630078 14:07:58 INFO - actual date: 1480630078 14:07:58 INFO - starting webserver on 'localhost:43923' 14:07:58 INFO - SUITE-START | Running 2 tests 14:07:58 INFO - TEST-START | dromaeo_css 14:07:58 INFO - operating with platform_type : linux_ 14:07:58 INFO - Initialising browser for dromaeo_css test... 14:07:58 INFO - TEST-INFO | started process 22512 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpscrMI5/profile http://localhost:43923/getInfo.html) 14:08:02 INFO - PROCESS | 22512 | __metrics Screen width/height:1600/1200 14:08:02 INFO - PROCESS | 22512 | colorDepth:24 14:08:02 INFO - PROCESS | 22512 | Browser inner width/height: 1024/697 14:08:02 INFO - PROCESS | 22512 | __metrics 14:08:02 INFO - PROCESS | 22512 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:08:02 INFO - PROCESS | 22512 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:08:03 INFO - PROCESS | 22512 | console.error: PushService: 14:08:03 INFO - PROCESS | 22512 | stateChangeProcessEnqueue: Error transitioning state 14:08:03 INFO - PROCESS | 22512 | UnknownError 14:08:03 INFO - TEST-INFO | 22512: exit 0 14:08:03 INFO - Browser initialized. 14:08:03 INFO - Running cycle 1/1 for dromaeo_css test... 14:08:03 INFO - TEST-INFO | started process 22605 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpscrMI5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:08:15 INFO - PROCESS | 22605 | RSS: Main: 144896000 14:08:15 INFO - PROCESS | 22605 | 14:09:07 INFO - PROCESS | 22605 | 1480630147375 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] 14:11:17 INFO - PROCESS | 22605 | Cycle 1(1): loaded http://localhost:43923/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43923/tests/dromaeo/cssquery-ext.html) 14:11:18 INFO - PROCESS | 22605 | RSS: Main: 248696832 14:11:18 INFO - PROCESS | 22605 | 14:14:21 INFO - PROCESS | 22605 | Cycle 1(1): loaded http://localhost:43923/tests/dromaeo/cssquery-ext.html (next: http://localhost:43923/tests/dromaeo/cssquery-jquery.html) 14:14:21 INFO - PROCESS | 22605 | RSS: Main: 225783808 14:14:21 INFO - PROCESS | 22605 | 14:17:23 INFO - PROCESS | 22605 | Cycle 1(1): loaded http://localhost:43923/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43923/tests/dromaeo/cssquery-mootools.html) 14:17:24 INFO - PROCESS | 22605 | RSS: Main: 174526464 14:17:24 INFO - PROCESS | 22605 | 14:20:26 INFO - PROCESS | 22605 | Cycle 1(1): loaded http://localhost:43923/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43923/tests/dromaeo/cssquery-prototype.html) 14:20:26 INFO - PROCESS | 22605 | RSS: Main: 219361280 14:20:26 INFO - PROCESS | 22605 | 14:23:29 INFO - PROCESS | 22605 | Cycle 1(1): loaded http://localhost:43923/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43923/tests/dromaeo/cssquery-yui.html) 14:23:30 INFO - PROCESS | 22605 | RSS: Main: 174505984 14:23:30 INFO - PROCESS | 22605 | 14:26:32 INFO - PROCESS | 22605 | Cycle 1(1): loaded http://localhost:43923/tests/dromaeo/cssquery-yui.html (next: http://localhost:43923/tests/dromaeo/cssquery-dojo.html) 14:26:33 INFO - PROCESS | 22605 | RSS: Main: 264876032 14:26:33 INFO - PROCESS | 22605 | 14:26:33 INFO - PROCESS | 22605 | __start_tp_report 14:26:33 INFO - PROCESS | 22605 | _x_x_mozilla_page_load 14:26:33 INFO - PROCESS | 22605 | _x_x_mozilla_page_load_details 14:26:33 INFO - PROCESS | 22605 | |i|pagename|runs| 14:26:33 INFO - PROCESS | 22605 | |0;dojo.html;3226.6289376721675;3248.0418276608407;3249.301400198957;3271.967280327196;3288.8355582220884;5428.837134885955;5452.59105567083;5484.369297530785;5489.560835133189;5495.999999999995;5589.776408943638;5592.189132575774;5619.213310136574;5627.983612840923;5667;5044.142495775718;5059.443461219263;5087.872803179913;5136.203888397305;5144.4083930348115;4948.703077815325;4954;5120.743962801845;5168.095583272912;5175.223716442526;5020.7489625518765;5038.345015148044;5078.339815823956;5086.567641750456;5113.411957624865;5128.358955130609;5140.8971820563565;5185.274061631375;5196.090684130262;5225.137852254374;4837.685550439245;5071.949280507221;5089.262057001751;5129.025485157846;5154.123798954187;5437.075697131458;5465.9180112298345;5468.507834294893;5500.889982200373;5557.805476808292;5892.499137573312;5899.882002359929;5975.551833612453;5976.521878249773;5978.192943952554;5878.177055212273;6028.668423236721;6030.728617212192;6042.879142417171;6055.909161362583;5492.670439773627;5525.309336332918;5529.087700529368;5530.834074977757;5552.444755524415;6050.727717252734;6057;6059.151718759377;6065.484433823174;6070.848228794315;5602.831915042555;5826.504747096545;5828.184054232411;5844.503217226584;5844.707764611752;5727.971360143172;5895.616784908967;5939.732712027969;5944.762209511658;6017.2779266488305;5945;5954.583179177416;5956.434138756811;5961.105834124916;5992.520598352121;5726.914096288559;5911.76352945886;5967.6121052131475;5977.6114552553945;5978.880422391528;4485.035717320727;4514.751688657089;4526.388937493396;4535.387722657465;4572.634189264851;4073.490813648294;4083.5099788025627;4095.508538975342;4115.279826030433;4134.028503301722;5541.5289700375115;5576.219329293902;5589.077802162679;5600.215969764155;5617.522510586564;5741.282339707536;5780.653160810365;5880.176775251468;5885.411458854166;5910.408959104056;5612.298462692163;5612.522935550524;5624.437556244425;5626.578006649518;5653.038983372837;5142.357205349332;5153.742312884341;5156.226566015052;5156.587473002151;5198.454162312978;5896.587238893237;6008.939910600838;6127.22007048413;6164.352742961924;6173.567850250529;5947.732352044255;6058.454739073504;6078.057901025348;6084.939150608438;6110.7861224856915;6224.604909800553;6245.094461303176;6248.593841400295;6252.656103914146;6266.561340706106;5712.000399930079;5753.626014309057;5921.703914804329;5924.644521328734;5959.28488581373;5987.161797348462;6008.489278411384;6035.939640603538;6093.908591371044;6116.602420842631;5891.764329426775;5927.733252003756;5930.940690593039;5937.287525496968;5947.988841896801;5563.860903477445;5923.08192230205;5929.0513517836935;5934.851628709144;5947.583669143119;5637.774489020558;5746.454086861741;5850.0932355484965;5858.355580886185;5881.05903055509;5941.405859414024;5957.225560677084;5963.2844058713235;5970.462658360769;5980.611260268242;5605.131204663284;5645.435456454322;5658.981383351036;5810.389909059488;5822.94177058224 14:26:33 INFO - PROCESS | 22605 | |1;ext.html;591.4263164730211;623.4918541388768;625.50272533336;658.3087757854255;678.291185710932;34537.48193777092;44929.326060109124;45587.77206113969;45608.3158752619;46223.76888115555;46842.765786171105;47147.52852471474;47159.76420117894;47176.292355614605;47298.290525642056;8167;8791.78020549485;8940.284777217807;8950.060243674418;8951.462912225288;8235.258826705594;10482.528286227138;10705.732356691105;10719.785604287948;11040.061594764455;10538.315009524395;10560.207984401162;10569.471526423686;10578.682639520826;10586.41774702391;10722.946385268062;10778.5688572457;10784.299020563716;10798.190135739851;10804.405757683324;10714.250002499828;10767.56929722818;10777.353358798497;10780;10781;43456.56543434557;43681;43802;43806.34290485645;43882.12235755299;3470.8958731238104;3494.3011397720556;3554.289142171576;3565.090901820045;3566.35805555;32834;32964;33114.50328245078;33216.33567328664;34041.31917361663;4136.855210067663;4257.531671516131;4378.715383500063;4380.78096095194;4397.428334316551;356405;362517;363683.181584093;364209;364389;64377.356226437136;65114;65172.674136629015;65214;65290.67354663291;39317;40256.396154057715;40355.79822100871;42550;68621.65689171522;17479;17595.29618815233;17626.383076592258;17639.118044098;17658.735118973225;11799.705007374712;12185.756284874253;12372.690682733004;13135.474581016651;13238.53665121716;19744.506387340432;20898.268560600307;20901.895490522755;20961.68557471639;20966.79033209679;7349.963250183715;7393;7519.8496030079095;7574.280443357872;7602.239776022354;950.0879156010308;1026.6201505442884;1077.6928575355985;1120.1654767198327;1194.2476239968764;33026.17434564107;33582.32835343279;33984.66015339865;34044.65955340464;34225;985.4235272365603;1149.4252873563219;1156.4275683536703;1158.6813626252679;1190.4285942747529;16420.75368869468;17827.197776100107;17954.371596994042;18385.172667230006;18671.626567468575;547092;550341;550586;551001;551412;61339.6933015332;61987.6900615494;62023.37976620266;62095;62114.68942655348;1316.6510874618234;1340.5978206538196;1392.0742706100532;1392.5335012770634;1423.6085076604018;30234.84882575573;34695.47956780701;35338.46992295169;35432.82283588566;35573.28853422865;52235.73882130565;52804.47195527996;52828.73585632047;52877;52981;443830;447917;448604;448886;449908;29617.25956851096;30391.39217215599;32303.35393292074;32388;32739.672603274616;50116.498835012644;50150.74924625354;50702.74648626733;51040.48959510357;51147.74426127846;42553.1489370217;42772.35841462318;43261;43336.783316083216;44700.32949505825;42758;42983.355249671906;43519;43851.78074109609;43993.34009989789;40902.38646420366;43368.56631433645;43788;44419;44535;36654.63345366512;39280.80359598184;39402.80298598488;39605.2078958425;39754.80122599369;20756.377308680763;20801.687974680088;20854;20863.374098776454;20909.26817561378 14:26:33 INFO - PROCESS | 22605 | |2;jquery.html;396.9639241579479;430.1117992679159;433.88502046957564;442.69896470400136;450.3942197744033;16628.667426651475;19350.709739353904;19912.800871991294;21002;21023.2641857535;19947.60104797903;20697.793022069774;20798.584028319463;20802;20957.895210523926;5632.042552766029;5874.9118763218585;5878.2064421303;5879.588428809985;5880.206172166767;5677.716114194273;5922.615030023035;5952.55355848311;5955.374685658008;5960.612560183574;5892.297028419279;5939.1388248703915;5948.107783832416;5953.285605727318;6540.476761859064;6442.871142577169;6461.709223084949;6488.416042556169;6605.042268870987;6622.834429139262;5722.799702010409;5801.477866991949;5829.883402331972;5844.064949608085;5963.493103086243;14814.703705925822;15076.623084422867;15086.245687715571;23467;24289.392765180834;2219.7225346831647;2227.7883601058033;2377.2749311459997;2408.963865542018;2640.6699162604673;10384.428856412895;10619.78760424795;10635.893641063567;11292.943535282353;11318.490667919963;1943;1977.4858536780541;1983.5735316906935;2022.8482863785275;2096.496840758207;75960.24039759643;78204.21795782026;84041;87609.56195218983;87825;10597.993190646876;11043.116550675926;11312.151588630886;11457.942710286396;11852.88147118535;14929.477468288558;15896.364145434052;15940.123293218752;16507.09210993383;16518.6696266074;8292.792680182924;8449.662013519513;8493.27807136388;8621.870671939925;8673.783155421039;8083.110857805636;8158.979314152739;8171.305439037629;8309.792255193668;8349;5048.0913435581215;5064.1137800885435;5085.186370180753;5103.8468845934685;5197.246399272084;1984.7915968823065;2059.4954236212225;2080.209520382245;2112.6725357569603;2114.873107613548;921.5898924978454;973.6251543155936;1007.4207330784828;1026.6150193677372;1063.2663462211049;19230.615387692167;19955.900220499094;20025.499362516053;20154.193832246838;20466.69299960472;967.5404183013012;997.4314640654902;1007;1013.3767732844395;1015.4871789746131;11202.60790872332;11638.76722465546;11688.649340519798;11722.765544689059;11731.35477548726;472160;479213;481503;483642;484595;100172.4991375053;100515.49742251242;101361;102654;103399.48300258601;981.5435822342645;1016.7356487313352;1016.9999999999852;1031.3605564550028;1041.0162396535202;17449.30202791874;17828;18019.09904504796;18296.634067318846;18436.98596577201;43492.78253608838;44502;44784;45943;46230.537694622624;57837.71081144567;58886.705566471894;60680.393196067474;61455;62444.68777656083;7709.267619576131;8121.269085782072;8388.832223355377;8591.828163436821;8946.060663630225;10359.792804144026;13779.862201377859;13890.236037018061;13941.166179300773;14188.858111418755;11116.49975751077;11204.159688023268;12122.818157727464;12225.144239903122;12448.502059917864;11747.588834390755;11905.46425410876;12017.579384721494;12071.637850864488;12311.69220769488;11930.284182949052;12177.391130443619;12315.75368492643;12465.065120116209;12736.172148810298;7881.330086942674;8015.799605009922;8227.629756660845;8414.789630259293;8502.74491765248;11390;11619.302841829518;11622.418879055844;11669.824952625888;11875.168738188244 14:26:33 INFO - PROCESS | 22605 | |3;mootools.html;1353.2083731017353;1523.520091171281;1535.5009621872887;1724.3619860651554;1822.735703323019;7821.960890195548;8509.957450212749;8722.47665140092;8756.649734010647;9013.864792028126;8834.249088827457;8926.107389261071;8937.865932011026;8941.865872011926;8949.955250223757;2411;2435.415500279938;2440.0727723465056;2441.389652586853;2449.424385269469;2386.95226095478;2448.902043918241;2450.4853980664084;2452.411421258903;2455.1284294075613;2190.4414374334524;2221.44463884029;2223.4107961390246;2226.576950379431;2245.719285089364;2357.97642023581;2374.0385144016614;2394.9521009579885;2395.964060539093;2397.6043952747864;2357.4577847095265;2374.1927744566756;2386.952260954771;2393.246127469841;2395.4250979764906;8717.607707653107;8737.650493980233;8804.735857924272;8815.294776417872;8816.118388161196;5411.188321751769;5533.944660553383;5541.362743284533;5545.861353466155;5564.8330550083565;3472.670096340869;3583.7133029357587;3596.2447885943984;3655.0679576708035;3656.652618001312;1152.487143221267;1169.631566056698;1188.5186499467643;1194.1044216837372;1229.391451231646;12763;12822.42299096543;12843.871561284455;12850.871491285061;12903.16129451592;4440.3339499074755;4700.929486057712;4759.23852183649;4770.856874293777;4783.062859541891;9888.653897113567;9962.103410693073;10007.199424046059;10007.49962501872;10013.198944084455;5481.013417584793;5485.396606373296;5491.148871924858;5495.0383682855345;5496.7526461309335;4303.483581970184;4417.757023363682;4576.993061526458;5087.872803179876;5125.461826508163;3893.201893611803;3910.7066969977363;4008.819603117867;4016.758994460342;4029.234445455354;1177.9234349767237;1196.1268274159738;1201.615483045417;1207.5471698113208;1212.9575464858865;864.004150412549;866.4021824940771;868.8522951098329;894.3918135667678;898.4743924804063;6022;6040.969795150996;6240.469560087353;6415.358464153547;6491.058796474579;964.3587014635189;966.6036924860914;977.2865807960087;993.7366597851575;1014.9797004059877;4040.373742069984;4076.3477843544892;4099.2878820345895;4261.169072030924;4325.1565944641125;10973;11029;11186.38474883873;11272.267302625303;11358.60244891425;11172.162087843444;11188.776224475629;11189.888101118884;11190.552377904793;11214.775704485864;8050.4364694472;8309.584520773937;8450.957745211235;8600.182982616641;8619.956900215584;5860.38465961085;6021.946159422171;6108.602940808833;6113.633182009094;6227.595206311576;10297.485125743833;10304.227182961458;10310.484475776031;10314.123299519324;10509.527071281964;8721.563921803758;8933.865992009994;10266.897331026594;10379.792404151724;10543;7569.962150189434;7986.600669966595;8058.476199047043;8061.556614386265;8065.87901181471;8482.915170848459;8532.573371331533;8580.570971451278;8590.914090859262;8597.570121493774;7673.6546855390525;7780.84438311242;7821.413393995359;8051.51690898548;8120.269175773972;7576.204498527795;7858.292753652198;7915.564643944408;7985.960070199844;8139.674413023413;7006.859862802818;7118.5017048806085;7119.1457025157315;7124;7126.824074027727;5153.510416510426;5262.842114736564;5322.600804939568;5327.09439395296;5356.80427905679;5330.067238233216;5368.624196306221;5375.274337964324;5403.756830942696;5493.340799104133 14:26:33 INFO - PROCESS | 22605 | |4;prototype.html;355.28587539046526;363.9599644039156;366.19985332049464;368.5154022460466;369.0957154970322;5199;5284.682919024852;5330.36035675719;5344.812931547397;5378;5111.386633603964;5198.220266959958;5203.2975548301065;5213.504717051874;5254.264402983586;4124.938125928114;4151.626353628165;4151.854685086023;4153.979230103845;4178.6657067434535;4064.9187016259657;4191.098913733546;4206.390073439349;4216.704830661855;4220.472440944882;4168;4171.290880550314;4181.623653871151;4189.685773566995;4200.894977625553;4169.1661667666585;4180.435641188446;4182.121754431573;4184.330507118877;4191.790410479494;3574.8748793792092;3697.352963231424;3709.4420343455813;3732.6453986871475;3747.1194269346684;5186.611004174702;5189.688618682853;5199.14214154664;5199.948000520022;5204.739763011834;4775.2598347256235;4790.688605240648;4791.880202994918;4798.2802579613335;4802.711837289774;5351.170568561879;5501.807436739735;5510.972445137789;5537.695426751527;5577.159537352704;4070.5115386153852;4094.7133700640966;4101.507819061701;4109.547949725527;4145.3781932710035;5797.36229014808;5806.912896306559;5810.883782324372;5815.709214539256;5838.883222335529;4072.6538244249573;4183.581641835792;4204.747715137101;4217.156568686275;4224.817051225662;4240.151969606091;4242.618164365222;4251.617354438054;4252.851150209728;4255;4758.976205118952;4761.595264402496;4774.928376074362;4781.402324709411;4785.306130611042;5400.783968641211;5532.6680399176175;5592.384837667853;5599.916001259984;5603.215549823028;1352.2157148853642;1386.2237147197602;1390.367382840805;1399.4542128569865;1399.5661344983089;946.186279799372;981.6613268422383;984.4733067808688;986.9259805514615;994.627014869424;5129.79480820763;5167.9224811627855;5184.533391994739;5187.172990720067;5200.945626477595;5482.479164479368;5487.533559647395;5495.340559132929;5502.339719233718;5540.252065971123;5181.326427564392;5202.947970520322;5206;5209.713465759344;5449.727513624303;2941.7205365490245;2955.7142642950384;2955.7930944834084;2957.704229577025;2965.2142182321704;5783.710814459344;5802.854928626733;5814.156947242626;5839.941600583939;5852.561057920673;5523.8066667666435;5625.86498923291;5660;5661.065924122474;5697.658140511582;5763.279590051244;5769;5777.768889244383;5778.925857270614;5789.507891829073;5347.224652425454;5480.958617862593;5526.861828454321;5536.97231513856;5543.77824887;5437.32033495813;5483.285773542122;5489.945100548944;5493.587980901529;5496.642718223303;5735.684537350486;5759.049756790083;5771.528260293599;5806;5819.246585952122;3969.622885825842;4082;4084.897877553085;4098.139390727981;4104.076582768853;5504.422035686195;5529.336479622471;5530.446955304437;5534.640248383842;5537.2524709165355;5468.207109969112;5522.972385138049;5550.361708403424;5585.826976335015;5622.662640241599;5594.608377413705;5610;5621.8594535136945;5633.774649013993;5637.43625637433;5310.362756469249;5502.972485137549;5551.444855514416;5555.638883472561;5608.439156084359;5642.463965923231;5670.291213598301;5693.743781529924;5700.315962084576;5716.971415142898;5447.155690867922;5573.7213139343685;5579.4978451937895;5601.327840659147;5614.6631202128 14:26:33 INFO - PROCESS | 22605 | |5;yui.html;774.9728759493419;793.3335997761878;822.8354329134174;848.889644346235;895.4627223665801;15189.4683686071;15739.213039348015;15871.84128158718;15927.761083583755;15945.521634350958;14503.637409064779;14756.704865902675;14802.259887005634;14810.55568332949;14821.925890370532;723.7792473295643;745.6681776609411;828.5277391886627;850.4047166983121;853.8292341531687;858.6865793985181;858.952757598335;860.2558786649565;862.0129951205865;862.1550880137469;895.7671005538574;900.572228191607;901.6799036342103;901.711452335253;901.7204666553357;755.9886601700979;779.6062988190984;867.2758246863876;883.3772190605607;892.8660700894853;658.7463826426812;664.3622122762106;664.3854434647932;665.2216906219686;665.9700313485905;14530.491432799907;14787.556373308711;14830.480933167288;14839.406423743038;14848.183349915751;13019.15375500599;13574.932125339408;13598.320083995859;13679.794803077863;13709.931450342785;11851.525938962432;12131.93934030333;12144.210626309261;12167.330796806173;12257.080718946025;4347.869563913087;4371.650267978554;4402.8679139625865;4419.513853476115;4433.556644335573;60564.69717651427;61173;61214;66105.00842487415;66244.6687766563;10533.209354409768;10707.785844283226;10830.620928267474;10865.728356791144;11328.716782080513;19012.144453499626;19114.52213694669;19135.90432047831;20537.89731051365;21481.462963425725;7552.848943021108;8018.679252829821;8043.959780201179;8061.677532898736;8311.542865142475;4601.263797792404;4646.09401166776;4661.091087238024;4758.07217592573;4772.188727916263;3288.1122097033667;3396.1679388549965;3423.4864770284657;3428;3481.9477707834403;612.4396177497629;615.4891440104702;616.5437576193584;619.1393962392278;622.5082185073832;554.0856341340658;617.3425302053299;642.00809748938;652.8628987912497;666.2837449741547;8710.825783484295;9041.547922603844;9052.321075919332;9213.216876565433;9564.282678799118;656.3731636287334;666.576723780403;675.6317806795308;688.8932215506604;727.1165533876366;4365.650747940157;4436.6672499562665;4531.410916580823;4579.244424669959;4642.3500709900645;72655.63672181606;73720;75266;93207;95594;47199.5280047202;53273;68754.74108675758;69357;71542.64228678927;63017.68491157515;67643.3235667637;68873.65563172151;69332.653336733;71246;9821.066998635119;10088.394696318244;10214.591416343263;10236.283460157718;10269.589216431557;43832.78083609562;45315;46501.3024804635;47411.76294118507;47912.7604361976;59169.40830591639;62864.68567657316;64528;65734.34265657474;66410.33589664042;12065.879341206475;12086.697832553904;12257.325847078497;12299.385030748248;12421.813672795097;13197.768526722719;13338.19970801755;13468.191908485522;13542.322883855571;13779.173249605055;10628.681139565826;10899.836502452628;12193.451294691582;12268.815967760313;13531.526396576073;12752.48990040388;13603.319834008458;13612.727745445234;13742.587722368346;14398.20809855468;11663.59177428786;11770.52917883275;11813.70465738329;12113.33376664292;13138.474461021453;10828.296160749525;11117.777644447227;11397.829032564685;11428.94285528567;11542.480588373375;11022.669319920415;11209.215354925404;11376.488058037243;11594.246373985665;11712.180147389601 14:26:33 INFO - PROCESS | 22605 | __end_tp_report 14:26:33 INFO - PROCESS | 22605 | __start_cc_report 14:26:33 INFO - PROCESS | 22605 | _x_x_mozilla_cycle_collect,1006 14:26:33 INFO - PROCESS | 22605 | __end_cc_report 14:26:33 INFO - PROCESS | 22605 | __startTimestamp1480631193066__endTimestamp 14:26:33 INFO - PROCESS | 22605 | 14:26:33 INFO - PROCESS | 22605 | ------- Summary: start ------- 14:26:33 INFO - PROCESS | 22605 | Number of tests: 6 14:26:33 INFO - PROCESS | 22605 | 14:26:33 INFO - PROCESS | 22605 | [#0] dojo.html Cycles:165 Average:5538.75 Median:5726.91 stddev:624.96 (10.9%) stddev-sans-first:599.98 14:26:33 INFO - PROCESS | 22605 | Values: 3226.6 3248.0 3249.3 3272.0 3288.8 5428.8 5452.6 5484.4 5489.6 5496.0 5589.8 5592.2 5619.2 5628.0 5667.0 5044.1 5059.4 5087.9 5136.2 5144.4 4948.7 4954.0 5120.7 5168.1 5175.2 5020.7 5038.3 5078.3 5086.6 5113.4 5128.4 5140.9 5185.3 5196.1 5225.1 4837.7 5071.9 5089.3 5129.0 5154.1 5437.1 5465.9 5468.5 5500.9 5557.8 5892.5 5899.9 5975.6 5976.5 5978.2 5878.2 6028.7 6030.7 6042.9 6055.9 5492.7 5525.3 5529.1 5530.8 5552.4 6050.7 6057.0 6059.2 6065.5 6070.8 5602.8 5826.5 5828.2 5844.5 5844.7 5728.0 5895.6 5939.7 5944.8 6017.3 5945.0 5954.6 5956.4 5961.1 5992.5 5726.9 5911.8 5967.6 5977.6 5978.9 4485.0 4514.8 4526.4 4535.4 4572.6 4073.5 4083.5 4095.5 4115.3 4134.0 5541.5 5576.2 5589.1 5600.2 5617.5 5741.3 5780.7 5880.2 5885.4 5910.4 5612.3 5612.5 5624.4 5626.6 5653.0 5142.4 5153.7 5156.2 5156.6 5198.5 5896.6 6008.9 6127.2 6164.4 6173.6 5947.7 6058.5 6078.1 6084.9 6110.8 6224.6 6245.1 6248.6 6252.7 6266.6 5712.0 5753.6 5921.7 5924.6 5959.3 5987.2 6008.5 6035.9 6093.9 6116.6 5891.8 5927.7 5930.9 5937.3 5948.0 5563.9 5923.1 5929.1 5934.9 5947.6 5637.8 5746.5 5850.1 5858.4 5881.1 5941.4 5957.2 5963.3 5970.5 5980.6 5605.1 5645.4 5659.0 5810.4 5822.9 14:26:33 INFO - PROCESS | 22605 | 14:26:33 INFO - PROCESS | 22605 | [#1] ext.html Cycles:180 Average:62026.05 Median:39359.90 stddev:121838.23 (309.5%) stddev-sans-first:122092.71 14:26:33 INFO - PROCESS | 22605 | Values: 591.4 623.5 625.5 658.3 678.3 34537.5 44929.3 45587.8 45608.3 46223.8 46842.8 47147.5 47159.8 47176.3 47298.3 8167.0 8791.8 8940.3 8950.1 8951.5 8235.3 10482.5 10705.7 10719.8 11040.1 10538.3 10560.2 10569.5 10578.7 10586.4 10722.9 10778.6 10784.3 10798.2 10804.4 10714.3 10767.6 10777.4 10780.0 10781.0 43456.6 43681.0 43802.0 43806.3 43882.1 3470.9 3494.3 3554.3 3565.1 3566.4 32834.0 32964.0 33114.5 33216.3 34041.3 4136.9 4257.5 4378.7 4380.8 4397.4 356405.0 362517.0 363683.2 364209.0 364389.0 64377.4 65114.0 65172.7 65214.0 65290.7 39317.0 40256.4 40355.8 42550.0 68621.7 17479.0 17595.3 17626.4 17639.1 17658.7 11799.7 12185.8 12372.7 13135.5 13238.5 19744.5 20898.3 20901.9 20961.7 20966.8 7350.0 7393.0 7519.8 7574.3 7602.2 950.1 1026.6 1077.7 1120.2 1194.2 33026.2 33582.3 33984.7 34044.7 34225.0 985.4 1149.4 1156.4 1158.7 1190.4 16420.8 17827.2 17954.4 18385.2 18671.6 547092.0 550341.0 550586.0 551001.0 551412.0 61339.7 61987.7 62023.4 62095.0 62114.7 1316.7 1340.6 1392.1 1392.5 1423.6 30234.8 34695.5 35338.5 35432.8 35573.3 52235.7 52804.5 52828.7 52877.0 52981.0 443830.0 447917.0 448604.0 448886.0 449908.0 29617.3 30391.4 32303.4 32388.0 32739.7 50116.5 50150.7 50702.7 51040.5 51147.7 42553.1 42772.4 43261.0 43336.8 44700.3 42758.0 42983.4 43519.0 43851.8 43993.3 40902.4 43368.6 43788.0 44419.0 44535.0 36654.6 39280.8 39402.8 39605.2 39754.8 20756.4 20801.7 20854.0 20863.4 20909.3 14:26:33 INFO - PROCESS | 22605 | 14:26:33 INFO - PROCESS | 22605 | [#2] jquery.html Cycles:180 Average:29323.95 Median:11567.97 stddev:79509.04 (687.3%) stddev-sans-first:79702.42 14:26:33 INFO - PROCESS | 22605 | Values: 397.0 430.1 433.9 442.7 450.4 16628.7 19350.7 19912.8 21002.0 21023.3 19947.6 20697.8 20798.6 20802.0 20957.9 5632.0 5874.9 5878.2 5879.6 5880.2 5677.7 5922.6 5952.6 5955.4 5960.6 5892.3 5939.1 5948.1 5953.3 6540.5 6442.9 6461.7 6488.4 6605.0 6622.8 5722.8 5801.5 5829.9 5844.1 5963.5 14814.7 15076.6 15086.2 23467.0 24289.4 2219.7 2227.8 2377.3 2409.0 2640.7 10384.4 10619.8 10635.9 11292.9 11318.5 1943.0 1977.5 1983.6 2022.8 2096.5 75960.2 78204.2 84041.0 87609.6 87825.0 10598.0 11043.1 11312.2 11457.9 11852.9 14929.5 15896.4 15940.1 16507.1 16518.7 8292.8 8449.7 8493.3 8621.9 8673.8 8083.1 8159.0 8171.3 8309.8 8349.0 5048.1 5064.1 5085.2 5103.8 5197.2 1984.8 2059.5 2080.2 2112.7 2114.9 921.6 973.6 1007.4 1026.6 1063.3 19230.6 19955.9 20025.5 20154.2 20466.7 967.5 997.4 1007.0 1013.4 1015.5 11202.6 11638.8 11688.6 11722.8 11731.4 472160.0 479213.0 481503.0 483642.0 484595.0 100172.5 100515.5 101361.0 102654.0 103399.5 981.5 1016.7 1017.0 1031.4 1041.0 17449.3 17828.0 18019.1 18296.6 18437.0 43492.8 44502.0 44784.0 45943.0 46230.5 57837.7 58886.7 60680.4 61455.0 62444.7 7709.3 8121.3 8388.8 8591.8 8946.1 10359.8 13779.9 13890.2 13941.2 14188.9 11116.5 11204.2 12122.8 12225.1 12448.5 11747.6 11905.5 12017.6 12071.6 12311.7 11930.3 12177.4 12315.8 12465.1 12736.2 7881.3 8015.8 8227.6 8414.8 8502.7 11390.0 11619.3 11622.4 11669.8 11875.2 14:26:33 INFO - PROCESS | 22605 | 14:26:33 INFO - PROCESS | 22605 | [#3] mootools.html Cycles:180 Average:5893.23 Median:5106.67 stddev:3335.75 (65.3%) stddev-sans-first:3327.66 14:26:33 INFO - PROCESS | 22605 | Values: 1353.2 1523.5 1535.5 1724.4 1822.7 7822.0 8510.0 8722.5 8756.6 9013.9 8834.2 8926.1 8937.9 8941.9 8950.0 2411.0 2435.4 2440.1 2441.4 2449.4 2387.0 2448.9 2450.5 2452.4 2455.1 2190.4 2221.4 2223.4 2226.6 2245.7 2358.0 2374.0 2395.0 2396.0 2397.6 2357.5 2374.2 2387.0 2393.2 2395.4 8717.6 8737.7 8804.7 8815.3 8816.1 5411.2 5533.9 5541.4 5545.9 5564.8 3472.7 3583.7 3596.2 3655.1 3656.7 1152.5 1169.6 1188.5 1194.1 1229.4 12763.0 12822.4 12843.9 12850.9 12903.2 4440.3 4700.9 4759.2 4770.9 4783.1 9888.7 9962.1 10007.2 10007.5 10013.2 5481.0 5485.4 5491.1 5495.0 5496.8 4303.5 4417.8 4577.0 5087.9 5125.5 3893.2 3910.7 4008.8 4016.8 4029.2 1177.9 1196.1 1201.6 1207.5 1213.0 864.0 866.4 868.9 894.4 898.5 6022.0 6041.0 6240.5 6415.4 6491.1 964.4 966.6 977.3 993.7 1015.0 4040.4 4076.3 4099.3 4261.2 4325.2 10973.0 11029.0 11186.4 11272.3 11358.6 11172.2 11188.8 11189.9 11190.6 11214.8 8050.4 8309.6 8451.0 8600.2 8620.0 5860.4 6021.9 6108.6 6113.6 6227.6 10297.5 10304.2 10310.5 10314.1 10509.5 8721.6 8933.9 10266.9 10379.8 10543.0 7570.0 7986.6 8058.5 8061.6 8065.9 8482.9 8532.6 8580.6 8590.9 8597.6 7673.7 7780.8 7821.4 8051.5 8120.3 7576.2 7858.3 7915.6 7986.0 8139.7 7006.9 7118.5 7119.1 7124.0 7126.8 5153.5 5262.8 5322.6 5327.1 5356.8 5330.1 5368.6 5375.3 5403.8 5493.3 14:26:33 INFO - PROCESS | 22605 | 14:26:33 INFO - PROCESS | 22605 | [#4] prototype.html Cycles:180 Average:4670.63 Median:5297.52 stddev:1347.33 (25.4%) stddev-sans-first:1311.60 14:26:33 INFO - PROCESS | 22605 | Values: 355.3 364.0 366.2 368.5 369.1 5199.0 5284.7 5330.4 5344.8 5378.0 5111.4 5198.2 5203.3 5213.5 5254.3 4124.9 4151.6 4151.9 4154.0 4178.7 4064.9 4191.1 4206.4 4216.7 4220.5 4168.0 4171.3 4181.6 4189.7 4200.9 4169.2 4180.4 4182.1 4184.3 4191.8 3574.9 3697.4 3709.4 3732.6 3747.1 5186.6 5189.7 5199.1 5199.9 5204.7 4775.3 4790.7 4791.9 4798.3 4802.7 5351.2 5501.8 5511.0 5537.7 5577.2 4070.5 4094.7 4101.5 4109.5 4145.4 5797.4 5806.9 5810.9 5815.7 5838.9 4072.7 4183.6 4204.7 4217.2 4224.8 4240.2 4242.6 4251.6 4252.9 4255.0 4759.0 4761.6 4774.9 4781.4 4785.3 5400.8 5532.7 5592.4 5599.9 5603.2 1352.2 1386.2 1390.4 1399.5 1399.6 946.2 981.7 984.5 986.9 994.6 5129.8 5167.9 5184.5 5187.2 5200.9 5482.5 5487.5 5495.3 5502.3 5540.3 5181.3 5202.9 5206.0 5209.7 5449.7 2941.7 2955.7 2955.8 2957.7 2965.2 5783.7 5802.9 5814.2 5839.9 5852.6 5523.8 5625.9 5660.0 5661.1 5697.7 5763.3 5769.0 5777.8 5778.9 5789.5 5347.2 5481.0 5526.9 5537.0 5543.8 5437.3 5483.3 5489.9 5493.6 5496.6 5735.7 5759.0 5771.5 5806.0 5819.2 3969.6 4082.0 4084.9 4098.1 4104.1 5504.4 5529.3 5530.4 5534.6 5537.3 5468.2 5523.0 5550.4 5585.8 5622.7 5594.6 5610.0 5621.9 5633.8 5637.4 5310.4 5503.0 5551.4 5555.6 5608.4 5642.5 5670.3 5693.7 5700.3 5717.0 5447.2 5573.7 5579.5 5601.3 5614.7 14:26:33 INFO - PROCESS | 22605 | 14:26:33 INFO - PROCESS | 22605 | [#5] yui.html Cycles:180 Average:17325.72 Median:4621.81 stddev:22247.25 (481.4%) stddev-sans-first:22274.94 14:26:33 INFO - PROCESS | 22605 | Values: 775.0 793.3 822.8 848.9 895.5 15189.5 15739.2 15871.8 15927.8 15945.5 14503.6 14756.7 14802.3 14810.6 14821.9 723.8 745.7 828.5 850.4 853.8 858.7 859.0 860.3 862.0 862.2 895.8 900.6 901.7 901.7 901.7 756.0 779.6 867.3 883.4 892.9 658.7 664.4 664.4 665.2 666.0 14530.5 14787.6 14830.5 14839.4 14848.2 13019.2 13574.9 13598.3 13679.8 13709.9 11851.5 12131.9 12144.2 12167.3 12257.1 4347.9 4371.7 4402.9 4419.5 4433.6 60564.7 61173.0 61214.0 66105.0 66244.7 10533.2 10707.8 10830.6 10865.7 11328.7 19012.1 19114.5 19135.9 20537.9 21481.5 7552.8 8018.7 8044.0 8061.7 8311.5 4601.3 4646.1 4661.1 4758.1 4772.2 3288.1 3396.2 3423.5 3428.0 3481.9 612.4 615.5 616.5 619.1 622.5 554.1 617.3 642.0 652.9 666.3 8710.8 9041.5 9052.3 9213.2 9564.3 656.4 666.6 675.6 688.9 727.1 4365.7 4436.7 4531.4 4579.2 4642.4 72655.6 73720.0 75266.0 93207.0 95594.0 47199.5 53273.0 68754.7 69357.0 71542.6 63017.7 67643.3 68873.7 69332.7 71246.0 9821.1 10088.4 10214.6 10236.3 10269.6 43832.8 45315.0 46501.3 47411.8 47912.8 59169.4 62864.7 64528.0 65734.3 66410.3 12065.9 12086.7 12257.3 12299.4 12421.8 13197.8 13338.2 13468.2 13542.3 13779.2 10628.7 10899.8 12193.5 12268.8 13531.5 12752.5 13603.3 13612.7 13742.6 14398.2 11663.6 11770.5 11813.7 12113.3 13138.5 10828.3 11117.8 11397.8 11428.9 11542.5 11022.7 11209.2 11376.5 11594.2 11712.2 14:26:33 INFO - PROCESS | 22605 | -------- Summary: end -------- 14:26:33 INFO - PROCESS | 22605 | 14:26:33 INFO - TEST-INFO | 22605: exit 0 14:26:33 INFO - TEST-OK | dromaeo_css | took 1115000ms 14:26:33 INFO - TEST-START | kraken 14:26:33 INFO - operating with platform_type : linux_ 14:26:33 INFO - Initialising browser for kraken test... 14:26:33 INFO - TEST-INFO | started process 22928 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7RRQUX/profile http://localhost:43923/getInfo.html) 14:26:37 INFO - PROCESS | 22928 | __metrics Screen width/height:1600/1200 14:26:37 INFO - PROCESS | 22928 | colorDepth:24 14:26:37 INFO - PROCESS | 22928 | Browser inner width/height: 1024/697 14:26:37 INFO - PROCESS | 22928 | __metrics 14:26:37 INFO - PROCESS | 22928 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:26:37 INFO - PROCESS | 22928 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:26:38 INFO - PROCESS | 22928 | console.error: PushService: 14:26:38 INFO - PROCESS | 22928 | stateChangeProcessEnqueue: Error transitioning state 14:26:38 INFO - PROCESS | 22928 | UnknownError 14:26:38 INFO - TEST-INFO | 22928: exit 0 14:26:38 INFO - Browser initialized. 14:26:38 INFO - Running cycle 1/1 for kraken test... 14:26:38 INFO - TEST-INFO | started process 23021 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7RRQUX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:26:50 INFO - PROCESS | 23021 | RSS: Main: 144404480 14:26:50 INFO - PROCESS | 23021 | 14:26:53 INFO - PROCESS | 23021 | Cycle 1(1): loaded http://localhost:43923/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43923/tests/kraken/driver.html?testName=audio-beat-detection) 14:26:53 INFO - PROCESS | 23021 | RSS: Main: 185851904 14:26:53 INFO - PROCESS | 23021 | 14:26:56 INFO - PROCESS | 23021 | Cycle 1(1): loaded http://localhost:43923/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43923/tests/kraken/driver.html?testName=audio-dft) 14:26:57 INFO - PROCESS | 23021 | RSS: Main: 175517696 14:26:57 INFO - PROCESS | 23021 | 14:26:59 INFO - PROCESS | 23021 | Cycle 1(1): loaded http://localhost:43923/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43923/tests/kraken/driver.html?testName=audio-fft) 14:27:00 INFO - PROCESS | 23021 | RSS: Main: 266514432 14:27:00 INFO - PROCESS | 23021 | 14:27:02 INFO - PROCESS | 23021 | Cycle 1(1): loaded http://localhost:43923/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43923/tests/kraken/driver.html?testName=audio-oscillator) 14:27:03 INFO - PROCESS | 23021 | RSS: Main: 172883968 14:27:03 INFO - PROCESS | 23021 | 14:27:05 INFO - PROCESS | 23021 | Cycle 1(1): loaded http://localhost:43923/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43923/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:27:05 INFO - PROCESS | 23021 | RSS: Main: 175464448 14:27:05 INFO - PROCESS | 23021 | 14:27:08 INFO - PROCESS | 23021 | Cycle 1(1): loaded http://localhost:43923/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43923/tests/kraken/driver.html?testName=imaging-darkroom) 14:27:09 INFO - PROCESS | 23021 | RSS: Main: 213811200 14:27:09 INFO - PROCESS | 23021 | 14:27:12 INFO - PROCESS | 23021 | Cycle 1(1): loaded http://localhost:43923/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43923/tests/kraken/driver.html?testName=imaging-desaturate) 14:27:13 INFO - PROCESS | 23021 | RSS: Main: 212402176 14:27:13 INFO - PROCESS | 23021 | 14:27:15 INFO - PROCESS | 23021 | Cycle 1(1): loaded http://localhost:43923/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43923/tests/kraken/driver.html?testName=json-parse-financial) 14:27:16 INFO - PROCESS | 23021 | RSS: Main: 211615744 14:27:16 INFO - PROCESS | 23021 | 14:27:18 INFO - PROCESS | 23021 | Cycle 1(1): loaded http://localhost:43923/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43923/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:27:18 INFO - PROCESS | 23021 | RSS: Main: 173764608 14:27:18 INFO - PROCESS | 23021 | 14:27:20 INFO - PROCESS | 23021 | Cycle 1(1): loaded http://localhost:43923/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43923/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:27:20 INFO - PROCESS | 23021 | RSS: Main: 180633600 14:27:20 INFO - PROCESS | 23021 | 14:27:22 INFO - PROCESS | 23021 | Cycle 1(1): loaded http://localhost:43923/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43923/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:27:23 INFO - PROCESS | 23021 | RSS: Main: 190550016 14:27:23 INFO - PROCESS | 23021 | 14:27:26 INFO - PROCESS | 23021 | Cycle 1(1): loaded http://localhost:43923/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43923/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:27:26 INFO - PROCESS | 23021 | RSS: Main: 198520832 14:27:26 INFO - PROCESS | 23021 | 14:27:29 INFO - PROCESS | 23021 | Cycle 1(1): loaded http://localhost:43923/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43923/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:27:30 INFO - PROCESS | 23021 | RSS: Main: 195567616 14:27:30 INFO - PROCESS | 23021 | 14:27:31 INFO - PROCESS | 23021 | Cycle 1(1): loaded http://localhost:43923/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43923/tests/kraken/driver.html?testName=ai-astar) 14:27:31 INFO - PROCESS | 23021 | RSS: Main: 246026240 14:27:31 INFO - PROCESS | 23021 | 14:27:31 INFO - PROCESS | 23021 | __start_tp_report 14:27:31 INFO - PROCESS | 23021 | _x_x_mozilla_page_load 14:27:31 INFO - PROCESS | 23021 | _x_x_mozilla_page_load_details 14:27:31 INFO - PROCESS | 23021 | |i|pagename|runs| 14:27:31 INFO - PROCESS | 23021 | |0;ai-astar;102;110;111;111;111;111;109;110;110;109 14:27:31 INFO - PROCESS | 23021 | |1;audio-beat-detection;150;124;122;162;128;125;121;120;161;121 14:27:31 INFO - PROCESS | 23021 | |2;audio-dft;161;160;161;161;161;160;160;160;160;161 14:27:31 INFO - PROCESS | 23021 | |3;audio-fft;75;76;82;113;76;75;76;76;96;74 14:27:31 INFO - PROCESS | 23021 | |4;audio-oscillator;83;82;127;82;82;82;98;81;82;112 14:27:31 INFO - PROCESS | 23021 | |5;imaging-gaussian-blur;116;117;117;117;117;116;116;117;116;117 14:27:31 INFO - PROCESS | 23021 | |6;imaging-darkroom;146;147;147;146;146;146;146;147;146;146 14:27:31 INFO - PROCESS | 23021 | |7;imaging-desaturate;85;87;84;84;84;85;85;85;84;85 14:27:31 INFO - PROCESS | 23021 | |8;json-parse-financial;52;50;51;50;55;51;51;51;51;56 14:27:31 INFO - PROCESS | 23021 | |9;json-stringify-tinderbox;58;58;58;59;59;58;59;58;58;58 14:27:31 INFO - PROCESS | 23021 | |10;stanford-crypto-aes;77;79;83;75;75;80;75;74;83;78 14:27:31 INFO - PROCESS | 23021 | |11;stanford-crypto-ccm;138;134;127;127;131;124;127;127;185;137 14:27:31 INFO - PROCESS | 23021 | |12;stanford-crypto-pbkdf2;155;155;155;154;158;154;155;157;155;155 14:27:31 INFO - PROCESS | 23021 | |13;stanford-crypto-sha256-iterative;65;64;64;64;64;63;64;62;65;62 14:27:31 INFO - PROCESS | 23021 | __end_tp_report 14:27:31 INFO - PROCESS | 23021 | __start_cc_report 14:27:31 INFO - PROCESS | 23021 | _x_x_mozilla_cycle_collect,1650 14:27:31 INFO - PROCESS | 23021 | __end_cc_report 14:27:31 INFO - PROCESS | 23021 | __startTimestamp1480631251948__endTimestamp 14:27:31 INFO - PROCESS | 23021 | 14:27:31 INFO - PROCESS | 23021 | ------- Summary: start ------- 14:27:31 INFO - PROCESS | 23021 | Number of tests: 14 14:27:31 INFO - PROCESS | 23021 | 14:27:31 INFO - PROCESS | 23021 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.50 stddev:2.72 (2.5%) stddev-sans-first:0.83 14:27:31 INFO - PROCESS | 23021 | Values: 102.0 110.0 111.0 111.0 111.0 111.0 109.0 110.0 110.0 109.0 14:27:31 INFO - PROCESS | 23021 | 14:27:31 INFO - PROCESS | 23021 | [#1] audio-beat-detection Cycles:10 Average:133.40 Median:126.50 stddev:17.19 (13.6%) stddev-sans-first:17.15 14:27:31 INFO - PROCESS | 23021 | Values: 150.0 124.0 122.0 162.0 128.0 125.0 121.0 120.0 161.0 121.0 14:27:31 INFO - PROCESS | 23021 | 14:27:31 INFO - PROCESS | 23021 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:0.53 (0.3%) stddev-sans-first:0.53 14:27:31 INFO - PROCESS | 23021 | Values: 161.0 160.0 161.0 161.0 161.0 160.0 160.0 160.0 160.0 161.0 14:27:31 INFO - PROCESS | 23021 | 14:27:31 INFO - PROCESS | 23021 | [#3] audio-fft Cycles:10 Average:81.90 Median:76.00 stddev:12.75 (16.8%) stddev-sans-first:13.28 14:27:31 INFO - PROCESS | 23021 | Values: 75.0 76.0 82.0 113.0 76.0 75.0 76.0 76.0 96.0 74.0 14:27:31 INFO - PROCESS | 23021 | 14:27:31 INFO - PROCESS | 23021 | [#4] audio-oscillator Cycles:10 Average:91.10 Median:82.00 stddev:16.18 (19.7%) stddev-sans-first:16.89 14:27:31 INFO - PROCESS | 23021 | Values: 83.0 82.0 127.0 82.0 82.0 82.0 98.0 81.0 82.0 112.0 14:27:31 INFO - PROCESS | 23021 | 14:27:31 INFO - PROCESS | 23021 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 14:27:31 INFO - PROCESS | 23021 | Values: 116.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 116.0 117.0 14:27:31 INFO - PROCESS | 23021 | 14:27:31 INFO - PROCESS | 23021 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 14:27:31 INFO - PROCESS | 23021 | Values: 146.0 147.0 147.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 14:27:31 INFO - PROCESS | 23021 | 14:27:31 INFO - PROCESS | 23021 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:0.92 (1.1%) stddev-sans-first:0.97 14:27:31 INFO - PROCESS | 23021 | Values: 85.0 87.0 84.0 84.0 84.0 85.0 85.0 85.0 84.0 85.0 14:27:31 INFO - PROCESS | 23021 | 14:27:31 INFO - PROCESS | 23021 | [#8] json-parse-financial Cycles:10 Average:51.80 Median:51.00 stddev:2.04 (4.0%) stddev-sans-first:2.17 14:27:31 INFO - PROCESS | 23021 | Values: 52.0 50.0 51.0 50.0 55.0 51.0 51.0 51.0 51.0 56.0 14:27:31 INFO - PROCESS | 23021 | 14:27:31 INFO - PROCESS | 23021 | [#9] json-stringify-tinderbox Cycles:10 Average:58.30 Median:58.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 14:27:31 INFO - PROCESS | 23021 | Values: 58.0 58.0 58.0 59.0 59.0 58.0 59.0 58.0 58.0 58.0 14:27:31 INFO - PROCESS | 23021 | 14:27:31 INFO - PROCESS | 23021 | [#10] stanford-crypto-aes Cycles:10 Average:77.90 Median:78.50 stddev:3.31 (4.2%) stddev-sans-first:3.50 14:27:31 INFO - PROCESS | 23021 | Values: 77.0 79.0 83.0 75.0 75.0 80.0 75.0 74.0 83.0 78.0 14:27:31 INFO - PROCESS | 23021 | 14:27:31 INFO - PROCESS | 23021 | [#11] stanford-crypto-ccm Cycles:10 Average:135.70 Median:132.50 stddev:17.96 (13.6%) stddev-sans-first:19.03 14:27:31 INFO - PROCESS | 23021 | Values: 138.0 134.0 127.0 127.0 131.0 124.0 127.0 127.0 185.0 137.0 14:27:31 INFO - PROCESS | 23021 | 14:27:31 INFO - PROCESS | 23021 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.30 Median:155.00 stddev:1.25 (0.8%) stddev-sans-first:1.32 14:27:31 INFO - PROCESS | 23021 | Values: 155.0 155.0 155.0 154.0 158.0 154.0 155.0 157.0 155.0 155.0 14:27:31 INFO - PROCESS | 23021 | 14:27:31 INFO - PROCESS | 23021 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:64.00 stddev:1.06 (1.7%) stddev-sans-first:1.01 14:27:31 INFO - PROCESS | 23021 | Values: 65.0 64.0 64.0 64.0 64.0 63.0 64.0 62.0 65.0 62.0 14:27:31 INFO - PROCESS | 23021 | -------- Summary: end -------- 14:27:31 INFO - PROCESS | 23021 | 14:27:32 INFO - TEST-INFO | 23021: exit 0 14:27:32 INFO - TEST-OK | kraken | took 59191ms 14:27:32 INFO - SUITE-END | took 1174s 14:27:33 INFO - Completed test suite (00:19:34) 14:27:33 INFO - javascript benchmark 14:27:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3226.6289376721675, 3248.0418276608407, 3249.301400198957, 3271.967280327196, 3288.8355582220884, 5428.837134885955, 5452.59105567083, 5484.369297530785, 5489.560835133189, 5495.999999999995, 5589.776408943638, 5592.189132575774, 5619.213310136574, 5627.983612840923, 5667.0, 5044.142495775718, 5059.443461219263, 5087.872803179913, 5136.203888397305, 5144.4083930348115, 4948.703077815325, 4954.0, 5120.743962801845, 5168.095583272912, 5175.223716442526, 5020.7489625518765, 5038.345015148044, 5078.339815823956, 5086.567641750456, 5113.411957624865, 5128.358955130609, 5140.8971820563565, 5185.274061631375, 5196.090684130262, 5225.137852254374, 4837.685550439245, 5071.949280507221, 5089.262057001751, 5129.025485157846, 5154.123798954187, 5437.075697131458, 5465.9180112298345, 5468.507834294893, 5500.889982200373, 5557.805476808292, 5892.499137573312, 5899.882002359929, 5975.551833612453, 5976.521878249773, 5978.192943952554, 5878.177055212273, 6028.668423236721, 6030.728617212192, 6042.879142417171, 6055.909161362583, 5492.670439773627, 5525.309336332918, 5529.087700529368, 5530.834074977757, 5552.444755524415, 6050.727717252734, 6057.0, 6059.151718759377, 6065.484433823174, 6070.848228794315, 5602.831915042555, 5826.504747096545, 5828.184054232411, 5844.503217226584, 5844.707764611752, 5727.971360143172, 5895.616784908967, 5939.732712027969, 5944.762209511658, 6017.2779266488305, 5945.0, 5954.583179177416, 5956.434138756811, 5961.105834124916, 5992.520598352121, 5726.914096288559, 5911.76352945886, 5967.6121052131475, 5977.6114552553945, 5978.880422391528, 4485.035717320727, 4514.751688657089, 4526.388937493396, 4535.387722657465, 4572.634189264851, 4073.490813648294, 4083.5099788025627, 4095.508538975342, 4115.279826030433, 4134.028503301722, 5541.5289700375115, 5576.219329293902, 5589.077802162679, 5600.215969764155, 5617.522510586564, 5741.282339707536, 5780.653160810365, 5880.176775251468, 5885.411458854166, 5910.408959104056, 5612.298462692163, 5612.522935550524, 5624.437556244425, 5626.578006649518, 5653.038983372837, 5142.357205349332, 5153.742312884341, 5156.226566015052, 5156.587473002151, 5198.454162312978, 5896.587238893237, 6008.939910600838, 6127.22007048413, 6164.352742961924, 6173.567850250529, 5947.732352044255, 6058.454739073504, 6078.057901025348, 6084.939150608438, 6110.7861224856915, 6224.604909800553, 6245.094461303176, 6248.593841400295, 6252.656103914146, 6266.561340706106, 5712.000399930079, 5753.626014309057, 5921.703914804329, 5924.644521328734, 5959.28488581373, 5987.161797348462, 6008.489278411384, 6035.939640603538, 6093.908591371044, 6116.602420842631, 5891.764329426775, 5927.733252003756, 5930.940690593039, 5937.287525496968, 5947.988841896801, 5563.860903477445, 5923.08192230205, 5929.0513517836935, 5934.851628709144, 5947.583669143119, 5637.774489020558, 5746.454086861741, 5850.0932355484965, 5858.355580886185, 5881.05903055509, 5941.405859414024, 5957.225560677084, 5963.2844058713235, 5970.462658360769, 5980.611260268242, 5605.131204663284, 5645.435456454322, 5658.981383351036, 5810.389909059488, 5822.94177058224], "value": 5497.19338177139, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.4263164730211, 623.4918541388768, 625.50272533336, 658.3087757854255, 678.291185710932, 34537.48193777092, 44929.326060109124, 45587.77206113969, 45608.3158752619, 46223.76888115555, 46842.765786171105, 47147.52852471474, 47159.76420117894, 47176.292355614605, 47298.290525642056, 8167.0, 8791.78020549485, 8940.284777217807, 8950.060243674418, 8951.462912225288, 8235.258826705594, 10482.528286227138, 10705.732356691105, 10719.785604287948, 11040.061594764455, 10538.315009524395, 10560.207984401162, 10569.471526423686, 10578.682639520826, 10586.41774702391, 10722.946385268062, 10778.5688572457, 10784.299020563716, 10798.190135739851, 10804.405757683324, 10714.250002499828, 10767.56929722818, 10777.353358798497, 10780.0, 10781.0, 43456.56543434557, 43681.0, 43802.0, 43806.34290485645, 43882.12235755299, 3470.8958731238104, 3494.3011397720556, 3554.289142171576, 3565.090901820045, 3566.35805555, 32834.0, 32964.0, 33114.50328245078, 33216.33567328664, 34041.31917361663, 4136.855210067663, 4257.531671516131, 4378.715383500063, 4380.78096095194, 4397.428334316551, 356405.0, 362517.0, 363683.181584093, 364209.0, 364389.0, 64377.356226437136, 65114.0, 65172.674136629015, 65214.0, 65290.67354663291, 39317.0, 40256.396154057715, 40355.79822100871, 42550.0, 68621.65689171522, 17479.0, 17595.29618815233, 17626.383076592258, 17639.118044098, 17658.735118973225, 11799.705007374712, 12185.756284874253, 12372.690682733004, 13135.474581016651, 13238.53665121716, 19744.506387340432, 20898.268560600307, 20901.895490522755, 20961.68557471639, 20966.79033209679, 7349.963250183715, 7393.0, 7519.8496030079095, 7574.280443357872, 7602.239776022354, 950.0879156010308, 1026.6201505442884, 1077.6928575355985, 1120.1654767198327, 1194.2476239968764, 33026.17434564107, 33582.32835343279, 33984.66015339865, 34044.65955340464, 34225.0, 985.4235272365603, 1149.4252873563219, 1156.4275683536703, 1158.6813626252679, 1190.4285942747529, 16420.75368869468, 17827.197776100107, 17954.371596994042, 18385.172667230006, 18671.626567468575, 547092.0, 550341.0, 550586.0, 551001.0, 551412.0, 61339.6933015332, 61987.6900615494, 62023.37976620266, 62095.0, 62114.68942655348, 1316.6510874618234, 1340.5978206538196, 1392.0742706100532, 1392.5335012770634, 1423.6085076604018, 30234.84882575573, 34695.47956780701, 35338.46992295169, 35432.82283588566, 35573.28853422865, 52235.73882130565, 52804.47195527996, 52828.73585632047, 52877.0, 52981.0, 443830.0, 447917.0, 448604.0, 448886.0, 449908.0, 29617.25956851096, 30391.39217215599, 32303.35393292074, 32388.0, 32739.672603274616, 50116.498835012644, 50150.74924625354, 50702.74648626733, 51040.48959510357, 51147.74426127846, 42553.1489370217, 42772.35841462318, 43261.0, 43336.783316083216, 44700.32949505825, 42758.0, 42983.355249671906, 43519.0, 43851.78074109609, 43993.34009989789, 40902.38646420366, 43368.56631433645, 43788.0, 44419.0, 44535.0, 36654.63345366512, 39280.80359598184, 39402.80298598488, 39605.2078958425, 39754.80122599369, 20756.377308680763, 20801.687974680088, 20854.0, 20863.374098776454, 20909.26817561378], "value": 20916.34738326933, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.9639241579479, 430.1117992679159, 433.88502046957564, 442.69896470400136, 450.3942197744033, 16628.667426651475, 19350.709739353904, 19912.800871991294, 21002.0, 21023.2641857535, 19947.60104797903, 20697.793022069774, 20798.584028319463, 20802.0, 20957.895210523926, 5632.042552766029, 5874.9118763218585, 5878.2064421303, 5879.588428809985, 5880.206172166767, 5677.716114194273, 5922.615030023035, 5952.55355848311, 5955.374685658008, 5960.612560183574, 5892.297028419279, 5939.1388248703915, 5948.107783832416, 5953.285605727318, 6540.476761859064, 6442.871142577169, 6461.709223084949, 6488.416042556169, 6605.042268870987, 6622.834429139262, 5722.799702010409, 5801.477866991949, 5829.883402331972, 5844.064949608085, 5963.493103086243, 14814.703705925822, 15076.623084422867, 15086.245687715571, 23467.0, 24289.392765180834, 2219.7225346831647, 2227.7883601058033, 2377.2749311459997, 2408.963865542018, 2640.6699162604673, 10384.428856412895, 10619.78760424795, 10635.893641063567, 11292.943535282353, 11318.490667919963, 1943.0, 1977.4858536780541, 1983.5735316906935, 2022.8482863785275, 2096.496840758207, 75960.24039759643, 78204.21795782026, 84041.0, 87609.56195218983, 87825.0, 10597.993190646876, 11043.116550675926, 11312.151588630886, 11457.942710286396, 11852.88147118535, 14929.477468288558, 15896.364145434052, 15940.123293218752, 16507.09210993383, 16518.6696266074, 8292.792680182924, 8449.662013519513, 8493.27807136388, 8621.870671939925, 8673.783155421039, 8083.110857805636, 8158.979314152739, 8171.305439037629, 8309.792255193668, 8349.0, 5048.0913435581215, 5064.1137800885435, 5085.186370180753, 5103.8468845934685, 5197.246399272084, 1984.7915968823065, 2059.4954236212225, 2080.209520382245, 2112.6725357569603, 2114.873107613548, 921.5898924978454, 973.6251543155936, 1007.4207330784828, 1026.6150193677372, 1063.2663462211049, 19230.615387692167, 19955.900220499094, 20025.499362516053, 20154.193832246838, 20466.69299960472, 967.5404183013012, 997.4314640654902, 1007.0, 1013.3767732844395, 1015.4871789746131, 11202.60790872332, 11638.76722465546, 11688.649340519798, 11722.765544689059, 11731.35477548726, 472160.0, 479213.0, 481503.0, 483642.0, 484595.0, 100172.4991375053, 100515.49742251242, 101361.0, 102654.0, 103399.48300258601, 981.5435822342645, 1016.7356487313352, 1016.9999999999852, 1031.3605564550028, 1041.0162396535202, 17449.30202791874, 17828.0, 18019.09904504796, 18296.634067318846, 18436.98596577201, 43492.78253608838, 44502.0, 44784.0, 45943.0, 46230.537694622624, 57837.71081144567, 58886.705566471894, 60680.393196067474, 61455.0, 62444.68777656083, 7709.267619576131, 8121.269085782072, 8388.832223355377, 8591.828163436821, 8946.060663630225, 10359.792804144026, 13779.862201377859, 13890.236037018061, 13941.166179300773, 14188.858111418755, 11116.49975751077, 11204.159688023268, 12122.818157727464, 12225.144239903122, 12448.502059917864, 11747.588834390755, 11905.46425410876, 12017.579384721494, 12071.637850864488, 12311.69220769488, 11930.284182949052, 12177.391130443619, 12315.75368492643, 12465.065120116209, 12736.172148810298, 7881.330086942674, 8015.799605009922, 8227.629756660845, 8414.789630259293, 8502.74491765248, 11390.0, 11619.302841829518, 11622.418879055844, 11669.824952625888, 11875.168738188244], "value": 9487.875588629853, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1353.2083731017353, 1523.520091171281, 1535.5009621872887, 1724.3619860651554, 1822.735703323019, 7821.960890195548, 8509.957450212749, 8722.47665140092, 8756.649734010647, 9013.864792028126, 8834.249088827457, 8926.107389261071, 8937.865932011026, 8941.865872011926, 8949.955250223757, 2411.0, 2435.415500279938, 2440.0727723465056, 2441.389652586853, 2449.424385269469, 2386.95226095478, 2448.902043918241, 2450.4853980664084, 2452.411421258903, 2455.1284294075613, 2190.4414374334524, 2221.44463884029, 2223.4107961390246, 2226.576950379431, 2245.719285089364, 2357.97642023581, 2374.0385144016614, 2394.9521009579885, 2395.964060539093, 2397.6043952747864, 2357.4577847095265, 2374.1927744566756, 2386.952260954771, 2393.246127469841, 2395.4250979764906, 8717.607707653107, 8737.650493980233, 8804.735857924272, 8815.294776417872, 8816.118388161196, 5411.188321751769, 5533.944660553383, 5541.362743284533, 5545.861353466155, 5564.8330550083565, 3472.670096340869, 3583.7133029357587, 3596.2447885943984, 3655.0679576708035, 3656.652618001312, 1152.487143221267, 1169.631566056698, 1188.5186499467643, 1194.1044216837372, 1229.391451231646, 12763.0, 12822.42299096543, 12843.871561284455, 12850.871491285061, 12903.16129451592, 4440.3339499074755, 4700.929486057712, 4759.23852183649, 4770.856874293777, 4783.062859541891, 9888.653897113567, 9962.103410693073, 10007.199424046059, 10007.49962501872, 10013.198944084455, 5481.013417584793, 5485.396606373296, 5491.148871924858, 5495.0383682855345, 5496.7526461309335, 4303.483581970184, 4417.757023363682, 4576.993061526458, 5087.872803179876, 5125.461826508163, 3893.201893611803, 3910.7066969977363, 4008.819603117867, 4016.758994460342, 4029.234445455354, 1177.9234349767237, 1196.1268274159738, 1201.615483045417, 1207.5471698113208, 1212.9575464858865, 864.004150412549, 866.4021824940771, 868.8522951098329, 894.3918135667678, 898.4743924804063, 6022.0, 6040.969795150996, 6240.469560087353, 6415.358464153547, 6491.058796474579, 964.3587014635189, 966.6036924860914, 977.2865807960087, 993.7366597851575, 1014.9797004059877, 4040.373742069984, 4076.3477843544892, 4099.2878820345895, 4261.169072030924, 4325.1565944641125, 10973.0, 11029.0, 11186.38474883873, 11272.267302625303, 11358.60244891425, 11172.162087843444, 11188.776224475629, 11189.888101118884, 11190.552377904793, 11214.775704485864, 8050.4364694472, 8309.584520773937, 8450.957745211235, 8600.182982616641, 8619.956900215584, 5860.38465961085, 6021.946159422171, 6108.602940808833, 6113.633182009094, 6227.595206311576, 10297.485125743833, 10304.227182961458, 10310.484475776031, 10314.123299519324, 10509.527071281964, 8721.563921803758, 8933.865992009994, 10266.897331026594, 10379.792404151724, 10543.0, 7569.962150189434, 7986.600669966595, 8058.476199047043, 8061.556614386265, 8065.87901181471, 8482.915170848459, 8532.573371331533, 8580.570971451278, 8590.914090859262, 8597.570121493774, 7673.6546855390525, 7780.84438311242, 7821.413393995359, 8051.51690898548, 8120.269175773972, 7576.204498527795, 7858.292753652198, 7915.564643944408, 7985.960070199844, 8139.674413023413, 7006.859862802818, 7118.5017048806085, 7119.1457025157315, 7124.0, 7126.824074027727, 5153.510416510426, 5262.842114736564, 5322.600804939568, 5327.09439395296, 5356.80427905679, 5330.067238233216, 5368.624196306221, 5375.274337964324, 5403.756830942696, 5493.340799104133], "value": 4712.544575072555, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.28587539046526, 363.9599644039156, 366.19985332049464, 368.5154022460466, 369.0957154970322, 5199.0, 5284.682919024852, 5330.36035675719, 5344.812931547397, 5378.0, 5111.386633603964, 5198.220266959958, 5203.2975548301065, 5213.504717051874, 5254.264402983586, 4124.938125928114, 4151.626353628165, 4151.854685086023, 4153.979230103845, 4178.6657067434535, 4064.9187016259657, 4191.098913733546, 4206.390073439349, 4216.704830661855, 4220.472440944882, 4168.0, 4171.290880550314, 4181.623653871151, 4189.685773566995, 4200.894977625553, 4169.1661667666585, 4180.435641188446, 4182.121754431573, 4184.330507118877, 4191.790410479494, 3574.8748793792092, 3697.352963231424, 3709.4420343455813, 3732.6453986871475, 3747.1194269346684, 5186.611004174702, 5189.688618682853, 5199.14214154664, 5199.948000520022, 5204.739763011834, 4775.2598347256235, 4790.688605240648, 4791.880202994918, 4798.2802579613335, 4802.711837289774, 5351.170568561879, 5501.807436739735, 5510.972445137789, 5537.695426751527, 5577.159537352704, 4070.5115386153852, 4094.7133700640966, 4101.507819061701, 4109.547949725527, 4145.3781932710035, 5797.36229014808, 5806.912896306559, 5810.883782324372, 5815.709214539256, 5838.883222335529, 4072.6538244249573, 4183.581641835792, 4204.747715137101, 4217.156568686275, 4224.817051225662, 4240.151969606091, 4242.618164365222, 4251.617354438054, 4252.851150209728, 4255.0, 4758.976205118952, 4761.595264402496, 4774.928376074362, 4781.402324709411, 4785.306130611042, 5400.783968641211, 5532.6680399176175, 5592.384837667853, 5599.916001259984, 5603.215549823028, 1352.2157148853642, 1386.2237147197602, 1390.367382840805, 1399.4542128569865, 1399.5661344983089, 946.186279799372, 981.6613268422383, 984.4733067808688, 986.9259805514615, 994.627014869424, 5129.79480820763, 5167.9224811627855, 5184.533391994739, 5187.172990720067, 5200.945626477595, 5482.479164479368, 5487.533559647395, 5495.340559132929, 5502.339719233718, 5540.252065971123, 5181.326427564392, 5202.947970520322, 5206.0, 5209.713465759344, 5449.727513624303, 2941.7205365490245, 2955.7142642950384, 2955.7930944834084, 2957.704229577025, 2965.2142182321704, 5783.710814459344, 5802.854928626733, 5814.156947242626, 5839.941600583939, 5852.561057920673, 5523.8066667666435, 5625.86498923291, 5660.0, 5661.065924122474, 5697.658140511582, 5763.279590051244, 5769.0, 5777.768889244383, 5778.925857270614, 5789.507891829073, 5347.224652425454, 5480.958617862593, 5526.861828454321, 5536.97231513856, 5543.77824887, 5437.32033495813, 5483.285773542122, 5489.945100548944, 5493.587980901529, 5496.642718223303, 5735.684537350486, 5759.049756790083, 5771.528260293599, 5806.0, 5819.246585952122, 3969.622885825842, 4082.0, 4084.897877553085, 4098.139390727981, 4104.076582768853, 5504.422035686195, 5529.336479622471, 5530.446955304437, 5534.640248383842, 5537.2524709165355, 5468.207109969112, 5522.972385138049, 5550.361708403424, 5585.826976335015, 5622.662640241599, 5594.608377413705, 5610.0, 5621.8594535136945, 5633.774649013993, 5637.43625637433, 5310.362756469249, 5502.972485137549, 5551.444855514416, 5555.638883472561, 5608.439156084359, 5642.463965923231, 5670.291213598301, 5693.743781529924, 5700.315962084576, 5716.971415142898, 5447.155690867922, 5573.7213139343685, 5579.4978451937895, 5601.327840659147, 5614.6631202128], "value": 4249.570474109574, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [774.9728759493419, 793.3335997761878, 822.8354329134174, 848.889644346235, 895.4627223665801, 15189.4683686071, 15739.213039348015, 15871.84128158718, 15927.761083583755, 15945.521634350958, 14503.637409064779, 14756.704865902675, 14802.259887005634, 14810.55568332949, 14821.925890370532, 723.7792473295643, 745.6681776609411, 828.5277391886627, 850.4047166983121, 853.8292341531687, 858.6865793985181, 858.952757598335, 860.2558786649565, 862.0129951205865, 862.1550880137469, 895.7671005538574, 900.572228191607, 901.6799036342103, 901.711452335253, 901.7204666553357, 755.9886601700979, 779.6062988190984, 867.2758246863876, 883.3772190605607, 892.8660700894853, 658.7463826426812, 664.3622122762106, 664.3854434647932, 665.2216906219686, 665.9700313485905, 14530.491432799907, 14787.556373308711, 14830.480933167288, 14839.406423743038, 14848.183349915751, 13019.15375500599, 13574.932125339408, 13598.320083995859, 13679.794803077863, 13709.931450342785, 11851.525938962432, 12131.93934030333, 12144.210626309261, 12167.330796806173, 12257.080718946025, 4347.869563913087, 4371.650267978554, 4402.8679139625865, 4419.513853476115, 4433.556644335573, 60564.69717651427, 61173.0, 61214.0, 66105.00842487415, 66244.6687766563, 10533.209354409768, 10707.785844283226, 10830.620928267474, 10865.728356791144, 11328.716782080513, 19012.144453499626, 19114.52213694669, 19135.90432047831, 20537.89731051365, 21481.462963425725, 7552.848943021108, 8018.679252829821, 8043.959780201179, 8061.677532898736, 8311.542865142475, 4601.263797792404, 4646.09401166776, 4661.091087238024, 4758.07217592573, 4772.188727916263, 3288.1122097033667, 3396.1679388549965, 3423.4864770284657, 3428.0, 3481.9477707834403, 612.4396177497629, 615.4891440104702, 616.5437576193584, 619.1393962392278, 622.5082185073832, 554.0856341340658, 617.3425302053299, 642.00809748938, 652.8628987912497, 666.2837449741547, 8710.825783484295, 9041.547922603844, 9052.321075919332, 9213.216876565433, 9564.282678799118, 656.3731636287334, 666.576723780403, 675.6317806795308, 688.8932215506604, 727.1165533876366, 4365.650747940157, 4436.6672499562665, 4531.410916580823, 4579.244424669959, 4642.3500709900645, 72655.63672181606, 73720.0, 75266.0, 93207.0, 95594.0, 47199.5280047202, 53273.0, 68754.74108675758, 69357.0, 71542.64228678927, 63017.68491157515, 67643.3235667637, 68873.65563172151, 69332.653336733, 71246.0, 9821.066998635119, 10088.394696318244, 10214.591416343263, 10236.283460157718, 10269.589216431557, 43832.78083609562, 45315.0, 46501.3024804635, 47411.76294118507, 47912.7604361976, 59169.40830591639, 62864.68567657316, 64528.0, 65734.34265657474, 66410.33589664042, 12065.879341206475, 12086.697832553904, 12257.325847078497, 12299.385030748248, 12421.813672795097, 13197.768526722719, 13338.19970801755, 13468.191908485522, 13542.322883855571, 13779.173249605055, 10628.681139565826, 10899.836502452628, 12193.451294691582, 12268.815967760313, 13531.526396576073, 12752.48990040388, 13603.319834008458, 13612.727745445234, 13742.587722368346, 14398.20809855468, 11663.59177428786, 11770.52917883275, 11813.70465738329, 12113.33376664292, 13138.474461021453, 10828.296160749525, 11117.777644447227, 11397.829032564685, 11428.94285528567, 11542.480588373375, 11022.669319920415, 11209.215354925404, 11376.488058037243, 11594.246373985665, 11712.180147389601], "value": 7150.388536114935, "unit": "score"}], "name": "dromaeo_css", "value": 7338.859797361989, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 110.0, 111.0, 111.0, 111.0, 111.0, 109.0, 110.0, 110.0, 109.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 124.0, 122.0, 162.0, 128.0, 125.0, 121.0, 120.0, 161.0, 121.0], "value": 133.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 161.0, 161.0, 160.0, 160.0, 160.0, 160.0, 161.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 82.0, 113.0, 76.0, 75.0, 76.0, 76.0, 96.0, 74.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 127.0, 82.0, 82.0, 82.0, 98.0, 81.0, 82.0, 112.0], "value": 91.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 84.0, 84.0, 84.0, 85.0, 85.0, 85.0, 84.0, 85.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 50.0, 51.0, 50.0, 55.0, 51.0, 51.0, 51.0, 51.0, 56.0], "value": 51.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 58.0, 59.0, 59.0, 58.0, 59.0, 58.0, 58.0, 58.0], "value": 58.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 79.0, 83.0, 75.0, 75.0, 80.0, 75.0, 74.0, 83.0, 78.0], "value": 77.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 134.0, 127.0, 127.0, 131.0, 124.0, 127.0, 127.0, 185.0, 137.0], "value": 135.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 155.0, 155.0, 154.0, 158.0, 154.0, 155.0, 157.0, 155.0, 155.0], "value": 155.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 64.0, 64.0, 63.0, 64.0, 62.0, 65.0, 62.0], "value": 63.7, "unit": "score"}], "name": "kraken", "value": 1466.7, "alertThreshold": 2.0}]} 14:27:33 INFO - Return code: 0 14:27:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:27:33 INFO - # TBPL SUCCESS # 14:27:33 INFO - Running post-action listener: _resource_record_post_action 14:27:33 INFO - [mozharness: 2016-12-01 22:27:33.259735Z] Finished run-tests step (success) 14:27:33 INFO - Running post-run listener: _resource_record_post_run 14:27:33 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 270336; Write bytes: 345841664; Read time: 140; Write time: 196128 14:27:33 INFO - TinderboxPrint: CPU usage
13.0% 14:27:33 INFO - TinderboxPrint: I/O read bytes / time
270,336 / 140 14:27:33 INFO - TinderboxPrint: I/O write bytes / time
345,841,664 / 196,128 14:27:33 INFO - TinderboxPrint: CPU idle
8,262.8 (87.0%) 14:27:33 INFO - TinderboxPrint: CPU user
1,192.9 (12.6%) 14:27:33 INFO - TinderboxPrint: Swap in / out
0 / 0 14:27:33 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107372544; Read time: 0; Write time: 61256 14:27:33 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 266240; Write bytes: 238469120; Read time: 124; Write time: 134872 14:27:33 INFO - Running post-run listener: _upload_blobber_files 14:27:33 INFO - Blob upload gear active. 14:27:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:27:33 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 14:27:33 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:27:33 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:27:34 INFO - (blobuploader) - INFO - Open directory for files ... 14:27:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:27:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:27:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:27:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:27:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:27:34 INFO - (blobuploader) - INFO - Done attempting. 14:27:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:27:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:27:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:27:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:27:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:27:38 INFO - (blobuploader) - INFO - Done attempting. 14:27:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:27:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:27:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:27:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:27:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:27:39 INFO - (blobuploader) - INFO - Done attempting. 14:27:39 INFO - (blobuploader) - INFO - Iteration through files over. 14:27:39 INFO - Return code: 0 14:27:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:27:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:27:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2a22758e905ca598ded429a628886dbb659a9ea810cda6e200655f130414ae4e0e819d5bab17f075ae1904ffaec348c5146e030d7ad77fadc5100de2bf2d99e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/081995dc2b6bc6068d0ebd4135f219feaac987f67997914b3225636be542b16f111b580bea4bff3d64e1afbfb6f9a217d902723dfe07a2a80c52c668fcecbc21", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/83d1354aea5dfb8a0e6d39b84c486ec0e0448a256c392888426b64bf7e7138bfefe7813f1acc177f619f4b067ae6c470a1c8d6c877dfec69aea49f4c15ea47d5"} 14:27:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:27:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:27:39 INFO - Contents: 14:27:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2a22758e905ca598ded429a628886dbb659a9ea810cda6e200655f130414ae4e0e819d5bab17f075ae1904ffaec348c5146e030d7ad77fadc5100de2bf2d99e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/081995dc2b6bc6068d0ebd4135f219feaac987f67997914b3225636be542b16f111b580bea4bff3d64e1afbfb6f9a217d902723dfe07a2a80c52c668fcecbc21", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/83d1354aea5dfb8a0e6d39b84c486ec0e0448a256c392888426b64bf7e7138bfefe7813f1acc177f619f4b067ae6c470a1c8d6c877dfec69aea49f4c15ea47d5"} 14:27:39 INFO - Running post-run listener: copy_logs_to_upload_dir 14:27:39 INFO - Copying logs to upload dir... 14:27:39 INFO - mkdir: /builds/slave/test/build/upload/logs 14:27:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.199769 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-12-01 14:27:39.232207) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-01 14:27:39.236004) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1480629053.596644-2050541285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2a22758e905ca598ded429a628886dbb659a9ea810cda6e200655f130414ae4e0e819d5bab17f075ae1904ffaec348c5146e030d7ad77fadc5100de2bf2d99e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/081995dc2b6bc6068d0ebd4135f219feaac987f67997914b3225636be542b16f111b580bea4bff3d64e1afbfb6f9a217d902723dfe07a2a80c52c668fcecbc21", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/83d1354aea5dfb8a0e6d39b84c486ec0e0448a256c392888426b64bf7e7138bfefe7813f1acc177f619f4b067ae6c470a1c8d6c877dfec69aea49f4c15ea47d5"} build_url:https://queue.taskcluster.net/v1/task/LJSDKVaASkyMyfAxlFofXg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011895 build_url: 'https://queue.taskcluster.net/v1/task/LJSDKVaASkyMyfAxlFofXg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2a22758e905ca598ded429a628886dbb659a9ea810cda6e200655f130414ae4e0e819d5bab17f075ae1904ffaec348c5146e030d7ad77fadc5100de2bf2d99e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/081995dc2b6bc6068d0ebd4135f219feaac987f67997914b3225636be542b16f111b580bea4bff3d64e1afbfb6f9a217d902723dfe07a2a80c52c668fcecbc21", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/83d1354aea5dfb8a0e6d39b84c486ec0e0448a256c392888426b64bf7e7138bfefe7813f1acc177f619f4b067ae6c470a1c8d6c877dfec69aea49f4c15ea47d5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-01 14:27:39.261409) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 14:27:39.261746) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1480629053.596644-2050541285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004441 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 14:27:39.345434) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-01 14:27:39.345748) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-01 14:27:39.346059) ========= ========= Total master_lag: 0.17 =========