builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-048 starttime: 1480487181.21 results: success (0) buildid: 20161129193208 builduid: c25642b788074aa983018da4a0eb8a47 revision: d55ebc9e509d61125961fa3b68488ce7b370d4eb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-29 22:26:21.205670) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-29 22:26:21.206117) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-29 22:26:21.206407) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-29 22:26:21.220976) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 22:26:21.221335) ========= 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=fa44defc139c4ba8574fe040000001db-1480487181.367456-2072277714 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-29 22:26:22-- 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% 42.7M=0s 2016-11-29 22:26:22 (42.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.075164 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 22:26:21.310238) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 22:26:21.310559) ========= 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=fa44defc139c4ba8574fe040000001db-1480487181.367456-2072277714 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016496 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 22:26:21.360394) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 22:26:21.360997) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d55ebc9e509d61125961fa3b68488ce7b370d4eb --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 d55ebc9e509d61125961fa3b68488ce7b370d4eb --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=fa44defc139c4ba8574fe040000001db-1480487181.367456-2072277714 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-29 22:26:22,298 truncating revision to first 12 chars 2016-11-29 22:26:22,299 Setting DEBUG logging. 2016-11-29 22:26:22,299 attempt 1/10 2016-11-29 22:26:22,299 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d55ebc9e509d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-29 22:26:22,658 unpacking tar archive at: mozilla-aurora-d55ebc9e509d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.684980 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 22:26:22.061865) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-29 22:26:22.062416) ========= script_repo_revision: d55ebc9e509d61125961fa3b68488ce7b370d4eb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-29 22:26:22.063043) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-29 22:26:22.063443) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-29 22:26:22.074719) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-11-29 22:26:22.075321) ========= /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=fa44defc139c4ba8574fe040000001db-1480487181.367456-2072277714 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:26:23 INFO - MultiFileLogger online at 20161129 22:26:23 in /builds/slave/test 22:26:23 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 22:26:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:26:23 INFO - {'append_to_log': False, 22:26:23 INFO - 'base_work_dir': '/builds/slave/test', 22:26:23 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 22:26:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:26:23 INFO - 'branch': 'Mozilla-Aurora', 22:26:23 INFO - 'buildbot_json_path': 'buildprops.json', 22:26:23 INFO - 'config_files': ('talos/linux_config.py',), 22:26:23 INFO - 'default_actions': ('clobber', 22:26:23 INFO - 'read-buildbot-config', 22:26:23 INFO - 'download-and-extract', 22:26:23 INFO - 'populate-webroot', 22:26:23 INFO - 'create-virtualenv', 22:26:23 INFO - 'install', 22:26:23 INFO - 'run-tests'), 22:26:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:26:23 INFO - 'download_minidump_stackwalk': True, 22:26:23 INFO - 'download_symbols': 'ondemand', 22:26:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:26:23 INFO - 'tooltool.py': '/tools/tooltool.py', 22:26:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:26:23 INFO - '/tools/misc-python/virtualenv.py')}, 22:26:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:26:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:26:23 INFO - 'installer_path': 'installer.exe', 22:26:23 INFO - 'log_level': 'info', 22:26:23 INFO - 'log_name': 'talos', 22:26:23 INFO - 'log_to_console': True, 22:26:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:26:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:26:23 INFO - 'opt_config_files': (), 22:26:23 INFO - 'pip_index': False, 22:26:23 INFO - 'sps_profile': False, 22:26:23 INFO - 'sps_profile_interval': 0, 22:26:23 INFO - 'suite': 'dromaeojs', 22:26:23 INFO - 'system_bits': '32', 22:26:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:26:23 INFO - 'title': 'talos-linux64-ix-048', 22:26:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:26:23 INFO - 'use_talos_json': True, 22:26:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:26:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:26:23 INFO - 'work_dir': 'build'} 22:26:23 INFO - [mozharness: 2016-11-30 06:26:23.113963Z] Running clobber step. 22:26:23 INFO - Running pre-action listener: _resource_record_pre_action 22:26:23 INFO - Running main action method: clobber 22:26:23 INFO - rmtree: /builds/slave/test/build 22:26:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:26:23 INFO - Running post-action listener: _resource_record_post_action 22:26:23 INFO - [mozharness: 2016-11-30 06:26:23.602967Z] Finished clobber step (success) 22:26:23 INFO - [mozharness: 2016-11-30 06:26:23.603066Z] Running read-buildbot-config step. 22:26:23 INFO - Running pre-action listener: _resource_record_pre_action 22:26:23 INFO - Running main action method: read_buildbot_config 22:26:23 INFO - Using buildbot properties: 22:26:23 INFO - { 22:26:23 INFO - "project": "", 22:26:23 INFO - "product": "firefox", 22:26:23 INFO - "script_repo_revision": "production", 22:26:23 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 22:26:23 INFO - "repository": "", 22:26:23 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 22:26:23 INFO - "buildid": "20161129193208", 22:26:23 INFO - "pgo_build": "True", 22:26:23 INFO - "basedir": "/builds/slave/test", 22:26:23 INFO - "buildnumber": 654, 22:26:23 INFO - "slavename": "talos-linux64-ix-048", 22:26:23 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:26:23 INFO - "platform": "ubuntu64_hw", 22:26:23 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 22:26:23 INFO - "branch": "mozilla-aurora", 22:26:23 INFO - "repo_path": "releases/mozilla-aurora", 22:26:23 INFO - "revision": "d55ebc9e509d61125961fa3b68488ce7b370d4eb", 22:26:23 INFO - "stage_platform": "linux64-pgo", 22:26:23 INFO - "builduid": "c25642b788074aa983018da4a0eb8a47", 22:26:23 INFO - "slavebuilddir": "test" 22:26:23 INFO - } 22:26:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/QRqCbHdHQdKceODRH2gXcw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 22:26:23 INFO - Running post-action listener: _resource_record_post_action 22:26:23 INFO - [mozharness: 2016-11-30 06:26:23.605475Z] Finished read-buildbot-config step (success) 22:26:23 INFO - [mozharness: 2016-11-30 06:26:23.605563Z] Running download-and-extract step. 22:26:23 INFO - Running pre-action listener: _resource_record_pre_action 22:26:23 INFO - Running main action method: download_and_extract 22:26:23 INFO - mkdir: /builds/slave/test/build/tests 22:26:23 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')]} 22:26:23 INFO - trying https://queue.taskcluster.net/v1/task/QRqCbHdHQdKceODRH2gXcw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 22:26:23 INFO - Downloading https://queue.taskcluster.net/v1/task/QRqCbHdHQdKceODRH2gXcw/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 22:26:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QRqCbHdHQdKceODRH2gXcw/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 22:26:24 INFO - Downloaded 1361 bytes. 22:26:24 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 22:26:24 INFO - Using the following test package requirements: 22:26:24 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 22:26:24 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 22:26:24 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 22:26:24 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 22:26:24 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 22:26:24 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 22:26:24 INFO - u'jsshell-linux-x86_64.zip'], 22:26:24 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 22:26:24 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 22:26:24 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 22:26:24 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 22:26:24 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 22:26:24 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 22:26:24 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 22:26:24 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 22:26:24 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 22:26:24 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 22:26:24 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 22:26:24 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:26:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QRqCbHdHQdKceODRH2gXcw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 22:26:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QRqCbHdHQdKceODRH2gXcw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:26:24 INFO - Fetch https://queue.taskcluster.net/v1/task/QRqCbHdHQdKceODRH2gXcw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 22:26:26 INFO - Http code: 200 22:26:26 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 22:26:26 INFO - x-amz-cf-id: Vkg3UndVvhsgX22rUsyEcs_ArWU4hQBBETr9yBGto3LESWQUWOcPgw== 22:26:26 INFO - x-amz-version-id: wgoFlZ8IcbpPYcM65IAwXi3CezWd1MyB 22:26:26 INFO - Expected file size: 21957738 22:26:26 INFO - Obtained file size: 21957738 22:26:30 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 22:26:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QRqCbHdHQdKceODRH2gXcw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 22:26:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QRqCbHdHQdKceODRH2gXcw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:26:30 INFO - Fetch https://queue.taskcluster.net/v1/task/QRqCbHdHQdKceODRH2gXcw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 22:26:31 INFO - Http code: 200 22:26:31 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 22:26:31 INFO - x-amz-cf-id: RtnR6KtVy9WgvKWEIfSMr2_kFRpwnImGRrKqM6h695Ru17GPBzzmJg== 22:26:31 INFO - x-amz-version-id: wgoFlZ8IcbpPYcM65IAwXi3CezWd1MyB 22:26:31 INFO - Expected file size: 21957738 22:26:31 INFO - Obtained file size: 21957738 22:26:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QRqCbHdHQdKceODRH2gXcw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 22:26:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QRqCbHdHQdKceODRH2gXcw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:26:36 INFO - Fetch https://queue.taskcluster.net/v1/task/QRqCbHdHQdKceODRH2gXcw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 22:26:36 INFO - Http code: 200 22:26:36 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 22:26:36 INFO - x-amz-cf-id: 2LXPnY8xBIm8v9zemr4fOgYyUxIjuAMZRmdcZFsoPzJiH_19979JKA== 22:26:36 INFO - x-amz-version-id: OjTb4bNOR_f36voVBSaDAmty4lqocf3_ 22:26:37 INFO - Expected file size: 14409038 22:26:37 INFO - Obtained file size: 14409038 22:26: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')]} 22:26:37 INFO - trying https://queue.taskcluster.net/v1/task/QRqCbHdHQdKceODRH2gXcw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 22:26:37 INFO - Downloading https://queue.taskcluster.net/v1/task/QRqCbHdHQdKceODRH2gXcw/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 22:26:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QRqCbHdHQdKceODRH2gXcw/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 22:26:38 INFO - Downloaded 63999487 bytes. 22:26:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QRqCbHdHQdKceODRH2gXcw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 22:26:38 INFO - mkdir: /builds/slave/test/properties 22:26:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:26:38 INFO - Writing to file /builds/slave/test/properties/build_url 22:26:38 INFO - Contents: 22:26:38 INFO - build_url:https://queue.taskcluster.net/v1/task/QRqCbHdHQdKceODRH2gXcw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 22:26:39 INFO - Running post-action listener: _resource_record_post_action 22:26:39 INFO - Running post-action listener: set_extra_try_arguments 22:26:39 INFO - [mozharness: 2016-11-30 06:26:39.142499Z] Finished download-and-extract step (success) 22:26:39 INFO - [mozharness: 2016-11-30 06:26:39.142725Z] Running populate-webroot step. 22:26:39 INFO - Running pre-action listener: _resource_record_pre_action 22:26:39 INFO - Running main action method: populate_webroot 22:26:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:26:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:26:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:26:39 INFO - '--tppagecycles', 22:26:39 INFO - '7'], 22:26:39 INFO - 'tests': ['tsvgm']}}, 22:26:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:26:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:26:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:26:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:26:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:26:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:26:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:26:39 INFO - 'talos_options': ['--disable-e10s'], 22:26:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:26:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:26:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:26:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:26:39 INFO - 'talos_options': ['--disable-e10s'], 22:26:39 INFO - 'tests': ['damp', 'tps']}, 22:26:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:26:39 INFO - 'tests': ['damp', 'tps']}, 22:26:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:26:39 INFO - 'tests': ['dromaeo_dom']}, 22:26:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:26:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:26:39 INFO - 'tests': ['basic_compositor_video']}, 22:26:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:26:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:26:39 INFO - 'tests': ['a11yr', 22:26:39 INFO - 'ts_paint', 22:26:39 INFO - 'tpaint', 22:26:39 INFO - 'sessionrestore', 22:26:39 INFO - 'sessionrestore_no_auto_restore', 22:26:39 INFO - 'tabpaint']}, 22:26:39 INFO - 'other-e10s': {'tests': ['a11yr', 22:26:39 INFO - 'ts_paint', 22:26:39 INFO - 'tpaint', 22:26:39 INFO - 'sessionrestore', 22:26:39 INFO - 'sessionrestore_no_auto_restore', 22:26:39 INFO - 'tabpaint']}, 22:26:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:26:39 INFO - 'ts_paint', 22:26:39 INFO - 'tpaint', 22:26:39 INFO - 'sessionrestore', 22:26:39 INFO - 'sessionrestore_no_auto_restore', 22:26:39 INFO - 'tabpaint']}, 22:26:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:26:39 INFO - 'ts_paint', 22:26:39 INFO - 'tpaint', 22:26:39 INFO - 'sessionrestore', 22:26:39 INFO - 'sessionrestore_no_auto_restore', 22:26:39 INFO - 'tabpaint']}, 22:26:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:26:39 INFO - 'tests': ['a11yr', 22:26:39 INFO - 'ts_paint', 22:26:39 INFO - 'tpaint', 22:26:39 INFO - 'sessionrestore', 22:26:39 INFO - 'sessionrestore_no_auto_restore', 22:26:39 INFO - 'tabpaint']}, 22:26:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:26:39 INFO - 'tests': ['a11yr', 22:26:39 INFO - 'ts_paint', 22:26:39 INFO - 'tpaint', 22:26:39 INFO - 'sessionrestore', 22:26:39 INFO - 'sessionrestore_no_auto_restore', 22:26:39 INFO - 'tabpaint']}, 22:26:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:26:39 INFO - 'tests': ['tsvgx', 22:26:39 INFO - 'tsvgr_opacity', 22:26:39 INFO - 'tart', 22:26:39 INFO - 'tscrollx', 22:26:39 INFO - 'cart']}, 22:26:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:26:39 INFO - 'tsvgr_opacity', 22:26:39 INFO - 'tart', 22:26:39 INFO - 'tscrollx', 22:26:39 INFO - 'cart']}, 22:26:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:26:39 INFO - 'talos_options': ['--disable-e10s'], 22:26:39 INFO - 'tests': ['tp5o']}, 22:26:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:26:39 INFO - 'tests': ['tp5o']}, 22:26:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:26:39 INFO - 'talos_options': ['--disable-e10s', 22:26:39 INFO - '--xperf_path', 22:26:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:26:39 INFO - 'tests': ['tp5n']}, 22:26:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:26:39 INFO - 'talos_options': ['--xperf_path', 22:26:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:26:39 INFO - 'tests': ['tp5n']}}, 22:26:39 INFO - 'talos.zip': {'path': '', 22:26:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:26:39 INFO - Running post-action listener: _resource_record_post_action 22:26:39 INFO - [mozharness: 2016-11-30 06:26:39.160617Z] Finished populate-webroot step (success) 22:26:39 INFO - [mozharness: 2016-11-30 06:26:39.160706Z] Running create-virtualenv step. 22:26:39 INFO - Running pre-action listener: _resource_record_pre_action 22:26:39 INFO - Running main action method: create_virtualenv 22:26:39 INFO - Creating virtualenv /builds/slave/test/build/venv 22:26:39 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 22:26:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:26:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:26:39 INFO - Using real prefix '/usr' 22:26:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:26:39 INFO - Installing distribute.............................................................................................................................................................................................done. 22:26:41 INFO - Installing pip.................done. 22:26:41 INFO - Return code: 0 22:26:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:26:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:26:41 INFO - Reading from file tmpfile_stdout 22:26:41 INFO - Output received: 22:26:41 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) 22:26:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:26: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')]} 22:26:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:26:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26: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')]} 22:26:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:26:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0fc0759f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a2f60>, '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 0x19a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a41d0>, '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': 'fa44defc139c4ba8574fe040000001db-1480487181.367456-2072277714', '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 22:26: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', 'pip>=1.5'] in /builds/slave/test/build 22:26: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 pip>=1.5 22:26:41 INFO - Using env: {'DISPLAY': ':0', 22:26:41 INFO - 'HOME': '/home/cltbld', 22:26:41 INFO - 'LANG': 'en_US.UTF-8', 22:26:41 INFO - 'LANGUAGE': 'en_US:en', 22:26:41 INFO - 'LOGNAME': 'cltbld', 22:26:41 INFO - 'MAIL': '/var/mail/cltbld', 22:26:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:26:41 INFO - 'MOZ_NO_REMOTE': '1', 22:26:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:26:41 INFO - 'NO_EM_RESTART': '1', 22:26:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:26:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:26:41 INFO - 'PWD': '/builds/slave/test', 22:26:41 INFO - 'SHELL': '/bin/bash', 22:26:41 INFO - 'SHLVL': '1', 22:26:41 INFO - 'TERM': 'linux', 22:26:41 INFO - 'TMOUT': '86400', 22:26:41 INFO - 'USER': 'cltbld', 22:26:41 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1480487181.367456-2072277714', 22:26:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:26:41 INFO - '_': '/tools/buildbot/bin/python'} 22:26:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:26:42 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 22:26:42 INFO - Cleaning up... 22:26:42 INFO - Return code: 0 22:26:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:26:42 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')]} 22:26:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:26:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:42 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')]} 22:26:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:26:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:42 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 0x7f0fc0759f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a2f60>, '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 0x19a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a41d0>, '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': 'fa44defc139c4ba8574fe040000001db-1480487181.367456-2072277714', '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 22:26:42 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 22:26:42 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 22:26:42 INFO - Using env: {'DISPLAY': ':0', 22:26:42 INFO - 'HOME': '/home/cltbld', 22:26:42 INFO - 'LANG': 'en_US.UTF-8', 22:26:42 INFO - 'LANGUAGE': 'en_US:en', 22:26:42 INFO - 'LOGNAME': 'cltbld', 22:26:42 INFO - 'MAIL': '/var/mail/cltbld', 22:26:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:26:42 INFO - 'MOZ_NO_REMOTE': '1', 22:26:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:26:42 INFO - 'NO_EM_RESTART': '1', 22:26:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:26:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:26:42 INFO - 'PWD': '/builds/slave/test', 22:26:42 INFO - 'SHELL': '/bin/bash', 22:26:42 INFO - 'SHLVL': '1', 22:26:42 INFO - 'TERM': 'linux', 22:26:42 INFO - 'TMOUT': '86400', 22:26:42 INFO - 'USER': 'cltbld', 22:26:42 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1480487181.367456-2072277714', 22:26:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:26:42 INFO - '_': '/tools/buildbot/bin/python'} 22:26:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:26:42 INFO - Downloading/unpacking psutil>=3.1.1 22:26:42 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 22:26:42 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 22:26:42 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 22:26:42 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 22:26:42 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 22:26:42 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 22:26:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:26:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:26:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:26:44 INFO - Installing collected packages: psutil 22:26:44 INFO - Running setup.py install for psutil 22:26:44 INFO - building 'psutil._psutil_linux' extension 22:26:44 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 22:26:44 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 22:26:44 INFO - building 'psutil._psutil_posix' extension 22:26:44 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 22:26:44 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 22:26:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:26:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:26:44 INFO - Successfully installed psutil 22:26:44 INFO - Cleaning up... 22:26:45 INFO - Return code: 0 22:26:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:26:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:26:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:26:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:26:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:26:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0fc0759f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a2f60>, '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 0x19a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a41d0>, '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': 'fa44defc139c4ba8574fe040000001db-1480487181.367456-2072277714', '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 22:26:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 22:26:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 22:26:45 INFO - Using env: {'DISPLAY': ':0', 22:26:45 INFO - 'HOME': '/home/cltbld', 22:26:45 INFO - 'LANG': 'en_US.UTF-8', 22:26:45 INFO - 'LANGUAGE': 'en_US:en', 22:26:45 INFO - 'LOGNAME': 'cltbld', 22:26:45 INFO - 'MAIL': '/var/mail/cltbld', 22:26:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:26:45 INFO - 'MOZ_NO_REMOTE': '1', 22:26:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:26:45 INFO - 'NO_EM_RESTART': '1', 22:26:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:26:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:26:45 INFO - 'PWD': '/builds/slave/test', 22:26:45 INFO - 'SHELL': '/bin/bash', 22:26:45 INFO - 'SHLVL': '1', 22:26:45 INFO - 'TERM': 'linux', 22:26:45 INFO - 'TMOUT': '86400', 22:26:45 INFO - 'USER': 'cltbld', 22:26:45 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1480487181.367456-2072277714', 22:26:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:26:45 INFO - '_': '/tools/buildbot/bin/python'} 22:26:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:26:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:26:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:26:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:26:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:26:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:26:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:26:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:26:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:26:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:26:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:26:47 INFO - Installing collected packages: mozsystemmonitor 22:26:47 INFO - Running setup.py install for mozsystemmonitor 22:26:47 INFO - Successfully installed mozsystemmonitor 22:26:47 INFO - Cleaning up... 22:26:47 INFO - Return code: 0 22:26:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:26:47 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')]} 22:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:26:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:47 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')]} 22:26:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:26:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:47 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 0x7f0fc0759f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a2f60>, '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 0x19a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a41d0>, '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': 'fa44defc139c4ba8574fe040000001db-1480487181.367456-2072277714', '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 22:26:47 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 22:26:47 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 22:26:47 INFO - Using env: {'DISPLAY': ':0', 22:26:47 INFO - 'HOME': '/home/cltbld', 22:26:47 INFO - 'LANG': 'en_US.UTF-8', 22:26:47 INFO - 'LANGUAGE': 'en_US:en', 22:26:47 INFO - 'LOGNAME': 'cltbld', 22:26:47 INFO - 'MAIL': '/var/mail/cltbld', 22:26:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:26:47 INFO - 'MOZ_NO_REMOTE': '1', 22:26:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:26:47 INFO - 'NO_EM_RESTART': '1', 22:26:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:26:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:26:47 INFO - 'PWD': '/builds/slave/test', 22:26:47 INFO - 'SHELL': '/bin/bash', 22:26:47 INFO - 'SHLVL': '1', 22:26:47 INFO - 'TERM': 'linux', 22:26:47 INFO - 'TMOUT': '86400', 22:26:47 INFO - 'USER': 'cltbld', 22:26:47 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1480487181.367456-2072277714', 22:26:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:26:47 INFO - '_': '/tools/buildbot/bin/python'} 22:26:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:26:47 INFO - Downloading/unpacking jsonschema==2.5.1 22:26:47 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 22:26:47 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 22:26:47 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 22:26:47 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 22:26:47 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 22:26:47 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 22:26:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:26:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:26:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:26:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:26:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:26:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:26:49 INFO - Downloading functools32-3.2.3-2.tar.gz 22:26:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:26:49 INFO - warning: no files found matching '*.txt' 22:26:49 INFO - no previously-included directories found matching 'build' 22:26:49 INFO - no previously-included directories found matching 'dist' 22:26:49 INFO - no previously-included directories found matching '.git*' 22:26:49 INFO - Installing collected packages: jsonschema, functools32 22:26:49 INFO - Running setup.py install for functools32 22:26:50 INFO - warning: no files found matching '*.txt' 22:26:50 INFO - no previously-included directories found matching 'build' 22:26:50 INFO - no previously-included directories found matching 'dist' 22:26:50 INFO - no previously-included directories found matching '.git*' 22:26:50 INFO - Successfully installed jsonschema functools32 22:26:50 INFO - Cleaning up... 22:26:50 INFO - Return code: 0 22:26:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:26:50 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')]} 22:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:26:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:50 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')]} 22:26:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:26:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:50 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 0x7f0fc0759f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a2f60>, '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 0x19a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a41d0>, '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': 'fa44defc139c4ba8574fe040000001db-1480487181.367456-2072277714', '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 22:26:50 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 22:26:50 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 22:26:50 INFO - Using env: {'DISPLAY': ':0', 22:26:50 INFO - 'HOME': '/home/cltbld', 22:26:50 INFO - 'LANG': 'en_US.UTF-8', 22:26:50 INFO - 'LANGUAGE': 'en_US:en', 22:26:50 INFO - 'LOGNAME': 'cltbld', 22:26:50 INFO - 'MAIL': '/var/mail/cltbld', 22:26:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:26:50 INFO - 'MOZ_NO_REMOTE': '1', 22:26:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:26:50 INFO - 'NO_EM_RESTART': '1', 22:26:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:26:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:26:50 INFO - 'PWD': '/builds/slave/test', 22:26:50 INFO - 'SHELL': '/bin/bash', 22:26:50 INFO - 'SHLVL': '1', 22:26:50 INFO - 'TERM': 'linux', 22:26:50 INFO - 'TMOUT': '86400', 22:26:50 INFO - 'USER': 'cltbld', 22:26:50 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1480487181.367456-2072277714', 22:26:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:26:50 INFO - '_': '/tools/buildbot/bin/python'} 22:26:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:26:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:26:50 INFO - Cleaning up... 22:26:50 INFO - Return code: 0 22:26:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:26:50 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')]} 22:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:26:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:50 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')]} 22:26:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:26:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:50 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 0x7f0fc0759f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a2f60>, '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 0x19a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a41d0>, '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': 'fa44defc139c4ba8574fe040000001db-1480487181.367456-2072277714', '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 22:26:50 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 22:26:50 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 22:26:50 INFO - Using env: {'DISPLAY': ':0', 22:26:50 INFO - 'HOME': '/home/cltbld', 22:26:50 INFO - 'LANG': 'en_US.UTF-8', 22:26:50 INFO - 'LANGUAGE': 'en_US:en', 22:26:50 INFO - 'LOGNAME': 'cltbld', 22:26:50 INFO - 'MAIL': '/var/mail/cltbld', 22:26:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:26:50 INFO - 'MOZ_NO_REMOTE': '1', 22:26:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:26:50 INFO - 'NO_EM_RESTART': '1', 22:26:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:26:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:26:50 INFO - 'PWD': '/builds/slave/test', 22:26:50 INFO - 'SHELL': '/bin/bash', 22:26:50 INFO - 'SHLVL': '1', 22:26:50 INFO - 'TERM': 'linux', 22:26:50 INFO - 'TMOUT': '86400', 22:26:50 INFO - 'USER': 'cltbld', 22:26:50 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1480487181.367456-2072277714', 22:26:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:26:50 INFO - '_': '/tools/buildbot/bin/python'} 22:26:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:26:50 INFO - Downloading/unpacking blobuploader==1.2.4 22:26:50 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 22:26:50 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 22:26:50 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 22:26:50 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 22:26:50 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 22:26:50 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 22:26:52 INFO - Downloading blobuploader-1.2.4.tar.gz 22:26:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:26:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:26:52 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 22:26:52 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 22:26:52 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 22:26:52 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 22:26:52 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 22:26:52 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 22:26:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:26:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:26:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:26:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:26:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:26:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:26:53 INFO - Downloading docopt-0.6.1.tar.gz 22:26:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:26:53 INFO - Installing collected packages: blobuploader, requests, docopt 22:26:53 INFO - Running setup.py install for blobuploader 22:26:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:26:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:26:53 INFO - Running setup.py install for requests 22:26:53 INFO - Running setup.py install for docopt 22:26:53 INFO - Successfully installed blobuploader requests docopt 22:26:53 INFO - Cleaning up... 22:26:54 INFO - Return code: 0 22:26:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:26:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:26:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:26:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:54 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 0x7f0fc0759f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a2f60>, '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 0x19a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a41d0>, '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': 'fa44defc139c4ba8574fe040000001db-1480487181.367456-2072277714', '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 22:26:54 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 22:26:54 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 22:26:54 INFO - Using env: {'DISPLAY': ':0', 22:26:54 INFO - 'HOME': '/home/cltbld', 22:26:54 INFO - 'LANG': 'en_US.UTF-8', 22:26:54 INFO - 'LANGUAGE': 'en_US:en', 22:26:54 INFO - 'LOGNAME': 'cltbld', 22:26:54 INFO - 'MAIL': '/var/mail/cltbld', 22:26:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:26:54 INFO - 'MOZ_NO_REMOTE': '1', 22:26:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:26:54 INFO - 'NO_EM_RESTART': '1', 22:26:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:26:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:26:54 INFO - 'PWD': '/builds/slave/test', 22:26:54 INFO - 'SHELL': '/bin/bash', 22:26:54 INFO - 'SHLVL': '1', 22:26:54 INFO - 'TERM': 'linux', 22:26:54 INFO - 'TMOUT': '86400', 22:26:54 INFO - 'USER': 'cltbld', 22:26:54 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1480487181.367456-2072277714', 22:26:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:26:54 INFO - '_': '/tools/buildbot/bin/python'} 22:26:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:26:54 INFO - Running setup.py (path:/tmp/pip-Xks1XF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:26:54 INFO - Running setup.py (path:/tmp/pip-tf7N5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:26:54 INFO - Running setup.py (path:/tmp/pip-Bki6J0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:26:54 INFO - Running setup.py (path:/tmp/pip-kNCyS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:26:54 INFO - Running setup.py (path:/tmp/pip-RWZLPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:26:54 INFO - Running setup.py (path:/tmp/pip-sXsKtE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:26:54 INFO - Running setup.py (path:/tmp/pip-EF0lwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:26:54 INFO - Running setup.py (path:/tmp/pip-rrYQYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:26:54 INFO - Running setup.py (path:/tmp/pip-9ojaMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:26:54 INFO - Running setup.py (path:/tmp/pip-LP4_M7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:26:54 INFO - Running setup.py (path:/tmp/pip-Nwk8S3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:26:55 INFO - Running setup.py (path:/tmp/pip-IAL8mx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:26:55 INFO - Running setup.py (path:/tmp/pip-BVKcFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:26:55 INFO - Running setup.py (path:/tmp/pip-m9aPq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:26:55 INFO - Running setup.py (path:/tmp/pip-OROq6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:26:55 INFO - Running setup.py (path:/tmp/pip-DUJnPe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:26:55 INFO - Running setup.py (path:/tmp/pip-B98taI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:26:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:26:55 INFO - Running setup.py install for manifestparser 22:26:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:26:55 INFO - Running setup.py install for mozcrash 22:26:55 INFO - Running setup.py install for mozdebug 22:26:55 INFO - Running setup.py install for mozdevice 22:26:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:26:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:26:55 INFO - Running setup.py install for mozfile 22:26:56 INFO - Running setup.py install for mozhttpd 22:26:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:26:56 INFO - Running setup.py install for mozinfo 22:26:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:26:56 INFO - Running setup.py install for mozInstall 22:26:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:26:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:26:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:26:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:26:56 INFO - Running setup.py install for mozleak 22:26:56 INFO - Running setup.py install for mozlog 22:26:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:26:56 INFO - Running setup.py install for moznetwork 22:26:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:26:56 INFO - Running setup.py install for mozprocess 22:26:56 INFO - Running setup.py install for mozprofile 22:26:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:26:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:26:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:26:56 INFO - Running setup.py install for mozrunner 22:26:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:26:56 INFO - Running setup.py install for mozscreenshot 22:26:57 INFO - Running setup.py install for moztest 22:26:57 INFO - Running setup.py install for mozversion 22:26:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:26:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:26:57 INFO - Cleaning up... 22:26:57 INFO - Return code: 0 22:26:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:26:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:26:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:26:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:26:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:57 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 0x7f0fc0759f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a2f60>, '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 0x19a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a41d0>, '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': 'fa44defc139c4ba8574fe040000001db-1480487181.367456-2072277714', '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 22:26:57 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 22:26:57 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 22:26:57 INFO - Using env: {'DISPLAY': ':0', 22:26:57 INFO - 'HOME': '/home/cltbld', 22:26:57 INFO - 'LANG': 'en_US.UTF-8', 22:26:57 INFO - 'LANGUAGE': 'en_US:en', 22:26:57 INFO - 'LOGNAME': 'cltbld', 22:26:57 INFO - 'MAIL': '/var/mail/cltbld', 22:26:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:26:57 INFO - 'MOZ_NO_REMOTE': '1', 22:26:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:26:57 INFO - 'NO_EM_RESTART': '1', 22:26:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:26:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:26:57 INFO - 'PWD': '/builds/slave/test', 22:26:57 INFO - 'SHELL': '/bin/bash', 22:26:57 INFO - 'SHLVL': '1', 22:26:57 INFO - 'TERM': 'linux', 22:26:57 INFO - 'TMOUT': '86400', 22:26:57 INFO - 'USER': 'cltbld', 22:26:57 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1480487181.367456-2072277714', 22:26:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:26:57 INFO - '_': '/tools/buildbot/bin/python'} 22:26:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:26:57 INFO - Running setup.py (path:/tmp/pip-FE1Z2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:26:57 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)) 22:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:26:57 INFO - Running setup.py (path:/tmp/pip-oPZXBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:26:57 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)) 22:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:26:57 INFO - Running setup.py (path:/tmp/pip-FPG6hZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:26:57 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)) 22:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:26:57 INFO - Running setup.py (path:/tmp/pip-i0PiMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:26:57 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)) 22:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:26:57 INFO - Running setup.py (path:/tmp/pip-L5tPqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:26:57 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)) 22:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:26:57 INFO - Running setup.py (path:/tmp/pip-caKCwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:26:57 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)) 22:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:26:57 INFO - Running setup.py (path:/tmp/pip-AyIFZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:26:58 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)) 22:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:26:58 INFO - Running setup.py (path:/tmp/pip-24d124-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:26:58 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)) 22:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:26:58 INFO - Running setup.py (path:/tmp/pip-12HCk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:26:58 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)) 22:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:26:58 INFO - Running setup.py (path:/tmp/pip-7Idge8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:26:58 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)) 22:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:26:58 INFO - Running setup.py (path:/tmp/pip-v53q6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:26:58 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)) 22:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:26:58 INFO - Running setup.py (path:/tmp/pip-BmzIJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:26:58 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)) 22:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:26:58 INFO - Running setup.py (path:/tmp/pip-JHFDd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:26:58 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)) 22:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:26:58 INFO - Running setup.py (path:/tmp/pip-cxKbkM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:26:58 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)) 22:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:26:58 INFO - Running setup.py (path:/tmp/pip-lwRtTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:26:58 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)) 22:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:26:58 INFO - Running setup.py (path:/tmp/pip-zvSyJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:26:58 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)) 22:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:26:58 INFO - Running setup.py (path:/tmp/pip-E8aJoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:26:58 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)) 22:26:58 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)) 22:26:58 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)) 22:26:58 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)) 22:26:58 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)) 22:26:58 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)) 22:26:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:26:58 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 22:26:58 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 22:26:58 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 22:26:58 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 22:26:58 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 22:26:58 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 22:27:00 INFO - Downloading blessings-1.6.tar.gz 22:27:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:27:00 INFO - Installing collected packages: blessings 22:27:00 INFO - Running setup.py install for blessings 22:27:00 INFO - Successfully installed blessings 22:27:00 INFO - Cleaning up... 22:27:01 INFO - Return code: 0 22:27:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:27:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:27:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:27:01 INFO - Reading from file tmpfile_stdout 22:27:01 INFO - Current package versions: 22:27:01 INFO - argparse == 1.2.1 22:27:01 INFO - blessings == 1.6 22:27:01 INFO - blobuploader == 1.2.4 22:27:01 INFO - docopt == 0.6.1 22:27:01 INFO - functools32 == 3.2.3-2 22:27:01 INFO - jsonschema == 2.5.1 22:27:01 INFO - manifestparser == 1.1 22:27:01 INFO - mozInstall == 1.12 22:27:01 INFO - mozcrash == 1.0 22:27:01 INFO - mozdebug == 0.1 22:27:01 INFO - mozdevice == 0.48 22:27:01 INFO - mozfile == 1.2 22:27:01 INFO - mozhttpd == 0.7 22:27:01 INFO - mozinfo == 0.9 22:27:01 INFO - mozleak == 0.1 22:27:01 INFO - mozlog == 3.4 22:27:01 INFO - moznetwork == 0.27 22:27:01 INFO - mozprocess == 0.23 22:27:01 INFO - mozprofile == 0.28 22:27:01 INFO - mozrunner == 6.13 22:27:01 INFO - mozscreenshot == 0.1 22:27:01 INFO - mozsystemmonitor == 0.3 22:27:01 INFO - moztest == 0.7 22:27:01 INFO - mozversion == 1.4 22:27:01 INFO - psutil == 3.1.1 22:27:01 INFO - requests == 1.2.3 22:27:01 INFO - wsgiref == 0.1.2 22:27:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:27:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:01 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 0x7f0fc0759f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a2f60>, '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 0x19a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a41d0>, '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': 'fa44defc139c4ba8574fe040000001db-1480487181.367456-2072277714', '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 22:27:01 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 22:27:01 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 22:27:01 INFO - Using env: {'DISPLAY': ':0', 22:27:01 INFO - 'HOME': '/home/cltbld', 22:27:01 INFO - 'LANG': 'en_US.UTF-8', 22:27:01 INFO - 'LANGUAGE': 'en_US:en', 22:27:01 INFO - 'LOGNAME': 'cltbld', 22:27:01 INFO - 'MAIL': '/var/mail/cltbld', 22:27:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:01 INFO - 'MOZ_NO_REMOTE': '1', 22:27:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:27:01 INFO - 'NO_EM_RESTART': '1', 22:27:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:27:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:27:01 INFO - 'PWD': '/builds/slave/test', 22:27:01 INFO - 'SHELL': '/bin/bash', 22:27:01 INFO - 'SHLVL': '1', 22:27:01 INFO - 'TERM': 'linux', 22:27:01 INFO - 'TMOUT': '86400', 22:27:01 INFO - 'USER': 'cltbld', 22:27:01 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1480487181.367456-2072277714', 22:27:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:01 INFO - '_': '/tools/buildbot/bin/python'} 22:27:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:01 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)) 22:27:01 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)) 22:27:01 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)) 22:27:01 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)) 22:27:01 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)) 22:27:01 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)) 22:27:01 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)) 22:27:01 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)) 22:27:01 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)) 22:27:01 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)) 22:27:01 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)) 22:27:01 INFO - Cleaning up... 22:27:01 INFO - Return code: 0 22:27:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:27:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:01 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 0x7f0fc0759f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a2f60>, '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 0x19a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a41d0>, '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': 'fa44defc139c4ba8574fe040000001db-1480487181.367456-2072277714', '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 22:27:01 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 22:27:01 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 22:27:01 INFO - Using env: {'DISPLAY': ':0', 22:27:01 INFO - 'HOME': '/home/cltbld', 22:27:01 INFO - 'LANG': 'en_US.UTF-8', 22:27:01 INFO - 'LANGUAGE': 'en_US:en', 22:27:01 INFO - 'LOGNAME': 'cltbld', 22:27:01 INFO - 'MAIL': '/var/mail/cltbld', 22:27:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:01 INFO - 'MOZ_NO_REMOTE': '1', 22:27:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:27:01 INFO - 'NO_EM_RESTART': '1', 22:27:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:27:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:27:01 INFO - 'PWD': '/builds/slave/test', 22:27:01 INFO - 'SHELL': '/bin/bash', 22:27:01 INFO - 'SHLVL': '1', 22:27:01 INFO - 'TERM': 'linux', 22:27:01 INFO - 'TMOUT': '86400', 22:27:01 INFO - 'USER': 'cltbld', 22:27:01 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1480487181.367456-2072277714', 22:27:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:01 INFO - '_': '/tools/buildbot/bin/python'} 22:27:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:27:01 INFO - Cleaning up... 22:27:01 INFO - Return code: 0 22:27:01 INFO - Running post-action listener: _resource_record_post_action 22:27:01 INFO - Running post-action listener: _start_resource_monitoring 22:27:01 INFO - Starting resource monitoring. 22:27:01 INFO - [mozharness: 2016-11-30 06:27:01.763011Z] Finished create-virtualenv step (success) 22:27:01 INFO - [mozharness: 2016-11-30 06:27:01.763513Z] Running install step. 22:27:01 INFO - Running pre-action listener: _resource_record_pre_action 22:27:01 INFO - Running main action method: install 22:27:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:27:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:27:01 INFO - Reading from file tmpfile_stdout 22:27:01 INFO - Detecting whether we're running mozinstall >=1.0... 22:27:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:27:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:27:02 INFO - Reading from file tmpfile_stdout 22:27:02 INFO - Output received: 22:27:02 INFO - Usage: mozinstall [options] installer 22:27:02 INFO - Options: 22:27:02 INFO - -h, --help show this help message and exit 22:27:02 INFO - -d DEST, --destination=DEST 22:27:02 INFO - Directory to install application into. [default: 22:27:02 INFO - "/builds/slave/test"] 22:27:02 INFO - --app=APP Application being installed. [default: firefox] 22:27:02 INFO - mkdir: /builds/slave/test/build/application 22:27:02 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'] 22:27:02 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 22:27:17 INFO - Reading from file tmpfile_stdout 22:27:17 INFO - Output received: 22:27:17 INFO - /builds/slave/test/build/application/firefox/firefox 22:27:17 INFO - Running post-action listener: _resource_record_post_action 22:27:17 INFO - [mozharness: 2016-11-30 06:27:17.990757Z] Finished install step (success) 22:27:17 INFO - [mozharness: 2016-11-30 06:27:17.990999Z] Running run-tests step. 22:27:17 INFO - Running pre-action listener: _resource_record_pre_action 22:27:17 INFO - Running main action method: run_tests 22:27:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:27:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:27:17 INFO - Python 2.7.3 22:27:17 INFO - Return code: 0 22:27:17 INFO - grabbing minidump binary from tooltool 22:27: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')]} 22:27:17 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 0x19a2f60>, '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 0x19a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a41d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:27:17 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 22:27:18 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 22:27:18 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 22:27:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:27:18 INFO - Return code: 0 22:27:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:27:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:27:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:27:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:27:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:27:18 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/QRqCbHdHQdKceODRH2gXcw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 22:27:18 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/QRqCbHdHQdKceODRH2gXcw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --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 22:27:18 INFO - Using env: {'DISPLAY': ':0', 22:27:18 INFO - 'HOME': '/home/cltbld', 22:27:18 INFO - 'LANG': 'en_US.UTF-8', 22:27:18 INFO - 'LANGUAGE': 'en_US:en', 22:27:18 INFO - 'LOGNAME': 'cltbld', 22:27:18 INFO - 'MAIL': '/var/mail/cltbld', 22:27:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:27:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:27:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:18 INFO - 'MOZ_NO_REMOTE': '1', 22:27:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:27:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:27:18 INFO - 'NO_EM_RESTART': '1', 22:27:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:27:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:27:18 INFO - 'PWD': '/builds/slave/test', 22:27:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:27:18 INFO - 'SHELL': '/bin/bash', 22:27:18 INFO - 'SHLVL': '1', 22:27:18 INFO - 'TERM': 'linux', 22:27:18 INFO - 'TMOUT': '86400', 22:27:18 INFO - 'USER': 'cltbld', 22:27:18 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1480487181.367456-2072277714', 22:27:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:18 INFO - '_': '/tools/buildbot/bin/python'} 22:27:18 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/QRqCbHdHQdKceODRH2gXcw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 22:27:18 INFO - mozversion application_buildid: 20161129193208 22:27:18 INFO - mozversion application_changeset: d55ebc9e509d61125961fa3b68488ce7b370d4eb 22:27:18 INFO - mozversion application_display_name: FirefoxDeveloperEdition 22:27:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:27:18 INFO - mozversion application_name: Firefox 22:27:18 INFO - mozversion application_remotingname: firefox-dev 22:27:18 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 22:27:18 INFO - mozversion application_vendor: Mozilla 22:27:18 INFO - mozversion application_version: 52.0a2 22:27:18 INFO - mozversion platform_buildid: 20161129193208 22:27:18 INFO - mozversion platform_changeset: d55ebc9e509d61125961fa3b68488ce7b370d4eb 22:27:18 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 22:27:18 INFO - mozversion platform_version: 52.0a2 22:27:18 INFO - using testdate: 1480487238 22:27:18 INFO - actual date: 1480487238 22:27:18 INFO - starting webserver on 'localhost:54492' 22:27:18 INFO - SUITE-START | Running 2 tests 22:27:18 INFO - TEST-START | dromaeo_css 22:27:18 INFO - operating with platform_type : linux_ 22:27:18 INFO - Initialising browser for dromaeo_css test... 22:27:18 INFO - TEST-INFO | started process 10302 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv6Yra_/profile http://localhost:54492/getInfo.html) 22:27:22 INFO - PROCESS | 10302 | __metrics Screen width/height:1600/1200 22:27:22 INFO - PROCESS | 10302 | colorDepth:24 22:27:22 INFO - PROCESS | 10302 | Browser inner width/height: 1024/697 22:27:22 INFO - PROCESS | 10302 | __metrics 22:27:22 INFO - PROCESS | 10302 | 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" 22:27:22 INFO - PROCESS | 10302 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:27:23 INFO - PROCESS | 10302 | console.error: PushService: 22:27:23 INFO - PROCESS | 10302 | stateChangeProcessEnqueue: Error transitioning state 22:27:23 INFO - PROCESS | 10302 | UnknownError 22:27:24 INFO - TEST-INFO | 10302: exit 0 22:27:24 INFO - Browser initialized. 22:27:24 INFO - Running cycle 1/1 for dromaeo_css test... 22:27:24 INFO - TEST-INFO | started process 10394 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv6Yra_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:27:36 INFO - PROCESS | 10394 | RSS: Main: 143917056 22:27:36 INFO - PROCESS | 10394 | 22:28:27 INFO - PROCESS | 10394 | 1480487307137 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] 22:30:37 INFO - PROCESS | 10394 | Cycle 1(1): loaded http://localhost:54492/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54492/tests/dromaeo/cssquery-ext.html) 22:30:38 INFO - PROCESS | 10394 | RSS: Main: 238256128 22:30:38 INFO - PROCESS | 10394 | 22:33:40 INFO - PROCESS | 10394 | Cycle 1(1): loaded http://localhost:54492/tests/dromaeo/cssquery-ext.html (next: http://localhost:54492/tests/dromaeo/cssquery-jquery.html) 22:33:41 INFO - PROCESS | 10394 | RSS: Main: 230559744 22:33:41 INFO - PROCESS | 10394 | 22:36:43 INFO - PROCESS | 10394 | Cycle 1(1): loaded http://localhost:54492/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54492/tests/dromaeo/cssquery-mootools.html) 22:36:44 INFO - PROCESS | 10394 | RSS: Main: 176959488 22:36:44 INFO - PROCESS | 10394 | 22:39:46 INFO - PROCESS | 10394 | Cycle 1(1): loaded http://localhost:54492/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54492/tests/dromaeo/cssquery-prototype.html) 22:39:46 INFO - PROCESS | 10394 | RSS: Main: 187486208 22:39:46 INFO - PROCESS | 10394 | 22:42:49 INFO - PROCESS | 10394 | Cycle 1(1): loaded http://localhost:54492/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54492/tests/dromaeo/cssquery-yui.html) 22:42:50 INFO - PROCESS | 10394 | RSS: Main: 175640576 22:42:50 INFO - PROCESS | 10394 | 22:45:52 INFO - PROCESS | 10394 | Cycle 1(1): loaded http://localhost:54492/tests/dromaeo/cssquery-yui.html (next: http://localhost:54492/tests/dromaeo/cssquery-dojo.html) 22:45:52 INFO - PROCESS | 10394 | RSS: Main: 264302592 22:45:52 INFO - PROCESS | 10394 | 22:45:52 INFO - PROCESS | 10394 | __start_tp_report 22:45:52 INFO - PROCESS | 10394 | _x_x_mozilla_page_load 22:45:52 INFO - PROCESS | 10394 | _x_x_mozilla_page_load_details 22:45:52 INFO - PROCESS | 10394 | |i|pagename|runs| 22:45:52 INFO - PROCESS | 10394 | |0;dojo.html;3156.447621666208;3187.6493585705566;3202.51962205669;3219.7424206063515;3243.8702451901927;5470.452954704528;5539.972300138499;5567.359753628334;5567.832965011056;5569.693666848327;5465;5513.889722205554;5530.834074977757;5533.253010843535;5552.86117847054;4975.502449755032;4998.150314446535;5021.548060674539;5045.924311135336;5091.643584949055;4919.188333924916;4937.925931111036;4942.604591632661;5035.974820125894;5075.847724568251;4942.555170034696;5034.496550344955;5040.949590504085;5044.268581055745;5050.090983622947;5045.394552653668;5053.317802096707;5065.290859279704;5065.341505604285;5096.898062038738;4871.196252618313;4874.975625121887;4957.529034741694;4974.502549745032;5031.597472202252;5301.151815709468;5311.389190243133;5379.8386048418215;5394.487523685283;5449.455054494559;5713.085906254979;5734.885302293973;5769.423057694239;5789.507891829199;5790.33411157718;5754.309482862083;5849.239598852122;5868.4424979626865;5869.559783016248;5870.3249126350165;5408.999335123015;5434.483724046209;5468.699221542774;5481.862953426196;5513.669179849222;5984.581079324405;5988.610740301867;5998.550108741774;6004.0693692477735;6006.789762358297;5580.107182850806;5782.335031471434;5786.971065144731;5788.160716696056;5792.247007889032;5717.514011309002;5750.971245143831;5804.796832110856;5806.1581070744505;5882.647041177543;5826.621269617546;5829.562782791308;5832.270966129234;5833.649981001154;5834.358220595731;5833.82498525045;5839.824805255849;5858.062709966385;5858.06270996647;5858.209141765807;4452.243118669834;4484.506704262529;4512.684112112121;4553.271476563734;4559.840405585855;4043.9485733708857;4093.1813637272667;4093.3246014407887;4094.713370064067;4107.219628270619;5633.887322253532;5654.6324488908085;5654.943450565442;5658.603897727119;5665.206871037975;5714.342850572154;5744.368119506851;5962.314333851576;5964.7315870785915;5973.253343332083;5495.917561236584;5529.060059789846;5529.612927095065;5591.41290164535;5630.662160270397;5105.770240339194;5114.43741188469;5119.436861945183;5123.052235336475;5146.974265128725;5941;6058.212432383762;6109.969450152721;6122.295935967331;6127.693615319127;5771.94228057714;5874.823755287348;5933.525317974638;5940.495057919952;6048.183495228264;6166.136740856194;6227.190465239671;6239.188905442445;6249.625022498482;6256.061590761422;5866.50134738552;5867.706614669335;5878.3239927407185;5879.05935050407;5913.349531551612;5729.4843464088435;5740.1102829061565;5815.185873977731;5858.2677165354335;5865.3254875689845;5733;5760.884782304414;5767.394423585463;5768.019436695688;5790.276215473066;5733;5750.396208398058;5757.3954734753925;5761.942380576141;5764.07774756037;5413.566914646897;5445.237666726583;5691.658500489983;5723.370429252695;5731.914021289601;5781.942180578309;5819.214406055297;5835.153902684172;5852.7658893643775;5864.736086876186;5486.31421072366;5687.260656114679;5692.288463942007;5699.715014249354;5702.315722113207 22:45:52 INFO - PROCESS | 10394 | |1;ext.html;564.8616089058181;602.12390971137;628.302584131614;654.0777503719753;665.1386454541368;32754.344913101722;35814;45376;45981.310280345824;46112.769436152776;46284.537154628444;46354.30468542966;46579;46632;46705.065898682005;8257.587120643973;8758.34312426569;8944.195022447979;8953.641854325819;8967.46195228285;8296.958515207445;10576.259661823675;10822.350658960448;10824.78350432991;11156.665300040971;10964.17768667349;11004.834927476095;11020.118390528738;11020.44897755113;11030;10556.419396933166;10577;10591.84112238317;10598.417087060208;10601.840972385344;10723.83914241287;10760.946195269053;10776.78446431067;10784.78430431387;10786.892131078666;44140.3378949316;44196.337054944204;44288;44307;44350;3364.9495257571157;3402.7788193767324;3799.5060642116623;3827.75119617224;3895.8246878890236;33145.83427082849;33290.167745806306;33352.49971250433;33353.83323083393;33499.16252093693;4243.405923170728;4243.560741358109;4264.509581398148;4269.679774016961;4283.700140990132;361012;362233.9999999974;362505;362973;368467;63962.68018659877;64248;64318.678406607665;64380.35619643744;64430.677846610466;39818.40272395917;40218.79890600587;40346.394804077376;66881.6655916727;67047;16214.918925405298;16323.673526529641;16332.673346533003;16334.101624410772;16356.182190890408;11894.464749086312;12168.634940951786;12337.198082124632;12541.623751287476;12658.683532911751;19578.27412182093;20854.791452085286;20884.269050583156;20909.58180836405;20947.16211351529;7443.144038435541;7497.887531687029;7621.885671714928;7625;7695.807604809813;991.3803872579638;1005.7284533176002;1066.5094056733835;1102.6471529110768;1104.6189064772802;32476.837615811768;34292;34313;34331.65668343334;34440.758577965826;1076.1821016027718;1079.7354648111263;1139.1797905508022;1154.2439701995206;1160.9609399587491;17243.482695519153;18004;18266.26934922615;18334.424787166376;19100.522486937938;525825;526185;528650;530834;533711;61217;61530;61542.69228653828;61605.38394616086;61681;1316.394458549078;1348.4740951029107;1388.94444222232;1426.450816435659;1454.70178613384;30651.846740766152;34755.13112172216;34765.30469390649;34870;35206.47190292097;53192.2021169675;53666.73166634142;53767;53780.46219537754;53907.73046134744;432995;433748;436727;437908;438732;29945.251368715955;30256.697433026267;30709.232269192555;30873.536896947015;32532.83733581317;48953.2657010138;49711;49860.75069624629;50632.746836265585;51008;40956;41638;42150.83003004268;43244.78377608218;43556.34665479957;41782.16435671331;41956.1608767829;42693.57306426896;42712.35931461093;43016.56983430251;42031.36952945647;42576.361354580324;42602.573974261104;42693;42790.5720942799;33756.493652595724;35169.64830351664;35366.82316588401;35650.46524302189;36068;28454;28611.713882860906;28651;28659.8567007172;28758.281042974093 22:45:52 INFO - PROCESS | 10394 | |2;jquery.html;397.8110397561161;398.124126920774;421.9767912764798;426.5819496893044;430.0817754095006;15528.45650402236;19240.30635710998;19295;19445.12496937638;19476.026198690062;19177.32879349223;19206.135723892425;19310.71033934492;19534.804651953476;19583.608327833434;5182.067227898977;5256.185291279858;5562.415946325628;5743.081107022877;5803.100519419476;5625.578081643873;5726.68503232322;5729.197912292282;5731.656100633954;5732.426757324255;5527.39198688144;5625.128105143709;5682.261306030231;5690.374058853523;5706.1726049722765;5633.63381380211;5673.290838645169;5675.545956323525;5681;5683.403242659502;4935.851924442272;5132.538071573539;5159.664621799571;5160.12277912752;5166.1217593008905;23210.41973950648;23257.3022809316;23272.65091023636;23302.3009309721;23489.295321140395;2262.751097379287;2339.3099035784485;2434.464417828075;2482.565551028563;3062.1119875236154;10447.895521044844;10498.895011049868;10569.894301056967;10583.047525722723;10855.348679079281;1945.7178709087245;1987.9801201988084;2023.251396983111;2030.1067530286628;2047.7440319960006;86862.56568717115;88964;89502;90348.5482572583;91473;11286.153538484647;11427.48576314068;11499.597514087134;11525.711857203636;11586.710332241593;16060;16124.516264512084;16135;16145;16159.919200403923;7868.291853733192;7907.604619768988;7963.217471701011;8037.7990550235545;8240.175982401832;7782.961085194538;7847.568383738949;7851.764447066597;8100.756977290691;8147.75556733299;4747.311639812208;4766.213574760195;4871.293662419001;4897.412310522689;4953.23224900141;1957.5399781051442;1972.2209727157979;2000.5298754792611;2020.9090590923445;2071.326818783901;913.8674892140735;947.2564037230741;954.9140577347933;993.8558908958161;1001.9749506262256;18305.359312424;19492.12285447158;19708.50728731793;19911.701324479855;20497.897510512354;988.7775250568565;992.151710287708;1025.2771795883884;1055.8099542082346;1062.8458873463305;10246.743831404274;10680.412577308323;11078.889211107948;11134.220604557766;11198.384088875027;492689;511194;532434;537085;541573;92298;96413;100482.49758751159;101339.49330253301;103195;1039.9428031458342;1084.7233955341496;1119.149446420726;1128.9266197697123;1146.083133493202;17691.911540442732;17971.910140449214;18183.363582274556;18193.272269109086;18433;43075.784621076695;43742.56257437385;43864.34203487014;44162.55837441584;45132.097358052;57375.71312143413;58667.70666146642;62165.37834621777;62980.37019629745;63281.050784237355;7877.566733829465;8140.633671484679;8269.917300826915;8404.705835295736;8878.911210888067;12100.576479823163;12242.755144896873;12957.546485872948;12975.610731678065;13360.331983400985;5924.496417804535;10999.570055892682;11533.192676512563;11627.59303424376;11767;11152;11171.106311494897;11306.378149201873;11507.827382589436;11798.292102473879;11879.881201188224;11906.166568340133;12063.336516491678;12184.20802647825;12211.877881221075;8458.577071146541;8628.697995570124;8653.956730216309;8761.123887611187;8770.07914169003;9575.23398128134;11175.664730058112;11437.542498299976;11533.538658453568;11670.533178672758 22:45:52 INFO - PROCESS | 10394 | |3;mootools.html;1351.513455156143;1465.5969608357698;1471.2496626720372;1617.7573363995407;1751.0719318761062;7339.522931009481;8196.221358970903;8526.531040792754;8526.658933642655;8651.783705407368;8482.66069357225;8563.229309362172;8566.357523185754;8572.65709371626;8575.91424085759;2344.6951896253463;2385.296337580418;2386.6420036994505;2389.4265376309736;2392.1627430399394;2256.9661455078185;2305.043406986099;2322.047960336254;2334.2647066174186;2345.94135146621;2262.558801033799;2283.2693538067824;2283.977160228393;2286.4855407533337;2307.2962746362355;2259.175400978639;2269.262489690857;2274.886255687209;2275.397019789757;2275.715535558047;2306.6655334976335;2323.7676232376625;2325.8953347099423;2328.7205535335697;2328.953420931589;8201.71294004707;8365.665373385058;8487.490750554987;8561.700340488052;8575.442596231225;5102.311187989611;5213.973930130363;5219.582433405319;5220.138677118309;5222.00781851447;3213.293075523381;3236.64396916339;3342.565466489341;3383.069655844638;3384.018634595964;995.5470261031213;1005.3158067958568;1025.318163421324;1045.9320144190604;1061.723951772537;11870.821937670942;11930.343831089287;11957.760844783055;12012.279263244232;12025.759484810254;4271.8718438446895;4462.754548499799;4540.8637740867825;4544.18204723153;4548.5906268436;9437.90562094384;9441.858372124423;9445.19715824149;9451.6691915784;9461.763455913657;5228.503292187236;5230.215467679878;5230.476952304739;5230.875361797232;5234.450382709837;3925.666318362914;4311.288637374861;4383.145286669069;4873.585745211626;4873.683210591371;3761.717871159674;3784.4512545680723;3787.962120378761;3818.529866001609;3846.0577158595765;1135.057901941403;1135.7160709822545;1138.8405623212757;1140.7091191746217;1140.7262257058246;754.1553460124586;847.525385783963;888.2538667519315;959.9776238306182;1014.2139841622654;5563.721813909288;5706.885862282731;5737.512311453574;5977.342492325841;5982.521398288127;943.7734943613483;963.7494251494521;976.1507488484922;990.782027953849;1029.145808978546;3838.8272527736317;3983.223271462095;4047.5952404759287;4053.574374690674;4121;9985.550650220757;10500.789984200273;10511.054005139575;10580.894191058145;10588.682339529827;10320.48397580133;10447.164226861833;10447.477626118663;10449.373037617766;10459.790804183875;7842.490238134503;7959;8036.035675719068;8048.154943730824;8058.194180581895;5559;5611.719414029364;5723.02708539541;5733;5810.767569297181;9617.79777527809;9679.419234845931;9690.224782017282;9793.118619324296;9814.75463113428;8560.357973151915;9571.904280957102;9752.12230899194;9895.406275623485;10023.849642255225;6576.934230657632;7073.858522829618;7146.67839947214;7215.458840586872;7402.25977402277;8110.716124935599;8254.793630159054;8353.0811610724;8371.95814020926;8465.026521949809;7185.401343140499;7467.551946883204;7649.273319034683;7677.577733224726;7892.960535197287;7451.3293803557945;7484.476086673881;7518.248175182657;7569.886451703119;7602.847943040998;6665.3001434850585;6928.203256625351;6972.058772065706;6981.616011119438;7003.124609423822;4963.652544322007;5010.549050585465;5061.215511595708;5096.745162741922;5110.105731497048;5072.54347108762;5083.466236045162;5116.817533109161;5240.89518209626;5331.226972089103 22:45:52 INFO - PROCESS | 10394 | |4;prototype.html;334.9363620912026;335.0264778990596;345.1543717891166;346.65854133678323;348.8186143205535;5304.336957880265;5323.680579165253;5350.866228344288;5354.5716342692585;5372.489613486722;5042.621803364744;5110.543495103896;5148.168507320977;5154.639175257734;5296.311479507659;4167.791610419482;4183.435236243114;4188.790560471979;4197.7271477354025;4215.430916826235;4171.395147703581;4178.498580170384;4186.016286172747;4201.43280657112;4221.746695198282;3972.0139930034984;3997.6202260785326;4030.1939612077554;4149.771762553059;4155.065110350177;4128.545859955432;4141.742750201148;4156.898421918194;4163.542010378856;4163.91672166558;3701.4262789267705;3701.648343407372;3707.94438083429;3712.5916149223835;3729.1982223821738;5072.289879416885;5087.771050302746;5121.871953201163;5125.282460455539;5155.278261043457;4742.478327383985;4764.809407623726;4776.5701086902;4785.258284965836;4788.186008378584;5467.507924286793;5477.561795056386;5484.396716361197;5525.11598144295;5530.806421775259;3982.625994032054;4000.399940008993;4077.571854955246;4088.5485652593197;4104.240715467618;5648.237487939116;5654.943450565442;5687.146927960797;5703.54371650267;5719.742611582489;4155.231282212801;4160.918161278089;4164.770937598461;4204.810783514688;4217.493900731932;4094.7952602369764;4177;4206.894827629272;4255.893602659959;4263.936040959388;4751.358566593535;4762.975285883423;4763.499832517605;4779.713217206979;4785.784639691222;5531.612787104945;5538.944610553924;5542.473465020817;5547.889042219133;5549.472800083986;1381.9101758385673;1382.6474249066625;1398.9020768546104;1425.5794540610545;1439.2443966917451;938.3572253006712;951.129716309569;988.3871999360442;1013.9036791504943;1017.3031473440717;5197.908439227805;5201.791928322825;5202.479752024843;5210.436868939303;5226.686398816083;5477.835664930059;5489.43551087938;5498.972505137449;5519.834404967857;5533.557315414757;5084.33903592538;5171;5206.453322401093;5227.320448341768;5257.737113144328;2921.9123426297247;2931.6042334285025;2934.8679309431127;2939.0595009596723;2939.6913324101088;5471.50756431923;5686.152000599739;5741.311042674905;5744.195812586157;5772.662071860903;5504.889902201933;5523.530499907472;5527.751251193706;5544.722763861791;5550.666959982414;5606.327240731139;5641.533201367674;5641.774329026875;5664.97167514168;5677.886442271214;5249.553787928069;5369.48989845964;5400.810971615974;5404.378686394145;5439;5366.517013468807;5371.838844834661;5383.062097644766;5398.78404863801;5400.216968539461;5459.481349271813;5661.886762264649;5680.4319568042865;5682.6306290091015;5711.172424824183;4009.699272554512;4048.5748996356137;4053.959460405476;4070.3894415836676;4079.8164082616945;5480.753366098615;5489.819688766935;5508.686351732202;5513.531349835309;5534.640248383842;5086.720230387365;5385.892282154413;5386.569074474111;5417.51242388187;5426.864328391822;5274.549498887836;5282.656627319212;5283.788648454019;5294.100002999422;5328.067588171977;5286.97356513215;5287.629865909349;5288.180332048539;5305.389880163676;5421.457854214705;5463.426340234377;5533.446655334435;5556.194351818883;5566.387697353369;5589.636673616202;5430;5433.56531477473;5443.918341224806;5453.64551304164;5467.152591348347 22:45:52 INFO - PROCESS | 10394 | |5;yui.html;653.9182602174727;677.8169894128583;688.538679085013;698.5459451356618;715.8067321823111;13698.794518082224;14331.211783351911;14392.568222953329;14471.710565788704;14499.855001449982;13252;13252.807247347737;13282.933585332059;13285.601431957033;13292.335383230848;679.1917618034523;699.0527834783871;812.2567850416862;812.5287333346645;832.6794184239051;828.1097819843692;829.266099501939;830.4021104804531;830.4145577367941;833.2334252487726;888.5734847273312;890.0965519997208;890.3989806880362;890.4167770110555;891.5052146058935;718.5760401363194;742.3133601418693;848.7241646464862;867.8871746672955;884.3588398411165;640.2093414632925;640.2604991235131;640.4588123036027;640.5196102922808;640.942315191635;13660.726785464334;13738.244396558186;13757.931210343984;13769.31153442334;13778.724425511433;13450.394732236975;13564.45742170312;13565;13639;13684.178949263076;11741.882581174164;11895.405229738564;11962;11983.640490785203;12233.632991010283;4167.666586673089;4202.600752928467;4207.915841683149;4237.13138806547;4353.434053573015;62757.37242627561;65685.67157164184;66001.3399866;66540.33459665389;66920.6653966732;10710.410927399067;10728.624498142528;10834.512446939907;10908.454577271263;11081.390523521284;19420.8057919419;19427.125779339964;19427.51431214231;19442.611147776966;19453.902730486257;7647.617619119022;7667.118281397599;7878.409119316074;7930.325922296554;8169.550674712829;4427.601515863587;4508.819647214074;4607.0785842831565;4759.9524004759505;4881.365422495124;3095.582096417;3187.3625274945102;3190.968090319067;3192.090254277566;3193.1218914798615;588.0297509110003;680.7379159023712;683.2962049089446;705.0481849503233;707.6249587718518;601.7923816283375;662.3674390956625;669.8827705151676;676.4182802789597;707.9469039822034;8875.846140001759;9309.953450232706;9497.810043799085;9516.764300137986;9686.176674982706;584.4944123333371;660.92729799722;667.8363800868818;688.1054628982303;690.6684791300204;4279;4320.351947207944;4328.653707703376;4339.305711086211;4393.165298593257;58911;88751.11248887557;89657.55171224102;93256.53371733098;97024.51487742516;80209;83255.583722081;84257;84614.57692711498;85051;69094;71330;71987;73423;74023.25976740164;8233.259006689426;8327.333813295043;8385.748427547183;8386.32909367237;8602.870956935525;49449.25826112683;49686.75156624194;49734.75132624314;50224.748876255384;50560.49439505705;66017.66991165206;68167;68420.6578967102;69447;69626;10228.181745460197;10680.412577308323;11013.347997800394;11204.991550760471;11717.179797414099;12170.513179473077;12188.939055305022;12290.815637765261;12313.753724925631;12464.252144871336;9998.350107243006;11231.66305010851;11329.830052549383;11407.771844563229;11899.583514576949;11475.196736228383;12006.159568830099;12031.699207519881;12145.089118315986;12257.142000060267;12445.377731113227;12476.5009399623;12488.12583119173;12538.310392928477;12565.560205392767;10116.949415252877;10267.691969240936;10463.11063559606;10514.737131571772;10733.946330268298;9654.979410706253;10190.694279171637;10267.94866025695;10300.742481438025;10323.277370584288 22:45:52 INFO - PROCESS | 10394 | __end_tp_report 22:45:52 INFO - PROCESS | 10394 | __start_cc_report 22:45:52 INFO - PROCESS | 10394 | _x_x_mozilla_cycle_collect,1041 22:45:52 INFO - PROCESS | 10394 | __end_cc_report 22:45:52 INFO - PROCESS | 10394 | __startTimestamp1480488352614__endTimestamp 22:45:52 INFO - PROCESS | 10394 | 22:45:52 INFO - PROCESS | 10394 | ------- Summary: start ------- 22:45:52 INFO - PROCESS | 10394 | Number of tests: 6 22:45:52 INFO - PROCESS | 10394 | 22:45:52 INFO - PROCESS | 10394 | [#0] dojo.html Cycles:165 Average:5462.10 Median:5699.72 stddev:609.94 (10.7%) stddev-sans-first:584.37 22:45:52 INFO - PROCESS | 10394 | Values: 3156.4 3187.6 3202.5 3219.7 3243.9 5470.5 5540.0 5567.4 5567.8 5569.7 5465.0 5513.9 5530.8 5533.3 5552.9 4975.5 4998.2 5021.5 5045.9 5091.6 4919.2 4937.9 4942.6 5036.0 5075.8 4942.6 5034.5 5040.9 5044.3 5050.1 5045.4 5053.3 5065.3 5065.3 5096.9 4871.2 4875.0 4957.5 4974.5 5031.6 5301.2 5311.4 5379.8 5394.5 5449.5 5713.1 5734.9 5769.4 5789.5 5790.3 5754.3 5849.2 5868.4 5869.6 5870.3 5409.0 5434.5 5468.7 5481.9 5513.7 5984.6 5988.6 5998.6 6004.1 6006.8 5580.1 5782.3 5787.0 5788.2 5792.2 5717.5 5751.0 5804.8 5806.2 5882.6 5826.6 5829.6 5832.3 5833.6 5834.4 5833.8 5839.8 5858.1 5858.1 5858.2 4452.2 4484.5 4512.7 4553.3 4559.8 4043.9 4093.2 4093.3 4094.7 4107.2 5633.9 5654.6 5654.9 5658.6 5665.2 5714.3 5744.4 5962.3 5964.7 5973.3 5495.9 5529.1 5529.6 5591.4 5630.7 5105.8 5114.4 5119.4 5123.1 5147.0 5941.0 6058.2 6110.0 6122.3 6127.7 5771.9 5874.8 5933.5 5940.5 6048.2 6166.1 6227.2 6239.2 6249.6 6256.1 5866.5 5867.7 5878.3 5879.1 5913.3 5729.5 5740.1 5815.2 5858.3 5865.3 5733.0 5760.9 5767.4 5768.0 5790.3 5733.0 5750.4 5757.4 5761.9 5764.1 5413.6 5445.2 5691.7 5723.4 5731.9 5781.9 5819.2 5835.2 5852.8 5864.7 5486.3 5687.3 5692.3 5699.7 5702.3 22:45:52 INFO - PROCESS | 10394 | 22:45:52 INFO - PROCESS | 10394 | [#1] ext.html Cycles:180 Average:61187.50 Median:365720.00 stddev:118520.03 (32.4%) stddev-sans-first:118765.11 22:45:52 INFO - PROCESS | 10394 | Values: 564.9 602.1 628.3 654.1 665.1 32754.3 35814.0 45376.0 45981.3 46112.8 46284.5 46354.3 46579.0 46632.0 46705.1 8257.6 8758.3 8944.2 8953.6 8967.5 8297.0 10576.3 10822.4 10824.8 11156.7 10964.2 11004.8 11020.1 11020.4 11030.0 10556.4 10577.0 10591.8 10598.4 10601.8 10723.8 10760.9 10776.8 10784.8 10786.9 44140.3 44196.3 44288.0 44307.0 44350.0 3364.9 3402.8 3799.5 3827.8 3895.8 33145.8 33290.2 33352.5 33353.8 33499.2 4243.4 4243.6 4264.5 4269.7 4283.7 361012.0 362234.0 362505.0 362973.0 368467.0 63962.7 64248.0 64318.7 64380.4 64430.7 39818.4 40218.8 40346.4 66881.7 67047.0 16214.9 16323.7 16332.7 16334.1 16356.2 11894.5 12168.6 12337.2 12541.6 12658.7 19578.3 20854.8 20884.3 20909.6 20947.2 7443.1 7497.9 7621.9 7625.0 7695.8 991.4 1005.7 1066.5 1102.6 1104.6 32476.8 34292.0 34313.0 34331.7 34440.8 1076.2 1079.7 1139.2 1154.2 1161.0 17243.5 18004.0 18266.3 18334.4 19100.5 525825.0 526185.0 528650.0 530834.0 533711.0 61217.0 61530.0 61542.7 61605.4 61681.0 1316.4 1348.5 1388.9 1426.5 1454.7 30651.8 34755.1 34765.3 34870.0 35206.5 53192.2 53666.7 53767.0 53780.5 53907.7 432995.0 433748.0 436727.0 437908.0 438732.0 29945.3 30256.7 30709.2 30873.5 32532.8 48953.3 49711.0 49860.8 50632.7 51008.0 40956.0 41638.0 42150.8 43244.8 43556.3 41782.2 41956.2 42693.6 42712.4 43016.6 42031.4 42576.4 42602.6 42693.0 42790.6 33756.5 35169.6 35366.8 35650.5 36068.0 28454.0 28611.7 28651.0 28659.9 28758.3 22:45:52 INFO - PROCESS | 10394 | 22:45:52 INFO - PROCESS | 10394 | [#2] jquery.html Cycles:180 Average:30475.26 Median:12914.30 stddev:86454.34 (669.4%) stddev-sans-first:86667.37 22:45:52 INFO - PROCESS | 10394 | Values: 397.8 398.1 422.0 426.6 430.1 15528.5 19240.3 19295.0 19445.1 19476.0 19177.3 19206.1 19310.7 19534.8 19583.6 5182.1 5256.2 5562.4 5743.1 5803.1 5625.6 5726.7 5729.2 5731.7 5732.4 5527.4 5625.1 5682.3 5690.4 5706.2 5633.6 5673.3 5675.5 5681.0 5683.4 4935.9 5132.5 5159.7 5160.1 5166.1 23210.4 23257.3 23272.7 23302.3 23489.3 2262.8 2339.3 2434.5 2482.6 3062.1 10447.9 10498.9 10569.9 10583.0 10855.3 1945.7 1988.0 2023.3 2030.1 2047.7 86862.6 88964.0 89502.0 90348.5 91473.0 11286.2 11427.5 11499.6 11525.7 11586.7 16060.0 16124.5 16135.0 16145.0 16159.9 7868.3 7907.6 7963.2 8037.8 8240.2 7783.0 7847.6 7851.8 8100.8 8147.8 4747.3 4766.2 4871.3 4897.4 4953.2 1957.5 1972.2 2000.5 2020.9 2071.3 913.9 947.3 954.9 993.9 1002.0 18305.4 19492.1 19708.5 19911.7 20497.9 988.8 992.2 1025.3 1055.8 1062.8 10246.7 10680.4 11078.9 11134.2 11198.4 492689.0 511194.0 532434.0 537085.0 541573.0 92298.0 96413.0 100482.5 101339.5 103195.0 1039.9 1084.7 1119.1 1128.9 1146.1 17691.9 17971.9 18183.4 18193.3 18433.0 43075.8 43742.6 43864.3 44162.6 45132.1 57375.7 58667.7 62165.4 62980.4 63281.1 7877.6 8140.6 8269.9 8404.7 8878.9 12100.6 12242.8 12957.5 12975.6 13360.3 5924.5 10999.6 11533.2 11627.6 11767.0 11152.0 11171.1 11306.4 11507.8 11798.3 11879.9 11906.2 12063.3 12184.2 12211.9 8458.6 8628.7 8654.0 8761.1 8770.1 9575.2 11175.7 11437.5 11533.5 11670.5 22:45:52 INFO - PROCESS | 10394 | 22:45:52 INFO - PROCESS | 10394 | [#3] mootools.html Cycles:180 Average:5597.51 Median:5216.78 stddev:3140.74 (60.2%) stddev-sans-first:3133.34 22:45:52 INFO - PROCESS | 10394 | Values: 1351.5 1465.6 1471.2 1617.8 1751.1 7339.5 8196.2 8526.5 8526.7 8651.8 8482.7 8563.2 8566.4 8572.7 8575.9 2344.7 2385.3 2386.6 2389.4 2392.2 2257.0 2305.0 2322.0 2334.3 2345.9 2262.6 2283.3 2284.0 2286.5 2307.3 2259.2 2269.3 2274.9 2275.4 2275.7 2306.7 2323.8 2325.9 2328.7 2329.0 8201.7 8365.7 8487.5 8561.7 8575.4 5102.3 5214.0 5219.6 5220.1 5222.0 3213.3 3236.6 3342.6 3383.1 3384.0 995.5 1005.3 1025.3 1045.9 1061.7 11870.8 11930.3 11957.8 12012.3 12025.8 4271.9 4462.8 4540.9 4544.2 4548.6 9437.9 9441.9 9445.2 9451.7 9461.8 5228.5 5230.2 5230.5 5230.9 5234.5 3925.7 4311.3 4383.1 4873.6 4873.7 3761.7 3784.5 3788.0 3818.5 3846.1 1135.1 1135.7 1138.8 1140.7 1140.7 754.2 847.5 888.3 960.0 1014.2 5563.7 5706.9 5737.5 5977.3 5982.5 943.8 963.7 976.2 990.8 1029.1 3838.8 3983.2 4047.6 4053.6 4121.0 9985.6 10500.8 10511.1 10580.9 10588.7 10320.5 10447.2 10447.5 10449.4 10459.8 7842.5 7959.0 8036.0 8048.2 8058.2 5559.0 5611.7 5723.0 5733.0 5810.8 9617.8 9679.4 9690.2 9793.1 9814.8 8560.4 9571.9 9752.1 9895.4 10023.8 6576.9 7073.9 7146.7 7215.5 7402.3 8110.7 8254.8 8353.1 8372.0 8465.0 7185.4 7467.6 7649.3 7677.6 7893.0 7451.3 7484.5 7518.2 7569.9 7602.8 6665.3 6928.2 6972.1 6981.6 7003.1 4963.7 5010.5 5061.2 5096.7 5110.1 5072.5 5083.5 5116.8 5240.9 5331.2 22:45:52 INFO - PROCESS | 10394 | 22:45:52 INFO - PROCESS | 10394 | [#4] prototype.html Cycles:180 Average:4608.85 Median:5238.44 stddev:1313.82 (25.1%) stddev-sans-first:1277.74 22:45:52 INFO - PROCESS | 10394 | Values: 334.9 335.0 345.2 346.7 348.8 5304.3 5323.7 5350.9 5354.6 5372.5 5042.6 5110.5 5148.2 5154.6 5296.3 4167.8 4183.4 4188.8 4197.7 4215.4 4171.4 4178.5 4186.0 4201.4 4221.7 3972.0 3997.6 4030.2 4149.8 4155.1 4128.5 4141.7 4156.9 4163.5 4163.9 3701.4 3701.6 3707.9 3712.6 3729.2 5072.3 5087.8 5121.9 5125.3 5155.3 4742.5 4764.8 4776.6 4785.3 4788.2 5467.5 5477.6 5484.4 5525.1 5530.8 3982.6 4000.4 4077.6 4088.5 4104.2 5648.2 5654.9 5687.1 5703.5 5719.7 4155.2 4160.9 4164.8 4204.8 4217.5 4094.8 4177.0 4206.9 4255.9 4263.9 4751.4 4763.0 4763.5 4779.7 4785.8 5531.6 5538.9 5542.5 5547.9 5549.5 1381.9 1382.6 1398.9 1425.6 1439.2 938.4 951.1 988.4 1013.9 1017.3 5197.9 5201.8 5202.5 5210.4 5226.7 5477.8 5489.4 5499.0 5519.8 5533.6 5084.3 5171.0 5206.5 5227.3 5257.7 2921.9 2931.6 2934.9 2939.1 2939.7 5471.5 5686.2 5741.3 5744.2 5772.7 5504.9 5523.5 5527.8 5544.7 5550.7 5606.3 5641.5 5641.8 5665.0 5677.9 5249.6 5369.5 5400.8 5404.4 5439.0 5366.5 5371.8 5383.1 5398.8 5400.2 5459.5 5661.9 5680.4 5682.6 5711.2 4009.7 4048.6 4054.0 4070.4 4079.8 5480.8 5489.8 5508.7 5513.5 5534.6 5086.7 5385.9 5386.6 5417.5 5426.9 5274.5 5282.7 5283.8 5294.1 5328.1 5287.0 5287.6 5288.2 5305.4 5421.5 5463.4 5533.4 5556.2 5566.4 5589.6 5430.0 5433.6 5443.9 5453.6 5467.2 22:45:52 INFO - PROCESS | 10394 | 22:45:52 INFO - PROCESS | 10394 | [#5] yui.html Cycles:180 Average:18056.71 Median:49979.75 stddev:24777.02 (49.6%) stddev-sans-first:24812.06 22:45:52 INFO - PROCESS | 10394 | Values: 653.9 677.8 688.5 698.5 715.8 13698.8 14331.2 14392.6 14471.7 14499.9 13252.0 13252.8 13282.9 13285.6 13292.3 679.2 699.1 812.3 812.5 832.7 828.1 829.3 830.4 830.4 833.2 888.6 890.1 890.4 890.4 891.5 718.6 742.3 848.7 867.9 884.4 640.2 640.3 640.5 640.5 640.9 13660.7 13738.2 13757.9 13769.3 13778.7 13450.4 13564.5 13565.0 13639.0 13684.2 11741.9 11895.4 11962.0 11983.6 12233.6 4167.7 4202.6 4207.9 4237.1 4353.4 62757.4 65685.7 66001.3 66540.3 66920.7 10710.4 10728.6 10834.5 10908.5 11081.4 19420.8 19427.1 19427.5 19442.6 19453.9 7647.6 7667.1 7878.4 7930.3 8169.6 4427.6 4508.8 4607.1 4760.0 4881.4 3095.6 3187.4 3191.0 3192.1 3193.1 588.0 680.7 683.3 705.0 707.6 601.8 662.4 669.9 676.4 707.9 8875.8 9310.0 9497.8 9516.8 9686.2 584.5 660.9 667.8 688.1 690.7 4279.0 4320.4 4328.7 4339.3 4393.2 58911.0 88751.1 89657.6 93256.5 97024.5 80209.0 83255.6 84257.0 84614.6 85051.0 69094.0 71330.0 71987.0 73423.0 74023.3 8233.3 8327.3 8385.7 8386.3 8602.9 49449.3 49686.8 49734.8 50224.7 50560.5 66017.7 68167.0 68420.7 69447.0 69626.0 10228.2 10680.4 11013.3 11205.0 11717.2 12170.5 12188.9 12290.8 12313.8 12464.3 9998.4 11231.7 11329.8 11407.8 11899.6 11475.2 12006.2 12031.7 12145.1 12257.1 12445.4 12476.5 12488.1 12538.3 12565.6 10116.9 10267.7 10463.1 10514.7 10733.9 9655.0 10190.7 10267.9 10300.7 10323.3 22:45:52 INFO - PROCESS | 10394 | -------- Summary: end -------- 22:45:52 INFO - PROCESS | 10394 | 22:45:53 INFO - TEST-INFO | 10394: exit 0 22:45:53 INFO - TEST-OK | dromaeo_css | took 1115109ms 22:45:53 INFO - TEST-START | kraken 22:45:53 INFO - operating with platform_type : linux_ 22:45:53 INFO - Initialising browser for kraken test... 22:45:53 INFO - TEST-INFO | started process 10709 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3lGJno/profile http://localhost:54492/getInfo.html) 22:45:57 INFO - PROCESS | 10709 | __metrics Screen width/height:1600/1200 22:45:57 INFO - PROCESS | 10709 | colorDepth:24 22:45:57 INFO - PROCESS | 10709 | Browser inner width/height: 1024/697 22:45:57 INFO - PROCESS | 10709 | __metrics 22:45:57 INFO - PROCESS | 10709 | 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" 22:45:57 INFO - PROCESS | 10709 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:45:58 INFO - PROCESS | 10709 | console.error: PushService: 22:45:58 INFO - PROCESS | 10709 | stateChangeProcessEnqueue: Error transitioning state 22:45:58 INFO - PROCESS | 10709 | UnknownError 22:45:59 INFO - TEST-INFO | 10709: exit 0 22:45:59 INFO - Browser initialized. 22:45:59 INFO - Running cycle 1/1 for kraken test... 22:45:59 INFO - TEST-INFO | started process 10800 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3lGJno/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:46:11 INFO - PROCESS | 10800 | RSS: Main: 144224256 22:46:11 INFO - PROCESS | 10800 | 22:46:13 INFO - PROCESS | 10800 | Cycle 1(1): loaded http://localhost:54492/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54492/tests/kraken/driver.html?testName=audio-beat-detection) 22:46:14 INFO - PROCESS | 10800 | RSS: Main: 185245696 22:46:14 INFO - PROCESS | 10800 | 22:46:16 INFO - PROCESS | 10800 | Cycle 1(1): loaded http://localhost:54492/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54492/tests/kraken/driver.html?testName=audio-dft) 22:46:17 INFO - PROCESS | 10800 | RSS: Main: 175816704 22:46:17 INFO - PROCESS | 10800 | 22:46:20 INFO - PROCESS | 10800 | Cycle 1(1): loaded http://localhost:54492/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54492/tests/kraken/driver.html?testName=audio-fft) 22:46:20 INFO - PROCESS | 10800 | RSS: Main: 266633216 22:46:20 INFO - PROCESS | 10800 | 22:46:23 INFO - PROCESS | 10800 | Cycle 1(1): loaded http://localhost:54492/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54492/tests/kraken/driver.html?testName=audio-oscillator) 22:46:23 INFO - PROCESS | 10800 | RSS: Main: 173596672 22:46:23 INFO - PROCESS | 10800 | 22:46:25 INFO - PROCESS | 10800 | Cycle 1(1): loaded http://localhost:54492/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54492/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:46:26 INFO - PROCESS | 10800 | RSS: Main: 175611904 22:46:26 INFO - PROCESS | 10800 | 22:46:29 INFO - PROCESS | 10800 | Cycle 1(1): loaded http://localhost:54492/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54492/tests/kraken/driver.html?testName=imaging-darkroom) 22:46:29 INFO - PROCESS | 10800 | RSS: Main: 214339584 22:46:29 INFO - PROCESS | 10800 | 22:46:33 INFO - PROCESS | 10800 | Cycle 1(1): loaded http://localhost:54492/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54492/tests/kraken/driver.html?testName=imaging-desaturate) 22:46:33 INFO - PROCESS | 10800 | RSS: Main: 213090304 22:46:33 INFO - PROCESS | 10800 | 22:46:36 INFO - PROCESS | 10800 | Cycle 1(1): loaded http://localhost:54492/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54492/tests/kraken/driver.html?testName=json-parse-financial) 22:46:37 INFO - PROCESS | 10800 | RSS: Main: 211333120 22:46:37 INFO - PROCESS | 10800 | 22:46:38 INFO - PROCESS | 10800 | Cycle 1(1): loaded http://localhost:54492/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54492/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:46:39 INFO - PROCESS | 10800 | RSS: Main: 173760512 22:46:39 INFO - PROCESS | 10800 | 22:46:40 INFO - PROCESS | 10800 | Cycle 1(1): loaded http://localhost:54492/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54492/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:46:41 INFO - PROCESS | 10800 | RSS: Main: 180867072 22:46:41 INFO - PROCESS | 10800 | 22:46:43 INFO - PROCESS | 10800 | Cycle 1(1): loaded http://localhost:54492/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54492/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:46:43 INFO - PROCESS | 10800 | RSS: Main: 190042112 22:46:43 INFO - PROCESS | 10800 | 22:46:46 INFO - PROCESS | 10800 | Cycle 1(1): loaded http://localhost:54492/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54492/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:46:47 INFO - PROCESS | 10800 | RSS: Main: 198709248 22:46:47 INFO - PROCESS | 10800 | 22:46:49 INFO - PROCESS | 10800 | Cycle 1(1): loaded http://localhost:54492/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54492/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:46:50 INFO - PROCESS | 10800 | RSS: Main: 194834432 22:46:50 INFO - PROCESS | 10800 | 22:46:52 INFO - PROCESS | 10800 | Cycle 1(1): loaded http://localhost:54492/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54492/tests/kraken/driver.html?testName=ai-astar) 22:46:52 INFO - PROCESS | 10800 | RSS: Main: 246427648 22:46:52 INFO - PROCESS | 10800 | 22:46:52 INFO - PROCESS | 10800 | __start_tp_report 22:46:52 INFO - PROCESS | 10800 | _x_x_mozilla_page_load 22:46:52 INFO - PROCESS | 10800 | _x_x_mozilla_page_load_details 22:46:52 INFO - PROCESS | 10800 | |i|pagename|runs| 22:46:52 INFO - PROCESS | 10800 | |0;ai-astar;101;111;111;111;113;113;112;110;111;112 22:46:52 INFO - PROCESS | 10800 | |1;audio-beat-detection;157;126;120;164;122;123;120;121;146;126 22:46:52 INFO - PROCESS | 10800 | |2;audio-dft;161;159;163;159;161;161;161;161;160;161 22:46:52 INFO - PROCESS | 10800 | |3;audio-fft;74;76;76;109;76;75;76;74;103;75 22:46:52 INFO - PROCESS | 10800 | |4;audio-oscillator;82;81;112;82;82;82;98;82;83;107 22:46:52 INFO - PROCESS | 10800 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;116;117;117 22:46:52 INFO - PROCESS | 10800 | |6;imaging-darkroom;147;146;146;146;146;146;145;147;146;145 22:46:52 INFO - PROCESS | 10800 | |7;imaging-desaturate;84;85;85;85;84;84;85;84;85;84 22:46:52 INFO - PROCESS | 10800 | |8;json-parse-financial;51;49;50;49;50;49;49;49;49;49 22:46:52 INFO - PROCESS | 10800 | |9;json-stringify-tinderbox;60;59;60;66;60;60;60;60;59;60 22:46:52 INFO - PROCESS | 10800 | |10;stanford-crypto-aes;75;77;81;76;75;75;74;75;75;77 22:46:52 INFO - PROCESS | 10800 | |11;stanford-crypto-ccm;142;138;126;126;135;136;124;124;182;131 22:46:52 INFO - PROCESS | 10800 | |12;stanford-crypto-pbkdf2;153;154;157;157;159;153;153;153;155;155 22:46:52 INFO - PROCESS | 10800 | |13;stanford-crypto-sha256-iterative;61;62;62;61;61;61;64;61;61;61 22:46:52 INFO - PROCESS | 10800 | __end_tp_report 22:46:52 INFO - PROCESS | 10800 | __start_cc_report 22:46:52 INFO - PROCESS | 10800 | _x_x_mozilla_cycle_collect,1621 22:46:52 INFO - PROCESS | 10800 | __end_cc_report 22:46:52 INFO - PROCESS | 10800 | __startTimestamp1480488412448__endTimestamp 22:46:52 INFO - PROCESS | 10800 | 22:46:52 INFO - PROCESS | 10800 | ------- Summary: start ------- 22:46:52 INFO - PROCESS | 10800 | Number of tests: 14 22:46:52 INFO - PROCESS | 10800 | 22:46:52 INFO - PROCESS | 10800 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.50 stddev:3.47 (3.1%) stddev-sans-first:1.01 22:46:52 INFO - PROCESS | 10800 | Values: 101.0 111.0 111.0 111.0 113.0 113.0 112.0 110.0 111.0 112.0 22:46:52 INFO - PROCESS | 10800 | 22:46:52 INFO - PROCESS | 10800 | [#1] audio-beat-detection Cycles:10 Average:132.50 Median:126.00 stddev:16.68 (13.2%) stddev-sans-first:15.16 22:46:52 INFO - PROCESS | 10800 | Values: 157.0 126.0 120.0 164.0 122.0 123.0 120.0 121.0 146.0 126.0 22:46:52 INFO - PROCESS | 10800 | 22:46:52 INFO - PROCESS | 10800 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.16 (0.7%) stddev-sans-first:1.22 22:46:52 INFO - PROCESS | 10800 | Values: 161.0 159.0 163.0 159.0 161.0 161.0 161.0 161.0 160.0 161.0 22:46:52 INFO - PROCESS | 10800 | 22:46:52 INFO - PROCESS | 10800 | [#3] audio-fft Cycles:10 Average:81.40 Median:75.50 stddev:13.07 (17.3%) stddev-sans-first:13.58 22:46:52 INFO - PROCESS | 10800 | Values: 74.0 76.0 76.0 109.0 76.0 75.0 76.0 74.0 103.0 75.0 22:46:52 INFO - PROCESS | 10800 | 22:46:52 INFO - PROCESS | 10800 | [#4] audio-oscillator Cycles:10 Average:89.10 Median:82.00 stddev:11.92 (14.5%) stddev-sans-first:12.36 22:46:52 INFO - PROCESS | 10800 | Values: 82.0 81.0 112.0 82.0 82.0 82.0 98.0 82.0 83.0 107.0 22:46:52 INFO - PROCESS | 10800 | 22:46:52 INFO - PROCESS | 10800 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 22:46:52 INFO - PROCESS | 10800 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 22:46:52 INFO - PROCESS | 10800 | 22:46:52 INFO - PROCESS | 10800 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 22:46:52 INFO - PROCESS | 10800 | Values: 147.0 146.0 146.0 146.0 146.0 146.0 145.0 147.0 146.0 145.0 22:46:52 INFO - PROCESS | 10800 | 22:46:52 INFO - PROCESS | 10800 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:85.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 22:46:52 INFO - PROCESS | 10800 | Values: 84.0 85.0 85.0 85.0 84.0 84.0 85.0 84.0 85.0 84.0 22:46:52 INFO - PROCESS | 10800 | 22:46:52 INFO - PROCESS | 10800 | [#8] json-parse-financial Cycles:10 Average:49.40 Median:49.00 stddev:0.70 (1.4%) stddev-sans-first:0.44 22:46:52 INFO - PROCESS | 10800 | Values: 51.0 49.0 50.0 49.0 50.0 49.0 49.0 49.0 49.0 49.0 22:46:52 INFO - PROCESS | 10800 | 22:46:52 INFO - PROCESS | 10800 | [#9] json-stringify-tinderbox Cycles:10 Average:60.40 Median:60.00 stddev:2.01 (3.4%) stddev-sans-first:2.13 22:46:52 INFO - PROCESS | 10800 | Values: 60.0 59.0 60.0 66.0 60.0 60.0 60.0 60.0 59.0 60.0 22:46:52 INFO - PROCESS | 10800 | 22:46:52 INFO - PROCESS | 10800 | [#10] stanford-crypto-aes Cycles:10 Average:76.00 Median:75.50 stddev:2.00 (2.6%) stddev-sans-first:2.09 22:46:52 INFO - PROCESS | 10800 | Values: 75.0 77.0 81.0 76.0 75.0 75.0 74.0 75.0 75.0 77.0 22:46:52 INFO - PROCESS | 10800 | 22:46:52 INFO - PROCESS | 10800 | [#11] stanford-crypto-ccm Cycles:10 Average:136.40 Median:135.50 stddev:17.22 (12.7%) stddev-sans-first:18.14 22:46:52 INFO - PROCESS | 10800 | Values: 142.0 138.0 126.0 126.0 135.0 136.0 124.0 124.0 182.0 131.0 22:46:52 INFO - PROCESS | 10800 | 22:46:52 INFO - PROCESS | 10800 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.90 Median:155.00 stddev:2.13 (1.4%) stddev-sans-first:2.15 22:46:52 INFO - PROCESS | 10800 | Values: 153.0 154.0 157.0 157.0 159.0 153.0 153.0 153.0 155.0 155.0 22:46:52 INFO - PROCESS | 10800 | 22:46:52 INFO - PROCESS | 10800 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.50 Median:61.00 stddev:0.97 (1.6%) stddev-sans-first:1.01 22:46:52 INFO - PROCESS | 10800 | Values: 61.0 62.0 62.0 61.0 61.0 61.0 64.0 61.0 61.0 61.0 22:46:52 INFO - PROCESS | 10800 | -------- Summary: end -------- 22:46:52 INFO - PROCESS | 10800 | 22:46:53 INFO - TEST-INFO | 10800: exit 0 22:46:53 INFO - TEST-OK | kraken | took 60182ms 22:46:53 INFO - SUITE-END | took 1175s 22:46:53 INFO - Completed test suite (00:19:35) 22:46:53 INFO - javascript benchmark 22:46:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3156.447621666208, 3187.6493585705566, 3202.51962205669, 3219.7424206063515, 3243.8702451901927, 5470.452954704528, 5539.972300138499, 5567.359753628334, 5567.832965011056, 5569.693666848327, 5465.0, 5513.889722205554, 5530.834074977757, 5533.253010843535, 5552.86117847054, 4975.502449755032, 4998.150314446535, 5021.548060674539, 5045.924311135336, 5091.643584949055, 4919.188333924916, 4937.925931111036, 4942.604591632661, 5035.974820125894, 5075.847724568251, 4942.555170034696, 5034.496550344955, 5040.949590504085, 5044.268581055745, 5050.090983622947, 5045.394552653668, 5053.317802096707, 5065.290859279704, 5065.341505604285, 5096.898062038738, 4871.196252618313, 4874.975625121887, 4957.529034741694, 4974.502549745032, 5031.597472202252, 5301.151815709468, 5311.389190243133, 5379.8386048418215, 5394.487523685283, 5449.455054494559, 5713.085906254979, 5734.885302293973, 5769.423057694239, 5789.507891829199, 5790.33411157718, 5754.309482862083, 5849.239598852122, 5868.4424979626865, 5869.559783016248, 5870.3249126350165, 5408.999335123015, 5434.483724046209, 5468.699221542774, 5481.862953426196, 5513.669179849222, 5984.581079324405, 5988.610740301867, 5998.550108741774, 6004.0693692477735, 6006.789762358297, 5580.107182850806, 5782.335031471434, 5786.971065144731, 5788.160716696056, 5792.247007889032, 5717.514011309002, 5750.971245143831, 5804.796832110856, 5806.1581070744505, 5882.647041177543, 5826.621269617546, 5829.562782791308, 5832.270966129234, 5833.649981001154, 5834.358220595731, 5833.82498525045, 5839.824805255849, 5858.062709966385, 5858.06270996647, 5858.209141765807, 4452.243118669834, 4484.506704262529, 4512.684112112121, 4553.271476563734, 4559.840405585855, 4043.9485733708857, 4093.1813637272667, 4093.3246014407887, 4094.713370064067, 4107.219628270619, 5633.887322253532, 5654.6324488908085, 5654.943450565442, 5658.603897727119, 5665.206871037975, 5714.342850572154, 5744.368119506851, 5962.314333851576, 5964.7315870785915, 5973.253343332083, 5495.917561236584, 5529.060059789846, 5529.612927095065, 5591.41290164535, 5630.662160270397, 5105.770240339194, 5114.43741188469, 5119.436861945183, 5123.052235336475, 5146.974265128725, 5941.0, 6058.212432383762, 6109.969450152721, 6122.295935967331, 6127.693615319127, 5771.94228057714, 5874.823755287348, 5933.525317974638, 5940.495057919952, 6048.183495228264, 6166.136740856194, 6227.190465239671, 6239.188905442445, 6249.625022498482, 6256.061590761422, 5866.50134738552, 5867.706614669335, 5878.3239927407185, 5879.05935050407, 5913.349531551612, 5729.4843464088435, 5740.1102829061565, 5815.185873977731, 5858.2677165354335, 5865.3254875689845, 5733.0, 5760.884782304414, 5767.394423585463, 5768.019436695688, 5790.276215473066, 5733.0, 5750.396208398058, 5757.3954734753925, 5761.942380576141, 5764.07774756037, 5413.566914646897, 5445.237666726583, 5691.658500489983, 5723.370429252695, 5731.914021289601, 5781.942180578309, 5819.214406055297, 5835.153902684172, 5852.7658893643775, 5864.736086876186, 5486.31421072366, 5687.260656114679, 5692.288463942007, 5699.715014249354, 5702.315722113207], "value": 5421.794298242024, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.8616089058181, 602.12390971137, 628.302584131614, 654.0777503719753, 665.1386454541368, 32754.344913101722, 35814.0, 45376.0, 45981.310280345824, 46112.769436152776, 46284.537154628444, 46354.30468542966, 46579.0, 46632.0, 46705.065898682005, 8257.587120643973, 8758.34312426569, 8944.195022447979, 8953.641854325819, 8967.46195228285, 8296.958515207445, 10576.259661823675, 10822.350658960448, 10824.78350432991, 11156.665300040971, 10964.17768667349, 11004.834927476095, 11020.118390528738, 11020.44897755113, 11030.0, 10556.419396933166, 10577.0, 10591.84112238317, 10598.417087060208, 10601.840972385344, 10723.83914241287, 10760.946195269053, 10776.78446431067, 10784.78430431387, 10786.892131078666, 44140.3378949316, 44196.337054944204, 44288.0, 44307.0, 44350.0, 3364.9495257571157, 3402.7788193767324, 3799.5060642116623, 3827.75119617224, 3895.8246878890236, 33145.83427082849, 33290.167745806306, 33352.49971250433, 33353.83323083393, 33499.16252093693, 4243.405923170728, 4243.560741358109, 4264.509581398148, 4269.679774016961, 4283.700140990132, 361012.0, 362233.9999999974, 362505.0, 362973.0, 368467.0, 63962.68018659877, 64248.0, 64318.678406607665, 64380.35619643744, 64430.677846610466, 39818.40272395917, 40218.79890600587, 40346.394804077376, 66881.6655916727, 67047.0, 16214.918925405298, 16323.673526529641, 16332.673346533003, 16334.101624410772, 16356.182190890408, 11894.464749086312, 12168.634940951786, 12337.198082124632, 12541.623751287476, 12658.683532911751, 19578.27412182093, 20854.791452085286, 20884.269050583156, 20909.58180836405, 20947.16211351529, 7443.144038435541, 7497.887531687029, 7621.885671714928, 7625.0, 7695.807604809813, 991.3803872579638, 1005.7284533176002, 1066.5094056733835, 1102.6471529110768, 1104.6189064772802, 32476.837615811768, 34292.0, 34313.0, 34331.65668343334, 34440.758577965826, 1076.1821016027718, 1079.7354648111263, 1139.1797905508022, 1154.2439701995206, 1160.9609399587491, 17243.482695519153, 18004.0, 18266.26934922615, 18334.424787166376, 19100.522486937938, 525825.0, 526185.0, 528650.0, 530834.0, 533711.0, 61217.0, 61530.0, 61542.69228653828, 61605.38394616086, 61681.0, 1316.394458549078, 1348.4740951029107, 1388.94444222232, 1426.450816435659, 1454.70178613384, 30651.846740766152, 34755.13112172216, 34765.30469390649, 34870.0, 35206.47190292097, 53192.2021169675, 53666.73166634142, 53767.0, 53780.46219537754, 53907.73046134744, 432995.0, 433748.0, 436727.0, 437908.0, 438732.0, 29945.251368715955, 30256.697433026267, 30709.232269192555, 30873.536896947015, 32532.83733581317, 48953.2657010138, 49711.0, 49860.75069624629, 50632.746836265585, 51008.0, 40956.0, 41638.0, 42150.83003004268, 43244.78377608218, 43556.34665479957, 41782.16435671331, 41956.1608767829, 42693.57306426896, 42712.35931461093, 43016.56983430251, 42031.36952945647, 42576.361354580324, 42602.573974261104, 42693.0, 42790.5720942799, 33756.493652595724, 35169.64830351664, 35366.82316588401, 35650.46524302189, 36068.0, 28454.0, 28611.713882860906, 28651.0, 28659.8567007172, 28758.281042974093], "value": 20950.740499620886, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.8110397561161, 398.124126920774, 421.9767912764798, 426.5819496893044, 430.0817754095006, 15528.45650402236, 19240.30635710998, 19295.0, 19445.12496937638, 19476.026198690062, 19177.32879349223, 19206.135723892425, 19310.71033934492, 19534.804651953476, 19583.608327833434, 5182.067227898977, 5256.185291279858, 5562.415946325628, 5743.081107022877, 5803.100519419476, 5625.578081643873, 5726.68503232322, 5729.197912292282, 5731.656100633954, 5732.426757324255, 5527.39198688144, 5625.128105143709, 5682.261306030231, 5690.374058853523, 5706.1726049722765, 5633.63381380211, 5673.290838645169, 5675.545956323525, 5681.0, 5683.403242659502, 4935.851924442272, 5132.538071573539, 5159.664621799571, 5160.12277912752, 5166.1217593008905, 23210.41973950648, 23257.3022809316, 23272.65091023636, 23302.3009309721, 23489.295321140395, 2262.751097379287, 2339.3099035784485, 2434.464417828075, 2482.565551028563, 3062.1119875236154, 10447.895521044844, 10498.895011049868, 10569.894301056967, 10583.047525722723, 10855.348679079281, 1945.7178709087245, 1987.9801201988084, 2023.251396983111, 2030.1067530286628, 2047.7440319960006, 86862.56568717115, 88964.0, 89502.0, 90348.5482572583, 91473.0, 11286.153538484647, 11427.48576314068, 11499.597514087134, 11525.711857203636, 11586.710332241593, 16060.0, 16124.516264512084, 16135.0, 16145.0, 16159.919200403923, 7868.291853733192, 7907.604619768988, 7963.217471701011, 8037.7990550235545, 8240.175982401832, 7782.961085194538, 7847.568383738949, 7851.764447066597, 8100.756977290691, 8147.75556733299, 4747.311639812208, 4766.213574760195, 4871.293662419001, 4897.412310522689, 4953.23224900141, 1957.5399781051442, 1972.2209727157979, 2000.5298754792611, 2020.9090590923445, 2071.326818783901, 913.8674892140735, 947.2564037230741, 954.9140577347933, 993.8558908958161, 1001.9749506262256, 18305.359312424, 19492.12285447158, 19708.50728731793, 19911.701324479855, 20497.897510512354, 988.7775250568565, 992.151710287708, 1025.2771795883884, 1055.8099542082346, 1062.8458873463305, 10246.743831404274, 10680.412577308323, 11078.889211107948, 11134.220604557766, 11198.384088875027, 492689.0, 511194.0, 532434.0, 537085.0, 541573.0, 92298.0, 96413.0, 100482.49758751159, 101339.49330253301, 103195.0, 1039.9428031458342, 1084.7233955341496, 1119.149446420726, 1128.9266197697123, 1146.083133493202, 17691.911540442732, 17971.910140449214, 18183.363582274556, 18193.272269109086, 18433.0, 43075.784621076695, 43742.56257437385, 43864.34203487014, 44162.55837441584, 45132.097358052, 57375.71312143413, 58667.70666146642, 62165.37834621777, 62980.37019629745, 63281.050784237355, 7877.566733829465, 8140.633671484679, 8269.917300826915, 8404.705835295736, 8878.911210888067, 12100.576479823163, 12242.755144896873, 12957.546485872948, 12975.610731678065, 13360.331983400985, 5924.496417804535, 10999.570055892682, 11533.192676512563, 11627.59303424376, 11767.0, 11152.0, 11171.106311494897, 11306.378149201873, 11507.827382589436, 11798.292102473879, 11879.881201188224, 11906.166568340133, 12063.336516491678, 12184.20802647825, 12211.877881221075, 8458.577071146541, 8628.697995570124, 8653.956730216309, 8761.123887611187, 8770.07914169003, 9575.23398128134, 11175.664730058112, 11437.542498299976, 11533.538658453568, 11670.533178672758], "value": 9330.258766180574, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1351.513455156143, 1465.5969608357698, 1471.2496626720372, 1617.7573363995407, 1751.0719318761062, 7339.522931009481, 8196.221358970903, 8526.531040792754, 8526.658933642655, 8651.783705407368, 8482.66069357225, 8563.229309362172, 8566.357523185754, 8572.65709371626, 8575.91424085759, 2344.6951896253463, 2385.296337580418, 2386.6420036994505, 2389.4265376309736, 2392.1627430399394, 2256.9661455078185, 2305.043406986099, 2322.047960336254, 2334.2647066174186, 2345.94135146621, 2262.558801033799, 2283.2693538067824, 2283.977160228393, 2286.4855407533337, 2307.2962746362355, 2259.175400978639, 2269.262489690857, 2274.886255687209, 2275.397019789757, 2275.715535558047, 2306.6655334976335, 2323.7676232376625, 2325.8953347099423, 2328.7205535335697, 2328.953420931589, 8201.71294004707, 8365.665373385058, 8487.490750554987, 8561.700340488052, 8575.442596231225, 5102.311187989611, 5213.973930130363, 5219.582433405319, 5220.138677118309, 5222.00781851447, 3213.293075523381, 3236.64396916339, 3342.565466489341, 3383.069655844638, 3384.018634595964, 995.5470261031213, 1005.3158067958568, 1025.318163421324, 1045.9320144190604, 1061.723951772537, 11870.821937670942, 11930.343831089287, 11957.760844783055, 12012.279263244232, 12025.759484810254, 4271.8718438446895, 4462.754548499799, 4540.8637740867825, 4544.18204723153, 4548.5906268436, 9437.90562094384, 9441.858372124423, 9445.19715824149, 9451.6691915784, 9461.763455913657, 5228.503292187236, 5230.215467679878, 5230.476952304739, 5230.875361797232, 5234.450382709837, 3925.666318362914, 4311.288637374861, 4383.145286669069, 4873.585745211626, 4873.683210591371, 3761.717871159674, 3784.4512545680723, 3787.962120378761, 3818.529866001609, 3846.0577158595765, 1135.057901941403, 1135.7160709822545, 1138.8405623212757, 1140.7091191746217, 1140.7262257058246, 754.1553460124586, 847.525385783963, 888.2538667519315, 959.9776238306182, 1014.2139841622654, 5563.721813909288, 5706.885862282731, 5737.512311453574, 5977.342492325841, 5982.521398288127, 943.7734943613483, 963.7494251494521, 976.1507488484922, 990.782027953849, 1029.145808978546, 3838.8272527736317, 3983.223271462095, 4047.5952404759287, 4053.574374690674, 4121.0, 9985.550650220757, 10500.789984200273, 10511.054005139575, 10580.894191058145, 10588.682339529827, 10320.48397580133, 10447.164226861833, 10447.477626118663, 10449.373037617766, 10459.790804183875, 7842.490238134503, 7959.0, 8036.035675719068, 8048.154943730824, 8058.194180581895, 5559.0, 5611.719414029364, 5723.02708539541, 5733.0, 5810.767569297181, 9617.79777527809, 9679.419234845931, 9690.224782017282, 9793.118619324296, 9814.75463113428, 8560.357973151915, 9571.904280957102, 9752.12230899194, 9895.406275623485, 10023.849642255225, 6576.934230657632, 7073.858522829618, 7146.67839947214, 7215.458840586872, 7402.25977402277, 8110.716124935599, 8254.793630159054, 8353.0811610724, 8371.95814020926, 8465.026521949809, 7185.401343140499, 7467.551946883204, 7649.273319034683, 7677.577733224726, 7892.960535197287, 7451.3293803557945, 7484.476086673881, 7518.248175182657, 7569.886451703119, 7602.847943040998, 6665.3001434850585, 6928.203256625351, 6972.058772065706, 6981.616011119438, 7003.124609423822, 4963.652544322007, 5010.549050585465, 5061.215511595708, 5096.745162741922, 5110.105731497048, 5072.54347108762, 5083.466236045162, 5116.817533109161, 5240.89518209626, 5331.226972089103], "value": 4492.8941638903825, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.9363620912026, 335.0264778990596, 345.1543717891166, 346.65854133678323, 348.8186143205535, 5304.336957880265, 5323.680579165253, 5350.866228344288, 5354.5716342692585, 5372.489613486722, 5042.621803364744, 5110.543495103896, 5148.168507320977, 5154.639175257734, 5296.311479507659, 4167.791610419482, 4183.435236243114, 4188.790560471979, 4197.7271477354025, 4215.430916826235, 4171.395147703581, 4178.498580170384, 4186.016286172747, 4201.43280657112, 4221.746695198282, 3972.0139930034984, 3997.6202260785326, 4030.1939612077554, 4149.771762553059, 4155.065110350177, 4128.545859955432, 4141.742750201148, 4156.898421918194, 4163.542010378856, 4163.91672166558, 3701.4262789267705, 3701.648343407372, 3707.94438083429, 3712.5916149223835, 3729.1982223821738, 5072.289879416885, 5087.771050302746, 5121.871953201163, 5125.282460455539, 5155.278261043457, 4742.478327383985, 4764.809407623726, 4776.5701086902, 4785.258284965836, 4788.186008378584, 5467.507924286793, 5477.561795056386, 5484.396716361197, 5525.11598144295, 5530.806421775259, 3982.625994032054, 4000.399940008993, 4077.571854955246, 4088.5485652593197, 4104.240715467618, 5648.237487939116, 5654.943450565442, 5687.146927960797, 5703.54371650267, 5719.742611582489, 4155.231282212801, 4160.918161278089, 4164.770937598461, 4204.810783514688, 4217.493900731932, 4094.7952602369764, 4177.0, 4206.894827629272, 4255.893602659959, 4263.936040959388, 4751.358566593535, 4762.975285883423, 4763.499832517605, 4779.713217206979, 4785.784639691222, 5531.612787104945, 5538.944610553924, 5542.473465020817, 5547.889042219133, 5549.472800083986, 1381.9101758385673, 1382.6474249066625, 1398.9020768546104, 1425.5794540610545, 1439.2443966917451, 938.3572253006712, 951.129716309569, 988.3871999360442, 1013.9036791504943, 1017.3031473440717, 5197.908439227805, 5201.791928322825, 5202.479752024843, 5210.436868939303, 5226.686398816083, 5477.835664930059, 5489.43551087938, 5498.972505137449, 5519.834404967857, 5533.557315414757, 5084.33903592538, 5171.0, 5206.453322401093, 5227.320448341768, 5257.737113144328, 2921.9123426297247, 2931.6042334285025, 2934.8679309431127, 2939.0595009596723, 2939.6913324101088, 5471.50756431923, 5686.152000599739, 5741.311042674905, 5744.195812586157, 5772.662071860903, 5504.889902201933, 5523.530499907472, 5527.751251193706, 5544.722763861791, 5550.666959982414, 5606.327240731139, 5641.533201367674, 5641.774329026875, 5664.97167514168, 5677.886442271214, 5249.553787928069, 5369.48989845964, 5400.810971615974, 5404.378686394145, 5439.0, 5366.517013468807, 5371.838844834661, 5383.062097644766, 5398.78404863801, 5400.216968539461, 5459.481349271813, 5661.886762264649, 5680.4319568042865, 5682.6306290091015, 5711.172424824183, 4009.699272554512, 4048.5748996356137, 4053.959460405476, 4070.3894415836676, 4079.8164082616945, 5480.753366098615, 5489.819688766935, 5508.686351732202, 5513.531349835309, 5534.640248383842, 5086.720230387365, 5385.892282154413, 5386.569074474111, 5417.51242388187, 5426.864328391822, 5274.549498887836, 5282.656627319212, 5283.788648454019, 5294.100002999422, 5328.067588171977, 5286.97356513215, 5287.629865909349, 5288.180332048539, 5305.389880163676, 5421.457854214705, 5463.426340234377, 5533.446655334435, 5556.194351818883, 5566.387697353369, 5589.636673616202, 5430.0, 5433.56531477473, 5443.918341224806, 5453.64551304164, 5467.152591348347], "value": 4195.02483378796, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [653.9182602174727, 677.8169894128583, 688.538679085013, 698.5459451356618, 715.8067321823111, 13698.794518082224, 14331.211783351911, 14392.568222953329, 14471.710565788704, 14499.855001449982, 13252.0, 13252.807247347737, 13282.933585332059, 13285.601431957033, 13292.335383230848, 679.1917618034523, 699.0527834783871, 812.2567850416862, 812.5287333346645, 832.6794184239051, 828.1097819843692, 829.266099501939, 830.4021104804531, 830.4145577367941, 833.2334252487726, 888.5734847273312, 890.0965519997208, 890.3989806880362, 890.4167770110555, 891.5052146058935, 718.5760401363194, 742.3133601418693, 848.7241646464862, 867.8871746672955, 884.3588398411165, 640.2093414632925, 640.2604991235131, 640.4588123036027, 640.5196102922808, 640.942315191635, 13660.726785464334, 13738.244396558186, 13757.931210343984, 13769.31153442334, 13778.724425511433, 13450.394732236975, 13564.45742170312, 13565.0, 13639.0, 13684.178949263076, 11741.882581174164, 11895.405229738564, 11962.0, 11983.640490785203, 12233.632991010283, 4167.666586673089, 4202.600752928467, 4207.915841683149, 4237.13138806547, 4353.434053573015, 62757.37242627561, 65685.67157164184, 66001.3399866, 66540.33459665389, 66920.6653966732, 10710.410927399067, 10728.624498142528, 10834.512446939907, 10908.454577271263, 11081.390523521284, 19420.8057919419, 19427.125779339964, 19427.51431214231, 19442.611147776966, 19453.902730486257, 7647.617619119022, 7667.118281397599, 7878.409119316074, 7930.325922296554, 8169.550674712829, 4427.601515863587, 4508.819647214074, 4607.0785842831565, 4759.9524004759505, 4881.365422495124, 3095.582096417, 3187.3625274945102, 3190.968090319067, 3192.090254277566, 3193.1218914798615, 588.0297509110003, 680.7379159023712, 683.2962049089446, 705.0481849503233, 707.6249587718518, 601.7923816283375, 662.3674390956625, 669.8827705151676, 676.4182802789597, 707.9469039822034, 8875.846140001759, 9309.953450232706, 9497.810043799085, 9516.764300137986, 9686.176674982706, 584.4944123333371, 660.92729799722, 667.8363800868818, 688.1054628982303, 690.6684791300204, 4279.0, 4320.351947207944, 4328.653707703376, 4339.305711086211, 4393.165298593257, 58911.0, 88751.11248887557, 89657.55171224102, 93256.53371733098, 97024.51487742516, 80209.0, 83255.583722081, 84257.0, 84614.57692711498, 85051.0, 69094.0, 71330.0, 71987.0, 73423.0, 74023.25976740164, 8233.259006689426, 8327.333813295043, 8385.748427547183, 8386.32909367237, 8602.870956935525, 49449.25826112683, 49686.75156624194, 49734.75132624314, 50224.748876255384, 50560.49439505705, 66017.66991165206, 68167.0, 68420.6578967102, 69447.0, 69626.0, 10228.181745460197, 10680.412577308323, 11013.347997800394, 11204.991550760471, 11717.179797414099, 12170.513179473077, 12188.939055305022, 12290.815637765261, 12313.753724925631, 12464.252144871336, 9998.350107243006, 11231.66305010851, 11329.830052549383, 11407.771844563229, 11899.583514576949, 11475.196736228383, 12006.159568830099, 12031.699207519881, 12145.089118315986, 12257.142000060267, 12445.377731113227, 12476.5009399623, 12488.12583119173, 12538.310392928477, 12565.560205392767, 10116.949415252877, 10267.691969240936, 10463.11063559606, 10514.737131571772, 10733.946330268298, 9654.979410706253, 10190.694279171637, 10267.94866025695, 10300.742481438025, 10323.277370584288], "value": 6985.062186258221, "unit": "score"}], "name": "dromaeo_css", "value": 7201.9898240321545, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 111.0, 111.0, 113.0, 113.0, 112.0, 110.0, 111.0, 112.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 126.0, 120.0, 164.0, 122.0, 123.0, 120.0, 121.0, 146.0, 126.0], "value": 132.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 163.0, 159.0, 161.0, 161.0, 161.0, 161.0, 160.0, 161.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 109.0, 76.0, 75.0, 76.0, 74.0, 103.0, 75.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 112.0, 82.0, 82.0, 82.0, 98.0, 82.0, 83.0, 107.0], "value": 89.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 147.0, 146.0, 145.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 85.0, 84.0, 84.0, 85.0, 84.0, 85.0, 84.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 49.0, 50.0, 49.0, 50.0, 49.0, 49.0, 49.0, 49.0, 49.0], "value": 49.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 60.0, 66.0, 60.0, 60.0, 60.0, 60.0, 59.0, 60.0], "value": 60.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 81.0, 76.0, 75.0, 75.0, 74.0, 75.0, 75.0, 77.0], "value": 76.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 138.0, 126.0, 126.0, 135.0, 136.0, 124.0, 124.0, 182.0, 131.0], "value": 136.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 154.0, 157.0, 157.0, 159.0, 153.0, 153.0, 153.0, 155.0, 155.0], "value": 154.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 61.0, 61.0, 61.0, 64.0, 61.0, 61.0, 61.0], "value": 61.5, "unit": "score"}], "name": "kraken", "value": 1460.2000000000003, "alertThreshold": 2.0}]} 22:46:53 INFO - Return code: 0 22:46:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:46:53 INFO - # TBPL SUCCESS # 22:46:53 INFO - Running post-action listener: _resource_record_post_action 22:46:53 INFO - [mozharness: 2016-11-30 06:46:53.747657Z] Finished run-tests step (success) 22:46:53 INFO - Running post-run listener: _resource_record_post_run 22:46:53 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 355524608; Read time: 16; Write time: 224812 22:46:53 INFO - TinderboxPrint: CPU usage
13.0% 22:46:53 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 22:46:53 INFO - TinderboxPrint: I/O write bytes / time
355,524,608 / 224,812 22:46:53 INFO - TinderboxPrint: CPU idle
8,267.8 (87.0%) 22:46:53 INFO - TinderboxPrint: CPU user
1,192.1 (12.5%) 22:46:53 INFO - TinderboxPrint: Swap in / out
0 / 0 22:46:53 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107335680; Read time: 0; Write time: 63240 22:46:53 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 246915072; Read time: 0; Write time: 161540 22:46:54 INFO - Running post-run listener: _upload_blobber_files 22:46:54 INFO - Blob upload gear active. 22:46:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:46:54 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 22:46:54 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'] 22:46:54 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 22:46:54 INFO - (blobuploader) - INFO - Open directory for files ... 22:46:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:46:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:46:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:46:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:46:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:46:58 INFO - (blobuploader) - INFO - Done attempting. 22:46:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:46:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:46:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:46:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:46:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:46:59 INFO - (blobuploader) - INFO - Done attempting. 22:46:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:46:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:46:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:47:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:47:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:47:01 INFO - (blobuploader) - INFO - Done attempting. 22:47:01 INFO - (blobuploader) - INFO - Iteration through files over. 22:47:01 INFO - Return code: 0 22:47:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:47:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:47:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/166aefd4276b0e25250419bcb85d18f4faea99b075d71d25ff219ceb931666733401dc9d0ce70a210c0b07aaea071a86c09eafd0c328353a8aec41c74a379048", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a99921892ed7306b34ca622225b01dc70a02be0ab35fb4fef93a549836f0472af119abf14a7bedc13a579138cb8a90bdec5fbf73385459a62c14e240440e1e9b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/60bc7929587a2d2a11c44abae3c501baa5bdf6f7b905cbf3ebd9c60a528ab6a14735a61fc3dc3750f85cfc5cb51e71df804fdf0cb0f1731a06901488d010ea95"} 22:47:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:47:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:47:01 INFO - Contents: 22:47:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/166aefd4276b0e25250419bcb85d18f4faea99b075d71d25ff219ceb931666733401dc9d0ce70a210c0b07aaea071a86c09eafd0c328353a8aec41c74a379048", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a99921892ed7306b34ca622225b01dc70a02be0ab35fb4fef93a549836f0472af119abf14a7bedc13a579138cb8a90bdec5fbf73385459a62c14e240440e1e9b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/60bc7929587a2d2a11c44abae3c501baa5bdf6f7b905cbf3ebd9c60a528ab6a14735a61fc3dc3750f85cfc5cb51e71df804fdf0cb0f1731a06901488d010ea95"} 22:47:01 INFO - Running post-run listener: copy_logs_to_upload_dir 22:47:01 INFO - Copying logs to upload dir... 22:47:01 INFO - mkdir: /builds/slave/test/build/upload/logs 22:47:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.697626 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-11-29 22:47:00.786434) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-29 22:47:00.789799) ========= 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=fa44defc139c4ba8574fe040000001db-1480487181.367456-2072277714 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/166aefd4276b0e25250419bcb85d18f4faea99b075d71d25ff219ceb931666733401dc9d0ce70a210c0b07aaea071a86c09eafd0c328353a8aec41c74a379048", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a99921892ed7306b34ca622225b01dc70a02be0ab35fb4fef93a549836f0472af119abf14a7bedc13a579138cb8a90bdec5fbf73385459a62c14e240440e1e9b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/60bc7929587a2d2a11c44abae3c501baa5bdf6f7b905cbf3ebd9c60a528ab6a14735a61fc3dc3750f85cfc5cb51e71df804fdf0cb0f1731a06901488d010ea95"} build_url:https://queue.taskcluster.net/v1/task/QRqCbHdHQdKceODRH2gXcw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011756 build_url: 'https://queue.taskcluster.net/v1/task/QRqCbHdHQdKceODRH2gXcw/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/166aefd4276b0e25250419bcb85d18f4faea99b075d71d25ff219ceb931666733401dc9d0ce70a210c0b07aaea071a86c09eafd0c328353a8aec41c74a379048", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a99921892ed7306b34ca622225b01dc70a02be0ab35fb4fef93a549836f0472af119abf14a7bedc13a579138cb8a90bdec5fbf73385459a62c14e240440e1e9b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/60bc7929587a2d2a11c44abae3c501baa5bdf6f7b905cbf3ebd9c60a528ab6a14735a61fc3dc3750f85cfc5cb51e71df804fdf0cb0f1731a06901488d010ea95"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-29 22:47:00.818075) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 22:47:00.818597) ========= 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=fa44defc139c4ba8574fe040000001db-1480487181.367456-2072277714 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004436 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 22:47:00.901790) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-29 22:47:00.902547) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-29 22:47:00.903100) ========= ========= Total master_lag: 0.17 =========