builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-043 starttime: 1482249722.82 results: success (0) buildid: 20161220062553 builduid: 77a00e3119284c46a454e3671ada89b8 revision: a16a286021714abebbf2cd629ae27cbaa0812887 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-20 08:02:02.822511) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-20 08:02:02.822974) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-20 08:02:02.823265) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-20 08:02:02.838983) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 08:02:02.839307) ========= 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=d2a8c569965ab8367867b893000001a1-1482248368.537627-247160603 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-20 08:02:02-- 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% 50.8K=0.2s 2016-12-20 08:02:03 (50.8 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.318977 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 08:02:03.173860) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 08:02:03.174183) ========= 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=d2a8c569965ab8367867b893000001a1-1482248368.537627-247160603 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020540 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 08:02:03.224629) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 08:02:03.225082) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a16a286021714abebbf2cd629ae27cbaa0812887 --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 a16a286021714abebbf2cd629ae27cbaa0812887 --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=d2a8c569965ab8367867b893000001a1-1482248368.537627-247160603 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-20 08:02:03,268 truncating revision to first 12 chars 2016-12-20 08:02:03,268 Setting DEBUG logging. 2016-12-20 08:02:03,268 attempt 1/10 2016-12-20 08:02:03,268 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a16a28602171?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-20 08:02:03,569 unpacking tar archive at: mozilla-aurora-a16a28602171/testing/mozharness/ program finished with exit code 0 elapsedTime=0.645316 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 08:02:03.885919) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-20 08:02:03.886394) ========= script_repo_revision: a16a286021714abebbf2cd629ae27cbaa0812887 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-20 08:02:03.887017) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-20 08:02:03.887439) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-20 08:02:03.898581) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-12-20 08:02:03.899128) ========= /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=d2a8c569965ab8367867b893000001a1-1482248368.537627-247160603 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:02:04 INFO - MultiFileLogger online at 20161220 08:02:04 in /builds/slave/test 08:02:04 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 08:02:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:02:04 INFO - {'append_to_log': False, 08:02:04 INFO - 'base_work_dir': '/builds/slave/test', 08:02:04 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:02:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:02:04 INFO - 'branch': 'Mozilla-Aurora', 08:02:04 INFO - 'buildbot_json_path': 'buildprops.json', 08:02:04 INFO - 'config_files': ('talos/linux_config.py',), 08:02:04 INFO - 'default_actions': ('clobber', 08:02:04 INFO - 'read-buildbot-config', 08:02:04 INFO - 'download-and-extract', 08:02:04 INFO - 'populate-webroot', 08:02:04 INFO - 'create-virtualenv', 08:02:04 INFO - 'install', 08:02:04 INFO - 'run-tests'), 08:02:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:02:04 INFO - 'download_minidump_stackwalk': True, 08:02:04 INFO - 'download_symbols': 'ondemand', 08:02:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:02:04 INFO - 'tooltool.py': '/tools/tooltool.py', 08:02:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:02:04 INFO - '/tools/misc-python/virtualenv.py')}, 08:02:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:02:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:02:04 INFO - 'installer_path': 'installer.exe', 08:02:04 INFO - 'log_level': 'info', 08:02:04 INFO - 'log_name': 'talos', 08:02:04 INFO - 'log_to_console': True, 08:02:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:02:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:02:04 INFO - 'opt_config_files': (), 08:02:04 INFO - 'pip_index': False, 08:02:04 INFO - 'sps_profile': False, 08:02:04 INFO - 'sps_profile_interval': 0, 08:02:04 INFO - 'suite': 'dromaeojs', 08:02:04 INFO - 'system_bits': '32', 08:02:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:02:04 INFO - 'title': 'talos-linux64-ix-043', 08:02:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:02:04 INFO - 'use_talos_json': True, 08:02:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:02:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:02:04 INFO - 'work_dir': 'build'} 08:02:04 INFO - [mozharness: 2016-12-20 16:02:04.041255Z] Running clobber step. 08:02:04 INFO - Running pre-action listener: _resource_record_pre_action 08:02:04 INFO - Running main action method: clobber 08:02:04 INFO - rmtree: /builds/slave/test/build 08:02:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:02:04 INFO - Running post-action listener: _resource_record_post_action 08:02:04 INFO - [mozharness: 2016-12-20 16:02:04.489986Z] Finished clobber step (success) 08:02:04 INFO - [mozharness: 2016-12-20 16:02:04.490086Z] Running read-buildbot-config step. 08:02:04 INFO - Running pre-action listener: _resource_record_pre_action 08:02:04 INFO - Running main action method: read_buildbot_config 08:02:04 INFO - Using buildbot properties: 08:02:04 INFO - { 08:02:04 INFO - "project": "", 08:02:04 INFO - "product": "firefox", 08:02:04 INFO - "script_repo_revision": "production", 08:02:04 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 08:02:04 INFO - "repository": "", 08:02:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 08:02:04 INFO - "buildid": "20161220062553", 08:02:04 INFO - "pgo_build": "True", 08:02:04 INFO - "basedir": "/builds/slave/test", 08:02:04 INFO - "buildnumber": 652, 08:02:04 INFO - "slavename": "talos-linux64-ix-043", 08:02:04 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:02:04 INFO - "platform": "ubuntu64_hw", 08:02:04 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 08:02:04 INFO - "branch": "mozilla-aurora", 08:02:04 INFO - "repo_path": "releases/mozilla-aurora", 08:02:04 INFO - "revision": "a16a286021714abebbf2cd629ae27cbaa0812887", 08:02:04 INFO - "stage_platform": "linux64-pgo", 08:02:04 INFO - "builduid": "77a00e3119284c46a454e3671ada89b8", 08:02:04 INFO - "slavebuilddir": "test" 08:02:04 INFO - } 08:02:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/PoVaUphYROW70-7JKtzgYw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 08:02:04 INFO - Running post-action listener: _resource_record_post_action 08:02:04 INFO - [mozharness: 2016-12-20 16:02:04.492489Z] Finished read-buildbot-config step (success) 08:02:04 INFO - [mozharness: 2016-12-20 16:02:04.492577Z] Running download-and-extract step. 08:02:04 INFO - Running pre-action listener: _resource_record_pre_action 08:02:04 INFO - Running main action method: download_and_extract 08:02:04 INFO - mkdir: /builds/slave/test/build/tests 08:02:04 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')]} 08:02:04 INFO - trying https://queue.taskcluster.net/v1/task/PoVaUphYROW70-7JKtzgYw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:02:04 INFO - Downloading https://queue.taskcluster.net/v1/task/PoVaUphYROW70-7JKtzgYw/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 08:02:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PoVaUphYROW70-7JKtzgYw/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 08:02:05 INFO - Downloaded 1361 bytes. 08:02:05 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:02:05 INFO - Using the following test package requirements: 08:02:05 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 08:02:05 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:02:05 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 08:02:05 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:02:05 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 08:02:05 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:02:05 INFO - u'jsshell-linux-x86_64.zip'], 08:02:05 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:02:05 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 08:02:05 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 08:02:05 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:02:05 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 08:02:05 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:02:05 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 08:02:05 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:02:05 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 08:02:05 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:02:05 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 08:02:05 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:02:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PoVaUphYROW70-7JKtzgYw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 08:02:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PoVaUphYROW70-7JKtzgYw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:02:05 INFO - Fetch https://queue.taskcluster.net/v1/task/PoVaUphYROW70-7JKtzgYw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:02:05 INFO - Http code: 200 08:02:05 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 08:02:05 INFO - x-amz-cf-id: U9AbFbCHLYbTaXh1oMc0bldwVGPzTQA0mkkc_H37MUnkp6FGX80MFw== 08:02:05 INFO - x-amz-version-id: PtV74colBUUwBY9H8EgJKJhGk7Jc2YFg 08:02:05 INFO - Expected file size: 21939125 08:02:05 INFO - Obtained file size: 21939125 08:02:09 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 08:02:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PoVaUphYROW70-7JKtzgYw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 08:02:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PoVaUphYROW70-7JKtzgYw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:02:09 INFO - Fetch https://queue.taskcluster.net/v1/task/PoVaUphYROW70-7JKtzgYw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:02:10 INFO - Http code: 200 08:02:10 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 08:02:10 INFO - x-amz-cf-id: btpuAmEW04LKA-62SYB2ATbE3H3I71w8V1M751K0v3hgzCw9RB1r5A== 08:02:10 INFO - x-amz-version-id: PtV74colBUUwBY9H8EgJKJhGk7Jc2YFg 08:02:11 INFO - Expected file size: 21939125 08:02:11 INFO - Obtained file size: 21939125 08:02:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PoVaUphYROW70-7JKtzgYw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 08:02:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PoVaUphYROW70-7JKtzgYw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:02:15 INFO - Fetch https://queue.taskcluster.net/v1/task/PoVaUphYROW70-7JKtzgYw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 08:02:16 INFO - Http code: 200 08:02:16 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 08:02:16 INFO - x-amz-cf-id: CNHcMGUcTrZU_hK-HoC4tTEw0_ous3KuXQRhwu3E03GMeygATerZ-w== 08:02:16 INFO - x-amz-version-id: yQa3wWaCtSpzfi9urVQE944hgmdksJiW 08:02:16 INFO - Expected file size: 14409038 08:02:16 INFO - Obtained file size: 14409038 08:02: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')]} 08:02:17 INFO - trying https://queue.taskcluster.net/v1/task/PoVaUphYROW70-7JKtzgYw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:02:17 INFO - Downloading https://queue.taskcluster.net/v1/task/PoVaUphYROW70-7JKtzgYw/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 08:02:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PoVaUphYROW70-7JKtzgYw/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 08:02:18 INFO - Downloaded 63950692 bytes. 08:02:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PoVaUphYROW70-7JKtzgYw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:02:18 INFO - mkdir: /builds/slave/test/properties 08:02:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:02:18 INFO - Writing to file /builds/slave/test/properties/build_url 08:02:18 INFO - Contents: 08:02:18 INFO - build_url:https://queue.taskcluster.net/v1/task/PoVaUphYROW70-7JKtzgYw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:02:19 INFO - Running post-action listener: _resource_record_post_action 08:02:19 INFO - Running post-action listener: set_extra_try_arguments 08:02:19 INFO - [mozharness: 2016-12-20 16:02:19.051727Z] Finished download-and-extract step (success) 08:02:19 INFO - [mozharness: 2016-12-20 16:02:19.051952Z] Running populate-webroot step. 08:02:19 INFO - Running pre-action listener: _resource_record_pre_action 08:02:19 INFO - Running main action method: populate_webroot 08:02:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:02:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:02:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:02:19 INFO - '--tppagecycles', 08:02:19 INFO - '7'], 08:02:19 INFO - 'tests': ['tsvgm']}}, 08:02:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:02:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:02:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:02:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:02:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:02:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:02:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:02:19 INFO - 'talos_options': ['--disable-e10s'], 08:02:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:02:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:02:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:02:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:02:19 INFO - 'talos_options': ['--disable-e10s'], 08:02:19 INFO - 'tests': ['damp', 'tps']}, 08:02:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:02:19 INFO - 'tests': ['damp', 'tps']}, 08:02:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:02:19 INFO - 'tests': ['dromaeo_dom']}, 08:02:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:02:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:02:19 INFO - 'tests': ['basic_compositor_video']}, 08:02:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:02:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:02:19 INFO - 'tests': ['a11yr', 08:02:19 INFO - 'ts_paint', 08:02:19 INFO - 'tpaint', 08:02:19 INFO - 'sessionrestore', 08:02:19 INFO - 'sessionrestore_no_auto_restore', 08:02:19 INFO - 'tabpaint']}, 08:02:19 INFO - 'other-e10s': {'tests': ['a11yr', 08:02:19 INFO - 'ts_paint', 08:02:19 INFO - 'tpaint', 08:02:19 INFO - 'sessionrestore', 08:02:19 INFO - 'sessionrestore_no_auto_restore', 08:02:19 INFO - 'tabpaint']}, 08:02:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:02:19 INFO - 'ts_paint', 08:02:19 INFO - 'tpaint', 08:02:19 INFO - 'sessionrestore', 08:02:19 INFO - 'sessionrestore_no_auto_restore', 08:02:19 INFO - 'tabpaint']}, 08:02:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:02:19 INFO - 'ts_paint', 08:02:19 INFO - 'tpaint', 08:02:19 INFO - 'sessionrestore', 08:02:19 INFO - 'sessionrestore_no_auto_restore', 08:02:19 INFO - 'tabpaint']}, 08:02:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:02:19 INFO - 'tests': ['a11yr', 08:02:19 INFO - 'ts_paint', 08:02:19 INFO - 'tpaint', 08:02:19 INFO - 'sessionrestore', 08:02:19 INFO - 'sessionrestore_no_auto_restore', 08:02:19 INFO - 'tabpaint']}, 08:02:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:02:19 INFO - 'tests': ['a11yr', 08:02:19 INFO - 'ts_paint', 08:02:19 INFO - 'tpaint', 08:02:19 INFO - 'sessionrestore', 08:02:19 INFO - 'sessionrestore_no_auto_restore', 08:02:19 INFO - 'tabpaint']}, 08:02:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:02:19 INFO - 'tests': ['tsvgx', 08:02:19 INFO - 'tsvgr_opacity', 08:02:19 INFO - 'tart', 08:02:19 INFO - 'tscrollx', 08:02:19 INFO - 'cart']}, 08:02:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:02:19 INFO - 'tsvgr_opacity', 08:02:19 INFO - 'tart', 08:02:19 INFO - 'tscrollx', 08:02:19 INFO - 'cart']}, 08:02:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:02:19 INFO - 'talos_options': ['--disable-e10s'], 08:02:19 INFO - 'tests': ['tp5o']}, 08:02:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:02:19 INFO - 'tests': ['tp5o']}, 08:02:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:02:19 INFO - 'talos_options': ['--disable-e10s', 08:02:19 INFO - '--xperf_path', 08:02:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:02:19 INFO - 'tests': ['tp5n']}, 08:02:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:02:19 INFO - 'talos_options': ['--xperf_path', 08:02:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:02:19 INFO - 'tests': ['tp5n']}}, 08:02:19 INFO - 'talos.zip': {'path': '', 08:02:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:02:19 INFO - Running post-action listener: _resource_record_post_action 08:02:19 INFO - [mozharness: 2016-12-20 16:02:19.071206Z] Finished populate-webroot step (success) 08:02:19 INFO - [mozharness: 2016-12-20 16:02:19.071294Z] Running create-virtualenv step. 08:02:19 INFO - Running pre-action listener: _resource_record_pre_action 08:02:19 INFO - Running main action method: create_virtualenv 08:02:19 INFO - Creating virtualenv /builds/slave/test/build/venv 08:02:19 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:02:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:02:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:02:19 INFO - Using real prefix '/usr' 08:02:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:02:19 INFO - Installing distribute.............................................................................................................................................................................................done. 08:02:21 INFO - Installing pip.................done. 08:02:21 INFO - Return code: 0 08:02:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:02:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:02:21 INFO - Reading from file tmpfile_stdout 08:02:21 INFO - Output received: 08:02:21 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) 08:02:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:02:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1a159c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2493ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2490f60>, '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 0x2491d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24921d0>, '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': 'd2a8c569965ab8367867b893000001a1-1482248368.537627-247160603', '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 08:02:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:02:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:02:21 INFO - Using env: {'DISPLAY': ':0', 08:02:21 INFO - 'HOME': '/home/cltbld', 08:02:21 INFO - 'LANG': 'en_US.UTF-8', 08:02:21 INFO - 'LANGUAGE': 'en_US:en', 08:02:21 INFO - 'LOGNAME': 'cltbld', 08:02:21 INFO - 'MAIL': '/var/mail/cltbld', 08:02:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:21 INFO - 'MOZ_NO_REMOTE': '1', 08:02:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:21 INFO - 'NO_EM_RESTART': '1', 08:02:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:21 INFO - 'PWD': '/builds/slave/test', 08:02:21 INFO - 'SHELL': '/bin/bash', 08:02:21 INFO - 'SHLVL': '1', 08:02:21 INFO - 'TERM': 'linux', 08:02:21 INFO - 'TMOUT': '86400', 08:02:21 INFO - 'USER': 'cltbld', 08:02:21 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1482248368.537627-247160603', 08:02:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:21 INFO - '_': '/tools/buildbot/bin/python'} 08:02:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:22 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:02:22 INFO - Cleaning up... 08:02:22 INFO - Return code: 0 08:02:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:02:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1a159c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2493ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2490f60>, '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 0x2491d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24921d0>, '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': 'd2a8c569965ab8367867b893000001a1-1482248368.537627-247160603', '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 08:02:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:02:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:02:22 INFO - Using env: {'DISPLAY': ':0', 08:02:22 INFO - 'HOME': '/home/cltbld', 08:02:22 INFO - 'LANG': 'en_US.UTF-8', 08:02:22 INFO - 'LANGUAGE': 'en_US:en', 08:02:22 INFO - 'LOGNAME': 'cltbld', 08:02:22 INFO - 'MAIL': '/var/mail/cltbld', 08:02:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:22 INFO - 'MOZ_NO_REMOTE': '1', 08:02:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:22 INFO - 'NO_EM_RESTART': '1', 08:02:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:22 INFO - 'PWD': '/builds/slave/test', 08:02:22 INFO - 'SHELL': '/bin/bash', 08:02:22 INFO - 'SHLVL': '1', 08:02:22 INFO - 'TERM': 'linux', 08:02:22 INFO - 'TMOUT': '86400', 08:02:22 INFO - 'USER': 'cltbld', 08:02:22 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1482248368.537627-247160603', 08:02:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:22 INFO - '_': '/tools/buildbot/bin/python'} 08:02:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:22 INFO - Downloading/unpacking psutil>=3.1.1 08:02:22 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 08:02:22 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 08:02:22 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 08:02:22 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 08:02:22 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 08:02:22 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 08:02:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:02:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:02:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:02:24 INFO - Installing collected packages: psutil 08:02:24 INFO - Running setup.py install for psutil 08:02:24 INFO - building 'psutil._psutil_linux' extension 08:02:24 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 08:02:24 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 08:02:24 INFO - building 'psutil._psutil_posix' extension 08:02:24 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 08:02:24 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 08:02:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:02:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:02:24 INFO - Successfully installed psutil 08:02:24 INFO - Cleaning up... 08:02:24 INFO - Return code: 0 08:02:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:02:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1a159c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2493ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2490f60>, '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 0x2491d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24921d0>, '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': 'd2a8c569965ab8367867b893000001a1-1482248368.537627-247160603', '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 08:02:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:02:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:02:24 INFO - Using env: {'DISPLAY': ':0', 08:02:24 INFO - 'HOME': '/home/cltbld', 08:02:24 INFO - 'LANG': 'en_US.UTF-8', 08:02:24 INFO - 'LANGUAGE': 'en_US:en', 08:02:24 INFO - 'LOGNAME': 'cltbld', 08:02:24 INFO - 'MAIL': '/var/mail/cltbld', 08:02:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:24 INFO - 'MOZ_NO_REMOTE': '1', 08:02:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:24 INFO - 'NO_EM_RESTART': '1', 08:02:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:24 INFO - 'PWD': '/builds/slave/test', 08:02:24 INFO - 'SHELL': '/bin/bash', 08:02:24 INFO - 'SHLVL': '1', 08:02:24 INFO - 'TERM': 'linux', 08:02:24 INFO - 'TMOUT': '86400', 08:02:24 INFO - 'USER': 'cltbld', 08:02:24 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1482248368.537627-247160603', 08:02:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:24 INFO - '_': '/tools/buildbot/bin/python'} 08:02:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:02:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:02:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:02:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:02:27 INFO - Installing collected packages: mozsystemmonitor 08:02:27 INFO - Running setup.py install for mozsystemmonitor 08:02:27 INFO - Successfully installed mozsystemmonitor 08:02:27 INFO - Cleaning up... 08:02:27 INFO - Return code: 0 08:02:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:02:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:27 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 0x7f1a159c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2493ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2490f60>, '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 0x2491d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24921d0>, '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': 'd2a8c569965ab8367867b893000001a1-1482248368.537627-247160603', '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 08:02:27 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 08:02:27 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 08:02:27 INFO - Using env: {'DISPLAY': ':0', 08:02:27 INFO - 'HOME': '/home/cltbld', 08:02:27 INFO - 'LANG': 'en_US.UTF-8', 08:02:27 INFO - 'LANGUAGE': 'en_US:en', 08:02:27 INFO - 'LOGNAME': 'cltbld', 08:02:27 INFO - 'MAIL': '/var/mail/cltbld', 08:02:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:27 INFO - 'MOZ_NO_REMOTE': '1', 08:02:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:27 INFO - 'NO_EM_RESTART': '1', 08:02:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:27 INFO - 'PWD': '/builds/slave/test', 08:02:27 INFO - 'SHELL': '/bin/bash', 08:02:27 INFO - 'SHLVL': '1', 08:02:27 INFO - 'TERM': 'linux', 08:02:27 INFO - 'TMOUT': '86400', 08:02:27 INFO - 'USER': 'cltbld', 08:02:27 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1482248368.537627-247160603', 08:02:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:27 INFO - '_': '/tools/buildbot/bin/python'} 08:02:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:27 INFO - Downloading/unpacking jsonschema==2.5.1 08:02:27 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 08:02:27 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 08:02:27 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 08:02:27 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 08:02:27 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 08:02:27 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 08:02:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:02:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:02:29 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 08:02:29 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 08:02:29 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 08:02:29 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 08:02:29 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 08:02:29 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 08:02:29 INFO - Downloading functools32-3.2.3-2.tar.gz 08:02:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:02:29 INFO - warning: no files found matching '*.txt' 08:02:29 INFO - no previously-included directories found matching 'build' 08:02:29 INFO - no previously-included directories found matching 'dist' 08:02:29 INFO - no previously-included directories found matching '.git*' 08:02:29 INFO - Installing collected packages: jsonschema, functools32 08:02:29 INFO - Running setup.py install for functools32 08:02:30 INFO - warning: no files found matching '*.txt' 08:02:30 INFO - no previously-included directories found matching 'build' 08:02:30 INFO - no previously-included directories found matching 'dist' 08:02:30 INFO - no previously-included directories found matching '.git*' 08:02:30 INFO - Successfully installed jsonschema functools32 08:02:30 INFO - Cleaning up... 08:02:30 INFO - Return code: 0 08:02:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1a159c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2493ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2490f60>, '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 0x2491d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24921d0>, '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': 'd2a8c569965ab8367867b893000001a1-1482248368.537627-247160603', '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 08:02:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:02:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:02:30 INFO - Using env: {'DISPLAY': ':0', 08:02:30 INFO - 'HOME': '/home/cltbld', 08:02:30 INFO - 'LANG': 'en_US.UTF-8', 08:02:30 INFO - 'LANGUAGE': 'en_US:en', 08:02:30 INFO - 'LOGNAME': 'cltbld', 08:02:30 INFO - 'MAIL': '/var/mail/cltbld', 08:02:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:30 INFO - 'MOZ_NO_REMOTE': '1', 08:02:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:30 INFO - 'NO_EM_RESTART': '1', 08:02:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:30 INFO - 'PWD': '/builds/slave/test', 08:02:30 INFO - 'SHELL': '/bin/bash', 08:02:30 INFO - 'SHLVL': '1', 08:02:30 INFO - 'TERM': 'linux', 08:02:30 INFO - 'TMOUT': '86400', 08:02:30 INFO - 'USER': 'cltbld', 08:02:30 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1482248368.537627-247160603', 08:02:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:30 INFO - '_': '/tools/buildbot/bin/python'} 08:02:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:02:30 INFO - Cleaning up... 08:02:30 INFO - Return code: 0 08:02:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1a159c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2493ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2490f60>, '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 0x2491d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24921d0>, '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': 'd2a8c569965ab8367867b893000001a1-1482248368.537627-247160603', '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 08:02:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:02:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:02:30 INFO - Using env: {'DISPLAY': ':0', 08:02:30 INFO - 'HOME': '/home/cltbld', 08:02:30 INFO - 'LANG': 'en_US.UTF-8', 08:02:30 INFO - 'LANGUAGE': 'en_US:en', 08:02:30 INFO - 'LOGNAME': 'cltbld', 08:02:30 INFO - 'MAIL': '/var/mail/cltbld', 08:02:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:30 INFO - 'MOZ_NO_REMOTE': '1', 08:02:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:30 INFO - 'NO_EM_RESTART': '1', 08:02:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:30 INFO - 'PWD': '/builds/slave/test', 08:02:30 INFO - 'SHELL': '/bin/bash', 08:02:30 INFO - 'SHLVL': '1', 08:02:30 INFO - 'TERM': 'linux', 08:02:30 INFO - 'TMOUT': '86400', 08:02:30 INFO - 'USER': 'cltbld', 08:02:30 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1482248368.537627-247160603', 08:02:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:30 INFO - '_': '/tools/buildbot/bin/python'} 08:02:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:30 INFO - Downloading/unpacking blobuploader==1.2.4 08:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:32 INFO - Downloading blobuploader-1.2.4.tar.gz 08:02:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:02:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:02:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:02:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:02:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:33 INFO - Downloading docopt-0.6.1.tar.gz 08:02:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:02:33 INFO - Installing collected packages: blobuploader, requests, docopt 08:02:33 INFO - Running setup.py install for blobuploader 08:02:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:02:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:02:33 INFO - Running setup.py install for requests 08:02:33 INFO - Running setup.py install for docopt 08:02:33 INFO - Successfully installed blobuploader requests docopt 08:02:33 INFO - Cleaning up... 08:02:33 INFO - Return code: 0 08:02:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:02:33 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')]} 08:02:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:33 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')]} 08:02:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:33 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 0x7f1a159c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2493ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2490f60>, '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 0x2491d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24921d0>, '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': 'd2a8c569965ab8367867b893000001a1-1482248368.537627-247160603', '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 08:02:33 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 08:02:33 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 08:02:33 INFO - Using env: {'DISPLAY': ':0', 08:02:33 INFO - 'HOME': '/home/cltbld', 08:02:33 INFO - 'LANG': 'en_US.UTF-8', 08:02:33 INFO - 'LANGUAGE': 'en_US:en', 08:02:33 INFO - 'LOGNAME': 'cltbld', 08:02:33 INFO - 'MAIL': '/var/mail/cltbld', 08:02:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:33 INFO - 'MOZ_NO_REMOTE': '1', 08:02:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:33 INFO - 'NO_EM_RESTART': '1', 08:02:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:33 INFO - 'PWD': '/builds/slave/test', 08:02:33 INFO - 'SHELL': '/bin/bash', 08:02:33 INFO - 'SHLVL': '1', 08:02:33 INFO - 'TERM': 'linux', 08:02:33 INFO - 'TMOUT': '86400', 08:02:33 INFO - 'USER': 'cltbld', 08:02:33 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1482248368.537627-247160603', 08:02:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:33 INFO - '_': '/tools/buildbot/bin/python'} 08:02:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:02:34 INFO - Running setup.py (path:/tmp/pip-GHgD4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:02:34 INFO - Running setup.py (path:/tmp/pip-WBhi1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:02:34 INFO - Running setup.py (path:/tmp/pip-0AxRKq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:02:34 INFO - Running setup.py (path:/tmp/pip-ru8yMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:02:34 INFO - Running setup.py (path:/tmp/pip-Bd2tZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:02:34 INFO - Running setup.py (path:/tmp/pip-PEJ3_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:02:34 INFO - Running setup.py (path:/tmp/pip-Gw7p09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:02:34 INFO - Running setup.py (path:/tmp/pip-RsC0o3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:02:34 INFO - Running setup.py (path:/tmp/pip-fU1seG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:02:34 INFO - Running setup.py (path:/tmp/pip-5vjGRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:02:34 INFO - Running setup.py (path:/tmp/pip-pkbGps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:02:34 INFO - Running setup.py (path:/tmp/pip-KEkVq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:02:35 INFO - Running setup.py (path:/tmp/pip-dA3LrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:02:35 INFO - Running setup.py (path:/tmp/pip-I2eF9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:02:35 INFO - Running setup.py (path:/tmp/pip-dWiMqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:02:35 INFO - Running setup.py (path:/tmp/pip-LuRshB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:02:35 INFO - Running setup.py (path:/tmp/pip-HlDGK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:02:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:02:35 INFO - Running setup.py install for manifestparser 08:02:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:02:35 INFO - Running setup.py install for mozcrash 08:02:35 INFO - Running setup.py install for mozdebug 08:02:35 INFO - Running setup.py install for mozdevice 08:02:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:02:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:02:35 INFO - Running setup.py install for mozfile 08:02:35 INFO - Running setup.py install for mozhttpd 08:02:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:02:35 INFO - Running setup.py install for mozinfo 08:02:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:02:36 INFO - Running setup.py install for mozInstall 08:02:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:02:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:02:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:02:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:02:36 INFO - Running setup.py install for mozleak 08:02:36 INFO - Running setup.py install for mozlog 08:02:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:02:36 INFO - Running setup.py install for moznetwork 08:02:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:02:36 INFO - Running setup.py install for mozprocess 08:02:36 INFO - Running setup.py install for mozprofile 08:02:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:02:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:02:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:02:36 INFO - Running setup.py install for mozrunner 08:02:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:02:36 INFO - Running setup.py install for mozscreenshot 08:02:36 INFO - Running setup.py install for moztest 08:02:37 INFO - Running setup.py install for mozversion 08:02:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:02:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:02:37 INFO - Cleaning up... 08:02:37 INFO - Return code: 0 08:02:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:02: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')]} 08:02:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02: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')]} 08:02:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1a159c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2493ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2490f60>, '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 0x2491d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24921d0>, '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': 'd2a8c569965ab8367867b893000001a1-1482248368.537627-247160603', '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 08:02:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:02:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:02:37 INFO - Using env: {'DISPLAY': ':0', 08:02:37 INFO - 'HOME': '/home/cltbld', 08:02:37 INFO - 'LANG': 'en_US.UTF-8', 08:02:37 INFO - 'LANGUAGE': 'en_US:en', 08:02:37 INFO - 'LOGNAME': 'cltbld', 08:02:37 INFO - 'MAIL': '/var/mail/cltbld', 08:02:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:37 INFO - 'MOZ_NO_REMOTE': '1', 08:02:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:37 INFO - 'NO_EM_RESTART': '1', 08:02:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:37 INFO - 'PWD': '/builds/slave/test', 08:02:37 INFO - 'SHELL': '/bin/bash', 08:02:37 INFO - 'SHLVL': '1', 08:02:37 INFO - 'TERM': 'linux', 08:02:37 INFO - 'TMOUT': '86400', 08:02:37 INFO - 'USER': 'cltbld', 08:02:37 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1482248368.537627-247160603', 08:02:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:37 INFO - '_': '/tools/buildbot/bin/python'} 08:02:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:02:37 INFO - Running setup.py (path:/tmp/pip-QyrCMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:02:37 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)) 08:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:02:37 INFO - Running setup.py (path:/tmp/pip-Qxk1DY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:02:37 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)) 08:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:02:37 INFO - Running setup.py (path:/tmp/pip-yYB4gk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:02:37 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)) 08:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:02:37 INFO - Running setup.py (path:/tmp/pip-tqORRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:02:37 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)) 08:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:02:37 INFO - Running setup.py (path:/tmp/pip-GruBW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:02:37 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)) 08:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:02:37 INFO - Running setup.py (path:/tmp/pip-wqwjmE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:02:37 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)) 08:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:02:37 INFO - Running setup.py (path:/tmp/pip-auaw6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:02:37 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)) 08:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:02:37 INFO - Running setup.py (path:/tmp/pip-fqEnTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:02:37 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)) 08:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:02:37 INFO - Running setup.py (path:/tmp/pip-u3VjhP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:02:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:02:38 INFO - Running setup.py (path:/tmp/pip-JGKtoO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:02:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:02:38 INFO - Running setup.py (path:/tmp/pip-c_HyfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:02:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:02:38 INFO - Running setup.py (path:/tmp/pip-ZQH_z_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:02:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:02:38 INFO - Running setup.py (path:/tmp/pip-g1fINp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:02:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:02:38 INFO - Running setup.py (path:/tmp/pip-WdlRA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:02:38 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)) 08:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:02:38 INFO - Running setup.py (path:/tmp/pip-97togV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:02:38 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)) 08:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:02:38 INFO - Running setup.py (path:/tmp/pip-MtPVqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:02:38 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)) 08:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:02:38 INFO - Running setup.py (path:/tmp/pip-D1RZJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:02:38 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)) 08:02:38 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)) 08:02:38 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)) 08:02:38 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)) 08:02:38 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)) 08:02:38 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)) 08:02:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:02:38 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 08:02:38 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 08:02:38 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 08:02:38 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 08:02:38 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 08:02:38 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 08:02:40 INFO - Downloading blessings-1.6.tar.gz 08:02:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:02:40 INFO - Installing collected packages: blessings 08:02:40 INFO - Running setup.py install for blessings 08:02:40 INFO - Successfully installed blessings 08:02:40 INFO - Cleaning up... 08:02:40 INFO - Return code: 0 08:02:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:02:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:02:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:02:41 INFO - Reading from file tmpfile_stdout 08:02:41 INFO - Current package versions: 08:02:41 INFO - argparse == 1.2.1 08:02:41 INFO - blessings == 1.6 08:02:41 INFO - blobuploader == 1.2.4 08:02:41 INFO - docopt == 0.6.1 08:02:41 INFO - functools32 == 3.2.3-2 08:02:41 INFO - jsonschema == 2.5.1 08:02:41 INFO - manifestparser == 1.1 08:02:41 INFO - mozInstall == 1.12 08:02:41 INFO - mozcrash == 1.0 08:02:41 INFO - mozdebug == 0.1 08:02:41 INFO - mozdevice == 0.48 08:02:41 INFO - mozfile == 1.2 08:02:41 INFO - mozhttpd == 0.7 08:02:41 INFO - mozinfo == 0.9 08:02:41 INFO - mozleak == 0.1 08:02:41 INFO - mozlog == 3.4 08:02:41 INFO - moznetwork == 0.27 08:02:41 INFO - mozprocess == 0.23 08:02:41 INFO - mozprofile == 0.28 08:02:41 INFO - mozrunner == 6.13 08:02:41 INFO - mozscreenshot == 0.1 08:02:41 INFO - mozsystemmonitor == 0.3 08:02:41 INFO - moztest == 0.7 08:02:41 INFO - mozversion == 1.4 08:02:41 INFO - psutil == 3.1.1 08:02:41 INFO - requests == 1.2.3 08:02:41 INFO - wsgiref == 0.1.2 08:02:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:02: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')]} 08:02:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02: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')]} 08:02:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1a159c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2493ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2490f60>, '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 0x2491d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24921d0>, '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': 'd2a8c569965ab8367867b893000001a1-1482248368.537627-247160603', '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 08:02:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:02:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:02:41 INFO - Using env: {'DISPLAY': ':0', 08:02:41 INFO - 'HOME': '/home/cltbld', 08:02:41 INFO - 'LANG': 'en_US.UTF-8', 08:02:41 INFO - 'LANGUAGE': 'en_US:en', 08:02:41 INFO - 'LOGNAME': 'cltbld', 08:02:41 INFO - 'MAIL': '/var/mail/cltbld', 08:02:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:41 INFO - 'MOZ_NO_REMOTE': '1', 08:02:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:41 INFO - 'NO_EM_RESTART': '1', 08:02:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:41 INFO - 'PWD': '/builds/slave/test', 08:02:41 INFO - 'SHELL': '/bin/bash', 08:02:41 INFO - 'SHLVL': '1', 08:02:41 INFO - 'TERM': 'linux', 08:02:41 INFO - 'TMOUT': '86400', 08:02:41 INFO - 'USER': 'cltbld', 08:02:41 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1482248368.537627-247160603', 08:02:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:41 INFO - '_': '/tools/buildbot/bin/python'} 08:02:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:02:41 INFO - Cleaning up... 08:02:41 INFO - Return code: 0 08:02:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:02: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')]} 08:02:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02: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')]} 08:02:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1a159c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2493ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2490f60>, '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 0x2491d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24921d0>, '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': 'd2a8c569965ab8367867b893000001a1-1482248368.537627-247160603', '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 08:02:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:02:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:02:41 INFO - Using env: {'DISPLAY': ':0', 08:02:41 INFO - 'HOME': '/home/cltbld', 08:02:41 INFO - 'LANG': 'en_US.UTF-8', 08:02:41 INFO - 'LANGUAGE': 'en_US:en', 08:02:41 INFO - 'LOGNAME': 'cltbld', 08:02:41 INFO - 'MAIL': '/var/mail/cltbld', 08:02:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:41 INFO - 'MOZ_NO_REMOTE': '1', 08:02:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:41 INFO - 'NO_EM_RESTART': '1', 08:02:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:41 INFO - 'PWD': '/builds/slave/test', 08:02:41 INFO - 'SHELL': '/bin/bash', 08:02:41 INFO - 'SHLVL': '1', 08:02:41 INFO - 'TERM': 'linux', 08:02:41 INFO - 'TMOUT': '86400', 08:02:41 INFO - 'USER': 'cltbld', 08:02:41 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1482248368.537627-247160603', 08:02:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:41 INFO - '_': '/tools/buildbot/bin/python'} 08:02:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:02:41 INFO - Cleaning up... 08:02:41 INFO - Return code: 0 08:02:41 INFO - Running post-action listener: _resource_record_post_action 08:02:41 INFO - Running post-action listener: _start_resource_monitoring 08:02:41 INFO - Starting resource monitoring. 08:02:41 INFO - [mozharness: 2016-12-20 16:02:41.638454Z] Finished create-virtualenv step (success) 08:02:41 INFO - [mozharness: 2016-12-20 16:02:41.638908Z] Running install step. 08:02:41 INFO - Running pre-action listener: _resource_record_pre_action 08:02:41 INFO - Running main action method: install 08:02:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:02:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:02:41 INFO - Reading from file tmpfile_stdout 08:02:41 INFO - Detecting whether we're running mozinstall >=1.0... 08:02:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:02:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:02:41 INFO - Reading from file tmpfile_stdout 08:02:41 INFO - Output received: 08:02:41 INFO - Usage: mozinstall [options] installer 08:02:41 INFO - Options: 08:02:41 INFO - -h, --help show this help message and exit 08:02:41 INFO - -d DEST, --destination=DEST 08:02:41 INFO - Directory to install application into. [default: 08:02:41 INFO - "/builds/slave/test"] 08:02:41 INFO - --app=APP Application being installed. [default: firefox] 08:02:41 INFO - mkdir: /builds/slave/test/build/application 08:02:41 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'] 08:02:41 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 08:02:57 INFO - Reading from file tmpfile_stdout 08:02:57 INFO - Output received: 08:02:57 INFO - /builds/slave/test/build/application/firefox/firefox 08:02:57 INFO - Running post-action listener: _resource_record_post_action 08:02:57 INFO - [mozharness: 2016-12-20 16:02:57.856148Z] Finished install step (success) 08:02:57 INFO - [mozharness: 2016-12-20 16:02:57.856390Z] Running run-tests step. 08:02:57 INFO - Running pre-action listener: _resource_record_pre_action 08:02:57 INFO - Running main action method: run_tests 08:02:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:02:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:02:57 INFO - Python 2.7.3 08:02:57 INFO - Return code: 0 08:02:57 INFO - grabbing minidump binary from tooltool 08:02: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')]} 08:02:57 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 0x2490f60>, '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 0x2491d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24921d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:02:57 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 08:02:57 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 08:02:57 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 08:02:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:02:57 INFO - Return code: 0 08:02:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:02:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:02:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:02:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:02:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:02:57 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/PoVaUphYROW70-7JKtzgYw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 08:02:57 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/PoVaUphYROW70-7JKtzgYw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --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 08:02:57 INFO - Using env: {'DISPLAY': ':0', 08:02:57 INFO - 'HOME': '/home/cltbld', 08:02:57 INFO - 'LANG': 'en_US.UTF-8', 08:02:57 INFO - 'LANGUAGE': 'en_US:en', 08:02:57 INFO - 'LOGNAME': 'cltbld', 08:02:57 INFO - 'MAIL': '/var/mail/cltbld', 08:02:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:02:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:02:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:57 INFO - 'MOZ_NO_REMOTE': '1', 08:02:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:02:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:57 INFO - 'NO_EM_RESTART': '1', 08:02:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:57 INFO - 'PWD': '/builds/slave/test', 08:02:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:02:57 INFO - 'SHELL': '/bin/bash', 08:02:57 INFO - 'SHLVL': '1', 08:02:57 INFO - 'TERM': 'linux', 08:02:57 INFO - 'TMOUT': '86400', 08:02:57 INFO - 'USER': 'cltbld', 08:02:57 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1482248368.537627-247160603', 08:02:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:57 INFO - '_': '/tools/buildbot/bin/python'} 08:02:57 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/PoVaUphYROW70-7JKtzgYw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 08:02:58 INFO - mozversion application_buildid: 20161220062553 08:02:58 INFO - mozversion application_changeset: a16a286021714abebbf2cd629ae27cbaa0812887 08:02:58 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:02:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:02:58 INFO - mozversion application_name: Firefox 08:02:58 INFO - mozversion application_remotingname: firefox-dev 08:02:58 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:02:58 INFO - mozversion application_vendor: Mozilla 08:02:58 INFO - mozversion application_version: 52.0a2 08:02:58 INFO - mozversion platform_buildid: 20161220062553 08:02:58 INFO - mozversion platform_changeset: a16a286021714abebbf2cd629ae27cbaa0812887 08:02:58 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:02:58 INFO - mozversion platform_version: 52.0a2 08:02:58 INFO - using testdate: 1482249778 08:02:58 INFO - actual date: 1482249778 08:02:58 INFO - starting webserver on 'localhost:58942' 08:02:58 INFO - SUITE-START | Running 2 tests 08:02:58 INFO - TEST-START | dromaeo_css 08:02:58 INFO - operating with platform_type : linux_ 08:02:58 INFO - Initialising browser for dromaeo_css test... 08:02:58 INFO - TEST-INFO | started process 6977 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphc6yuB/profile http://localhost:58942/getInfo.html) 08:03:02 INFO - PROCESS | 6977 | __metrics Screen width/height:1600/1200 08:03:02 INFO - PROCESS | 6977 | colorDepth:24 08:03:02 INFO - PROCESS | 6977 | Browser inner width/height: 1024/697 08:03:02 INFO - PROCESS | 6977 | __metrics 08:03:02 INFO - PROCESS | 6977 | 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" 08:03:02 INFO - PROCESS | 6977 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:03:03 INFO - PROCESS | 6977 | console.error: PushService: 08:03:03 INFO - PROCESS | 6977 | stateChangeProcessEnqueue: Error transitioning state 08:03:03 INFO - PROCESS | 6977 | UnknownError 08:03:03 INFO - TEST-INFO | 6977: exit 0 08:03:03 INFO - Browser initialized. 08:03:03 INFO - Running cycle 1/1 for dromaeo_css test... 08:03:03 INFO - TEST-INFO | started process 7068 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphc6yuB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:03:15 INFO - PROCESS | 7068 | RSS: Main: 144969728 08:03:15 INFO - PROCESS | 7068 | 08:04:07 INFO - PROCESS | 7068 | 1482249847012 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] 08:06:17 INFO - PROCESS | 7068 | Cycle 1(1): loaded http://localhost:58942/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58942/tests/dromaeo/cssquery-ext.html) 08:06:18 INFO - PROCESS | 7068 | RSS: Main: 247148544 08:06:18 INFO - PROCESS | 7068 | 08:09:21 INFO - PROCESS | 7068 | Cycle 1(1): loaded http://localhost:58942/tests/dromaeo/cssquery-ext.html (next: http://localhost:58942/tests/dromaeo/cssquery-jquery.html) 08:09:21 INFO - PROCESS | 7068 | RSS: Main: 233492480 08:09:21 INFO - PROCESS | 7068 | 08:12:23 INFO - PROCESS | 7068 | Cycle 1(1): loaded http://localhost:58942/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58942/tests/dromaeo/cssquery-mootools.html) 08:12:24 INFO - PROCESS | 7068 | RSS: Main: 180027392 08:12:24 INFO - PROCESS | 7068 | 08:15:26 INFO - PROCESS | 7068 | Cycle 1(1): loaded http://localhost:58942/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58942/tests/dromaeo/cssquery-prototype.html) 08:15:26 INFO - PROCESS | 7068 | RSS: Main: 175218688 08:15:26 INFO - PROCESS | 7068 | 08:18:29 INFO - PROCESS | 7068 | Cycle 1(1): loaded http://localhost:58942/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58942/tests/dromaeo/cssquery-yui.html) 08:18:30 INFO - PROCESS | 7068 | RSS: Main: 175800320 08:18:30 INFO - PROCESS | 7068 | 08:21:32 INFO - PROCESS | 7068 | Cycle 1(1): loaded http://localhost:58942/tests/dromaeo/cssquery-yui.html (next: http://localhost:58942/tests/dromaeo/cssquery-dojo.html) 08:21:32 INFO - PROCESS | 7068 | RSS: Main: 253997056 08:21:32 INFO - PROCESS | 7068 | 08:21:32 INFO - PROCESS | 7068 | __start_tp_report 08:21:32 INFO - PROCESS | 7068 | _x_x_mozilla_page_load 08:21:32 INFO - PROCESS | 7068 | _x_x_mozilla_page_load_details 08:21:32 INFO - PROCESS | 7068 | |i|pagename|runs| 08:21:32 INFO - PROCESS | 7068 | |0;dojo.html;3172.270377813103;3209.037288813355;3209.0854106579623;3237.8219197944104;3239.335936133093;5498.120300751881;5518.530924871381;5547.33431988161;5564.972175139119;5568.220449137119;5625.5218306444;5671.376148623648;5677.716114194294;5684.175794509804;5685.715714214293;5125.513076257749;5139.152039913429;5174.948250517503;5206.0368831766245;5242.344706911636;4973.801047958077;4990.625703072266;5050.646454748169;5172.896542069157;5230.163173892178;5102.846914592568;5163.793448262065;5166.974165129188;5190.195519694454;5204.29741984831;5181.222816577525;5191.117510023268;5197.87005324868;5198.2722418861385;5215.791368345262;4912.287718280829;4953.653244272902;5012.624053196025;5067.847964561069;5083.05963396769;5384.488473595042;5393.622446428752;5459.481349271852;5494.5054945054735;5511.917321240185;5821.097729851837;5825.388334224887;5862.179294898675;5905.852353691149;5907.556933229982;5890.911636325459;5941.851453713649;5955.927932972063;5973.910391344133;5980.8504787380225;5560.527355174815;5599;5659.40576239493;5663.575231857545;5688.11834165705;6189.319174890758;6202.255729312511;6204.410580994799;6210.782622608187;6214.067889816563;5709.914351284734;5958.702064896738;5964.075568286922;5974.253218347707;5978.461938425476;5818.418158184232;5916.55625828056;5960;5979.312379076375;6046.304674962347;5907.23205983228;5953.732082056318;5968.552358573038;5980.850478738066;6019.518438524908;5989.221401217814;6006.969965150146;6007.579469437185;6008.789692360747;6012.969935150296;4453.888652783707;4472.619827314715;4559.110973360229;4560.156371071296;4590.8163673453355;4037.555868854424;4066.552679205285;4070.369092790563;4089.754614723126;4096.836126554964;5719.542436605062;5757.942420575824;5758.165066065397;5758.568107391962;5786.797462088806;5848.941510584925;5907.054871220584;5909.113632955005;5939.10913362999;6073.939260607337;5648.209250704905;5653.378128405872;5665.433456654384;5667.093265077568;5686.317641883001;5164.04465173944;5196.064708352457;5209.374875015023;5210.348706411699;5238.292830467838;6095.664738439428;6156;6171.6297022178815;6218.098375735493;6227;5958.0169272069625;6063.181470501602;6063.696815159136;6084.421979911901;6090.665013424127;6304.464120549805;6319.9052014218905;6323.810285691437;6324.462420694109;6327.430531252209;5807.535397168132;5813.593048486735;5959.374265702038;5964.284285885721;5964.582479226413;6009.278886533644;6011.308699499438;6029.939700603113;6125.23545181825;6148.077788331607;5895.41045895407;5954;5965.015772397506;5974.790882319098;5990.161377407254;5674.914876276942;5924.31870334917;5928.3775203603;5929.822105336847;5934.554908381802;5736.254286942671;5737.799177028784;5799.623024503394;5813.82558523245;5901.291844978458;5943.108533719977;5943.851403714942;5953.970230148821;5954.493868021266;5957.821265362046;5605.159226116115;5662.2639056922335;5665.745041473226;5804.738786754522;5811.128330750421 08:21:32 INFO - PROCESS | 7068 | |1;ext.html;585.9736311865965;618.8947878860594;649.7368565730877;650.3204151661515;670.105409278613;35160.472592911094;46272.76863615681;47649.761751191196;47691.284630730566;47724.52275477244;45457.31814022792;46009;46118.53881461184;46121.308180377324;46341.7682911585;8229.382796290272;8461.746147615582;8760.386772925882;8892.555372231394;8901.599428025722;10453.11148552374;10730.302530335543;10732;11037.061849742782;11042.834357484644;10956.506957186946;11032.724181895477;11043.72390690231;11044.33733975964;11051.447427628586;10805.891941080607;10853.565857365697;10854.837177442345;10868.347899125998;10872.130229581693;10790.244682872202;10840;10853.131749460103;10854.34873907568;10864.565417383295;45311.546884531395;45549.772251138864;45630.31554526685;45680.3147952781;45684;3752.099496120911;3820.44603532489;3855.151866589374;3873.9612603873884;3925.568187499373;33298.66701333004;34085;34475.65524344775;35263.82368088169;35347.4697879532;4462.977685111554;4573.565511276423;4609.331646911179;4657.6273898088075;4768.642351823592;263051;263571.41071473365;263727;263970;264065;65160;65606;65635;65687.34312656907;65751.67124164444;69623.3037669627;69645.30354696489;70010.2998970014;70239;70447.64776176086;18159.092045397676;18430.815691843178;18440.90779546094;18451.723224151647;18453.077346132908;12756.298403587705;12985.545505907437;13145.21128732279;13335.399907004208;14057.648558786112;19741.703874441893;20051.398458046282;20153;20155.59688806245;20196.495087622632;6986.650667466606;7000.509964302551;7060.823479413056;7129.538007130508;7407.85184296311;1007.1539906478594;1035.5754140802235;1061.8054688475465;1075.3977772447454;1121.2095472691733;33994.32011359759;34635.30729385449;34820.477692834625;34821.9553413398;34840.79741120992;1125.7692173104494;1138.1691365303209;1164.6622479481025;1188.8454500915;1221.5020283520223;16654.16729163537;17818.732719009226;17879.910600446914;17912.373066942593;17920;537306;539559;539710;540904;541675;63375.68312158502;63927.68036159789;64045.35954640487;64199.35800641934;64248.357516425174;1441.502681574855;1442.5239670908575;1443.5452832357773;1467.8385377608454;1469.7427950108688;30932;32998;33041.33917321592;33045.83477082695;33419.66580334263;55045;55321;55428.16857747218;55450.72274638601;55477.722611386685;424262;426588;426661;426691;427625;27807.860960695067;28746.425071498034;29813.552796707634;31397.8430107848;31748.36503269968;50646;51024.234636481226;52124;52296.21555676592;55655;42820.35769463398;43170;43436.56563434325;43701.47044853415;45312.32031519596;42623;43569.78215108904;43955.34066989062;44437.11125777401;45187.32219016783;44375;44828.103437930404;45537.31694024659;45625.77187114043;45724.54275457203;36220.4566931491;38831.308077198046;39247;39411.60588394194;40129.598704013755;29472.55791163177;30042.24894377658;30151.849240753654;30215.546766798954;30272 08:21:32 INFO - PROCESS | 7068 | |2;jquery.html;427.8533530139226;435.6688916423519;438.2090326959837;445.03871637263506;451.36808468144613;18556.443306700803;20193;20239.696404553924;20324.288649897255;20659.896700516478;19801.702974455395;19885.701714474293;20102.49743756403;20405.48986275344;20552.28067017651;5682.289713785777;5882.176495290662;5941.435563621449;5948.821535353946;5954.4938680212235;5606.35526914406;5736.110902810071;5806.883862322751;5812.099124635667;5821.621594596359;5790.913136302959;5793.159991801186;5795.971020144914;5797.478226959573;5799.304083509964;5662.065759149756;5728.341240757304;5782.219400380936;5799.3910639382675;5804.071348584206;5207.843764687028;5248.21276808478;5273.604479664003;5279.577633789288;5280.894382112337;23784.643230351558;23805;23862.7613723864;23990.76009239903;24207.87896060526;2553.859537725424;2586.456844062749;2596.4677241165514;2690.9370798534665;2740.369714965569;14444.855551444456;14481.56555303332;14724.411023559045;14792.778108328384;15146.318415671321;1909.3889955214338;2009.4574464894397;2014.1238561225914;2022.9089690963942;2054.95890082199;90010.41983457853;94634.52682736542;95086;95522;96626;11437.256578322382;11606.767864642828;11617.76764464706;11629.80180450383;11795.88204117965;16625.168741562873;16627.168641567874;16645.41741039058;16653.91673041627;16661.333546658;8493.957530212308;8558.315334773204;8593.183647553473;8813.647454101892;8833.514156721441;8362.540060296742;8387.490251754622;8527.829443411098;8559.828803423896;8579.699710510227;4818.277258411196;4977.253411988158;4986.077575648516;4990.2764099205415;5095.770690318945;1999.4601457606366;2049.559344740888;2056.5475595368994;2073.481629592602;2174.336827267667;995.8945570416831;1000.0599436529784;1003.8092762375271;1006.1598565198142;1037.1391744851755;19023.714644280346;20565.89717051405;20729.79270207309;20765.480862978246;20848.895755521124;997.9251556133319;1036.4403222260046;1050.6585359757955;1097.3470784882982;1102.6030628973563;10722.195835312383;11471.770564588662;11595.652130436101;11685.88314116865;11732.530698772125;501629;506954;508604;510617;514135;88433;99088;102016;102805.48597256966;103718;990.069334825262;1023.6877752285625;1037.4657051618422;1045.4929359260752;1051.731808388856;17831.10844457746;18168.818311816714;18652.44042678722;18695.813041869405;18739.812601873808;40588.39117413182;43619.78190109156;43862;44977.77511112423;44994.32508512309;51948;63192;63431.36568634255;64756.676216618616;64881.67559162174;8921.732348029569;9036.909630903607;9139.314551408805;9177.21993630549;9421.434713917188;10337.586496540054;13708.52020179289;14244.71510569762;14343;14726.852731472549;12381.814272785736;12501.494798102472;12596.496140154657;12670;12734.554290600156;11740.471678774305;12032.578859740217;12270.202436841577;12644.620661380173;12754.936225318814;12374.13381063317;12573.874261257637;12649.810252846031;12662.810057848956;13011.869881301065;8847.867281990904;9037.638494460149;9073.364864459425;9075.863862041942;9531.666391676257;10561.683149505527;12148.271103733805;12178.45196966121;12195.146339756131;12223.205491643015 08:21:32 INFO - PROCESS | 7068 | |3;mootools.html;1347.3802051056514;1484.9406023759047;1488.9702205955882;1657.7430498272765;1808.339955916091;7852.489588176764;8316.916830831697;8455.788605284872;8666.52334121623;8688.826223475528;8869.334799890003;8921.866172007409;8933.553322333873;8935.776605584864;8946.507942063201;2445.7065152181763;2472.666190064336;2477.1949116537107;2480.553500369933;2480.5659009673236;2368.0764501844296;2418.625113107471;2426.502566973766;2426.963595546068;2427.635854621812;2361.1853910400882;2374.643803429482;2389.51015041916;2391.1272385579227;2392.5883728600124;2348.8120950323932;2379.2862141357696;2406.879656017201;2411.0476361837063;2422.2733180045916;2299.471121642015;2309.6766452696634;2333.5332933413215;2333.9147296507035;2334.1130370459286;8863;8926.285897128215;8963.910360896438;8992.325575581857;9000.054994225577;5441.2654291670515;5560.972195139039;5578.135389014709;5644.717764111778;5664.40523745005;3458.2737625098757;3466.7399945004227;3567.625399333059;3580.874669386559;3618.4572314152824;1204.819277108432;1208.456194712383;1224.9877501224962;1231.2550906701497;1254.5420921363727;11276.436178191057;11299.830502542469;11332.6033588824;11371.260868043468;11386.487608057574;4320.330348795942;4479.283314669638;4564.543545645475;4578.427696537933;4643.071385722801;9805.950970245103;9827.361221520578;9828.606855725833;9833;9842.606295748234;5438.265834112423;5440.91838622421;5444.210589464506;5444.945550544444;5448.37343705471;4399.36209249657;4521.3896124023495;4673.205555055649;5099.209622508517;5170;3803.410471376941;3844.4041173618134;3932.5870783567884;3958.089639382958;3967.0677390813134;1159.1190695071807;1163.1973937982934;1165.685264978451;1172.1560476456937;1178.1811640909486;893.5398269891011;941.4821847983718;941.990580094204;949.3022628368144;955.961761529531;5613.129964855454;5689.800856970069;5713.518646494608;5917.408259174134;6017.759289628453;424.8831571317912;426.3604593110334;428.5500224763985;428.70633615973156;429.7472866593906;3980.900477488086;4011.859584914514;4025.2352053109817;4040.393940908887;4071.816768245436;10487.580496780196;10694.304870183412;10734.194935379877;11086.279391839666;11168.66494005181;10979.121670266359;11032.558697652164;11057.72355691098;11064.723381915517;11066.114710823114;7817;8094.473859199134;8126.55303958288;8132.7560173193715;8139.83720325602;5705.201271821865;5769.711514424346;5770.8845823082465;5799.913001305068;5897.67562784051;9715.611375545182;10011.749706257402;10031.197504199501;10142.594296228068;10147.898521014695;9164.541772911194;9425.858612120961;10188.949055254676;10242.897571024492;10267.383956962607;7064.364207221375;7879.606019699107;7923.405744569065;8060.355171586376;8151.062627797642;8761.211490965843;8769.166929141722;8826.161514656098;8829.955850220707;8854.07032261629;7700.576468294297;7704.422168337509;7759.883601746092;7782.1828707987115;7832.412569057229;7467.514611550232;7625.885611715939;7649.923500764921;7758.728444504415;7849.215078492333;7080.362767350963;7168.498205125799;7173.318534739192;7178.066851309296;7189.352958233575;4994.1509943309;5008.148614735431;5066.9746651266505;5086.287919691172;5243.606729495379;5100.7449627517735;5118.590512758896;5136.075506408883;5217.921731174111;5312.760925758427 08:21:32 INFO - PROCESS | 7068 | |4;prototype.html;347.16333635937383;349.4775310910189;352.832125664052;356.20388431854786;359.0735901374454;5414.810481633143;5424.403315635282;5428.185772134177;5436.91844622331;5459.262999495067;5323.1749078892735;5338.692020454984;5351.759170837312;5394.136938089907;5401.4328495508;4025.8188381522755;4194.370844373338;4215.641670458015;4244.1511697660435;4304.741715497073;4205.600467955539;4206.390073439349;4223.746575205498;4229.111886503838;4248.34150706641;3990.580988996157;4203.453551038361;4205.675212308113;4206.432131662233;4234.513031001428;4057.797110144496;4099.364598487239;4140.834366625331;4167.52073511547;4170.645495132917;3689.6494832990825;3695.0947017980766;3699.463577781207;3699.8890033299044;3706.42550404685;5016.824411145592;5108.897822043538;5179.249008893727;5194.246834209019;5202.673318303846;4496.2581174106235;4761.880952976168;4769.189237829577;4780.976095119502;4808.567228949376;5559.8888022239325;5561.666300021971;5566.777328906839;5568.610197286192;5572.4148964358565;4015.9397609035886;4071.025552606983;4071.226466971266;4096.344584866437;4097.959020409818;5680.829575112753;5710.885782284331;5723.828285151452;5778.075507918713;5796.014677504792;4128.731632443882;4158.397032430341;4190.161967606491;4193.182329445729;4197.958020419818;4097.713160078766;4236.385724069993;4254.191703576311;4262.914741705148;4279.807408666617;4745.288206768943;4748.145333839942;4753.338130646849;4777.665563410528;4802.447718512416;5611.523020543218;5614.494695477427;5638.43615638441;5655.802046928337;5664.320281566238;1374.3403166480146;1413.3569226002144;1426.8145141131795;1427.9143251404948;1438.6259572511221;970.7767213540925;979.9951000245096;984.8030393921101;993.9850902236473;1002.904724051214;5055.368078990126;5251.501107394792;5251.632385733038;5256.082874004887;5259.58059292722;5535.363433205152;5539.307586551681;5546.142042415755;5546.861328466821;5547.306586676666;5189.481051894781;5207.739613019334;5218.869528261748;5250.317458730341;5384.596155288369;2888.9277768055967;2933.266683329168;2943.2200466876293;2944.263934016496;2945.7937944344117;5743.851229753982;5744.425557444222;5766.365699773021;5767.192593036978;5780.335261444903;5494;5590.524805391506;5632.113242063872;5634.943650563524;5652.349979752381;5628.409017053233;5628.915566266591;5657.688827114548;5681.733003522991;5701.971490142606;5379.811706590251;5526.585506086979;5532;5555.166724991122;5564.638298510584;5474.616776825744;5493.242162507959;5505.944940550704;5509.173623956439;5515;5710.200571920018;5720.141978703228;5721.914171287351;5743;5772.624779389326;3877.8836634901;4004.2391945530258;4029.9395509066803;4060.167665628598;4071.3689378146437;5530.944690553043;5545.916811247754;5569.637973531708;5592.105263157875;5603.3836278008575;5420.403755586961;5421.241026256248;5422.186671999231;5446.455354464521;5454.5818087298385;5255.868603284948;5370.516653501204;5395.865103372447;5418.620696551204;5424.656713137635;5361.865953351197;5369.758360873848;5398.623351045615;5411.458854114557;5418.431064738304;5379.515843574097;5488.17677348401;5503.587230957774;5512.3660779010925;5532.695701736282;5556.611037227517;5573.498385145356;5604.094607833356;5607.5513958884;5607.971960140337 08:21:32 INFO - PROCESS | 7068 | |5;yui.html;788.1330536409946;798.0264077825051;826.818100017996;831.4803247970019;851.3572252949023;15025.774613380809;15569.221538923051;15781.526554203392;16027.198640068009;16074.678506429878;14779.261036948163;15018.849811501881;15027.173505457224;15275.312610932508;15729.764053539206;842.9072801991776;862.0603542139067;863.753830158405;864.5158711121792;865.0657290126679;729.4930023633577;751.515272649141;817.9427440079197;840.1892174052039;846.0904527632789;907.2288554728494;913.2283220678516;914.3416739947228;914.5198770645397;915.249495413761;901.378049146087;904.2494729374636;905.714699869539;906.5648488725416;907.1699395053486;561.6994907724388;577.4081566394437;641.3938827807724;653.5000724445803;663.6582160187507;15216.923915380352;15300.617484562863;15309.923450382788;15311.923440382838;15342.463013794575;12649.43077561512;12808.551700690525;13110.213387196798;13705.657358566115;13817.447302107903;11787.410629468579;11923.344216068113;11979.640610781691;11997.34014629195;12194.451249693786;4484.148011877765;4514.277715565527;4555.362249285103;4566.246569316058;4578.702384345041;55213.44786552123;55705;56798;64560.67719661419;66355;11316;11584.884151158549;11599.304041757521;11782.646520604225;11813.173077884638;20851.478713031993;20864.895675521828;20907.58184836325;21036.684449733268;21187.894060529597;8247.752567422987;8254.504729716236;8642.956785216034;8941.955290223506;9028.36801423894;4718.834840780556;4724.622030237572;4785.833931562544;4829.830955916526;4839.782209800567;3556.715462762973;3672.3756961316108;3676.558812942464;3680.3743363628246;3680.7975561344383;591.3849596419761;598.9610675306092;607.2106261859565;612.3203244398713;613.6931534232883;671.5668393886014;673.1249375811426;710.7618947652594;718.6011763471323;722.757876111498;8465.238128568459;8831.116888311117;8875.955620221857;8926.107389261151;9087.318451116193;596.9492593129546;653.7189008726293;683.3166833166833;685.7051467868864;687.4466054825913;4207.852725154605;4251.87244382669;4382.627476664519;4408.206522825923;4441.089576636782;83323.5833820827;92319.5384023089;94300;95358.52320738352;98905.01094988958;77055;77399;82043.58978205071;82112.17887821165;84474;73856.26143738494;75281.24718752742;75360.24639753642;75516;76479.23520764832;7896.68413263486;8144.429889907649;8468.872966905625;8545.61544730501;8616.956915215384;48335.75832120958;48718.75640621774;48749.512504875915;49780.502194977584;50129.248061278384;63267.367326326144;65858.34141658522;66797;68318;69201.65399173173;10693.358398496115;10707.518161682587;10779;10861.891381086089;11352.318860868374;11388.974992250738;11532.654020379403;11557.47991340375;11676.241044332091;11806.409679515818;10266.743331416774;10364.119049880845;10652.201084918506;10662.360258384522;11073.667789966314;11857.5849845255;12599.685007874876;12649.367531623198;12675.239485630891;12833.230006199658;11575.942120289345;11614.593489227836;11817.586384476503;11885.5840045598;11973.742757010737;10664.84002739944;10838.783224335626;10875.02124808771;10891.564337426731;11413;8549.572521374032;9078.228350590274;10411.583536658753;10544.103751180928;10657.626983055556 08:21:32 INFO - PROCESS | 7068 | __end_tp_report 08:21:32 INFO - PROCESS | 7068 | __start_cc_report 08:21:32 INFO - PROCESS | 7068 | _x_x_mozilla_cycle_collect,1100 08:21:32 INFO - PROCESS | 7068 | __end_cc_report 08:21:32 INFO - PROCESS | 7068 | __startTimestamp1482250892894__endTimestamp 08:21:32 INFO - PROCESS | 7068 | 08:21:32 INFO - PROCESS | 7068 | ------- Summary: start ------- 08:21:32 INFO - PROCESS | 7068 | Number of tests: 6 08:21:32 INFO - PROCESS | 7068 | 08:21:32 INFO - PROCESS | 7068 | [#0] dojo.html Cycles:165 Average:5574.18 Median:5799.62 stddev:642.49 (11.1%) stddev-sans-first:616.21 08:21:32 INFO - PROCESS | 7068 | Values: 3172.3 3209.0 3209.1 3237.8 3239.3 5498.1 5518.5 5547.3 5565.0 5568.2 5625.5 5671.4 5677.7 5684.2 5685.7 5125.5 5139.2 5174.9 5206.0 5242.3 4973.8 4990.6 5050.6 5172.9 5230.2 5102.8 5163.8 5167.0 5190.2 5204.3 5181.2 5191.1 5197.9 5198.3 5215.8 4912.3 4953.7 5012.6 5067.8 5083.1 5384.5 5393.6 5459.5 5494.5 5511.9 5821.1 5825.4 5862.2 5905.9 5907.6 5890.9 5941.9 5955.9 5973.9 5980.9 5560.5 5599.0 5659.4 5663.6 5688.1 6189.3 6202.3 6204.4 6210.8 6214.1 5709.9 5958.7 5964.1 5974.3 5978.5 5818.4 5916.6 5960.0 5979.3 6046.3 5907.2 5953.7 5968.6 5980.9 6019.5 5989.2 6007.0 6007.6 6008.8 6013.0 4453.9 4472.6 4559.1 4560.2 4590.8 4037.6 4066.6 4070.4 4089.8 4096.8 5719.5 5757.9 5758.2 5758.6 5786.8 5848.9 5907.1 5909.1 5939.1 6073.9 5648.2 5653.4 5665.4 5667.1 5686.3 5164.0 5196.1 5209.4 5210.3 5238.3 6095.7 6156.0 6171.6 6218.1 6227.0 5958.0 6063.2 6063.7 6084.4 6090.7 6304.5 6319.9 6323.8 6324.5 6327.4 5807.5 5813.6 5959.4 5964.3 5964.6 6009.3 6011.3 6029.9 6125.2 6148.1 5895.4 5954.0 5965.0 5974.8 5990.2 5674.9 5924.3 5928.4 5929.8 5934.6 5736.3 5737.8 5799.6 5813.8 5901.3 5943.1 5943.9 5954.0 5954.5 5957.8 5605.2 5662.3 5665.7 5804.7 5811.1 08:21:32 INFO - PROCESS | 7068 | 08:21:32 INFO - PROCESS | 7068 | [#1] ext.html Cycles:180 Average:59675.90 Median:21352.63 stddev:112659.12 (527.6%) stddev-sans-first:112887.80 08:21:32 INFO - PROCESS | 7068 | Values: 586.0 618.9 649.7 650.3 670.1 35160.5 46272.8 47649.8 47691.3 47724.5 45457.3 46009.0 46118.5 46121.3 46341.8 8229.4 8461.7 8760.4 8892.6 8901.6 10453.1 10730.3 10732.0 11037.1 11042.8 10956.5 11032.7 11043.7 11044.3 11051.4 10805.9 10853.6 10854.8 10868.3 10872.1 10790.2 10840.0 10853.1 10854.3 10864.6 45311.5 45549.8 45630.3 45680.3 45684.0 3752.1 3820.4 3855.2 3874.0 3925.6 33298.7 34085.0 34475.7 35263.8 35347.5 4463.0 4573.6 4609.3 4657.6 4768.6 263051.0 263571.4 263727.0 263970.0 264065.0 65160.0 65606.0 65635.0 65687.3 65751.7 69623.3 69645.3 70010.3 70239.0 70447.6 18159.1 18430.8 18440.9 18451.7 18453.1 12756.3 12985.5 13145.2 13335.4 14057.6 19741.7 20051.4 20153.0 20155.6 20196.5 6986.7 7000.5 7060.8 7129.5 7407.9 1007.2 1035.6 1061.8 1075.4 1121.2 33994.3 34635.3 34820.5 34822.0 34840.8 1125.8 1138.2 1164.7 1188.8 1221.5 16654.2 17818.7 17879.9 17912.4 17920.0 537306.0 539559.0 539710.0 540904.0 541675.0 63375.7 63927.7 64045.4 64199.4 64248.4 1441.5 1442.5 1443.5 1467.8 1469.7 30932.0 32998.0 33041.3 33045.8 33419.7 55045.0 55321.0 55428.2 55450.7 55477.7 424262.0 426588.0 426661.0 426691.0 427625.0 27807.9 28746.4 29813.6 31397.8 31748.4 50646.0 51024.2 52124.0 52296.2 55655.0 42820.4 43170.0 43436.6 43701.5 45312.3 42623.0 43569.8 43955.3 44437.1 45187.3 44375.0 44828.1 45537.3 45625.8 45724.5 36220.5 38831.3 39247.0 39411.6 40129.6 29472.6 30042.2 30151.8 30215.5 30272.0 08:21:32 INFO - PROCESS | 7068 | 08:21:32 INFO - PROCESS | 7068 | [#2] jquery.html Cycles:180 Average:30734.29 Median:23794.82 stddev:84097.63 (353.4%) stddev-sans-first:84302.76 08:21:32 INFO - PROCESS | 7068 | Values: 427.9 435.7 438.2 445.0 451.4 18556.4 20193.0 20239.7 20324.3 20659.9 19801.7 19885.7 20102.5 20405.5 20552.3 5682.3 5882.2 5941.4 5948.8 5954.5 5606.4 5736.1 5806.9 5812.1 5821.6 5790.9 5793.2 5796.0 5797.5 5799.3 5662.1 5728.3 5782.2 5799.4 5804.1 5207.8 5248.2 5273.6 5279.6 5280.9 23784.6 23805.0 23862.8 23990.8 24207.9 2553.9 2586.5 2596.5 2690.9 2740.4 14444.9 14481.6 14724.4 14792.8 15146.3 1909.4 2009.5 2014.1 2022.9 2055.0 90010.4 94634.5 95086.0 95522.0 96626.0 11437.3 11606.8 11617.8 11629.8 11795.9 16625.2 16627.2 16645.4 16653.9 16661.3 8494.0 8558.3 8593.2 8813.6 8833.5 8362.5 8387.5 8527.8 8559.8 8579.7 4818.3 4977.3 4986.1 4990.3 5095.8 1999.5 2049.6 2056.5 2073.5 2174.3 995.9 1000.1 1003.8 1006.2 1037.1 19023.7 20565.9 20729.8 20765.5 20848.9 997.9 1036.4 1050.7 1097.3 1102.6 10722.2 11471.8 11595.7 11685.9 11732.5 501629.0 506954.0 508604.0 510617.0 514135.0 88433.0 99088.0 102016.0 102805.5 103718.0 990.1 1023.7 1037.5 1045.5 1051.7 17831.1 18168.8 18652.4 18695.8 18739.8 40588.4 43619.8 43862.0 44977.8 44994.3 51948.0 63192.0 63431.4 64756.7 64881.7 8921.7 9036.9 9139.3 9177.2 9421.4 10337.6 13708.5 14244.7 14343.0 14726.9 12381.8 12501.5 12596.5 12670.0 12734.6 11740.5 12032.6 12270.2 12644.6 12754.9 12374.1 12573.9 12649.8 12662.8 13011.9 8847.9 9037.6 9073.4 9075.9 9531.7 10561.7 12148.3 12178.5 12195.1 12223.2 08:21:32 INFO - PROCESS | 7068 | 08:21:32 INFO - PROCESS | 7068 | [#3] mootools.html Cycles:180 Average:5759.69 Median:5001.15 stddev:3235.81 (64.7%) stddev-sans-first:3227.90 08:21:32 INFO - PROCESS | 7068 | Values: 1347.4 1484.9 1489.0 1657.7 1808.3 7852.5 8316.9 8455.8 8666.5 8688.8 8869.3 8921.9 8933.6 8935.8 8946.5 2445.7 2472.7 2477.2 2480.6 2480.6 2368.1 2418.6 2426.5 2427.0 2427.6 2361.2 2374.6 2389.5 2391.1 2392.6 2348.8 2379.3 2406.9 2411.0 2422.3 2299.5 2309.7 2333.5 2333.9 2334.1 8863.0 8926.3 8963.9 8992.3 9000.1 5441.3 5561.0 5578.1 5644.7 5664.4 3458.3 3466.7 3567.6 3580.9 3618.5 1204.8 1208.5 1225.0 1231.3 1254.5 11276.4 11299.8 11332.6 11371.3 11386.5 4320.3 4479.3 4564.5 4578.4 4643.1 9806.0 9827.4 9828.6 9833.0 9842.6 5438.3 5440.9 5444.2 5444.9 5448.4 4399.4 4521.4 4673.2 5099.2 5170.0 3803.4 3844.4 3932.6 3958.1 3967.1 1159.1 1163.2 1165.7 1172.2 1178.2 893.5 941.5 942.0 949.3 956.0 5613.1 5689.8 5713.5 5917.4 6017.8 424.9 426.4 428.6 428.7 429.7 3980.9 4011.9 4025.2 4040.4 4071.8 10487.6 10694.3 10734.2 11086.3 11168.7 10979.1 11032.6 11057.7 11064.7 11066.1 7817.0 8094.5 8126.6 8132.8 8139.8 5705.2 5769.7 5770.9 5799.9 5897.7 9715.6 10011.7 10031.2 10142.6 10147.9 9164.5 9425.9 10188.9 10242.9 10267.4 7064.4 7879.6 7923.4 8060.4 8151.1 8761.2 8769.2 8826.2 8830.0 8854.1 7700.6 7704.4 7759.9 7782.2 7832.4 7467.5 7625.9 7649.9 7758.7 7849.2 7080.4 7168.5 7173.3 7178.1 7189.4 4994.2 5008.1 5067.0 5086.3 5243.6 5100.7 5118.6 5136.1 5217.9 5312.8 08:21:32 INFO - PROCESS | 7068 | 08:21:32 INFO - PROCESS | 7068 | [#4] prototype.html Cycles:180 Average:4654.36 Median:5370.14 stddev:1337.96 (24.9%) stddev-sans-first:1302.07 08:21:32 INFO - PROCESS | 7068 | Values: 347.2 349.5 352.8 356.2 359.1 5414.8 5424.4 5428.2 5436.9 5459.3 5323.2 5338.7 5351.8 5394.1 5401.4 4025.8 4194.4 4215.6 4244.2 4304.7 4205.6 4206.4 4223.7 4229.1 4248.3 3990.6 4203.5 4205.7 4206.4 4234.5 4057.8 4099.4 4140.8 4167.5 4170.6 3689.6 3695.1 3699.5 3699.9 3706.4 5016.8 5108.9 5179.2 5194.2 5202.7 4496.3 4761.9 4769.2 4781.0 4808.6 5559.9 5561.7 5566.8 5568.6 5572.4 4015.9 4071.0 4071.2 4096.3 4098.0 5680.8 5710.9 5723.8 5778.1 5796.0 4128.7 4158.4 4190.2 4193.2 4198.0 4097.7 4236.4 4254.2 4262.9 4279.8 4745.3 4748.1 4753.3 4777.7 4802.4 5611.5 5614.5 5638.4 5655.8 5664.3 1374.3 1413.4 1426.8 1427.9 1438.6 970.8 980.0 984.8 994.0 1002.9 5055.4 5251.5 5251.6 5256.1 5259.6 5535.4 5539.3 5546.1 5546.9 5547.3 5189.5 5207.7 5218.9 5250.3 5384.6 2888.9 2933.3 2943.2 2944.3 2945.8 5743.9 5744.4 5766.4 5767.2 5780.3 5494.0 5590.5 5632.1 5634.9 5652.3 5628.4 5628.9 5657.7 5681.7 5702.0 5379.8 5526.6 5532.0 5555.2 5564.6 5474.6 5493.2 5505.9 5509.2 5515.0 5710.2 5720.1 5721.9 5743.0 5772.6 3877.9 4004.2 4029.9 4060.2 4071.4 5530.9 5545.9 5569.6 5592.1 5603.4 5420.4 5421.2 5422.2 5446.5 5454.6 5255.9 5370.5 5395.9 5418.6 5424.7 5361.9 5369.8 5398.6 5411.5 5418.4 5379.5 5488.2 5503.6 5512.4 5532.7 5556.6 5573.5 5604.1 5607.6 5608.0 08:21:32 INFO - PROCESS | 7068 | 08:21:32 INFO - PROCESS | 7068 | [#5] yui.html Cycles:180 Average:18233.26 Median:49265.01 stddev:24845.13 (50.4%) stddev-sans-first:24880.30 08:21:32 INFO - PROCESS | 7068 | Values: 788.1 798.0 826.8 831.5 851.4 15025.8 15569.2 15781.5 16027.2 16074.7 14779.3 15018.8 15027.2 15275.3 15729.8 842.9 862.1 863.8 864.5 865.1 729.5 751.5 817.9 840.2 846.1 907.2 913.2 914.3 914.5 915.2 901.4 904.2 905.7 906.6 907.2 561.7 577.4 641.4 653.5 663.7 15216.9 15300.6 15309.9 15311.9 15342.5 12649.4 12808.6 13110.2 13705.7 13817.4 11787.4 11923.3 11979.6 11997.3 12194.5 4484.1 4514.3 4555.4 4566.2 4578.7 55213.4 55705.0 56798.0 64560.7 66355.0 11316.0 11584.9 11599.3 11782.6 11813.2 20851.5 20864.9 20907.6 21036.7 21187.9 8247.8 8254.5 8643.0 8942.0 9028.4 4718.8 4724.6 4785.8 4829.8 4839.8 3556.7 3672.4 3676.6 3680.4 3680.8 591.4 599.0 607.2 612.3 613.7 671.6 673.1 710.8 718.6 722.8 8465.2 8831.1 8876.0 8926.1 9087.3 596.9 653.7 683.3 685.7 687.4 4207.9 4251.9 4382.6 4408.2 4441.1 83323.6 92319.5 94300.0 95358.5 98905.0 77055.0 77399.0 82043.6 82112.2 84474.0 73856.3 75281.2 75360.2 75516.0 76479.2 7896.7 8144.4 8468.9 8545.6 8617.0 48335.8 48718.8 48749.5 49780.5 50129.2 63267.4 65858.3 66797.0 68318.0 69201.7 10693.4 10707.5 10779.0 10861.9 11352.3 11389.0 11532.7 11557.5 11676.2 11806.4 10266.7 10364.1 10652.2 10662.4 11073.7 11857.6 12599.7 12649.4 12675.2 12833.2 11575.9 11614.6 11817.6 11885.6 11973.7 10664.8 10838.8 10875.0 10891.6 11413.0 8549.6 9078.2 10411.6 10544.1 10657.6 08:21:32 INFO - PROCESS | 7068 | -------- Summary: end -------- 08:21:32 INFO - PROCESS | 7068 | 08:21:33 INFO - TEST-INFO | 7068: exit 0 08:21:33 INFO - TEST-OK | dromaeo_css | took 1115545ms 08:21:33 INFO - TEST-START | kraken 08:21:33 INFO - operating with platform_type : linux_ 08:21:33 INFO - Initialising browser for kraken test... 08:21:33 INFO - TEST-INFO | started process 7387 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUN6JMF/profile http://localhost:58942/getInfo.html) 08:21:37 INFO - PROCESS | 7387 | __metrics Screen width/height:1600/1200 08:21:37 INFO - PROCESS | 7387 | colorDepth:24 08:21:37 INFO - PROCESS | 7387 | Browser inner width/height: 1024/697 08:21:37 INFO - PROCESS | 7387 | __metrics 08:21:38 INFO - PROCESS | 7387 | 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" 08:21:38 INFO - PROCESS | 7387 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:21:38 INFO - PROCESS | 7387 | console.error: PushService: 08:21:38 INFO - PROCESS | 7387 | stateChangeProcessEnqueue: Error transitioning state 08:21:38 INFO - PROCESS | 7387 | UnknownError 08:21:39 INFO - TEST-INFO | 7387: exit 0 08:21:39 INFO - Browser initialized. 08:21:39 INFO - Running cycle 1/1 for kraken test... 08:21:39 INFO - TEST-INFO | started process 7478 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUN6JMF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:21:51 INFO - PROCESS | 7478 | RSS: Main: 145211392 08:21:51 INFO - PROCESS | 7478 | 08:21:53 INFO - PROCESS | 7478 | Cycle 1(1): loaded http://localhost:58942/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58942/tests/kraken/driver.html?testName=audio-beat-detection) 08:21:54 INFO - PROCESS | 7478 | RSS: Main: 186150912 08:21:54 INFO - PROCESS | 7478 | 08:21:57 INFO - PROCESS | 7478 | Cycle 1(1): loaded http://localhost:58942/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58942/tests/kraken/driver.html?testName=audio-dft) 08:21:57 INFO - PROCESS | 7478 | RSS: Main: 175443968 08:21:57 INFO - PROCESS | 7478 | 08:22:00 INFO - PROCESS | 7478 | Cycle 1(1): loaded http://localhost:58942/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58942/tests/kraken/driver.html?testName=audio-fft) 08:22:01 INFO - PROCESS | 7478 | RSS: Main: 266838016 08:22:01 INFO - PROCESS | 7478 | 08:22:03 INFO - PROCESS | 7478 | Cycle 1(1): loaded http://localhost:58942/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58942/tests/kraken/driver.html?testName=audio-oscillator) 08:22:03 INFO - PROCESS | 7478 | RSS: Main: 172814336 08:22:03 INFO - PROCESS | 7478 | 08:22:05 INFO - PROCESS | 7478 | Cycle 1(1): loaded http://localhost:58942/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58942/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:22:06 INFO - PROCESS | 7478 | RSS: Main: 175419392 08:22:06 INFO - PROCESS | 7478 | 08:22:09 INFO - PROCESS | 7478 | Cycle 1(1): loaded http://localhost:58942/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58942/tests/kraken/driver.html?testName=imaging-darkroom) 08:22:10 INFO - PROCESS | 7478 | RSS: Main: 214163456 08:22:10 INFO - PROCESS | 7478 | 08:22:13 INFO - PROCESS | 7478 | Cycle 1(1): loaded http://localhost:58942/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58942/tests/kraken/driver.html?testName=imaging-desaturate) 08:22:14 INFO - PROCESS | 7478 | RSS: Main: 212885504 08:22:14 INFO - PROCESS | 7478 | 08:22:16 INFO - PROCESS | 7478 | Cycle 1(1): loaded http://localhost:58942/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58942/tests/kraken/driver.html?testName=json-parse-financial) 08:22:17 INFO - PROCESS | 7478 | RSS: Main: 211337216 08:22:17 INFO - PROCESS | 7478 | 08:22:18 INFO - PROCESS | 7478 | Cycle 1(1): loaded http://localhost:58942/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58942/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:22:19 INFO - PROCESS | 7478 | RSS: Main: 173903872 08:22:19 INFO - PROCESS | 7478 | 08:22:20 INFO - PROCESS | 7478 | Cycle 1(1): loaded http://localhost:58942/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58942/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:22:21 INFO - PROCESS | 7478 | RSS: Main: 180387840 08:22:21 INFO - PROCESS | 7478 | 08:22:23 INFO - PROCESS | 7478 | Cycle 1(1): loaded http://localhost:58942/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58942/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:22:24 INFO - PROCESS | 7478 | RSS: Main: 189714432 08:22:24 INFO - PROCESS | 7478 | 08:22:26 INFO - PROCESS | 7478 | Cycle 1(1): loaded http://localhost:58942/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58942/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:22:27 INFO - PROCESS | 7478 | RSS: Main: 198463488 08:22:27 INFO - PROCESS | 7478 | 08:22:30 INFO - PROCESS | 7478 | Cycle 1(1): loaded http://localhost:58942/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58942/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:22:30 INFO - PROCESS | 7478 | RSS: Main: 194584576 08:22:30 INFO - PROCESS | 7478 | 08:22:32 INFO - PROCESS | 7478 | Cycle 1(1): loaded http://localhost:58942/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58942/tests/kraken/driver.html?testName=ai-astar) 08:22:32 INFO - PROCESS | 7478 | RSS: Main: 245878784 08:22:32 INFO - PROCESS | 7478 | 08:22:32 INFO - PROCESS | 7478 | __start_tp_report 08:22:32 INFO - PROCESS | 7478 | _x_x_mozilla_page_load 08:22:32 INFO - PROCESS | 7478 | _x_x_mozilla_page_load_details 08:22:32 INFO - PROCESS | 7478 | |i|pagename|runs| 08:22:32 INFO - PROCESS | 7478 | |0;ai-astar;102;110;110;111;111;110;110;110;110;110 08:22:32 INFO - PROCESS | 7478 | |1;audio-beat-detection;144;119;115;158;119;124;122;117;147;118 08:22:32 INFO - PROCESS | 7478 | |2;audio-dft;161;162;160;160;161;165;159;160;161;162 08:22:32 INFO - PROCESS | 7478 | |3;audio-fft;74;75;76;108;75;76;76;76;101;74 08:22:32 INFO - PROCESS | 7478 | |4;audio-oscillator;81;82;122;82;88;81;98;81;81;109 08:22:32 INFO - PROCESS | 7478 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;116 08:22:32 INFO - PROCESS | 7478 | |6;imaging-darkroom;146;146;147;146;146;146;146;146;146;146 08:22:32 INFO - PROCESS | 7478 | |7;imaging-desaturate;85;84;85;84;85;84;85;84;84;85 08:22:32 INFO - PROCESS | 7478 | |8;json-parse-financial;50;51;50;50;50;50;50;50;49;52 08:22:32 INFO - PROCESS | 7478 | |9;json-stringify-tinderbox;59;59;58;58;59;59;58;59;58;60 08:22:32 INFO - PROCESS | 7478 | |10;stanford-crypto-aes;76;75;81;84;77;75;83;76;75;73 08:22:32 INFO - PROCESS | 7478 | |11;stanford-crypto-ccm;135;123;133;121;121;130;126;119;165;123 08:22:32 INFO - PROCESS | 7478 | |12;stanford-crypto-pbkdf2;156;155;154;152;155;155;162;152;155;154 08:22:32 INFO - PROCESS | 7478 | |13;stanford-crypto-sha256-iterative;67;64;64;62;63;63;62;61;62;62 08:22:32 INFO - PROCESS | 7478 | __end_tp_report 08:22:32 INFO - PROCESS | 7478 | __start_cc_report 08:22:32 INFO - PROCESS | 7478 | _x_x_mozilla_cycle_collect,1660 08:22:32 INFO - PROCESS | 7478 | __end_cc_report 08:22:32 INFO - PROCESS | 7478 | __startTimestamp1482250952596__endTimestamp 08:22:32 INFO - PROCESS | 7478 | 08:22:32 INFO - PROCESS | 7478 | ------- Summary: start ------- 08:22:32 INFO - PROCESS | 7478 | Number of tests: 14 08:22:32 INFO - PROCESS | 7478 | 08:22:32 INFO - PROCESS | 7478 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:2.63 (2.4%) stddev-sans-first:0.44 08:22:32 INFO - PROCESS | 7478 | Values: 102.0 110.0 110.0 111.0 111.0 110.0 110.0 110.0 110.0 110.0 08:22:32 INFO - PROCESS | 7478 | 08:22:32 INFO - PROCESS | 7478 | [#1] audio-beat-detection Cycles:10 Average:128.30 Median:123.00 stddev:15.35 (12.5%) stddev-sans-first:15.19 08:22:32 INFO - PROCESS | 7478 | Values: 144.0 119.0 115.0 158.0 119.0 124.0 122.0 117.0 147.0 118.0 08:22:32 INFO - PROCESS | 7478 | 08:22:32 INFO - PROCESS | 7478 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:1.66 (1.0%) stddev-sans-first:1.76 08:22:32 INFO - PROCESS | 7478 | Values: 161.0 162.0 160.0 160.0 161.0 165.0 159.0 160.0 161.0 162.0 08:22:32 INFO - PROCESS | 7478 | 08:22:32 INFO - PROCESS | 7478 | [#3] audio-fft Cycles:10 Average:81.10 Median:75.50 stddev:12.47 (16.5%) stddev-sans-first:12.96 08:22:32 INFO - PROCESS | 7478 | Values: 74.0 75.0 76.0 108.0 75.0 76.0 76.0 76.0 101.0 74.0 08:22:32 INFO - PROCESS | 7478 | 08:22:32 INFO - PROCESS | 7478 | [#4] audio-oscillator Cycles:10 Average:90.50 Median:81.50 stddev:14.54 (17.8%) stddev-sans-first:15.01 08:22:32 INFO - PROCESS | 7478 | Values: 81.0 82.0 122.0 82.0 88.0 81.0 98.0 81.0 81.0 109.0 08:22:32 INFO - PROCESS | 7478 | 08:22:32 INFO - PROCESS | 7478 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:22:32 INFO - PROCESS | 7478 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 08:22:32 INFO - PROCESS | 7478 | 08:22:32 INFO - PROCESS | 7478 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 08:22:32 INFO - PROCESS | 7478 | Values: 146.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 08:22:32 INFO - PROCESS | 7478 | 08:22:32 INFO - PROCESS | 7478 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:85.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 08:22:32 INFO - PROCESS | 7478 | Values: 85.0 84.0 85.0 84.0 85.0 84.0 85.0 84.0 84.0 85.0 08:22:32 INFO - PROCESS | 7478 | 08:22:32 INFO - PROCESS | 7478 | [#8] json-parse-financial Cycles:10 Average:50.20 Median:50.00 stddev:0.79 (1.6%) stddev-sans-first:0.83 08:22:32 INFO - PROCESS | 7478 | Values: 50.0 51.0 50.0 50.0 50.0 50.0 50.0 50.0 49.0 52.0 08:22:32 INFO - PROCESS | 7478 | 08:22:32 INFO - PROCESS | 7478 | [#9] json-stringify-tinderbox Cycles:10 Average:58.70 Median:59.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 08:22:32 INFO - PROCESS | 7478 | Values: 59.0 59.0 58.0 58.0 59.0 59.0 58.0 59.0 58.0 60.0 08:22:32 INFO - PROCESS | 7478 | 08:22:32 INFO - PROCESS | 7478 | [#10] stanford-crypto-aes Cycles:10 Average:77.50 Median:76.50 stddev:3.78 (4.9%) stddev-sans-first:3.97 08:22:32 INFO - PROCESS | 7478 | Values: 76.0 75.0 81.0 84.0 77.0 75.0 83.0 76.0 75.0 73.0 08:22:32 INFO - PROCESS | 7478 | 08:22:32 INFO - PROCESS | 7478 | [#11] stanford-crypto-ccm Cycles:10 Average:129.60 Median:128.00 stddev:13.56 (10.6%) stddev-sans-first:14.24 08:22:32 INFO - PROCESS | 7478 | Values: 135.0 123.0 133.0 121.0 121.0 130.0 126.0 119.0 165.0 123.0 08:22:32 INFO - PROCESS | 7478 | 08:22:32 INFO - PROCESS | 7478 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.00 Median:155.00 stddev:2.79 (1.8%) stddev-sans-first:2.93 08:22:32 INFO - PROCESS | 7478 | Values: 156.0 155.0 154.0 152.0 155.0 155.0 162.0 152.0 155.0 154.0 08:22:32 INFO - PROCESS | 7478 | 08:22:32 INFO - PROCESS | 7478 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.00 stddev:1.70 (2.7%) stddev-sans-first:1.01 08:22:32 INFO - PROCESS | 7478 | Values: 67.0 64.0 64.0 62.0 63.0 63.0 62.0 61.0 62.0 62.0 08:22:32 INFO - PROCESS | 7478 | -------- Summary: end -------- 08:22:32 INFO - PROCESS | 7478 | 08:22:33 INFO - TEST-INFO | 7478: exit 0 08:22:33 INFO - TEST-OK | kraken | took 59986ms 08:22:33 INFO - SUITE-END | took 1175s 08:22:33 INFO - Completed test suite (00:19:35) 08:22:33 INFO - javascript benchmark 08:22:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3172.270377813103, 3209.037288813355, 3209.0854106579623, 3237.8219197944104, 3239.335936133093, 5498.120300751881, 5518.530924871381, 5547.33431988161, 5564.972175139119, 5568.220449137119, 5625.5218306444, 5671.376148623648, 5677.716114194294, 5684.175794509804, 5685.715714214293, 5125.513076257749, 5139.152039913429, 5174.948250517503, 5206.0368831766245, 5242.344706911636, 4973.801047958077, 4990.625703072266, 5050.646454748169, 5172.896542069157, 5230.163173892178, 5102.846914592568, 5163.793448262065, 5166.974165129188, 5190.195519694454, 5204.29741984831, 5181.222816577525, 5191.117510023268, 5197.87005324868, 5198.2722418861385, 5215.791368345262, 4912.287718280829, 4953.653244272902, 5012.624053196025, 5067.847964561069, 5083.05963396769, 5384.488473595042, 5393.622446428752, 5459.481349271852, 5494.5054945054735, 5511.917321240185, 5821.097729851837, 5825.388334224887, 5862.179294898675, 5905.852353691149, 5907.556933229982, 5890.911636325459, 5941.851453713649, 5955.927932972063, 5973.910391344133, 5980.8504787380225, 5560.527355174815, 5599.0, 5659.40576239493, 5663.575231857545, 5688.11834165705, 6189.319174890758, 6202.255729312511, 6204.410580994799, 6210.782622608187, 6214.067889816563, 5709.914351284734, 5958.702064896738, 5964.075568286922, 5974.253218347707, 5978.461938425476, 5818.418158184232, 5916.55625828056, 5960.0, 5979.312379076375, 6046.304674962347, 5907.23205983228, 5953.732082056318, 5968.552358573038, 5980.850478738066, 6019.518438524908, 5989.221401217814, 6006.969965150146, 6007.579469437185, 6008.789692360747, 6012.969935150296, 4453.888652783707, 4472.619827314715, 4559.110973360229, 4560.156371071296, 4590.8163673453355, 4037.555868854424, 4066.552679205285, 4070.369092790563, 4089.754614723126, 4096.836126554964, 5719.542436605062, 5757.942420575824, 5758.165066065397, 5758.568107391962, 5786.797462088806, 5848.941510584925, 5907.054871220584, 5909.113632955005, 5939.10913362999, 6073.939260607337, 5648.209250704905, 5653.378128405872, 5665.433456654384, 5667.093265077568, 5686.317641883001, 5164.04465173944, 5196.064708352457, 5209.374875015023, 5210.348706411699, 5238.292830467838, 6095.664738439428, 6156.0, 6171.6297022178815, 6218.098375735493, 6227.0, 5958.0169272069625, 6063.181470501602, 6063.696815159136, 6084.421979911901, 6090.665013424127, 6304.464120549805, 6319.9052014218905, 6323.810285691437, 6324.462420694109, 6327.430531252209, 5807.535397168132, 5813.593048486735, 5959.374265702038, 5964.284285885721, 5964.582479226413, 6009.278886533644, 6011.308699499438, 6029.939700603113, 6125.23545181825, 6148.077788331607, 5895.41045895407, 5954.0, 5965.015772397506, 5974.790882319098, 5990.161377407254, 5674.914876276942, 5924.31870334917, 5928.3775203603, 5929.822105336847, 5934.554908381802, 5736.254286942671, 5737.799177028784, 5799.623024503394, 5813.82558523245, 5901.291844978458, 5943.108533719977, 5943.851403714942, 5953.970230148821, 5954.493868021266, 5957.821265362046, 5605.159226116115, 5662.2639056922335, 5665.745041473226, 5804.738786754522, 5811.128330750421], "value": 5529.948951225555, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.9736311865965, 618.8947878860594, 649.7368565730877, 650.3204151661515, 670.105409278613, 35160.472592911094, 46272.76863615681, 47649.761751191196, 47691.284630730566, 47724.52275477244, 45457.31814022792, 46009.0, 46118.53881461184, 46121.308180377324, 46341.7682911585, 8229.382796290272, 8461.746147615582, 8760.386772925882, 8892.555372231394, 8901.599428025722, 10453.11148552374, 10730.302530335543, 10732.0, 11037.061849742782, 11042.834357484644, 10956.506957186946, 11032.724181895477, 11043.72390690231, 11044.33733975964, 11051.447427628586, 10805.891941080607, 10853.565857365697, 10854.837177442345, 10868.347899125998, 10872.130229581693, 10790.244682872202, 10840.0, 10853.131749460103, 10854.34873907568, 10864.565417383295, 45311.546884531395, 45549.772251138864, 45630.31554526685, 45680.3147952781, 45684.0, 3752.099496120911, 3820.44603532489, 3855.151866589374, 3873.9612603873884, 3925.568187499373, 33298.66701333004, 34085.0, 34475.65524344775, 35263.82368088169, 35347.4697879532, 4462.977685111554, 4573.565511276423, 4609.331646911179, 4657.6273898088075, 4768.642351823592, 263051.0, 263571.41071473365, 263727.0, 263970.0, 264065.0, 65160.0, 65606.0, 65635.0, 65687.34312656907, 65751.67124164444, 69623.3037669627, 69645.30354696489, 70010.2998970014, 70239.0, 70447.64776176086, 18159.092045397676, 18430.815691843178, 18440.90779546094, 18451.723224151647, 18453.077346132908, 12756.298403587705, 12985.545505907437, 13145.21128732279, 13335.399907004208, 14057.648558786112, 19741.703874441893, 20051.398458046282, 20153.0, 20155.59688806245, 20196.495087622632, 6986.650667466606, 7000.509964302551, 7060.823479413056, 7129.538007130508, 7407.85184296311, 1007.1539906478594, 1035.5754140802235, 1061.8054688475465, 1075.3977772447454, 1121.2095472691733, 33994.32011359759, 34635.30729385449, 34820.477692834625, 34821.9553413398, 34840.79741120992, 1125.7692173104494, 1138.1691365303209, 1164.6622479481025, 1188.8454500915, 1221.5020283520223, 16654.16729163537, 17818.732719009226, 17879.910600446914, 17912.373066942593, 17920.0, 537306.0, 539559.0, 539710.0, 540904.0, 541675.0, 63375.68312158502, 63927.68036159789, 64045.35954640487, 64199.35800641934, 64248.357516425174, 1441.502681574855, 1442.5239670908575, 1443.5452832357773, 1467.8385377608454, 1469.7427950108688, 30932.0, 32998.0, 33041.33917321592, 33045.83477082695, 33419.66580334263, 55045.0, 55321.0, 55428.16857747218, 55450.72274638601, 55477.722611386685, 424262.0, 426588.0, 426661.0, 426691.0, 427625.0, 27807.860960695067, 28746.425071498034, 29813.552796707634, 31397.8430107848, 31748.36503269968, 50646.0, 51024.234636481226, 52124.0, 52296.21555676592, 55655.0, 42820.35769463398, 43170.0, 43436.56563434325, 43701.47044853415, 45312.32031519596, 42623.0, 43569.78215108904, 43955.34066989062, 44437.11125777401, 45187.32219016783, 44375.0, 44828.103437930404, 45537.31694024659, 45625.77187114043, 45724.54275457203, 36220.4566931491, 38831.308077198046, 39247.0, 39411.60588394194, 40129.598704013755, 29472.55791163177, 30042.24894377658, 30151.849240753654, 30215.546766798954, 30272.0], "value": 21459.599840677205, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [427.8533530139226, 435.6688916423519, 438.2090326959837, 445.03871637263506, 451.36808468144613, 18556.443306700803, 20193.0, 20239.696404553924, 20324.288649897255, 20659.896700516478, 19801.702974455395, 19885.701714474293, 20102.49743756403, 20405.48986275344, 20552.28067017651, 5682.289713785777, 5882.176495290662, 5941.435563621449, 5948.821535353946, 5954.4938680212235, 5606.35526914406, 5736.110902810071, 5806.883862322751, 5812.099124635667, 5821.621594596359, 5790.913136302959, 5793.159991801186, 5795.971020144914, 5797.478226959573, 5799.304083509964, 5662.065759149756, 5728.341240757304, 5782.219400380936, 5799.3910639382675, 5804.071348584206, 5207.843764687028, 5248.21276808478, 5273.604479664003, 5279.577633789288, 5280.894382112337, 23784.643230351558, 23805.0, 23862.7613723864, 23990.76009239903, 24207.87896060526, 2553.859537725424, 2586.456844062749, 2596.4677241165514, 2690.9370798534665, 2740.369714965569, 14444.855551444456, 14481.56555303332, 14724.411023559045, 14792.778108328384, 15146.318415671321, 1909.3889955214338, 2009.4574464894397, 2014.1238561225914, 2022.9089690963942, 2054.95890082199, 90010.41983457853, 94634.52682736542, 95086.0, 95522.0, 96626.0, 11437.256578322382, 11606.767864642828, 11617.76764464706, 11629.80180450383, 11795.88204117965, 16625.168741562873, 16627.168641567874, 16645.41741039058, 16653.91673041627, 16661.333546658, 8493.957530212308, 8558.315334773204, 8593.183647553473, 8813.647454101892, 8833.514156721441, 8362.540060296742, 8387.490251754622, 8527.829443411098, 8559.828803423896, 8579.699710510227, 4818.277258411196, 4977.253411988158, 4986.077575648516, 4990.2764099205415, 5095.770690318945, 1999.4601457606366, 2049.559344740888, 2056.5475595368994, 2073.481629592602, 2174.336827267667, 995.8945570416831, 1000.0599436529784, 1003.8092762375271, 1006.1598565198142, 1037.1391744851755, 19023.714644280346, 20565.89717051405, 20729.79270207309, 20765.480862978246, 20848.895755521124, 997.9251556133319, 1036.4403222260046, 1050.6585359757955, 1097.3470784882982, 1102.6030628973563, 10722.195835312383, 11471.770564588662, 11595.652130436101, 11685.88314116865, 11732.530698772125, 501629.0, 506954.0, 508604.0, 510617.0, 514135.0, 88433.0, 99088.0, 102016.0, 102805.48597256966, 103718.0, 990.069334825262, 1023.6877752285625, 1037.4657051618422, 1045.4929359260752, 1051.731808388856, 17831.10844457746, 18168.818311816714, 18652.44042678722, 18695.813041869405, 18739.812601873808, 40588.39117413182, 43619.78190109156, 43862.0, 44977.77511112423, 44994.32508512309, 51948.0, 63192.0, 63431.36568634255, 64756.676216618616, 64881.67559162174, 8921.732348029569, 9036.909630903607, 9139.314551408805, 9177.21993630549, 9421.434713917188, 10337.586496540054, 13708.52020179289, 14244.71510569762, 14343.0, 14726.852731472549, 12381.814272785736, 12501.494798102472, 12596.496140154657, 12670.0, 12734.554290600156, 11740.471678774305, 12032.578859740217, 12270.202436841577, 12644.620661380173, 12754.936225318814, 12374.13381063317, 12573.874261257637, 12649.810252846031, 12662.810057848956, 13011.869881301065, 8847.867281990904, 9037.638494460149, 9073.364864459425, 9075.863862041942, 9531.666391676257, 10561.683149505527, 12148.271103733805, 12178.45196966121, 12195.146339756131, 12223.205491643015], "value": 9781.345459880811, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1347.3802051056514, 1484.9406023759047, 1488.9702205955882, 1657.7430498272765, 1808.339955916091, 7852.489588176764, 8316.916830831697, 8455.788605284872, 8666.52334121623, 8688.826223475528, 8869.334799890003, 8921.866172007409, 8933.553322333873, 8935.776605584864, 8946.507942063201, 2445.7065152181763, 2472.666190064336, 2477.1949116537107, 2480.553500369933, 2480.5659009673236, 2368.0764501844296, 2418.625113107471, 2426.502566973766, 2426.963595546068, 2427.635854621812, 2361.1853910400882, 2374.643803429482, 2389.51015041916, 2391.1272385579227, 2392.5883728600124, 2348.8120950323932, 2379.2862141357696, 2406.879656017201, 2411.0476361837063, 2422.2733180045916, 2299.471121642015, 2309.6766452696634, 2333.5332933413215, 2333.9147296507035, 2334.1130370459286, 8863.0, 8926.285897128215, 8963.910360896438, 8992.325575581857, 9000.054994225577, 5441.2654291670515, 5560.972195139039, 5578.135389014709, 5644.717764111778, 5664.40523745005, 3458.2737625098757, 3466.7399945004227, 3567.625399333059, 3580.874669386559, 3618.4572314152824, 1204.819277108432, 1208.456194712383, 1224.9877501224962, 1231.2550906701497, 1254.5420921363727, 11276.436178191057, 11299.830502542469, 11332.6033588824, 11371.260868043468, 11386.487608057574, 4320.330348795942, 4479.283314669638, 4564.543545645475, 4578.427696537933, 4643.071385722801, 9805.950970245103, 9827.361221520578, 9828.606855725833, 9833.0, 9842.606295748234, 5438.265834112423, 5440.91838622421, 5444.210589464506, 5444.945550544444, 5448.37343705471, 4399.36209249657, 4521.3896124023495, 4673.205555055649, 5099.209622508517, 5170.0, 3803.410471376941, 3844.4041173618134, 3932.5870783567884, 3958.089639382958, 3967.0677390813134, 1159.1190695071807, 1163.1973937982934, 1165.685264978451, 1172.1560476456937, 1178.1811640909486, 893.5398269891011, 941.4821847983718, 941.990580094204, 949.3022628368144, 955.961761529531, 5613.129964855454, 5689.800856970069, 5713.518646494608, 5917.408259174134, 6017.759289628453, 424.8831571317912, 426.3604593110334, 428.5500224763985, 428.70633615973156, 429.7472866593906, 3980.900477488086, 4011.859584914514, 4025.2352053109817, 4040.393940908887, 4071.816768245436, 10487.580496780196, 10694.304870183412, 10734.194935379877, 11086.279391839666, 11168.66494005181, 10979.121670266359, 11032.558697652164, 11057.72355691098, 11064.723381915517, 11066.114710823114, 7817.0, 8094.473859199134, 8126.55303958288, 8132.7560173193715, 8139.83720325602, 5705.201271821865, 5769.711514424346, 5770.8845823082465, 5799.913001305068, 5897.67562784051, 9715.611375545182, 10011.749706257402, 10031.197504199501, 10142.594296228068, 10147.898521014695, 9164.541772911194, 9425.858612120961, 10188.949055254676, 10242.897571024492, 10267.383956962607, 7064.364207221375, 7879.606019699107, 7923.405744569065, 8060.355171586376, 8151.062627797642, 8761.211490965843, 8769.166929141722, 8826.161514656098, 8829.955850220707, 8854.07032261629, 7700.576468294297, 7704.422168337509, 7759.883601746092, 7782.1828707987115, 7832.412569057229, 7467.514611550232, 7625.885611715939, 7649.923500764921, 7758.728444504415, 7849.215078492333, 7080.362767350963, 7168.498205125799, 7173.318534739192, 7178.066851309296, 7189.352958233575, 4994.1509943309, 5008.148614735431, 5066.9746651266505, 5086.287919691172, 5243.606729495379, 5100.7449627517735, 5118.590512758896, 5136.075506408883, 5217.921731174111, 5312.760925758427], "value": 4545.861064434379, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.16333635937383, 349.4775310910189, 352.832125664052, 356.20388431854786, 359.0735901374454, 5414.810481633143, 5424.403315635282, 5428.185772134177, 5436.91844622331, 5459.262999495067, 5323.1749078892735, 5338.692020454984, 5351.759170837312, 5394.136938089907, 5401.4328495508, 4025.8188381522755, 4194.370844373338, 4215.641670458015, 4244.1511697660435, 4304.741715497073, 4205.600467955539, 4206.390073439349, 4223.746575205498, 4229.111886503838, 4248.34150706641, 3990.580988996157, 4203.453551038361, 4205.675212308113, 4206.432131662233, 4234.513031001428, 4057.797110144496, 4099.364598487239, 4140.834366625331, 4167.52073511547, 4170.645495132917, 3689.6494832990825, 3695.0947017980766, 3699.463577781207, 3699.8890033299044, 3706.42550404685, 5016.824411145592, 5108.897822043538, 5179.249008893727, 5194.246834209019, 5202.673318303846, 4496.2581174106235, 4761.880952976168, 4769.189237829577, 4780.976095119502, 4808.567228949376, 5559.8888022239325, 5561.666300021971, 5566.777328906839, 5568.610197286192, 5572.4148964358565, 4015.9397609035886, 4071.025552606983, 4071.226466971266, 4096.344584866437, 4097.959020409818, 5680.829575112753, 5710.885782284331, 5723.828285151452, 5778.075507918713, 5796.014677504792, 4128.731632443882, 4158.397032430341, 4190.161967606491, 4193.182329445729, 4197.958020419818, 4097.713160078766, 4236.385724069993, 4254.191703576311, 4262.914741705148, 4279.807408666617, 4745.288206768943, 4748.145333839942, 4753.338130646849, 4777.665563410528, 4802.447718512416, 5611.523020543218, 5614.494695477427, 5638.43615638441, 5655.802046928337, 5664.320281566238, 1374.3403166480146, 1413.3569226002144, 1426.8145141131795, 1427.9143251404948, 1438.6259572511221, 970.7767213540925, 979.9951000245096, 984.8030393921101, 993.9850902236473, 1002.904724051214, 5055.368078990126, 5251.501107394792, 5251.632385733038, 5256.082874004887, 5259.58059292722, 5535.363433205152, 5539.307586551681, 5546.142042415755, 5546.861328466821, 5547.306586676666, 5189.481051894781, 5207.739613019334, 5218.869528261748, 5250.317458730341, 5384.596155288369, 2888.9277768055967, 2933.266683329168, 2943.2200466876293, 2944.263934016496, 2945.7937944344117, 5743.851229753982, 5744.425557444222, 5766.365699773021, 5767.192593036978, 5780.335261444903, 5494.0, 5590.524805391506, 5632.113242063872, 5634.943650563524, 5652.349979752381, 5628.409017053233, 5628.915566266591, 5657.688827114548, 5681.733003522991, 5701.971490142606, 5379.811706590251, 5526.585506086979, 5532.0, 5555.166724991122, 5564.638298510584, 5474.616776825744, 5493.242162507959, 5505.944940550704, 5509.173623956439, 5515.0, 5710.200571920018, 5720.141978703228, 5721.914171287351, 5743.0, 5772.624779389326, 3877.8836634901, 4004.2391945530258, 4029.9395509066803, 4060.167665628598, 4071.3689378146437, 5530.944690553043, 5545.916811247754, 5569.637973531708, 5592.105263157875, 5603.3836278008575, 5420.403755586961, 5421.241026256248, 5422.186671999231, 5446.455354464521, 5454.5818087298385, 5255.868603284948, 5370.516653501204, 5395.865103372447, 5418.620696551204, 5424.656713137635, 5361.865953351197, 5369.758360873848, 5398.623351045615, 5411.458854114557, 5418.431064738304, 5379.515843574097, 5488.17677348401, 5503.587230957774, 5512.3660779010925, 5532.695701736282, 5556.611037227517, 5573.498385145356, 5604.094607833356, 5607.5513958884, 5607.971960140337], "value": 4235.15945695751, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [788.1330536409946, 798.0264077825051, 826.818100017996, 831.4803247970019, 851.3572252949023, 15025.774613380809, 15569.221538923051, 15781.526554203392, 16027.198640068009, 16074.678506429878, 14779.261036948163, 15018.849811501881, 15027.173505457224, 15275.312610932508, 15729.764053539206, 842.9072801991776, 862.0603542139067, 863.753830158405, 864.5158711121792, 865.0657290126679, 729.4930023633577, 751.515272649141, 817.9427440079197, 840.1892174052039, 846.0904527632789, 907.2288554728494, 913.2283220678516, 914.3416739947228, 914.5198770645397, 915.249495413761, 901.378049146087, 904.2494729374636, 905.714699869539, 906.5648488725416, 907.1699395053486, 561.6994907724388, 577.4081566394437, 641.3938827807724, 653.5000724445803, 663.6582160187507, 15216.923915380352, 15300.617484562863, 15309.923450382788, 15311.923440382838, 15342.463013794575, 12649.43077561512, 12808.551700690525, 13110.213387196798, 13705.657358566115, 13817.447302107903, 11787.410629468579, 11923.344216068113, 11979.640610781691, 11997.34014629195, 12194.451249693786, 4484.148011877765, 4514.277715565527, 4555.362249285103, 4566.246569316058, 4578.702384345041, 55213.44786552123, 55705.0, 56798.0, 64560.67719661419, 66355.0, 11316.0, 11584.884151158549, 11599.304041757521, 11782.646520604225, 11813.173077884638, 20851.478713031993, 20864.895675521828, 20907.58184836325, 21036.684449733268, 21187.894060529597, 8247.752567422987, 8254.504729716236, 8642.956785216034, 8941.955290223506, 9028.36801423894, 4718.834840780556, 4724.622030237572, 4785.833931562544, 4829.830955916526, 4839.782209800567, 3556.715462762973, 3672.3756961316108, 3676.558812942464, 3680.3743363628246, 3680.7975561344383, 591.3849596419761, 598.9610675306092, 607.2106261859565, 612.3203244398713, 613.6931534232883, 671.5668393886014, 673.1249375811426, 710.7618947652594, 718.6011763471323, 722.757876111498, 8465.238128568459, 8831.116888311117, 8875.955620221857, 8926.107389261151, 9087.318451116193, 596.9492593129546, 653.7189008726293, 683.3166833166833, 685.7051467868864, 687.4466054825913, 4207.852725154605, 4251.87244382669, 4382.627476664519, 4408.206522825923, 4441.089576636782, 83323.5833820827, 92319.5384023089, 94300.0, 95358.52320738352, 98905.01094988958, 77055.0, 77399.0, 82043.58978205071, 82112.17887821165, 84474.0, 73856.26143738494, 75281.24718752742, 75360.24639753642, 75516.0, 76479.23520764832, 7896.68413263486, 8144.429889907649, 8468.872966905625, 8545.61544730501, 8616.956915215384, 48335.75832120958, 48718.75640621774, 48749.512504875915, 49780.502194977584, 50129.248061278384, 63267.367326326144, 65858.34141658522, 66797.0, 68318.0, 69201.65399173173, 10693.358398496115, 10707.518161682587, 10779.0, 10861.891381086089, 11352.318860868374, 11388.974992250738, 11532.654020379403, 11557.47991340375, 11676.241044332091, 11806.409679515818, 10266.743331416774, 10364.119049880845, 10652.201084918506, 10662.360258384522, 11073.667789966314, 11857.5849845255, 12599.685007874876, 12649.367531623198, 12675.239485630891, 12833.230006199658, 11575.942120289345, 11614.593489227836, 11817.586384476503, 11885.5840045598, 11973.742757010737, 10664.84002739944, 10838.783224335626, 10875.02124808771, 10891.564337426731, 11413.0, 8549.572521374032, 9078.228350590274, 10411.583536658753, 10544.103751180928, 10657.626983055556], "value": 7154.894059173916, "unit": "score"}], "name": "dromaeo_css", "value": 7367.380841800927, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 110.0, 110.0, 111.0, 111.0, 110.0, 110.0, 110.0, 110.0, 110.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 119.0, 115.0, 158.0, 119.0, 124.0, 122.0, 117.0, 147.0, 118.0], "value": 128.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 160.0, 160.0, 161.0, 165.0, 159.0, 160.0, 161.0, 162.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 108.0, 75.0, 76.0, 76.0, 76.0, 101.0, 74.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 122.0, 82.0, 88.0, 81.0, 98.0, 81.0, 81.0, 109.0], "value": 90.5, "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, 117.0, 117.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 85.0, 84.0, 85.0, 84.0, 85.0, 84.0, 84.0, 85.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 50.0, 50.0, 50.0, 50.0, 50.0, 50.0, 49.0, 52.0], "value": 50.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 58.0, 58.0, 59.0, 59.0, 58.0, 59.0, 58.0, 60.0], "value": 58.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 81.0, 84.0, 77.0, 75.0, 83.0, 76.0, 75.0, 73.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 123.0, 133.0, 121.0, 121.0, 130.0, 126.0, 119.0, 165.0, 123.0], "value": 129.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 155.0, 154.0, 152.0, 155.0, 155.0, 162.0, 152.0, 155.0, 154.0], "value": 155.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 64.0, 62.0, 63.0, 63.0, 62.0, 61.0, 62.0, 62.0], "value": 63.0, "unit": "score"}], "name": "kraken", "value": 1451.8999999999999, "alertThreshold": 2.0}]} 08:22:33 INFO - Return code: 0 08:22:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:22:33 INFO - # TBPL SUCCESS # 08:22:33 INFO - Running post-action listener: _resource_record_post_action 08:22:33 INFO - [mozharness: 2016-12-20 16:22:33.908998Z] Finished run-tests step (success) 08:22:33 INFO - Running post-run listener: _resource_record_post_run 08:22:33 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 466944; Write bytes: 366436352; Read time: 64; Write time: 186860 08:22:33 INFO - TinderboxPrint: CPU usage
13.0% 08:22:33 INFO - TinderboxPrint: I/O read bytes / time
466,944 / 64 08:22:33 INFO - TinderboxPrint: I/O write bytes / time
366,436,352 / 186,860 08:22:33 INFO - TinderboxPrint: CPU idle
8,275.8 (87.0%) 08:22:33 INFO - TinderboxPrint: CPU user
1,193.2 (12.5%) 08:22:33 INFO - TinderboxPrint: Swap in / out
0 / 0 08:22:33 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 118579200; Read time: 0; Write time: 63132 08:22:33 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 462848; Write bytes: 246603776; Read time: 52; Write time: 123704 08:22:34 INFO - Running post-run listener: _upload_blobber_files 08:22:34 INFO - Blob upload gear active. 08:22:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:22:34 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 08:22:34 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'] 08:22:34 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 08:22:34 INFO - (blobuploader) - INFO - Open directory for files ... 08:22:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:22:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:22:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:22:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:22:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:22:38 INFO - (blobuploader) - INFO - Done attempting. 08:22:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:22:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:22:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:22:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:22:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:22:39 INFO - (blobuploader) - INFO - Done attempting. 08:22:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:22:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:22:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:22:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:22:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:22:42 INFO - (blobuploader) - INFO - Done attempting. 08:22:42 INFO - (blobuploader) - INFO - Iteration through files over. 08:22:42 INFO - Return code: 0 08:22:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:22:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:22:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b76b43ab9c507e72cfdd30ac313354aa1e2401f04c9bba0aad356cfb1956027568291ee565ace42df83c81de8d1b2ef0f9db51a0169e13eff88a2936988b3d08", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/17e13a942a30067c6fe8f349cab95ecd5032c693f8eb737b9d29666612f89e348f37a6260d20b9c08f09d024c6359b06c25b6d0183807c2aafb2a04fe65c6724", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c014bbbc04887c63746a2bf076cbe45ac4d00dee9806f5e28016fac521f437b4e0c6f2b1050bf79916b17aa6a43d6dfb9fee5b3701d482698c0d40fd4663dda0"} 08:22:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:22:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:22:42 INFO - Contents: 08:22:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b76b43ab9c507e72cfdd30ac313354aa1e2401f04c9bba0aad356cfb1956027568291ee565ace42df83c81de8d1b2ef0f9db51a0169e13eff88a2936988b3d08", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/17e13a942a30067c6fe8f349cab95ecd5032c693f8eb737b9d29666612f89e348f37a6260d20b9c08f09d024c6359b06c25b6d0183807c2aafb2a04fe65c6724", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c014bbbc04887c63746a2bf076cbe45ac4d00dee9806f5e28016fac521f437b4e0c6f2b1050bf79916b17aa6a43d6dfb9fee5b3701d482698c0d40fd4663dda0"} 08:22:42 INFO - Running post-run listener: copy_logs_to_upload_dir 08:22:42 INFO - Copying logs to upload dir... 08:22:42 INFO - mkdir: /builds/slave/test/build/upload/logs 08:22:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.201791 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-12-20 08:22:42.116377) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-20 08:22:42.120033) ========= 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=d2a8c569965ab8367867b893000001a1-1482248368.537627-247160603 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/b76b43ab9c507e72cfdd30ac313354aa1e2401f04c9bba0aad356cfb1956027568291ee565ace42df83c81de8d1b2ef0f9db51a0169e13eff88a2936988b3d08", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/17e13a942a30067c6fe8f349cab95ecd5032c693f8eb737b9d29666612f89e348f37a6260d20b9c08f09d024c6359b06c25b6d0183807c2aafb2a04fe65c6724", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c014bbbc04887c63746a2bf076cbe45ac4d00dee9806f5e28016fac521f437b4e0c6f2b1050bf79916b17aa6a43d6dfb9fee5b3701d482698c0d40fd4663dda0"} build_url:https://queue.taskcluster.net/v1/task/PoVaUphYROW70-7JKtzgYw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011839 build_url: 'https://queue.taskcluster.net/v1/task/PoVaUphYROW70-7JKtzgYw/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/b76b43ab9c507e72cfdd30ac313354aa1e2401f04c9bba0aad356cfb1956027568291ee565ace42df83c81de8d1b2ef0f9db51a0169e13eff88a2936988b3d08", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/17e13a942a30067c6fe8f349cab95ecd5032c693f8eb737b9d29666612f89e348f37a6260d20b9c08f09d024c6359b06c25b6d0183807c2aafb2a04fe65c6724", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c014bbbc04887c63746a2bf076cbe45ac4d00dee9806f5e28016fac521f437b4e0c6f2b1050bf79916b17aa6a43d6dfb9fee5b3701d482698c0d40fd4663dda0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-20 08:22:42.145880) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 08:22:42.146225) ========= 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=d2a8c569965ab8367867b893000001a1-1482248368.537627-247160603 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004500 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 08:22:42.233028) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-20 08:22:42.233583) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-20 08:22:42.234104) ========= ========= Total master_lag: 0.17 =========