builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-021 starttime: 1482336001.79 results: success (0) buildid: 20161221062253 builduid: be73f60bd9d147e4ab9638f222b0de82 revision: 6c1dd7d65949799726e1ab823d66070927f622e8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-21 08:00:01.787207) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-21 08:00:01.787834) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-21 08:00:01.788133) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-21 08:00:01.941069) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 08:00:01.941381) ========= 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=df17445c3590ff7897617a0e00000225-1482333807.805368-1727432444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-21 08:00: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.2M=0s 2016-12-21 08:00:02 (50.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122652 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 08:00:02.105707) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 08:00:02.106054) ========= 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=df17445c3590ff7897617a0e00000225-1482333807.805368-1727432444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020843 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 08:00:02.158462) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-21 08:00:02.158787) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6c1dd7d65949799726e1ab823d66070927f622e8 --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 6c1dd7d65949799726e1ab823d66070927f622e8 --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=df17445c3590ff7897617a0e00000225-1482333807.805368-1727432444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-21 08:00:02,689 truncating revision to first 12 chars 2016-12-21 08:00:02,689 Setting DEBUG logging. 2016-12-21 08:00:02,689 attempt 1/10 2016-12-21 08:00:02,689 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/6c1dd7d65949?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-21 08:00:03,464 unpacking tar archive at: mozilla-aurora-6c1dd7d65949/testing/mozharness/ program finished with exit code 0 elapsedTime=1.078555 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-21 08:00:03.255863) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-21 08:00:03.256413) ========= script_repo_revision: 6c1dd7d65949799726e1ab823d66070927f622e8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-21 08:00:03.256865) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-21 08:00:03.257165) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-21 08:00:03.268418) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-12-21 08:00:03.268964) ========= /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=df17445c3590ff7897617a0e00000225-1482333807.805368-1727432444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:00:03 INFO - MultiFileLogger online at 20161221 08:00:03 in /builds/slave/test 08:00:03 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:00:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:00:03 INFO - {'append_to_log': False, 08:00:03 INFO - 'base_work_dir': '/builds/slave/test', 08:00:03 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:00:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:00:03 INFO - 'branch': 'Mozilla-Aurora', 08:00:03 INFO - 'buildbot_json_path': 'buildprops.json', 08:00:03 INFO - 'config_files': ('talos/linux_config.py',), 08:00:03 INFO - 'default_actions': ('clobber', 08:00:03 INFO - 'read-buildbot-config', 08:00:03 INFO - 'download-and-extract', 08:00:03 INFO - 'populate-webroot', 08:00:03 INFO - 'create-virtualenv', 08:00:03 INFO - 'install', 08:00:03 INFO - 'run-tests'), 08:00:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:00:03 INFO - 'download_minidump_stackwalk': True, 08:00:03 INFO - 'download_symbols': 'ondemand', 08:00:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:00:03 INFO - 'tooltool.py': '/tools/tooltool.py', 08:00:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:00:03 INFO - '/tools/misc-python/virtualenv.py')}, 08:00:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:00:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:00:03 INFO - 'installer_path': 'installer.exe', 08:00:03 INFO - 'log_level': 'info', 08:00:03 INFO - 'log_name': 'talos', 08:00:03 INFO - 'log_to_console': True, 08:00:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:00:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:00:03 INFO - 'opt_config_files': (), 08:00:03 INFO - 'pip_index': False, 08:00:03 INFO - 'sps_profile': False, 08:00:03 INFO - 'sps_profile_interval': 0, 08:00:03 INFO - 'suite': 'dromaeojs', 08:00:03 INFO - 'system_bits': '32', 08:00:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:00:03 INFO - 'title': 'talos-linux64-ix-021', 08:00:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:00:03 INFO - 'use_talos_json': True, 08:00:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:00:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:00:03 INFO - 'work_dir': 'build'} 08:00:03 INFO - [mozharness: 2016-12-21 16:00:03.893604Z] Running clobber step. 08:00:03 INFO - Running pre-action listener: _resource_record_pre_action 08:00:03 INFO - Running main action method: clobber 08:00:03 INFO - rmtree: /builds/slave/test/build 08:00:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:00:04 INFO - Running post-action listener: _resource_record_post_action 08:00:04 INFO - [mozharness: 2016-12-21 16:00:04.861637Z] Finished clobber step (success) 08:00:04 INFO - [mozharness: 2016-12-21 16:00:04.861736Z] Running read-buildbot-config step. 08:00:04 INFO - Running pre-action listener: _resource_record_pre_action 08:00:04 INFO - Running main action method: read_buildbot_config 08:00:04 INFO - Using buildbot properties: 08:00:04 INFO - { 08:00:04 INFO - "project": "", 08:00:04 INFO - "product": "firefox", 08:00:04 INFO - "script_repo_revision": "production", 08:00:04 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 08:00:04 INFO - "repository": "", 08:00:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 08:00:04 INFO - "buildid": "20161221062253", 08:00:04 INFO - "pgo_build": "True", 08:00:04 INFO - "basedir": "/builds/slave/test", 08:00:04 INFO - "buildnumber": 689, 08:00:04 INFO - "slavename": "talos-linux64-ix-021", 08:00:04 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:00:04 INFO - "platform": "ubuntu64_hw", 08:00:04 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 08:00:04 INFO - "branch": "mozilla-aurora", 08:00:04 INFO - "repo_path": "releases/mozilla-aurora", 08:00:04 INFO - "revision": "6c1dd7d65949799726e1ab823d66070927f622e8", 08:00:04 INFO - "stage_platform": "linux64-pgo", 08:00:04 INFO - "builduid": "be73f60bd9d147e4ab9638f222b0de82", 08:00:04 INFO - "slavebuilddir": "test" 08:00:04 INFO - } 08:00:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/HDPsacxMS8WzKuWNhkoGrg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 08:00:04 INFO - Running post-action listener: _resource_record_post_action 08:00:04 INFO - [mozharness: 2016-12-21 16:00:04.864147Z] Finished read-buildbot-config step (success) 08:00:04 INFO - [mozharness: 2016-12-21 16:00:04.864235Z] Running download-and-extract step. 08:00:04 INFO - Running pre-action listener: _resource_record_pre_action 08:00:04 INFO - Running main action method: download_and_extract 08:00:04 INFO - mkdir: /builds/slave/test/build/tests 08:00: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:00:04 INFO - trying https://queue.taskcluster.net/v1/task/HDPsacxMS8WzKuWNhkoGrg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:00:04 INFO - Downloading https://queue.taskcluster.net/v1/task/HDPsacxMS8WzKuWNhkoGrg/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:00:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HDPsacxMS8WzKuWNhkoGrg/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:00:05 INFO - Downloaded 1361 bytes. 08:00:05 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:00:05 INFO - Using the following test package requirements: 08:00:05 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 08:00:05 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:00:05 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 08:00:05 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:00:05 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 08:00:05 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:00:05 INFO - u'jsshell-linux-x86_64.zip'], 08:00:05 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:00:05 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 08:00:05 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 08:00:05 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:00:05 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 08:00:05 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:00:05 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 08:00:05 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:00:05 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 08:00:05 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:00:05 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 08:00:05 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:00:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HDPsacxMS8WzKuWNhkoGrg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 08:00:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HDPsacxMS8WzKuWNhkoGrg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:00:05 INFO - Fetch https://queue.taskcluster.net/v1/task/HDPsacxMS8WzKuWNhkoGrg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:00:06 INFO - Http code: 200 08:00:06 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 08:00:06 INFO - x-amz-cf-id: K2MAVw0L8opIYBAGX2auF_7TmI8hcycu3cMT9gZkkI3XAtx-MPspDA== 08:00:06 INFO - x-amz-version-id: latEnHTvllLuPRoiaFd5gVzpGWRSg_b8 08:00:06 INFO - Expected file size: 21940351 08:00:06 INFO - Obtained file size: 21940351 08:00:10 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:00:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HDPsacxMS8WzKuWNhkoGrg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 08:00:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HDPsacxMS8WzKuWNhkoGrg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:00:10 INFO - Fetch https://queue.taskcluster.net/v1/task/HDPsacxMS8WzKuWNhkoGrg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:00:11 INFO - Http code: 200 08:00:11 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 08:00:11 INFO - x-amz-cf-id: m6qZULC7z7HEPxTR-LOZCVFgkjkTRYo-B9ZaUV-zFxdLfnT23Fqmwg== 08:00:11 INFO - x-amz-version-id: latEnHTvllLuPRoiaFd5gVzpGWRSg_b8 08:00:11 INFO - Expected file size: 21940351 08:00:11 INFO - Obtained file size: 21940351 08:00:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HDPsacxMS8WzKuWNhkoGrg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 08:00:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HDPsacxMS8WzKuWNhkoGrg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:00:15 INFO - Fetch https://queue.taskcluster.net/v1/task/HDPsacxMS8WzKuWNhkoGrg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 08:00:16 INFO - Http code: 200 08:00:16 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 08:00:16 INFO - x-amz-cf-id: ddrX4WzGTaS95t4Z7E6AZa-U-XaSBPOPu7GDkpRwG4PWuNRzxtyQhQ== 08:00:16 INFO - x-amz-version-id: RVCdDWTJHkwtpDepyExWwI4kVQ9FoEDC 08:00:16 INFO - Expected file size: 14409038 08:00:16 INFO - Obtained file size: 14409038 08:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:00:16 INFO - trying https://queue.taskcluster.net/v1/task/HDPsacxMS8WzKuWNhkoGrg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:00:16 INFO - Downloading https://queue.taskcluster.net/v1/task/HDPsacxMS8WzKuWNhkoGrg/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:00:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HDPsacxMS8WzKuWNhkoGrg/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:00:17 INFO - Downloaded 63988494 bytes. 08:00:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HDPsacxMS8WzKuWNhkoGrg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:00:17 INFO - mkdir: /builds/slave/test/properties 08:00:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:00:17 INFO - Writing to file /builds/slave/test/properties/build_url 08:00:17 INFO - Contents: 08:00:17 INFO - build_url:https://queue.taskcluster.net/v1/task/HDPsacxMS8WzKuWNhkoGrg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:00:18 INFO - Running post-action listener: _resource_record_post_action 08:00:18 INFO - Running post-action listener: set_extra_try_arguments 08:00:18 INFO - [mozharness: 2016-12-21 16:00:18.678008Z] Finished download-and-extract step (success) 08:00:18 INFO - [mozharness: 2016-12-21 16:00:18.678234Z] Running populate-webroot step. 08:00:18 INFO - Running pre-action listener: _resource_record_pre_action 08:00:18 INFO - Running main action method: populate_webroot 08:00:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:00:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:00:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:00:18 INFO - '--tppagecycles', 08:00:18 INFO - '7'], 08:00:18 INFO - 'tests': ['tsvgm']}}, 08:00:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:00:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:00:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:00:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:00:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:00:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:00:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:18 INFO - 'talos_options': ['--disable-e10s'], 08:00:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:00:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:00:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:18 INFO - 'talos_options': ['--disable-e10s'], 08:00:18 INFO - 'tests': ['damp', 'tps']}, 08:00:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:18 INFO - 'tests': ['damp', 'tps']}, 08:00:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:00:18 INFO - 'tests': ['dromaeo_dom']}, 08:00:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:00:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:00:18 INFO - 'tests': ['basic_compositor_video']}, 08:00:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:00:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:00:18 INFO - 'tests': ['a11yr', 08:00:18 INFO - 'ts_paint', 08:00:18 INFO - 'tpaint', 08:00:18 INFO - 'sessionrestore', 08:00:18 INFO - 'sessionrestore_no_auto_restore', 08:00:18 INFO - 'tabpaint']}, 08:00:18 INFO - 'other-e10s': {'tests': ['a11yr', 08:00:18 INFO - 'ts_paint', 08:00:18 INFO - 'tpaint', 08:00:18 INFO - 'sessionrestore', 08:00:18 INFO - 'sessionrestore_no_auto_restore', 08:00:18 INFO - 'tabpaint']}, 08:00:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:00:18 INFO - 'ts_paint', 08:00:18 INFO - 'tpaint', 08:00:18 INFO - 'sessionrestore', 08:00:18 INFO - 'sessionrestore_no_auto_restore', 08:00:18 INFO - 'tabpaint']}, 08:00:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:00:18 INFO - 'ts_paint', 08:00:18 INFO - 'tpaint', 08:00:18 INFO - 'sessionrestore', 08:00:18 INFO - 'sessionrestore_no_auto_restore', 08:00:18 INFO - 'tabpaint']}, 08:00:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:00:18 INFO - 'tests': ['a11yr', 08:00:18 INFO - 'ts_paint', 08:00:18 INFO - 'tpaint', 08:00:18 INFO - 'sessionrestore', 08:00:18 INFO - 'sessionrestore_no_auto_restore', 08:00:18 INFO - 'tabpaint']}, 08:00:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:00:18 INFO - 'tests': ['a11yr', 08:00:18 INFO - 'ts_paint', 08:00:18 INFO - 'tpaint', 08:00:18 INFO - 'sessionrestore', 08:00:18 INFO - 'sessionrestore_no_auto_restore', 08:00:18 INFO - 'tabpaint']}, 08:00:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:00:18 INFO - 'tests': ['tsvgx', 08:00:18 INFO - 'tsvgr_opacity', 08:00:18 INFO - 'tart', 08:00:18 INFO - 'tscrollx', 08:00:18 INFO - 'cart']}, 08:00:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:00:18 INFO - 'tsvgr_opacity', 08:00:18 INFO - 'tart', 08:00:18 INFO - 'tscrollx', 08:00:18 INFO - 'cart']}, 08:00:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:18 INFO - 'talos_options': ['--disable-e10s'], 08:00:18 INFO - 'tests': ['tp5o']}, 08:00:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:18 INFO - 'tests': ['tp5o']}, 08:00:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:18 INFO - 'talos_options': ['--disable-e10s', 08:00:18 INFO - '--xperf_path', 08:00:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:00:18 INFO - 'tests': ['tp5n']}, 08:00:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:18 INFO - 'talos_options': ['--xperf_path', 08:00:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:00:18 INFO - 'tests': ['tp5n']}}, 08:00:18 INFO - 'talos.zip': {'path': '', 08:00:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:00:18 INFO - Running post-action listener: _resource_record_post_action 08:00:18 INFO - [mozharness: 2016-12-21 16:00:18.695721Z] Finished populate-webroot step (success) 08:00:18 INFO - [mozharness: 2016-12-21 16:00:18.695809Z] Running create-virtualenv step. 08:00:18 INFO - Running pre-action listener: _resource_record_pre_action 08:00:18 INFO - Running main action method: create_virtualenv 08:00:18 INFO - Creating virtualenv /builds/slave/test/build/venv 08:00:18 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:00:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:00:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:00:18 INFO - Using real prefix '/usr' 08:00:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:00:19 INFO - Installing distribute.............................................................................................................................................................................................done. 08:00:21 INFO - Installing pip.................done. 08:00:21 INFO - Return code: 0 08:00:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:00:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:00:21 INFO - Reading from file tmpfile_stdout 08:00:21 INFO - Output received: 08:00: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:00:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:00: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:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00: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:00:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00: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 0x7f1c9803cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27baf60>, '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 0x27bbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bc1d0>, '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': 'df17445c3590ff7897617a0e00000225-1482333807.805368-1727432444', '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:00: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:00: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:00:21 INFO - Using env: {'DISPLAY': ':0', 08:00:21 INFO - 'HOME': '/home/cltbld', 08:00:21 INFO - 'LANG': 'en_US.UTF-8', 08:00:21 INFO - 'LANGUAGE': 'en_US:en', 08:00:21 INFO - 'LOGNAME': 'cltbld', 08:00:21 INFO - 'MAIL': '/var/mail/cltbld', 08:00:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:21 INFO - 'MOZ_NO_REMOTE': '1', 08:00:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:21 INFO - 'NO_EM_RESTART': '1', 08:00:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:21 INFO - 'PWD': '/builds/slave/test', 08:00:21 INFO - 'SHELL': '/bin/bash', 08:00:21 INFO - 'SHLVL': '1', 08:00:21 INFO - 'TERM': 'linux', 08:00:21 INFO - 'TMOUT': '86400', 08:00:21 INFO - 'USER': 'cltbld', 08:00:21 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1482333807.805368-1727432444', 08:00:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:21 INFO - '_': '/tools/buildbot/bin/python'} 08:00:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:21 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:00:21 INFO - Cleaning up... 08:00:21 INFO - Return code: 0 08:00:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:00: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:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00: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:00:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00: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', '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 0x7f1c9803cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27baf60>, '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 0x27bbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bc1d0>, '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': 'df17445c3590ff7897617a0e00000225-1482333807.805368-1727432444', '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:00: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', 'psutil>=3.1.1'] in /builds/slave/test/build 08:00: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 psutil>=3.1.1 08:00:21 INFO - Using env: {'DISPLAY': ':0', 08:00:21 INFO - 'HOME': '/home/cltbld', 08:00:21 INFO - 'LANG': 'en_US.UTF-8', 08:00:21 INFO - 'LANGUAGE': 'en_US:en', 08:00:21 INFO - 'LOGNAME': 'cltbld', 08:00:21 INFO - 'MAIL': '/var/mail/cltbld', 08:00:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:21 INFO - 'MOZ_NO_REMOTE': '1', 08:00:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:21 INFO - 'NO_EM_RESTART': '1', 08:00:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:21 INFO - 'PWD': '/builds/slave/test', 08:00:21 INFO - 'SHELL': '/bin/bash', 08:00:21 INFO - 'SHLVL': '1', 08:00:21 INFO - 'TERM': 'linux', 08:00:21 INFO - 'TMOUT': '86400', 08:00:21 INFO - 'USER': 'cltbld', 08:00:21 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1482333807.805368-1727432444', 08:00:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:21 INFO - '_': '/tools/buildbot/bin/python'} 08:00:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:21 INFO - Downloading/unpacking psutil>=3.1.1 08:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:00:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:00:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:00:24 INFO - Installing collected packages: psutil 08:00:24 INFO - Running setup.py install for psutil 08:00:24 INFO - building 'psutil._psutil_linux' extension 08:00: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:00: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:00:24 INFO - building 'psutil._psutil_posix' extension 08:00: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:00: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:00:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:00:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:00:24 INFO - Successfully installed psutil 08:00:24 INFO - Cleaning up... 08:00:24 INFO - Return code: 0 08:00:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:00: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:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00: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:00:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00: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 0x7f1c9803cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27baf60>, '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 0x27bbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bc1d0>, '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': 'df17445c3590ff7897617a0e00000225-1482333807.805368-1727432444', '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:00: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:00: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:00:24 INFO - Using env: {'DISPLAY': ':0', 08:00:24 INFO - 'HOME': '/home/cltbld', 08:00:24 INFO - 'LANG': 'en_US.UTF-8', 08:00:24 INFO - 'LANGUAGE': 'en_US:en', 08:00:24 INFO - 'LOGNAME': 'cltbld', 08:00:24 INFO - 'MAIL': '/var/mail/cltbld', 08:00:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:24 INFO - 'MOZ_NO_REMOTE': '1', 08:00:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:24 INFO - 'NO_EM_RESTART': '1', 08:00:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:24 INFO - 'PWD': '/builds/slave/test', 08:00:24 INFO - 'SHELL': '/bin/bash', 08:00:24 INFO - 'SHLVL': '1', 08:00:24 INFO - 'TERM': 'linux', 08:00:24 INFO - 'TMOUT': '86400', 08:00:24 INFO - 'USER': 'cltbld', 08:00:24 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1482333807.805368-1727432444', 08:00:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:24 INFO - '_': '/tools/buildbot/bin/python'} 08:00:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:00:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:00:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:00:26 INFO - Installing collected packages: mozsystemmonitor 08:00:26 INFO - Running setup.py install for mozsystemmonitor 08:00:26 INFO - Successfully installed mozsystemmonitor 08:00:26 INFO - Cleaning up... 08:00:27 INFO - Return code: 0 08:00:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:00: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:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00: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:00:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00: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 0x7f1c9803cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27baf60>, '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 0x27bbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bc1d0>, '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': 'df17445c3590ff7897617a0e00000225-1482333807.805368-1727432444', '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:00: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:00: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:00:27 INFO - Using env: {'DISPLAY': ':0', 08:00:27 INFO - 'HOME': '/home/cltbld', 08:00:27 INFO - 'LANG': 'en_US.UTF-8', 08:00:27 INFO - 'LANGUAGE': 'en_US:en', 08:00:27 INFO - 'LOGNAME': 'cltbld', 08:00:27 INFO - 'MAIL': '/var/mail/cltbld', 08:00:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:27 INFO - 'MOZ_NO_REMOTE': '1', 08:00:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:27 INFO - 'NO_EM_RESTART': '1', 08:00:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:27 INFO - 'PWD': '/builds/slave/test', 08:00:27 INFO - 'SHELL': '/bin/bash', 08:00:27 INFO - 'SHLVL': '1', 08:00:27 INFO - 'TERM': 'linux', 08:00:27 INFO - 'TMOUT': '86400', 08:00:27 INFO - 'USER': 'cltbld', 08:00:27 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1482333807.805368-1727432444', 08:00:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:27 INFO - '_': '/tools/buildbot/bin/python'} 08:00:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:27 INFO - Downloading/unpacking jsonschema==2.5.1 08:00: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:00: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:00: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:00: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:00: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:00: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:00:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:00:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:00: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:00: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:00: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:00: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:00: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:00: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:00:29 INFO - Downloading functools32-3.2.3-2.tar.gz 08:00:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:00:29 INFO - warning: no files found matching '*.txt' 08:00:29 INFO - no previously-included directories found matching 'build' 08:00:29 INFO - no previously-included directories found matching 'dist' 08:00:29 INFO - no previously-included directories found matching '.git*' 08:00:29 INFO - Installing collected packages: jsonschema, functools32 08:00:29 INFO - Running setup.py install for functools32 08:00:29 INFO - warning: no files found matching '*.txt' 08:00:29 INFO - no previously-included directories found matching 'build' 08:00:29 INFO - no previously-included directories found matching 'dist' 08:00:29 INFO - no previously-included directories found matching '.git*' 08:00:29 INFO - Successfully installed jsonschema functools32 08:00:29 INFO - Cleaning up... 08:00:29 INFO - Return code: 0 08:00:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:00:29 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:00:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:29 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:00:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:29 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 0x7f1c9803cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27baf60>, '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 0x27bbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bc1d0>, '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': 'df17445c3590ff7897617a0e00000225-1482333807.805368-1727432444', '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:00:29 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:00:29 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:00:29 INFO - Using env: {'DISPLAY': ':0', 08:00:29 INFO - 'HOME': '/home/cltbld', 08:00:29 INFO - 'LANG': 'en_US.UTF-8', 08:00:29 INFO - 'LANGUAGE': 'en_US:en', 08:00:29 INFO - 'LOGNAME': 'cltbld', 08:00:29 INFO - 'MAIL': '/var/mail/cltbld', 08:00:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:29 INFO - 'MOZ_NO_REMOTE': '1', 08:00:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:29 INFO - 'NO_EM_RESTART': '1', 08:00:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:29 INFO - 'PWD': '/builds/slave/test', 08:00:29 INFO - 'SHELL': '/bin/bash', 08:00:29 INFO - 'SHLVL': '1', 08:00:29 INFO - 'TERM': 'linux', 08:00:29 INFO - 'TMOUT': '86400', 08:00:29 INFO - 'USER': 'cltbld', 08:00:29 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1482333807.805368-1727432444', 08:00:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:29 INFO - '_': '/tools/buildbot/bin/python'} 08:00:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:00:29 INFO - Cleaning up... 08:00:29 INFO - Return code: 0 08:00:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:00:29 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:00:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:29 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:00:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:29 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 0x7f1c9803cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27baf60>, '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 0x27bbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bc1d0>, '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': 'df17445c3590ff7897617a0e00000225-1482333807.805368-1727432444', '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:00:29 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:00:29 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:00:29 INFO - Using env: {'DISPLAY': ':0', 08:00:29 INFO - 'HOME': '/home/cltbld', 08:00:29 INFO - 'LANG': 'en_US.UTF-8', 08:00:29 INFO - 'LANGUAGE': 'en_US:en', 08:00:29 INFO - 'LOGNAME': 'cltbld', 08:00:29 INFO - 'MAIL': '/var/mail/cltbld', 08:00:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:29 INFO - 'MOZ_NO_REMOTE': '1', 08:00:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:29 INFO - 'NO_EM_RESTART': '1', 08:00:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:29 INFO - 'PWD': '/builds/slave/test', 08:00:29 INFO - 'SHELL': '/bin/bash', 08:00:29 INFO - 'SHLVL': '1', 08:00:29 INFO - 'TERM': 'linux', 08:00:29 INFO - 'TMOUT': '86400', 08:00:29 INFO - 'USER': 'cltbld', 08:00:29 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1482333807.805368-1727432444', 08:00:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:29 INFO - '_': '/tools/buildbot/bin/python'} 08:00:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:30 INFO - Downloading/unpacking blobuploader==1.2.4 08:00: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:00: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:00: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:00: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:00: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:00: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:00:32 INFO - Downloading blobuploader-1.2.4.tar.gz 08:00:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:00:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:00: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:00: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:00: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:00: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:00: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:00: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:00:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:00:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:00: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:00: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:00: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:00: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:00: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:00: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:00:33 INFO - Downloading docopt-0.6.1.tar.gz 08:00:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:00:33 INFO - Installing collected packages: blobuploader, requests, docopt 08:00:33 INFO - Running setup.py install for blobuploader 08:00:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:00:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:00:33 INFO - Running setup.py install for requests 08:00:33 INFO - Running setup.py install for docopt 08:00:33 INFO - Successfully installed blobuploader requests docopt 08:00:33 INFO - Cleaning up... 08:00:33 INFO - Return code: 0 08:00:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:00: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:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00: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:00:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00: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 0x7f1c9803cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27baf60>, '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 0x27bbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bc1d0>, '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': 'df17445c3590ff7897617a0e00000225-1482333807.805368-1727432444', '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:00: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:00: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:00:33 INFO - Using env: {'DISPLAY': ':0', 08:00:33 INFO - 'HOME': '/home/cltbld', 08:00:33 INFO - 'LANG': 'en_US.UTF-8', 08:00:33 INFO - 'LANGUAGE': 'en_US:en', 08:00:33 INFO - 'LOGNAME': 'cltbld', 08:00:33 INFO - 'MAIL': '/var/mail/cltbld', 08:00:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:33 INFO - 'MOZ_NO_REMOTE': '1', 08:00:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:33 INFO - 'NO_EM_RESTART': '1', 08:00:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:33 INFO - 'PWD': '/builds/slave/test', 08:00:33 INFO - 'SHELL': '/bin/bash', 08:00:33 INFO - 'SHLVL': '1', 08:00:33 INFO - 'TERM': 'linux', 08:00:33 INFO - 'TMOUT': '86400', 08:00:33 INFO - 'USER': 'cltbld', 08:00:33 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1482333807.805368-1727432444', 08:00:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:33 INFO - '_': '/tools/buildbot/bin/python'} 08:00:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:00:34 INFO - Running setup.py (path:/tmp/pip-dI8H2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:00:34 INFO - Running setup.py (path:/tmp/pip-4gBcQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:00:34 INFO - Running setup.py (path:/tmp/pip-k6o1P5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:00:34 INFO - Running setup.py (path:/tmp/pip-Wv1OKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:00:34 INFO - Running setup.py (path:/tmp/pip-Kvmw_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:00:34 INFO - Running setup.py (path:/tmp/pip-s70GA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:00:34 INFO - Running setup.py (path:/tmp/pip-yHoqCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:00:34 INFO - Running setup.py (path:/tmp/pip-yKiVJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:00:34 INFO - Running setup.py (path:/tmp/pip-bw8nzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:00:34 INFO - Running setup.py (path:/tmp/pip-_5YfrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:00:34 INFO - Running setup.py (path:/tmp/pip-uKjeDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:00:34 INFO - Running setup.py (path:/tmp/pip-4JR7z0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:00:34 INFO - Running setup.py (path:/tmp/pip-egiTQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:00:34 INFO - Running setup.py (path:/tmp/pip-Fy6E0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:00:35 INFO - Running setup.py (path:/tmp/pip-oY73WH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:00:35 INFO - Running setup.py (path:/tmp/pip-uQ9qYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:00:35 INFO - Running setup.py (path:/tmp/pip-adBnZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:00:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:00:35 INFO - Running setup.py install for manifestparser 08:00:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:00:35 INFO - Running setup.py install for mozcrash 08:00:35 INFO - Running setup.py install for mozdebug 08:00:35 INFO - Running setup.py install for mozdevice 08:00:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:00:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:00:35 INFO - Running setup.py install for mozfile 08:00:35 INFO - Running setup.py install for mozhttpd 08:00:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:00:35 INFO - Running setup.py install for mozinfo 08:00:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:00:35 INFO - Running setup.py install for mozInstall 08:00:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:00:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:00:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:00:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:00:36 INFO - Running setup.py install for mozleak 08:00:36 INFO - Running setup.py install for mozlog 08:00:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:00:36 INFO - Running setup.py install for moznetwork 08:00:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:00:36 INFO - Running setup.py install for mozprocess 08:00:36 INFO - Running setup.py install for mozprofile 08:00:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:00:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:00:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:00:36 INFO - Running setup.py install for mozrunner 08:00:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:00:36 INFO - Running setup.py install for mozscreenshot 08:00:36 INFO - Running setup.py install for moztest 08:00:36 INFO - Running setup.py install for mozversion 08:00:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:00:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:00:37 INFO - Cleaning up... 08:00:37 INFO - Return code: 0 08:00:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:00: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:00:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00: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:00:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00: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 0x7f1c9803cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27baf60>, '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 0x27bbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bc1d0>, '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': 'df17445c3590ff7897617a0e00000225-1482333807.805368-1727432444', '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:00: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:00: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:00:37 INFO - Using env: {'DISPLAY': ':0', 08:00:37 INFO - 'HOME': '/home/cltbld', 08:00:37 INFO - 'LANG': 'en_US.UTF-8', 08:00:37 INFO - 'LANGUAGE': 'en_US:en', 08:00:37 INFO - 'LOGNAME': 'cltbld', 08:00:37 INFO - 'MAIL': '/var/mail/cltbld', 08:00:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:37 INFO - 'MOZ_NO_REMOTE': '1', 08:00:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:37 INFO - 'NO_EM_RESTART': '1', 08:00:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:37 INFO - 'PWD': '/builds/slave/test', 08:00:37 INFO - 'SHELL': '/bin/bash', 08:00:37 INFO - 'SHLVL': '1', 08:00:37 INFO - 'TERM': 'linux', 08:00:37 INFO - 'TMOUT': '86400', 08:00:37 INFO - 'USER': 'cltbld', 08:00:37 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1482333807.805368-1727432444', 08:00:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:37 INFO - '_': '/tools/buildbot/bin/python'} 08:00:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:00:37 INFO - Running setup.py (path:/tmp/pip-Bj8LNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:00: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:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:00:37 INFO - Running setup.py (path:/tmp/pip-hTsR7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:00: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:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:00:37 INFO - Running setup.py (path:/tmp/pip-bKqK8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:00: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:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:00:37 INFO - Running setup.py (path:/tmp/pip-6q1T6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:00: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:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:00:37 INFO - Running setup.py (path:/tmp/pip-VnA5Bf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:00: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:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:00:37 INFO - Running setup.py (path:/tmp/pip-zmu2GW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:00: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:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:00:37 INFO - Running setup.py (path:/tmp/pip-5X4hNg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:00: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:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:00:37 INFO - Running setup.py (path:/tmp/pip-6mYzeG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:00: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:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:00:37 INFO - Running setup.py (path:/tmp/pip-5q0QXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:00:37 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:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:00:37 INFO - Running setup.py (path:/tmp/pip-YDjcV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:00: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:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:00:38 INFO - Running setup.py (path:/tmp/pip-s5d5kk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:00: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:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:00:38 INFO - Running setup.py (path:/tmp/pip-xqDCzK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:00: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:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:00:38 INFO - Running setup.py (path:/tmp/pip-nytj8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:00: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:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:00:38 INFO - Running setup.py (path:/tmp/pip-ZB2Pct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:00: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:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:00:38 INFO - Running setup.py (path:/tmp/pip-G1Ixtk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:00: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:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:00:38 INFO - Running setup.py (path:/tmp/pip-k4hO9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:00: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:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:00:38 INFO - Running setup.py (path:/tmp/pip-yR2Ui2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:00: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:00: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:00: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:00: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:00: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:00: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:00:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:00: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:00: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:00: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:00: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:00: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:00: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:00:40 INFO - Downloading blessings-1.6.tar.gz 08:00:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:00:40 INFO - Installing collected packages: blessings 08:00:40 INFO - Running setup.py install for blessings 08:00:40 INFO - Successfully installed blessings 08:00:40 INFO - Cleaning up... 08:00:40 INFO - Return code: 0 08:00:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:00:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:00:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:00:41 INFO - Reading from file tmpfile_stdout 08:00:41 INFO - Current package versions: 08:00:41 INFO - argparse == 1.2.1 08:00:41 INFO - blessings == 1.6 08:00:41 INFO - blobuploader == 1.2.4 08:00:41 INFO - docopt == 0.6.1 08:00:41 INFO - functools32 == 3.2.3-2 08:00:41 INFO - jsonschema == 2.5.1 08:00:41 INFO - manifestparser == 1.1 08:00:41 INFO - mozInstall == 1.12 08:00:41 INFO - mozcrash == 1.0 08:00:41 INFO - mozdebug == 0.1 08:00:41 INFO - mozdevice == 0.48 08:00:41 INFO - mozfile == 1.2 08:00:41 INFO - mozhttpd == 0.7 08:00:41 INFO - mozinfo == 0.9 08:00:41 INFO - mozleak == 0.1 08:00:41 INFO - mozlog == 3.4 08:00:41 INFO - moznetwork == 0.27 08:00:41 INFO - mozprocess == 0.23 08:00:41 INFO - mozprofile == 0.28 08:00:41 INFO - mozrunner == 6.13 08:00:41 INFO - mozscreenshot == 0.1 08:00:41 INFO - mozsystemmonitor == 0.3 08:00:41 INFO - moztest == 0.7 08:00:41 INFO - mozversion == 1.4 08:00:41 INFO - psutil == 3.1.1 08:00:41 INFO - requests == 1.2.3 08:00:41 INFO - wsgiref == 0.1.2 08:00:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:00: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:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00: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:00:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00: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 0x7f1c9803cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27baf60>, '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 0x27bbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bc1d0>, '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': 'df17445c3590ff7897617a0e00000225-1482333807.805368-1727432444', '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:00: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:00: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:00:41 INFO - Using env: {'DISPLAY': ':0', 08:00:41 INFO - 'HOME': '/home/cltbld', 08:00:41 INFO - 'LANG': 'en_US.UTF-8', 08:00:41 INFO - 'LANGUAGE': 'en_US:en', 08:00:41 INFO - 'LOGNAME': 'cltbld', 08:00:41 INFO - 'MAIL': '/var/mail/cltbld', 08:00:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:41 INFO - 'MOZ_NO_REMOTE': '1', 08:00:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:41 INFO - 'NO_EM_RESTART': '1', 08:00:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:41 INFO - 'PWD': '/builds/slave/test', 08:00:41 INFO - 'SHELL': '/bin/bash', 08:00:41 INFO - 'SHLVL': '1', 08:00:41 INFO - 'TERM': 'linux', 08:00:41 INFO - 'TMOUT': '86400', 08:00:41 INFO - 'USER': 'cltbld', 08:00:41 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1482333807.805368-1727432444', 08:00:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:41 INFO - '_': '/tools/buildbot/bin/python'} 08:00:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00: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:00: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:00: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:00: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:00: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:00: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:00: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:00: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:00: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:00: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:00: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:00:41 INFO - Cleaning up... 08:00:41 INFO - Return code: 0 08:00:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:00: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:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00: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:00:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00: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 0x7f1c9803cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27baf60>, '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 0x27bbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bc1d0>, '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': 'df17445c3590ff7897617a0e00000225-1482333807.805368-1727432444', '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:00: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:00: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:00:41 INFO - Using env: {'DISPLAY': ':0', 08:00:41 INFO - 'HOME': '/home/cltbld', 08:00:41 INFO - 'LANG': 'en_US.UTF-8', 08:00:41 INFO - 'LANGUAGE': 'en_US:en', 08:00:41 INFO - 'LOGNAME': 'cltbld', 08:00:41 INFO - 'MAIL': '/var/mail/cltbld', 08:00:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:41 INFO - 'MOZ_NO_REMOTE': '1', 08:00:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:41 INFO - 'NO_EM_RESTART': '1', 08:00:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:41 INFO - 'PWD': '/builds/slave/test', 08:00:41 INFO - 'SHELL': '/bin/bash', 08:00:41 INFO - 'SHLVL': '1', 08:00:41 INFO - 'TERM': 'linux', 08:00:41 INFO - 'TMOUT': '86400', 08:00:41 INFO - 'USER': 'cltbld', 08:00:41 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1482333807.805368-1727432444', 08:00:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:41 INFO - '_': '/tools/buildbot/bin/python'} 08:00:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:00:41 INFO - Cleaning up... 08:00:41 INFO - Return code: 0 08:00:41 INFO - Running post-action listener: _resource_record_post_action 08:00:41 INFO - Running post-action listener: _start_resource_monitoring 08:00:41 INFO - Starting resource monitoring. 08:00:41 INFO - [mozharness: 2016-12-21 16:00:41.514176Z] Finished create-virtualenv step (success) 08:00:41 INFO - [mozharness: 2016-12-21 16:00:41.514638Z] Running install step. 08:00:41 INFO - Running pre-action listener: _resource_record_pre_action 08:00:41 INFO - Running main action method: install 08:00:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:00:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:00:41 INFO - Reading from file tmpfile_stdout 08:00:41 INFO - Detecting whether we're running mozinstall >=1.0... 08:00:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:00:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:00:41 INFO - Reading from file tmpfile_stdout 08:00:41 INFO - Output received: 08:00:41 INFO - Usage: mozinstall [options] installer 08:00:41 INFO - Options: 08:00:41 INFO - -h, --help show this help message and exit 08:00:41 INFO - -d DEST, --destination=DEST 08:00:41 INFO - Directory to install application into. [default: 08:00:41 INFO - "/builds/slave/test"] 08:00:41 INFO - --app=APP Application being installed. [default: firefox] 08:00:41 INFO - mkdir: /builds/slave/test/build/application 08:00: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:00: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:00:58 INFO - Reading from file tmpfile_stdout 08:00:58 INFO - Output received: 08:00:58 INFO - /builds/slave/test/build/application/firefox/firefox 08:00:58 INFO - Running post-action listener: _resource_record_post_action 08:00:58 INFO - [mozharness: 2016-12-21 16:00:58.804962Z] Finished install step (success) 08:00:58 INFO - [mozharness: 2016-12-21 16:00:58.805211Z] Running run-tests step. 08:00:58 INFO - Running pre-action listener: _resource_record_pre_action 08:00:58 INFO - Running main action method: run_tests 08:00:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:00:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:00:58 INFO - Python 2.7.3 08:00:58 INFO - Return code: 0 08:00:58 INFO - grabbing minidump binary from tooltool 08:00:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:00:58 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27baf60>, '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 0x27bbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bc1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:00:58 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:00:58 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:00:58 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:00:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:00:58 INFO - Return code: 0 08:00:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:00:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:00:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:00:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:00:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:00:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HDPsacxMS8WzKuWNhkoGrg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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:00:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HDPsacxMS8WzKuWNhkoGrg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --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:00:58 INFO - Using env: {'DISPLAY': ':0', 08:00:58 INFO - 'HOME': '/home/cltbld', 08:00:58 INFO - 'LANG': 'en_US.UTF-8', 08:00:58 INFO - 'LANGUAGE': 'en_US:en', 08:00:58 INFO - 'LOGNAME': 'cltbld', 08:00:58 INFO - 'MAIL': '/var/mail/cltbld', 08:00:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:00:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:00:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:58 INFO - 'MOZ_NO_REMOTE': '1', 08:00:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:00:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:58 INFO - 'NO_EM_RESTART': '1', 08:00:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:58 INFO - 'PWD': '/builds/slave/test', 08:00:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:00:58 INFO - 'SHELL': '/bin/bash', 08:00:58 INFO - 'SHLVL': '1', 08:00:58 INFO - 'TERM': 'linux', 08:00:58 INFO - 'TMOUT': '86400', 08:00:58 INFO - 'USER': 'cltbld', 08:00:58 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1482333807.805368-1727432444', 08:00:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:58 INFO - '_': '/tools/buildbot/bin/python'} 08:00:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HDPsacxMS8WzKuWNhkoGrg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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:00:59 INFO - mozversion application_buildid: 20161221062253 08:00:59 INFO - mozversion application_changeset: 6c1dd7d65949799726e1ab823d66070927f622e8 08:00:59 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:00:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:00:59 INFO - mozversion application_name: Firefox 08:00:59 INFO - mozversion application_remotingname: firefox-dev 08:00:59 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:00:59 INFO - mozversion application_vendor: Mozilla 08:00:59 INFO - mozversion application_version: 52.0a2 08:00:59 INFO - mozversion platform_buildid: 20161221062253 08:00:59 INFO - mozversion platform_changeset: 6c1dd7d65949799726e1ab823d66070927f622e8 08:00:59 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:00:59 INFO - mozversion platform_version: 52.0a2 08:00:59 INFO - using testdate: 1482336059 08:00:59 INFO - actual date: 1482336059 08:00:59 INFO - starting webserver on 'localhost:36095' 08:00:59 INFO - SUITE-START | Running 2 tests 08:00:59 INFO - TEST-START | dromaeo_css 08:00:59 INFO - operating with platform_type : linux_ 08:00:59 INFO - Initialising browser for dromaeo_css test... 08:00:59 INFO - TEST-INFO | started process 30499 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplJrs5X/profile http://localhost:36095/getInfo.html) 08:01:04 INFO - PROCESS | 30499 | __metrics Screen width/height:1600/1200 08:01:04 INFO - PROCESS | 30499 | colorDepth:24 08:01:04 INFO - PROCESS | 30499 | Browser inner width/height: 1024/697 08:01:04 INFO - PROCESS | 30499 | __metrics 08:01:04 INFO - PROCESS | 30499 | 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:01:04 INFO - PROCESS | 30499 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:01:05 INFO - PROCESS | 30499 | console.error: PushService: 08:01:05 INFO - PROCESS | 30499 | stateChangeProcessEnqueue: Error transitioning state 08:01:05 INFO - PROCESS | 30499 | UnknownError 08:01:06 INFO - TEST-INFO | 30499: exit 0 08:01:06 INFO - Browser initialized. 08:01:06 INFO - Running cycle 1/1 for dromaeo_css test... 08:01:06 INFO - TEST-INFO | started process 30593 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplJrs5X/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:01:17 INFO - PROCESS | 30593 | RSS: Main: 148140032 08:01:17 INFO - PROCESS | 30593 | 08:02:09 INFO - PROCESS | 30593 | 1482336129121 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:04:20 INFO - PROCESS | 30593 | Cycle 1(1): loaded http://localhost:36095/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36095/tests/dromaeo/cssquery-ext.html) 08:04:21 INFO - PROCESS | 30593 | RSS: Main: 246513664 08:04:21 INFO - PROCESS | 30593 | 08:07:23 INFO - PROCESS | 30593 | Cycle 1(1): loaded http://localhost:36095/tests/dromaeo/cssquery-ext.html (next: http://localhost:36095/tests/dromaeo/cssquery-jquery.html) 08:07:24 INFO - PROCESS | 30593 | RSS: Main: 237076480 08:07:24 INFO - PROCESS | 30593 | 08:10:26 INFO - PROCESS | 30593 | Cycle 1(1): loaded http://localhost:36095/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36095/tests/dromaeo/cssquery-mootools.html) 08:10:26 INFO - PROCESS | 30593 | RSS: Main: 173395968 08:10:26 INFO - PROCESS | 30593 | 08:13:28 INFO - PROCESS | 30593 | Cycle 1(1): loaded http://localhost:36095/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36095/tests/dromaeo/cssquery-prototype.html) 08:13:29 INFO - PROCESS | 30593 | RSS: Main: 214933504 08:13:29 INFO - PROCESS | 30593 | 08:16:31 INFO - PROCESS | 30593 | Cycle 1(1): loaded http://localhost:36095/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36095/tests/dromaeo/cssquery-yui.html) 08:16:32 INFO - PROCESS | 30593 | RSS: Main: 179625984 08:16:32 INFO - PROCESS | 30593 | 08:19:34 INFO - PROCESS | 30593 | Cycle 1(1): loaded http://localhost:36095/tests/dromaeo/cssquery-yui.html (next: http://localhost:36095/tests/dromaeo/cssquery-dojo.html) 08:19:34 INFO - PROCESS | 30593 | RSS: Main: 262168576 08:19:34 INFO - PROCESS | 30593 | 08:19:34 INFO - PROCESS | 30593 | __start_tp_report 08:19:34 INFO - PROCESS | 30593 | _x_x_mozilla_page_load 08:19:34 INFO - PROCESS | 30593 | _x_x_mozilla_page_load_details 08:19:34 INFO - PROCESS | 30593 | |i|pagename|runs| 08:19:34 INFO - PROCESS | 30593 | |0;dojo.html;3211.710946014859;3247.3342964692242;3253.333066721321;3273.3616944695796;3291.094948889055;5482.45175482452;5536.861578460541;5594.524465420444;5596.860078498034;5601.383847776741;5595.21666966625;5614.242077319561;5615.185798059279;5642.689652069134;5660.9433905660935;5076.79692812288;5096.974515127437;5132.101882170624;5155.7422128893595;5159.871003224931;5045.293658887758;5048.570871475929;5059.620528460362;5137.255098010786;5187.818426355078;5128.769205385748;5196.896062078757;5198.50614191653;5221.112410890139;5227.18978558324;5218.660787048849;5228.633995620308;5229.581633469352;5230.8692282692855;5260.763265653055;4980.078685443204;4983.576396006344;5113;5141.074606570815;5209.973950130225;5439.211314359435;5472.288602481652;5478.397376288605;5532.28080349556;5544.528715059225;5904.645721256738;5915.497182739472;5952.375000624958;5999.850003749898;6004.3395226525045;5811.070228763419;6010.338862725097;6026.487748541379;6039.214902062748;6040.335563088057;5483.917741233885;5521.309836270466;5564.081926482085;5567.860803479945;5591.07747221712;6112.633242005494;6119.969400152971;6122.571420000646;6124.203853499017;6128.080787881764;5747.109198074305;5857.765689372377;5875.706214689249;5881.147233651182;5889.823305300848;5861.20873682056;5925.318588362307;5982.46157845796;5987.161797348374;6068.908966365508;5956.76172953077;5998.880022399615;6011.098335249748;6011.398860114041;6052.576319657582;5967.5524335675;5978.730957106941;5986.910196347058;5997.220361352996;6004.189434426296;4492.955070449254;4512.075024619945;4542.068875880436;4579.129965306581;4580.404547408815;4083.3670781028986;4096.32410652245;4099.3031184698675;4129.112240868168;4136.152088821785;5621.437856214346;5622.240997465372;5623.831285061455;5631;5664.461876121762;5829.912551311733;5883.588148829541;5963.403659634002;5966.701664916737;5998.190244316961;5708.143778433268;5711.286089238845;5719.57103217252;5735.913961290584;5743.253377061039;5204.0372531081875;5216.869578260574;5218.399884013311;5219.19102539107;5260.184671375866;6004.399560044048;6059.727312271047;6061.060535616986;6167.784127555514;6221.626702397871;5939.524838013035;6045.244344456943;6049.0926361046195;6051.909221361595;6090.725917333642;6115.969420152871;6117.877642447215;6122.2959359674205;6125.05061715417;6179.412955769195;5707.286589176353;5745.511631511368;5909.852253693692;5923.851903702442;5928.584999050197;6047.395260473917;6083.6045657032155;6087.482563981934;6112.78605248832;6132.38676132401;5873;5909.734061967308;5918.644881307136;5926.496247818984;5931.495822855106;5552.7223638818705;5869.236999190078;5870.324912635102;5875.118732190205;5887.411258874078;5723.627964182481;5743.770249189985;5776.335721392094;5781.306243250837;5824.5340372770925;5838.503727183237;5905.527557795452;5915.438033386821;5915.674637894957;5917.792877249276;5575.219469274224;5620.606557541097;5634.492895639412;5774.624649397776;5782.392848750821 08:19:34 INFO - PROCESS | 30593 | |1;ext.html;588.2793577867113;626.7900253415106;652.2824892618119;662.4071456046838;670.986580268395;33961.49057764132;43795.34306985394;44278.55721442785;44458.77770611146;44590.77704611472;44809.32786008212;45288.773556132255;45328.0934381313;45340.09319813602;45349.31976020354;8241.711540096097;8756.168164024424;8883.156100170505;8890.022097569294;8896.911030889672;8238.50568965864;10641.308314959502;10890.564377424893;10891.400972946485;10920.50857711401;10725.517351719152;10786.352818830856;10798.082163016154;10801.243912926098;10801.621943231989;10628.096611788007;10671.19966002553;10683.83974240387;10688.946555267174;10693.46532673367;10501;10554.472276386226;10560.577576896914;10580.735481612945;10580.841287380696;43179.78410107961;43522.347164792554;43596.78201609004;43724.56275437237;43729.781351093356;3441.7246620270316;3557.0929412999776;3695.648913353254;3789.5642001169945;4155.896102597429;31745.682543174502;31861.84069079663;32023;32407.83796081028;32604.673953260637;4328.653707703376;4413.889652758675;4440.333949907507;4452.465704115527;4535.727856328631;333982;336815;337548;337669;338987;37875.43186852199;60501;60922.69538652367;60973.69513152406;60982.69508652517;38257.6174238254;40332;40495.392569111485;40502.392464113065;40518;14208;14292.356843942047;14295.78556321656;14299.285035748171;14393;10545.683629491128;10591.046805787517;10965.342079475256;11539.076873850072;11549.36478493691;9258.21305189053;9428.057194280655;9436.292278079172;9487.952560237292;9507.762305942406;3549.4853246279145;3549.6272891346553;3559.555055618048;3590.335787879251;3686.5391826021746;1025.4257615735212;1044.3107549017764;1083.853679753239;1130.3669944830756;1132.5469812075237;33102.668973309956;33222.66777332244;33359.33281334408;33586.496202556984;33633.32733345319;1071.1216802222102;1097.3415950429678;1097.846301517788;1138.7893239750506;1160.1994623709613;16790.74813877793;17792.199351029234;17822.10889455548;17863.73204401935;17896.194671239824;542832;549315;550493;550554;550999;60866.69566652227;61266;61437;61555.38444615586;61602.38397615967;1278.1755767529892;1289.5615490733196;1303.2376060005004;1392.958211253664;1442.5167568864338;31490.842545787124;36062.09844753902;36271.27457450889;36458.63541364553;36492.81753591215;57226;58080;58109.4189058104;58179.41820581909;58224.70887645704;446910;451244;451266;451391.7152071093;452362;27008.45983080288;27039.86480067587;27671.861640691666;29962.400751985275;30417.23956901095;43273;44726.55273447354;47868.76065619649;52023.73988130035;52948.735256323474;41340.37989430221;41655.37516937188;42439.3634095495;43313;43941;42137.1572568553;42341.36487952621;42885.57114428816;43564.34653480264;43948.340774887765;42694;42844.571554284055;42918.78540607402;43325.78337108294;43451.78274108609;36137.63862361448;37462.250754984205;37474.8126259367;38145.618543814206;38245.617543824206;28873.711262887104;29146.27134321659;29227.048331873524;29284.560731588615;29504 08:19:34 INFO - PROCESS | 30593 | |2;jquery.html;402.88517772434864;417.22604568525384;419.2620987062769;430.4705212588516;430.4984692832848;16154;19472.70790938137;19490.90254548727;19497.41507754766;19676.409707708775;18993.240270389168;19227.711584326247;19435.514112147204;19779.30772422962;19881.90059049703;4944.975275123637;5521.4478552144865;5734.340550836645;6457.580257283285;6505.284418713938;6490.123833282493;6502.577332473397;6566.179227596551;6569.244536878273;6575.5068369872215;6368.29948705642;6508.219013718361;6512;6515.250746164181;6535.183102112236;6317.905231421532;6357.116871078508;6413.871722565523;6505.284418713938;6540.672966351687;5608.383077861432;5648.068068768648;5650.9152362714185;5651.519620832234;5658.094704847204;19910;23340.76659233403;23527;23530.058797648075;23738.64392034121;2408.1330720940446;2473.727889932106;2510.297116807297;2616.358992046961;3069.3247485553143;14574.41702331916;14831;14879.628009299855;15181.316840742193;15471.381144754196;1914.74150989616;1977.7231187633743;2003.5592169722638;2019.9293024744063;2031.7561892572985;58580.70709646425;73264.63367683181;73394.26605733928;80736.59631701803;81794.59102704449;11148.888511114785;11161.944190278997;11417.714557135972;11504.194706370474;11667.941660291644;16161.757573636405;16190.352385904433;16203.594910127105;16234.51296461108;16235.59411014734;7889.9211007890335;8168.346532277404;8218.835623287501;8274.213949674891;8404.579771011426;7677.155512893577;7708.26771456722;7802.648880800378;7843.921560784319;7999.120096789348;6664.666766661648;7041.612711300825;7047.43620510358;7057.50597458173;7076.610786406797;1791.1435201175175;1839.9944060973603;2012.5169959209684;2043.570850121491;2081.188336548747;1015.8577799108131;1041.5420802934186;1050.7425680708122;1063.941483218415;1087.4499299143497;19930.402087937386;20224.89887550553;20300.79699202989;20356;20451.8977405115;1022.7238645565656;1040.573364920379;1056.630179437191;1057.984130238047;1073.4525392049954;10430.598799134785;11718.648440546796;11807.586734464252;11876.524939002344;11967.222130561486;486624;507642;508253;510860;515320;78717.60641196757;80174;81412.59293703493;82708.58645706733;83627.5818620903;1034.2863424237403;1038.1694644284694;1049.1554298789395;1066.7653116314555;1074.5701719312337;17294.82705172932;17575.912120439316;17961.910190448965;18021.369252076114;18102.818971810113;38490.422643660924;38740.22519549537;38964.610353896096;39237.41143882787;39991.60008399879;51425.7428712854;51900.480995189566;51968.48031519788;52919.20621190608;53155;6368.936310636835;8256.13310602402;8296.585170741319;8408.70569530088;8486.0241072275;12819.935900320812;13132.343382831012;13169.802452963404;13357.465701371837;13397.263150526815;8796.60415281301;11365.659030229106;11648.301101933912;11743.530258789553;11908.583199587973;11233.32600044;11691.240069395802;11862.584809531625;11995.520179193083;12193.939030304791;11354.489047993025;11494.425278736197;11767.470463828977;12057.698557536132;12305.077119215915;8010.439269251096;8997.145271199226;9001.7749556259;9022.894582964604;9161.816763664823;11183.105351571692;11318.09455243595;12009.699757505783;12045.217060891015;12281.263124212575 08:19:34 INFO - PROCESS | 30593 | |3;mootools.html;1499.7675360319151;1541.683954789268;1704.8380403861636;1789.2753434858887;1817.9818201817986;8225.383096267775;8777.473351598908;8779.385443018984;8781.736547903565;8783.341249406289;7662.272084151997;7852;8333.708320208778;8469.703560375388;8574.91425085749;2467.975320246797;2494.8128890333205;2497.325722055044;2502;2502.637117617944;2454.3005243505604;2541.8220724549287;2549.3116858448207;2549.6430499730054;2549.9745002550017;2447.070113356922;2449.3141920262356;2489.962650560234;2496.7378425265356;2502.2118032819694;2439.5486834935505;2446.3639453742067;2466.5683505386487;2467.5558399488173;2467.7655622715815;2465.4206261528525;2473.839200451983;2490.8879100440345;2492.2523243027017;2505.5615267328144;8588.484690918565;8675;8689.26141277992;8711.08533603975;8714.302855771522;5283.735813209324;5404.108322126884;5409.323834520685;5409.377921539034;5414.810481633124;3453.4992426098074;3699.1491956849804;3720.051386896324;3723.050622091376;3732.402815549499;1188.566173346731;1226.4113225651738;1243.9440225189799;1269.4351013798864;1318.202487495071;11289.661310160709;11947.462364193632;11948.163628546004;11975.22161059537;11996.640100796903;4732.621390288768;4769.974455492086;4893.657443978887;4905.509449055137;4916.508349165127;9421.340506164503;9512.429254244767;9527.428354298765;9532.618695252251;9533.761655958519;5457.781688732485;5470.234167216593;5480.068388373986;5492.533134683516;5499.395066542757;4312.331588603772;4435.911281774411;4533.977330113395;4914.533119353656;5009.148444764399;3933.272344616255;3957.8614748483665;4078.490188726409;4081.591840815954;4083.734557253769;1234.9938250308692;1262.9666237357847;1267.1320145700224;1267.8034904589804;1284.2551320234243;948.9288303377274;959.947202903847;965.280865755017;972.4554249620236;987.0474991632965;5810.360860305363;5811.738471768781;5835.67903765297;5928.170056192136;5969.432903874125;489.19527377464584;493.580456611877;506.44797171083695;515.1088616693141;518.6576859272861;3964.8612298569988;4027.4160246764054;4077.673786097105;4112.280350938574;4116.91766164675;10212.795744085077;10489.895101049044;10599;10600.04599586041;10600.681979540626;10533.631322903662;10536.420496872746;10537.42044187577;10538.789224215472;10550.63072792464;7701.345385642171;7789.1042530108625;8006.879896801553;8010.919890801134;8142.104368519458;5724.685142317213;5841.415858414124;5870.26621672291;5888.087346461305;5921.881562368814;9180.862287065833;9291.581878815605;9322.860157097784;9532.95233523828;9548.713538593853;9347.298952578447;9674.274429417963;9825.950870245602;9925.900740992498;9974.052465015811;7457.105147382349;7586.165521792488;7639.465237433548;7692.346150577264;7710.7686769397005;7909.485883417559;7954.085280192852;7964.522128672298;8079.83840323202;8142.145074767301;7329.377002954809;7513;7598.8100297493;7631.7328893490685;7792.181820908723;7407.925920740724;7508.174100848793;7551.980482634994;7580.166181720117;7597;6713.56361836479;6801.557898736764;6821.079154314302;6825.419839313516;6839.2476827547935;4887.828925987574;5088.262201980766;5101.69389836611;5112.846614601568;5271.683698978073;5133;5208.791648334024;5255.789768409374;5267.71027593486;5445.809396671098 08:19:34 INFO - PROCESS | 30593 | |4;prototype.html;352.48185167803337;358.449779588332;364.10067134178576;368.6847745177873;368.83402468889005;5219.869503262411;5360.383555891074;5390.380106287778;5422.566194704429;5455;5204.8698782530455;5320.707361095138;5350.8127215547465;5369.355677318717;5416.566674666027;4305.935410968838;4324.329728892011;4325.113351762881;4325.377983256279;4331.956680433187;4239.236937351276;4284.871453856374;4310.978445107786;4334.761588112652;4337.652987760987;4267.48790145183;4274.337477690963;4275.40144379787;4276.123394704078;4283.485981682203;4258.190943720699;4269.594388533084;4276.615104640582;4286.335617979218;4314.71954322968;3763.7741735495683;3845.65389114981;3849.3456112460667;3857.3442514772555;3866.864659736924;5218.112920803473;5246.842594722164;5260.605454590883;5319.494648008472;5331.360236771573;4907.950920490785;4910.631702622318;4914.3611330527165;4914.557689807899;4922;5503.862403439906;5630.971845140748;5644.774209031634;5659.4340565943485;5674.404187560288;4162.293459681547;4175.5572989801;4180.310248808943;4209.200251952119;4235.512916014636;5823.5341172706085;5832.270966129234;5832.358440571534;5867.794627188028;5880.500157486576;4247.766372849523;4313.245182093121;4329.19909816685;4334.9783251083545;4337.175936572041;4348.913021739548;4352.542982986741;4360.367746676778;4366.868993930188;4375.212461756914;4870.951290487121;4884.511548845158;4900;4912.852614421573;4915.48387419323;5477.016971247136;5637.295338082739;5639.407862174413;5682.77268909239;5699.494810691395;1425.6792221750022;1431.3415828718905;1434.583970648521;1439.4242303078852;1442.6321288071474;1008.4469916328918;1042.801867645145;1043.9164866810636;1053.5943661690305;1053.731298518888;5221.060209162387;5304.098303288451;5306.681599104066;5308.362996440452;5319.547838433777;5655.30340897729;5666.744996475169;5674.631148975303;5681;5690.715464226772;5060.898782024413;5247.737613119405;5281.20781882713;5328.6802791832615;5398.595105367113;2962.4374915698195;2977.211039074647;2982.1799005273724;2984.865681044358;2994.6406431228393;5716.542676585863;5728.828135155952;5732.885342293131;5745.339285982165;5772.7690892363835;5679.290088738908;5989.31122920861;5995.220621319288;5997.6401415914315;6010.939890601038;5994.490468310155;6023.524236561982;6028.728707208186;6039.63762174271;6039.78860739872;5641.407652196624;5837.94162058391;5852.94147058524;5867.383924688017;5913.881722365614;5725.93866208173;5784.652920824764;5791.884162316815;5800.332961709458;5802.883942321215;5821.534277257894;5966.731497082555;5999.5500337473995;6004.118023348904;6027.427394397525;4187.685923555685;4209.137126889042;4215.220184265921;4217.9367309491;4236.152769446061;5852.561057920588;5874.530037597067;5878.412828536357;5888.910551547978;5901.557383196363;5545.643101681689;5692;5724.8282551523525;5772.336181339199;5777.91333129995;5652.68910209926;5665.235193249024;5673.8297851064535;5674.092145256739;5676.489115979582;5658.538535736968;5663.263775709132;5667.489925906688;5668.404817494104;5685.687287199078;5555.472230138131;5684.237886255274;5740.885182296414;5745.2818397700285;5776.855578610568;5612.7193640317;5615.775368985195;5615.859603509945;5616.606837521498;5625.915611265917 08:19:34 INFO - PROCESS | 30593 | |5;yui.html;727.9999999999997;757.303280981497;794.1819925476757;837.777988832959;849.52426641081;15590;15755.921220393911;16236;16242.269097890594;16318.673626527463;13712.451501939935;14719.411223551071;14907.403703851833;14912.328945197465;14926.850731492681;841.4908980067048;862.2541501601102;862.8791969124328;863.0937515608617;863.197226579281;852.799592095857;855.683397143058;858.8282343531288;860.096898256831;860.2816648098814;898.2364989758718;901.6979311930511;902.2736696958946;902.9413088149249;903.6927444668811;883.5891310540597;883.8674198870157;887.5695287785419;888.8133491966695;889.4085433186955;659.7921654678761;664.2195420381081;664.6078813500059;665.2947875252248;665.5574043261225;14179.43282268708;14200.644983875383;14205.360758765777;14434.639134021629;14666.340014699364;14254.643633909132;14872.405103795834;14911.925440372728;14937.253137343198;14976.925115374463;12120.151589388746;12210.32843193624;12212.32832194229;12253.081018923527;12332.630021099381;3821.885343439701;3822.10180607557;3826.5408151022057;3892.0853599404118;3924.352481840493;38798.41802372967;46222.53777462216;51540.22689659658;56586.43413565853;64340.67829660822;11846.940765296118;11971.940140299417;12069.637910862688;12079.27524348542;12280.938595307145;20737;20807.791922080887;20812.47968800792;20825.271115510885;20852.165913363297;7273.745418910313;8332.62503187358;8612.397132200811;8697;8717.564121793885;4525.886852828706;4600.631949444037;4653.278741795028;4714.339992401066;4825.686330388514;3469.427544455187;3565.7860528368383;3572.6070132285427;3580.4987301777774;3587.0673624857204;663.0882536512296;673.1282988529767;678.5352033856725;679.2155060904663;680.0377465885716;754.528419737664;773.9148693643695;774.1832366852911;781.8514482248355;790.6797746912509;9650;10186.388816671024;10195.643152489627;10336.948315258525;10444.843327350096;657.5068698476143;685.348918527401;728.8797348437555;774.1213722425088;782.4444644302608;4957.3059771632;5032.874178145576;5042.117629414838;5051.116054690415;5087.440381558025;55944;56601.43398565962;89373;92083;93783.53108234552;77187.61406192933;79438.6028069856;80449;80740;81037.59481202674;45983.77008114938;46649;54700.45299547033;69710.65144674346;73426.26573734195;9336.253099752139;9812.607495700093;9922.355046921926;10009.349392289478;10022.098011179029;40562;41312;49321.506784933124;49403;49502.50497495123;50562.747186263834;57765.422345776;57952;59802;62070.68964655148;12213.633590992284;13077;13226.603201903958;13296.734065318833;13579.117357371739;13619.591412257649;14401.279936003368;14521.564353069425;14563.85436145625;14569.635759106108;13606.183628982293;13818.447262109805;14046.859531404556;14100.78848817248;14473.782893256399;13989.93005035009;14111.788323174955;14128.293585320898;14177.858221417653;14485.85514144845;13450;13503.527376541773;13697.726045479234;13971.161730295808;14501.419943202154;11177.242408066173;11672.824907626562;11899.821502677294;11901.285922844658;12088.566747753632;11862.82205766897;11999;12023.21849079807;12073.335966521574;12108.273503589813 08:19:34 INFO - PROCESS | 30593 | __end_tp_report 08:19:34 INFO - PROCESS | 30593 | __start_cc_report 08:19:34 INFO - PROCESS | 30593 | _x_x_mozilla_cycle_collect,1082 08:19:34 INFO - PROCESS | 30593 | __end_cc_report 08:19:34 INFO - PROCESS | 30593 | __startTimestamp1482337174917__endTimestamp 08:19:34 INFO - PROCESS | 30593 | 08:19:34 INFO - PROCESS | 30593 | ------- Summary: start ------- 08:19:34 INFO - PROCESS | 30593 | Number of tests: 6 08:19:34 INFO - PROCESS | 30593 | 08:19:34 INFO - PROCESS | 30593 | [#0] dojo.html Cycles:165 Average:5561.22 Median:5745.51 stddev:618.79 (10.8%) stddev-sans-first:592.61 08:19:34 INFO - PROCESS | 30593 | Values: 3211.7 3247.3 3253.3 3273.4 3291.1 5482.5 5536.9 5594.5 5596.9 5601.4 5595.2 5614.2 5615.2 5642.7 5660.9 5076.8 5097.0 5132.1 5155.7 5159.9 5045.3 5048.6 5059.6 5137.3 5187.8 5128.8 5196.9 5198.5 5221.1 5227.2 5218.7 5228.6 5229.6 5230.9 5260.8 4980.1 4983.6 5113.0 5141.1 5210.0 5439.2 5472.3 5478.4 5532.3 5544.5 5904.6 5915.5 5952.4 5999.9 6004.3 5811.1 6010.3 6026.5 6039.2 6040.3 5483.9 5521.3 5564.1 5567.9 5591.1 6112.6 6120.0 6122.6 6124.2 6128.1 5747.1 5857.8 5875.7 5881.1 5889.8 5861.2 5925.3 5982.5 5987.2 6068.9 5956.8 5998.9 6011.1 6011.4 6052.6 5967.6 5978.7 5986.9 5997.2 6004.2 4493.0 4512.1 4542.1 4579.1 4580.4 4083.4 4096.3 4099.3 4129.1 4136.2 5621.4 5622.2 5623.8 5631.0 5664.5 5829.9 5883.6 5963.4 5966.7 5998.2 5708.1 5711.3 5719.6 5735.9 5743.3 5204.0 5216.9 5218.4 5219.2 5260.2 6004.4 6059.7 6061.1 6167.8 6221.6 5939.5 6045.2 6049.1 6051.9 6090.7 6116.0 6117.9 6122.3 6125.1 6179.4 5707.3 5745.5 5909.9 5923.9 5928.6 6047.4 6083.6 6087.5 6112.8 6132.4 5873.0 5909.7 5918.6 5926.5 5931.5 5552.7 5869.2 5870.3 5875.1 5887.4 5723.6 5743.8 5776.3 5781.3 5824.5 5838.5 5905.5 5915.4 5915.7 5917.8 5575.2 5620.6 5634.5 5774.6 5782.4 08:19:34 INFO - PROCESS | 30593 | 08:19:34 INFO - PROCESS | 30593 | [#1] ext.html Cycles:180 Average:60420.55 Median:37675.12 stddev:120496.10 (319.8%) stddev-sans-first:120750.38 08:19:34 INFO - PROCESS | 30593 | Values: 588.3 626.8 652.3 662.4 671.0 33961.5 43795.3 44278.6 44458.8 44590.8 44809.3 45288.8 45328.1 45340.1 45349.3 8241.7 8756.2 8883.2 8890.0 8896.9 8238.5 10641.3 10890.6 10891.4 10920.5 10725.5 10786.4 10798.1 10801.2 10801.6 10628.1 10671.2 10683.8 10688.9 10693.5 10501.0 10554.5 10560.6 10580.7 10580.8 43179.8 43522.3 43596.8 43724.6 43729.8 3441.7 3557.1 3695.6 3789.6 4155.9 31745.7 31861.8 32023.0 32407.8 32604.7 4328.7 4413.9 4440.3 4452.5 4535.7 333982.0 336815.0 337548.0 337669.0 338987.0 37875.4 60501.0 60922.7 60973.7 60982.7 38257.6 40332.0 40495.4 40502.4 40518.0 14208.0 14292.4 14295.8 14299.3 14393.0 10545.7 10591.0 10965.3 11539.1 11549.4 9258.2 9428.1 9436.3 9488.0 9507.8 3549.5 3549.6 3559.6 3590.3 3686.5 1025.4 1044.3 1083.9 1130.4 1132.5 33102.7 33222.7 33359.3 33586.5 33633.3 1071.1 1097.3 1097.8 1138.8 1160.2 16790.7 17792.2 17822.1 17863.7 17896.2 542832.0 549315.0 550493.0 550554.0 550999.0 60866.7 61266.0 61437.0 61555.4 61602.4 1278.2 1289.6 1303.2 1393.0 1442.5 31490.8 36062.1 36271.3 36458.6 36492.8 57226.0 58080.0 58109.4 58179.4 58224.7 446910.0 451244.0 451266.0 451391.7 452362.0 27008.5 27039.9 27671.9 29962.4 30417.2 43273.0 44726.6 47868.8 52023.7 52948.7 41340.4 41655.4 42439.4 43313.0 43941.0 42137.2 42341.4 42885.6 43564.3 43948.3 42694.0 42844.6 42918.8 43325.8 43451.8 36137.6 37462.3 37474.8 38145.6 38245.6 28873.7 29146.3 29227.0 29284.6 29504.0 08:19:34 INFO - PROCESS | 30593 | 08:19:34 INFO - PROCESS | 30593 | [#2] jquery.html Cycles:180 Average:29048.83 Median:23433.88 stddev:82866.24 (353.6%) stddev-sans-first:83070.79 08:19:34 INFO - PROCESS | 30593 | Values: 402.9 417.2 419.3 430.5 430.5 16154.0 19472.7 19490.9 19497.4 19676.4 18993.2 19227.7 19435.5 19779.3 19881.9 4945.0 5521.4 5734.3 6457.6 6505.3 6490.1 6502.6 6566.2 6569.2 6575.5 6368.3 6508.2 6512.0 6515.3 6535.2 6317.9 6357.1 6413.9 6505.3 6540.7 5608.4 5648.1 5650.9 5651.5 5658.1 19910.0 23340.8 23527.0 23530.1 23738.6 2408.1 2473.7 2510.3 2616.4 3069.3 14574.4 14831.0 14879.6 15181.3 15471.4 1914.7 1977.7 2003.6 2019.9 2031.8 58580.7 73264.6 73394.3 80736.6 81794.6 11148.9 11161.9 11417.7 11504.2 11667.9 16161.8 16190.4 16203.6 16234.5 16235.6 7889.9 8168.3 8218.8 8274.2 8404.6 7677.2 7708.3 7802.6 7843.9 7999.1 6664.7 7041.6 7047.4 7057.5 7076.6 1791.1 1840.0 2012.5 2043.6 2081.2 1015.9 1041.5 1050.7 1063.9 1087.4 19930.4 20224.9 20300.8 20356.0 20451.9 1022.7 1040.6 1056.6 1058.0 1073.5 10430.6 11718.6 11807.6 11876.5 11967.2 486624.0 507642.0 508253.0 510860.0 515320.0 78717.6 80174.0 81412.6 82708.6 83627.6 1034.3 1038.2 1049.2 1066.8 1074.6 17294.8 17575.9 17961.9 18021.4 18102.8 38490.4 38740.2 38964.6 39237.4 39991.6 51425.7 51900.5 51968.5 52919.2 53155.0 6368.9 8256.1 8296.6 8408.7 8486.0 12819.9 13132.3 13169.8 13357.5 13397.3 8796.6 11365.7 11648.3 11743.5 11908.6 11233.3 11691.2 11862.6 11995.5 12193.9 11354.5 11494.4 11767.5 12057.7 12305.1 8010.4 8997.1 9001.8 9022.9 9161.8 11183.1 11318.1 12009.7 12045.2 12281.3 08:19:34 INFO - PROCESS | 30593 | 08:19:34 INFO - PROCESS | 30593 | [#3] mootools.html Cycles:180 Average:5687.73 Median:5232.29 stddev:3099.03 (59.2%) stddev-sans-first:3091.74 08:19:34 INFO - PROCESS | 30593 | Values: 1499.8 1541.7 1704.8 1789.3 1818.0 8225.4 8777.5 8779.4 8781.7 8783.3 7662.3 7852.0 8333.7 8469.7 8574.9 2468.0 2494.8 2497.3 2502.0 2502.6 2454.3 2541.8 2549.3 2549.6 2550.0 2447.1 2449.3 2490.0 2496.7 2502.2 2439.5 2446.4 2466.6 2467.6 2467.8 2465.4 2473.8 2490.9 2492.3 2505.6 8588.5 8675.0 8689.3 8711.1 8714.3 5283.7 5404.1 5409.3 5409.4 5414.8 3453.5 3699.1 3720.1 3723.1 3732.4 1188.6 1226.4 1243.9 1269.4 1318.2 11289.7 11947.5 11948.2 11975.2 11996.6 4732.6 4770.0 4893.7 4905.5 4916.5 9421.3 9512.4 9527.4 9532.6 9533.8 5457.8 5470.2 5480.1 5492.5 5499.4 4312.3 4435.9 4534.0 4914.5 5009.1 3933.3 3957.9 4078.5 4081.6 4083.7 1235.0 1263.0 1267.1 1267.8 1284.3 948.9 959.9 965.3 972.5 987.0 5810.4 5811.7 5835.7 5928.2 5969.4 489.2 493.6 506.4 515.1 518.7 3964.9 4027.4 4077.7 4112.3 4116.9 10212.8 10489.9 10599.0 10600.0 10600.7 10533.6 10536.4 10537.4 10538.8 10550.6 7701.3 7789.1 8006.9 8010.9 8142.1 5724.7 5841.4 5870.3 5888.1 5921.9 9180.9 9291.6 9322.9 9533.0 9548.7 9347.3 9674.3 9826.0 9925.9 9974.1 7457.1 7586.2 7639.5 7692.3 7710.8 7909.5 7954.1 7964.5 8079.8 8142.1 7329.4 7513.0 7598.8 7631.7 7792.2 7407.9 7508.2 7552.0 7580.2 7597.0 6713.6 6801.6 6821.1 6825.4 6839.2 4887.8 5088.3 5101.7 5112.8 5271.7 5133.0 5208.8 5255.8 5267.7 5445.8 08:19:34 INFO - PROCESS | 30593 | 08:19:34 INFO - PROCESS | 30593 | [#4] prototype.html Cycles:180 Average:4792.55 Median:5330.02 stddev:1380.00 (25.9%) stddev-sans-first:1343.03 08:19:34 INFO - PROCESS | 30593 | Values: 352.5 358.4 364.1 368.7 368.8 5219.9 5360.4 5390.4 5422.6 5455.0 5204.9 5320.7 5350.8 5369.4 5416.6 4305.9 4324.3 4325.1 4325.4 4332.0 4239.2 4284.9 4311.0 4334.8 4337.7 4267.5 4274.3 4275.4 4276.1 4283.5 4258.2 4269.6 4276.6 4286.3 4314.7 3763.8 3845.7 3849.3 3857.3 3866.9 5218.1 5246.8 5260.6 5319.5 5331.4 4908.0 4910.6 4914.4 4914.6 4922.0 5503.9 5631.0 5644.8 5659.4 5674.4 4162.3 4175.6 4180.3 4209.2 4235.5 5823.5 5832.3 5832.4 5867.8 5880.5 4247.8 4313.2 4329.2 4335.0 4337.2 4348.9 4352.5 4360.4 4366.9 4375.2 4871.0 4884.5 4900.0 4912.9 4915.5 5477.0 5637.3 5639.4 5682.8 5699.5 1425.7 1431.3 1434.6 1439.4 1442.6 1008.4 1042.8 1043.9 1053.6 1053.7 5221.1 5304.1 5306.7 5308.4 5319.5 5655.3 5666.7 5674.6 5681.0 5690.7 5060.9 5247.7 5281.2 5328.7 5398.6 2962.4 2977.2 2982.2 2984.9 2994.6 5716.5 5728.8 5732.9 5745.3 5772.8 5679.3 5989.3 5995.2 5997.6 6010.9 5994.5 6023.5 6028.7 6039.6 6039.8 5641.4 5837.9 5852.9 5867.4 5913.9 5725.9 5784.7 5791.9 5800.3 5802.9 5821.5 5966.7 5999.6 6004.1 6027.4 4187.7 4209.1 4215.2 4217.9 4236.2 5852.6 5874.5 5878.4 5888.9 5901.6 5545.6 5692.0 5724.8 5772.3 5777.9 5652.7 5665.2 5673.8 5674.1 5676.5 5658.5 5663.3 5667.5 5668.4 5685.7 5555.5 5684.2 5740.9 5745.3 5776.9 5612.7 5615.8 5615.9 5616.6 5625.9 08:19:34 INFO - PROCESS | 30593 | 08:19:34 INFO - PROCESS | 30593 | [#5] yui.html Cycles:180 Average:17255.28 Median:25292.20 stddev:21722.62 (85.9%) stddev-sans-first:21748.11 08:19:34 INFO - PROCESS | 30593 | Values: 728.0 757.3 794.2 837.8 849.5 15590.0 15755.9 16236.0 16242.3 16318.7 13712.5 14719.4 14907.4 14912.3 14926.9 841.5 862.3 862.9 863.1 863.2 852.8 855.7 858.8 860.1 860.3 898.2 901.7 902.3 902.9 903.7 883.6 883.9 887.6 888.8 889.4 659.8 664.2 664.6 665.3 665.6 14179.4 14200.6 14205.4 14434.6 14666.3 14254.6 14872.4 14911.9 14937.3 14976.9 12120.2 12210.3 12212.3 12253.1 12332.6 3821.9 3822.1 3826.5 3892.1 3924.4 38798.4 46222.5 51540.2 56586.4 64340.7 11846.9 11971.9 12069.6 12079.3 12280.9 20737.0 20807.8 20812.5 20825.3 20852.2 7273.7 8332.6 8612.4 8697.0 8717.6 4525.9 4600.6 4653.3 4714.3 4825.7 3469.4 3565.8 3572.6 3580.5 3587.1 663.1 673.1 678.5 679.2 680.0 754.5 773.9 774.2 781.9 790.7 9650.0 10186.4 10195.6 10336.9 10444.8 657.5 685.3 728.9 774.1 782.4 4957.3 5032.9 5042.1 5051.1 5087.4 55944.0 56601.4 89373.0 92083.0 93783.5 77187.6 79438.6 80449.0 80740.0 81037.6 45983.8 46649.0 54700.5 69710.7 73426.3 9336.3 9812.6 9922.4 10009.3 10022.1 40562.0 41312.0 49321.5 49403.0 49502.5 50562.7 57765.4 57952.0 59802.0 62070.7 12213.6 13077.0 13226.6 13296.7 13579.1 13619.6 14401.3 14521.6 14563.9 14569.6 13606.2 13818.4 14046.9 14100.8 14473.8 13989.9 14111.8 14128.3 14177.9 14485.9 13450.0 13503.5 13697.7 13971.2 14501.4 11177.2 11672.8 11899.8 11901.3 12088.6 11862.8 11999.0 12023.2 12073.3 12108.3 08:19:34 INFO - PROCESS | 30593 | -------- Summary: end -------- 08:19:34 INFO - PROCESS | 30593 | 08:19:35 INFO - TEST-INFO | 30593: exit 0 08:19:35 INFO - TEST-OK | dromaeo_css | took 1116581ms 08:19:35 INFO - TEST-START | kraken 08:19:35 INFO - operating with platform_type : linux_ 08:19:35 INFO - Initialising browser for kraken test... 08:19:35 INFO - TEST-INFO | started process 30912 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiHMHrK/profile http://localhost:36095/getInfo.html) 08:19:40 INFO - PROCESS | 30912 | __metrics Screen width/height:1600/1200 08:19:40 INFO - PROCESS | 30912 | colorDepth:24 08:19:40 INFO - PROCESS | 30912 | Browser inner width/height: 1024/697 08:19:40 INFO - PROCESS | 30912 | __metrics 08:19:41 INFO - PROCESS | 30912 | 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:19:41 INFO - PROCESS | 30912 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:19:42 INFO - PROCESS | 30912 | console.error: PushService: 08:19:42 INFO - PROCESS | 30912 | stateChangeProcessEnqueue: Error transitioning state 08:19:42 INFO - PROCESS | 30912 | UnknownError 08:19:42 INFO - TEST-INFO | 30912: exit 0 08:19:42 INFO - Browser initialized. 08:19:42 INFO - Running cycle 1/1 for kraken test... 08:19:42 INFO - TEST-INFO | started process 31001 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiHMHrK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:19:54 INFO - PROCESS | 31001 | RSS: Main: 144723968 08:19:54 INFO - PROCESS | 31001 | 08:19:56 INFO - PROCESS | 31001 | Cycle 1(1): loaded http://localhost:36095/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36095/tests/kraken/driver.html?testName=audio-beat-detection) 08:19:57 INFO - PROCESS | 31001 | RSS: Main: 185622528 08:19:57 INFO - PROCESS | 31001 | 08:20:00 INFO - PROCESS | 31001 | Cycle 1(1): loaded http://localhost:36095/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36095/tests/kraken/driver.html?testName=audio-dft) 08:20:00 INFO - PROCESS | 31001 | RSS: Main: 175235072 08:20:00 INFO - PROCESS | 31001 | 08:20:03 INFO - PROCESS | 31001 | Cycle 1(1): loaded http://localhost:36095/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36095/tests/kraken/driver.html?testName=audio-fft) 08:20:04 INFO - PROCESS | 31001 | RSS: Main: 266539008 08:20:04 INFO - PROCESS | 31001 | 08:20:06 INFO - PROCESS | 31001 | Cycle 1(1): loaded http://localhost:36095/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36095/tests/kraken/driver.html?testName=audio-oscillator) 08:20:06 INFO - PROCESS | 31001 | RSS: Main: 173240320 08:20:06 INFO - PROCESS | 31001 | 08:20:09 INFO - PROCESS | 31001 | Cycle 1(1): loaded http://localhost:36095/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36095/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:20:09 INFO - PROCESS | 31001 | RSS: Main: 175923200 08:20:09 INFO - PROCESS | 31001 | 08:20:12 INFO - PROCESS | 31001 | Cycle 1(1): loaded http://localhost:36095/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36095/tests/kraken/driver.html?testName=imaging-darkroom) 08:20:13 INFO - PROCESS | 31001 | RSS: Main: 214732800 08:20:13 INFO - PROCESS | 31001 | 08:20:16 INFO - PROCESS | 31001 | Cycle 1(1): loaded http://localhost:36095/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36095/tests/kraken/driver.html?testName=imaging-desaturate) 08:20:17 INFO - PROCESS | 31001 | RSS: Main: 213245952 08:20:17 INFO - PROCESS | 31001 | 08:20:19 INFO - PROCESS | 31001 | Cycle 1(1): loaded http://localhost:36095/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36095/tests/kraken/driver.html?testName=json-parse-financial) 08:20:20 INFO - PROCESS | 31001 | RSS: Main: 212422656 08:20:20 INFO - PROCESS | 31001 | 08:20:21 INFO - PROCESS | 31001 | Cycle 1(1): loaded http://localhost:36095/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36095/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:20:22 INFO - PROCESS | 31001 | RSS: Main: 174104576 08:20:22 INFO - PROCESS | 31001 | 08:20:24 INFO - PROCESS | 31001 | Cycle 1(1): loaded http://localhost:36095/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36095/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:20:24 INFO - PROCESS | 31001 | RSS: Main: 181542912 08:20:24 INFO - PROCESS | 31001 | 08:20:26 INFO - PROCESS | 31001 | Cycle 1(1): loaded http://localhost:36095/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36095/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:20:27 INFO - PROCESS | 31001 | RSS: Main: 190238720 08:20:27 INFO - PROCESS | 31001 | 08:20:29 INFO - PROCESS | 31001 | Cycle 1(1): loaded http://localhost:36095/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36095/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:20:30 INFO - PROCESS | 31001 | RSS: Main: 199839744 08:20:30 INFO - PROCESS | 31001 | 08:20:33 INFO - PROCESS | 31001 | Cycle 1(1): loaded http://localhost:36095/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36095/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:20:33 INFO - PROCESS | 31001 | RSS: Main: 194895872 08:20:33 INFO - PROCESS | 31001 | 08:20:35 INFO - PROCESS | 31001 | Cycle 1(1): loaded http://localhost:36095/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36095/tests/kraken/driver.html?testName=ai-astar) 08:20:35 INFO - PROCESS | 31001 | RSS: Main: 246087680 08:20:35 INFO - PROCESS | 31001 | 08:20:35 INFO - PROCESS | 31001 | __start_tp_report 08:20:35 INFO - PROCESS | 31001 | _x_x_mozilla_page_load 08:20:35 INFO - PROCESS | 31001 | _x_x_mozilla_page_load_details 08:20:35 INFO - PROCESS | 31001 | |i|pagename|runs| 08:20:35 INFO - PROCESS | 31001 | |0;ai-astar;101;111;112;109;111;109;111;110;110;111 08:20:35 INFO - PROCESS | 31001 | |1;audio-beat-detection;150;121;119;161;120;121;123;118;149;120 08:20:35 INFO - PROCESS | 31001 | |2;audio-dft;160;161;163;160;159;159;160;159;162;159 08:20:35 INFO - PROCESS | 31001 | |3;audio-fft;74;75;75;107;83;76;75;75;100;74 08:20:35 INFO - PROCESS | 31001 | |4;audio-oscillator;83;82;110;82;82;82;98;81;81;103 08:20:35 INFO - PROCESS | 31001 | |5;imaging-gaussian-blur;117;117;117;117;117;117;116;117;117;117 08:20:35 INFO - PROCESS | 31001 | |6;imaging-darkroom;148;146;145;145;146;145;145;146;146;146 08:20:35 INFO - PROCESS | 31001 | |7;imaging-desaturate;85;85;85;85;85;84;85;85;84;85 08:20:35 INFO - PROCESS | 31001 | |8;json-parse-financial;51;50;51;51;50;50;60;53;50;50 08:20:35 INFO - PROCESS | 31001 | |9;json-stringify-tinderbox;61;59;59;59;59;60;59;59;60;61 08:20:35 INFO - PROCESS | 31001 | |10;stanford-crypto-aes;74;73;83;74;74;74;74;74;75;82 08:20:35 INFO - PROCESS | 31001 | |11;stanford-crypto-ccm;125;130;127;123;129;129;124;118;169;130 08:20:35 INFO - PROCESS | 31001 | |12;stanford-crypto-pbkdf2;153;151;151;150;155;152;152;157;152;151 08:20:35 INFO - PROCESS | 31001 | |13;stanford-crypto-sha256-iterative;61;63;64;62;62;63;62;61;60;60 08:20:35 INFO - PROCESS | 31001 | __end_tp_report 08:20:35 INFO - PROCESS | 31001 | __start_cc_report 08:20:35 INFO - PROCESS | 31001 | _x_x_mozilla_cycle_collect,1585 08:20:35 INFO - PROCESS | 31001 | __end_cc_report 08:20:35 INFO - PROCESS | 31001 | __startTimestamp1482337235568__endTimestamp 08:20:35 INFO - PROCESS | 31001 | 08:20:35 INFO - PROCESS | 31001 | ------- Summary: start ------- 08:20:35 INFO - PROCESS | 31001 | Number of tests: 14 08:20:35 INFO - PROCESS | 31001 | 08:20:35 INFO - PROCESS | 31001 | [#0] ai-astar Cycles:10 Average:109.50 Median:111.00 stddev:3.14 (2.8%) stddev-sans-first:1.01 08:20:35 INFO - PROCESS | 31001 | Values: 101.0 111.0 112.0 109.0 111.0 109.0 111.0 110.0 110.0 111.0 08:20:35 INFO - PROCESS | 31001 | 08:20:35 INFO - PROCESS | 31001 | [#1] audio-beat-detection Cycles:10 Average:130.20 Median:122.00 stddev:16.32 (13.4%) stddev-sans-first:15.66 08:20:35 INFO - PROCESS | 31001 | Values: 150.0 121.0 119.0 161.0 120.0 121.0 123.0 118.0 149.0 120.0 08:20:35 INFO - PROCESS | 31001 | 08:20:35 INFO - PROCESS | 31001 | [#2] audio-dft Cycles:10 Average:160.20 Median:160.00 stddev:1.40 (0.9%) stddev-sans-first:1.48 08:20:35 INFO - PROCESS | 31001 | Values: 160.0 161.0 163.0 160.0 159.0 159.0 160.0 159.0 162.0 159.0 08:20:35 INFO - PROCESS | 31001 | 08:20:35 INFO - PROCESS | 31001 | [#3] audio-fft Cycles:10 Average:81.40 Median:75.00 stddev:12.05 (16.1%) stddev-sans-first:12.48 08:20:35 INFO - PROCESS | 31001 | Values: 74.0 75.0 75.0 107.0 83.0 76.0 75.0 75.0 100.0 74.0 08:20:35 INFO - PROCESS | 31001 | 08:20:35 INFO - PROCESS | 31001 | [#4] audio-oscillator Cycles:10 Average:88.40 Median:82.00 stddev:10.93 (13.3%) stddev-sans-first:11.41 08:20:35 INFO - PROCESS | 31001 | Values: 83.0 82.0 110.0 82.0 82.0 82.0 98.0 81.0 81.0 103.0 08:20:35 INFO - PROCESS | 31001 | 08:20:35 INFO - PROCESS | 31001 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:20:35 INFO - PROCESS | 31001 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 08:20:35 INFO - PROCESS | 31001 | 08:20:35 INFO - PROCESS | 31001 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.92 (0.6%) stddev-sans-first:0.53 08:20:35 INFO - PROCESS | 31001 | Values: 148.0 146.0 145.0 145.0 146.0 145.0 145.0 146.0 146.0 146.0 08:20:35 INFO - PROCESS | 31001 | 08:20:35 INFO - PROCESS | 31001 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 08:20:35 INFO - PROCESS | 31001 | Values: 85.0 85.0 85.0 85.0 85.0 84.0 85.0 85.0 84.0 85.0 08:20:35 INFO - PROCESS | 31001 | 08:20:35 INFO - PROCESS | 31001 | [#8] json-parse-financial Cycles:10 Average:51.60 Median:51.00 stddev:3.10 (6.1%) stddev-sans-first:3.28 08:20:35 INFO - PROCESS | 31001 | Values: 51.0 50.0 51.0 51.0 50.0 50.0 60.0 53.0 50.0 50.0 08:20:35 INFO - PROCESS | 31001 | 08:20:35 INFO - PROCESS | 31001 | [#9] json-stringify-tinderbox Cycles:10 Average:59.60 Median:59.50 stddev:0.84 (1.4%) stddev-sans-first:0.73 08:20:35 INFO - PROCESS | 31001 | Values: 61.0 59.0 59.0 59.0 59.0 60.0 59.0 59.0 60.0 61.0 08:20:35 INFO - PROCESS | 31001 | 08:20:35 INFO - PROCESS | 31001 | [#10] stanford-crypto-aes Cycles:10 Average:75.70 Median:74.00 stddev:3.62 (4.9%) stddev-sans-first:3.79 08:20:35 INFO - PROCESS | 31001 | Values: 74.0 73.0 83.0 74.0 74.0 74.0 74.0 74.0 75.0 82.0 08:20:35 INFO - PROCESS | 31001 | 08:20:35 INFO - PROCESS | 31001 | [#11] stanford-crypto-ccm Cycles:10 Average:130.40 Median:129.00 stddev:14.08 (10.9%) stddev-sans-first:14.80 08:20:35 INFO - PROCESS | 31001 | Values: 125.0 130.0 127.0 123.0 129.0 129.0 124.0 118.0 169.0 130.0 08:20:35 INFO - PROCESS | 31001 | 08:20:35 INFO - PROCESS | 31001 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.40 Median:152.00 stddev:2.12 (1.4%) stddev-sans-first:2.24 08:20:35 INFO - PROCESS | 31001 | Values: 153.0 151.0 151.0 150.0 155.0 152.0 152.0 157.0 152.0 151.0 08:20:35 INFO - PROCESS | 31001 | 08:20:35 INFO - PROCESS | 31001 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.80 Median:62.00 stddev:1.32 (2.1%) stddev-sans-first:1.36 08:20:35 INFO - PROCESS | 31001 | Values: 61.0 63.0 64.0 62.0 62.0 63.0 62.0 61.0 60.0 60.0 08:20:35 INFO - PROCESS | 31001 | -------- Summary: end -------- 08:20:35 INFO - PROCESS | 31001 | 08:20:36 INFO - TEST-INFO | 31001: exit 0 08:20:36 INFO - TEST-OK | kraken | took 60994ms 08:20:36 INFO - SUITE-END | took 1177s 08:20:36 INFO - Completed test suite (00:19:37) 08:20:36 INFO - javascript benchmark 08:20:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3211.710946014859, 3247.3342964692242, 3253.333066721321, 3273.3616944695796, 3291.094948889055, 5482.45175482452, 5536.861578460541, 5594.524465420444, 5596.860078498034, 5601.383847776741, 5595.21666966625, 5614.242077319561, 5615.185798059279, 5642.689652069134, 5660.9433905660935, 5076.79692812288, 5096.974515127437, 5132.101882170624, 5155.7422128893595, 5159.871003224931, 5045.293658887758, 5048.570871475929, 5059.620528460362, 5137.255098010786, 5187.818426355078, 5128.769205385748, 5196.896062078757, 5198.50614191653, 5221.112410890139, 5227.18978558324, 5218.660787048849, 5228.633995620308, 5229.581633469352, 5230.8692282692855, 5260.763265653055, 4980.078685443204, 4983.576396006344, 5113.0, 5141.074606570815, 5209.973950130225, 5439.211314359435, 5472.288602481652, 5478.397376288605, 5532.28080349556, 5544.528715059225, 5904.645721256738, 5915.497182739472, 5952.375000624958, 5999.850003749898, 6004.3395226525045, 5811.070228763419, 6010.338862725097, 6026.487748541379, 6039.214902062748, 6040.335563088057, 5483.917741233885, 5521.309836270466, 5564.081926482085, 5567.860803479945, 5591.07747221712, 6112.633242005494, 6119.969400152971, 6122.571420000646, 6124.203853499017, 6128.080787881764, 5747.109198074305, 5857.765689372377, 5875.706214689249, 5881.147233651182, 5889.823305300848, 5861.20873682056, 5925.318588362307, 5982.46157845796, 5987.161797348374, 6068.908966365508, 5956.76172953077, 5998.880022399615, 6011.098335249748, 6011.398860114041, 6052.576319657582, 5967.5524335675, 5978.730957106941, 5986.910196347058, 5997.220361352996, 6004.189434426296, 4492.955070449254, 4512.075024619945, 4542.068875880436, 4579.129965306581, 4580.404547408815, 4083.3670781028986, 4096.32410652245, 4099.3031184698675, 4129.112240868168, 4136.152088821785, 5621.437856214346, 5622.240997465372, 5623.831285061455, 5631.0, 5664.461876121762, 5829.912551311733, 5883.588148829541, 5963.403659634002, 5966.701664916737, 5998.190244316961, 5708.143778433268, 5711.286089238845, 5719.57103217252, 5735.913961290584, 5743.253377061039, 5204.0372531081875, 5216.869578260574, 5218.399884013311, 5219.19102539107, 5260.184671375866, 6004.399560044048, 6059.727312271047, 6061.060535616986, 6167.784127555514, 6221.626702397871, 5939.524838013035, 6045.244344456943, 6049.0926361046195, 6051.909221361595, 6090.725917333642, 6115.969420152871, 6117.877642447215, 6122.2959359674205, 6125.05061715417, 6179.412955769195, 5707.286589176353, 5745.511631511368, 5909.852253693692, 5923.851903702442, 5928.584999050197, 6047.395260473917, 6083.6045657032155, 6087.482563981934, 6112.78605248832, 6132.38676132401, 5873.0, 5909.734061967308, 5918.644881307136, 5926.496247818984, 5931.495822855106, 5552.7223638818705, 5869.236999190078, 5870.324912635102, 5875.118732190205, 5887.411258874078, 5723.627964182481, 5743.770249189985, 5776.335721392094, 5781.306243250837, 5824.5340372770925, 5838.503727183237, 5905.527557795452, 5915.438033386821, 5915.674637894957, 5917.792877249276, 5575.219469274224, 5620.606557541097, 5634.492895639412, 5774.624649397776, 5782.392848750821], "value": 5520.147356249052, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.2793577867113, 626.7900253415106, 652.2824892618119, 662.4071456046838, 670.986580268395, 33961.49057764132, 43795.34306985394, 44278.55721442785, 44458.77770611146, 44590.77704611472, 44809.32786008212, 45288.773556132255, 45328.0934381313, 45340.09319813602, 45349.31976020354, 8241.711540096097, 8756.168164024424, 8883.156100170505, 8890.022097569294, 8896.911030889672, 8238.50568965864, 10641.308314959502, 10890.564377424893, 10891.400972946485, 10920.50857711401, 10725.517351719152, 10786.352818830856, 10798.082163016154, 10801.243912926098, 10801.621943231989, 10628.096611788007, 10671.19966002553, 10683.83974240387, 10688.946555267174, 10693.46532673367, 10501.0, 10554.472276386226, 10560.577576896914, 10580.735481612945, 10580.841287380696, 43179.78410107961, 43522.347164792554, 43596.78201609004, 43724.56275437237, 43729.781351093356, 3441.7246620270316, 3557.0929412999776, 3695.648913353254, 3789.5642001169945, 4155.896102597429, 31745.682543174502, 31861.84069079663, 32023.0, 32407.83796081028, 32604.673953260637, 4328.653707703376, 4413.889652758675, 4440.333949907507, 4452.465704115527, 4535.727856328631, 333982.0, 336815.0, 337548.0, 337669.0, 338987.0, 37875.43186852199, 60501.0, 60922.69538652367, 60973.69513152406, 60982.69508652517, 38257.6174238254, 40332.0, 40495.392569111485, 40502.392464113065, 40518.0, 14208.0, 14292.356843942047, 14295.78556321656, 14299.285035748171, 14393.0, 10545.683629491128, 10591.046805787517, 10965.342079475256, 11539.076873850072, 11549.36478493691, 9258.21305189053, 9428.057194280655, 9436.292278079172, 9487.952560237292, 9507.762305942406, 3549.4853246279145, 3549.6272891346553, 3559.555055618048, 3590.335787879251, 3686.5391826021746, 1025.4257615735212, 1044.3107549017764, 1083.853679753239, 1130.3669944830756, 1132.5469812075237, 33102.668973309956, 33222.66777332244, 33359.33281334408, 33586.496202556984, 33633.32733345319, 1071.1216802222102, 1097.3415950429678, 1097.846301517788, 1138.7893239750506, 1160.1994623709613, 16790.74813877793, 17792.199351029234, 17822.10889455548, 17863.73204401935, 17896.194671239824, 542832.0, 549315.0, 550493.0, 550554.0, 550999.0, 60866.69566652227, 61266.0, 61437.0, 61555.38444615586, 61602.38397615967, 1278.1755767529892, 1289.5615490733196, 1303.2376060005004, 1392.958211253664, 1442.5167568864338, 31490.842545787124, 36062.09844753902, 36271.27457450889, 36458.63541364553, 36492.81753591215, 57226.0, 58080.0, 58109.4189058104, 58179.41820581909, 58224.70887645704, 446910.0, 451244.0, 451266.0, 451391.7152071093, 452362.0, 27008.45983080288, 27039.86480067587, 27671.861640691666, 29962.400751985275, 30417.23956901095, 43273.0, 44726.55273447354, 47868.76065619649, 52023.73988130035, 52948.735256323474, 41340.37989430221, 41655.37516937188, 42439.3634095495, 43313.0, 43941.0, 42137.1572568553, 42341.36487952621, 42885.57114428816, 43564.34653480264, 43948.340774887765, 42694.0, 42844.571554284055, 42918.78540607402, 43325.78337108294, 43451.78274108609, 36137.63862361448, 37462.250754984205, 37474.8126259367, 38145.618543814206, 38245.617543824206, 28873.711262887104, 29146.27134321659, 29227.048331873524, 29284.560731588615, 29504.0], "value": 19752.774922944227, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [402.88517772434864, 417.22604568525384, 419.2620987062769, 430.4705212588516, 430.4984692832848, 16154.0, 19472.70790938137, 19490.90254548727, 19497.41507754766, 19676.409707708775, 18993.240270389168, 19227.711584326247, 19435.514112147204, 19779.30772422962, 19881.90059049703, 4944.975275123637, 5521.4478552144865, 5734.340550836645, 6457.580257283285, 6505.284418713938, 6490.123833282493, 6502.577332473397, 6566.179227596551, 6569.244536878273, 6575.5068369872215, 6368.29948705642, 6508.219013718361, 6512.0, 6515.250746164181, 6535.183102112236, 6317.905231421532, 6357.116871078508, 6413.871722565523, 6505.284418713938, 6540.672966351687, 5608.383077861432, 5648.068068768648, 5650.9152362714185, 5651.519620832234, 5658.094704847204, 19910.0, 23340.76659233403, 23527.0, 23530.058797648075, 23738.64392034121, 2408.1330720940446, 2473.727889932106, 2510.297116807297, 2616.358992046961, 3069.3247485553143, 14574.41702331916, 14831.0, 14879.628009299855, 15181.316840742193, 15471.381144754196, 1914.74150989616, 1977.7231187633743, 2003.5592169722638, 2019.9293024744063, 2031.7561892572985, 58580.70709646425, 73264.63367683181, 73394.26605733928, 80736.59631701803, 81794.59102704449, 11148.888511114785, 11161.944190278997, 11417.714557135972, 11504.194706370474, 11667.941660291644, 16161.757573636405, 16190.352385904433, 16203.594910127105, 16234.51296461108, 16235.59411014734, 7889.9211007890335, 8168.346532277404, 8218.835623287501, 8274.213949674891, 8404.579771011426, 7677.155512893577, 7708.26771456722, 7802.648880800378, 7843.921560784319, 7999.120096789348, 6664.666766661648, 7041.612711300825, 7047.43620510358, 7057.50597458173, 7076.610786406797, 1791.1435201175175, 1839.9944060973603, 2012.5169959209684, 2043.570850121491, 2081.188336548747, 1015.8577799108131, 1041.5420802934186, 1050.7425680708122, 1063.941483218415, 1087.4499299143497, 19930.402087937386, 20224.89887550553, 20300.79699202989, 20356.0, 20451.8977405115, 1022.7238645565656, 1040.573364920379, 1056.630179437191, 1057.984130238047, 1073.4525392049954, 10430.598799134785, 11718.648440546796, 11807.586734464252, 11876.524939002344, 11967.222130561486, 486624.0, 507642.0, 508253.0, 510860.0, 515320.0, 78717.60641196757, 80174.0, 81412.59293703493, 82708.58645706733, 83627.5818620903, 1034.2863424237403, 1038.1694644284694, 1049.1554298789395, 1066.7653116314555, 1074.5701719312337, 17294.82705172932, 17575.912120439316, 17961.910190448965, 18021.369252076114, 18102.818971810113, 38490.422643660924, 38740.22519549537, 38964.610353896096, 39237.41143882787, 39991.60008399879, 51425.7428712854, 51900.480995189566, 51968.48031519788, 52919.20621190608, 53155.0, 6368.936310636835, 8256.13310602402, 8296.585170741319, 8408.70569530088, 8486.0241072275, 12819.935900320812, 13132.343382831012, 13169.802452963404, 13357.465701371837, 13397.263150526815, 8796.60415281301, 11365.659030229106, 11648.301101933912, 11743.530258789553, 11908.583199587973, 11233.32600044, 11691.240069395802, 11862.584809531625, 11995.520179193083, 12193.939030304791, 11354.489047993025, 11494.425278736197, 11767.470463828977, 12057.698557536132, 12305.077119215915, 8010.439269251096, 8997.145271199226, 9001.7749556259, 9022.894582964604, 9161.816763664823, 11183.105351571692, 11318.09455243595, 12009.699757505783, 12045.217060891015, 12281.263124212575], "value": 9563.668043496278, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1499.7675360319151, 1541.683954789268, 1704.8380403861636, 1789.2753434858887, 1817.9818201817986, 8225.383096267775, 8777.473351598908, 8779.385443018984, 8781.736547903565, 8783.341249406289, 7662.272084151997, 7852.0, 8333.708320208778, 8469.703560375388, 8574.91425085749, 2467.975320246797, 2494.8128890333205, 2497.325722055044, 2502.0, 2502.637117617944, 2454.3005243505604, 2541.8220724549287, 2549.3116858448207, 2549.6430499730054, 2549.9745002550017, 2447.070113356922, 2449.3141920262356, 2489.962650560234, 2496.7378425265356, 2502.2118032819694, 2439.5486834935505, 2446.3639453742067, 2466.5683505386487, 2467.5558399488173, 2467.7655622715815, 2465.4206261528525, 2473.839200451983, 2490.8879100440345, 2492.2523243027017, 2505.5615267328144, 8588.484690918565, 8675.0, 8689.26141277992, 8711.08533603975, 8714.302855771522, 5283.735813209324, 5404.108322126884, 5409.323834520685, 5409.377921539034, 5414.810481633124, 3453.4992426098074, 3699.1491956849804, 3720.051386896324, 3723.050622091376, 3732.402815549499, 1188.566173346731, 1226.4113225651738, 1243.9440225189799, 1269.4351013798864, 1318.202487495071, 11289.661310160709, 11947.462364193632, 11948.163628546004, 11975.22161059537, 11996.640100796903, 4732.621390288768, 4769.974455492086, 4893.657443978887, 4905.509449055137, 4916.508349165127, 9421.340506164503, 9512.429254244767, 9527.428354298765, 9532.618695252251, 9533.761655958519, 5457.781688732485, 5470.234167216593, 5480.068388373986, 5492.533134683516, 5499.395066542757, 4312.331588603772, 4435.911281774411, 4533.977330113395, 4914.533119353656, 5009.148444764399, 3933.272344616255, 3957.8614748483665, 4078.490188726409, 4081.591840815954, 4083.734557253769, 1234.9938250308692, 1262.9666237357847, 1267.1320145700224, 1267.8034904589804, 1284.2551320234243, 948.9288303377274, 959.947202903847, 965.280865755017, 972.4554249620236, 987.0474991632965, 5810.360860305363, 5811.738471768781, 5835.67903765297, 5928.170056192136, 5969.432903874125, 489.19527377464584, 493.580456611877, 506.44797171083695, 515.1088616693141, 518.6576859272861, 3964.8612298569988, 4027.4160246764054, 4077.673786097105, 4112.280350938574, 4116.91766164675, 10212.795744085077, 10489.895101049044, 10599.0, 10600.04599586041, 10600.681979540626, 10533.631322903662, 10536.420496872746, 10537.42044187577, 10538.789224215472, 10550.63072792464, 7701.345385642171, 7789.1042530108625, 8006.879896801553, 8010.919890801134, 8142.104368519458, 5724.685142317213, 5841.415858414124, 5870.26621672291, 5888.087346461305, 5921.881562368814, 9180.862287065833, 9291.581878815605, 9322.860157097784, 9532.95233523828, 9548.713538593853, 9347.298952578447, 9674.274429417963, 9825.950870245602, 9925.900740992498, 9974.052465015811, 7457.105147382349, 7586.165521792488, 7639.465237433548, 7692.346150577264, 7710.7686769397005, 7909.485883417559, 7954.085280192852, 7964.522128672298, 8079.83840323202, 8142.145074767301, 7329.377002954809, 7513.0, 7598.8100297493, 7631.7328893490685, 7792.181820908723, 7407.925920740724, 7508.174100848793, 7551.980482634994, 7580.166181720117, 7597.0, 6713.56361836479, 6801.557898736764, 6821.079154314302, 6825.419839313516, 6839.2476827547935, 4887.828925987574, 5088.262201980766, 5101.69389836611, 5112.846614601568, 5271.683698978073, 5133.0, 5208.791648334024, 5255.789768409374, 5267.71027593486, 5445.809396671098], "value": 4574.345586802644, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.48185167803337, 358.449779588332, 364.10067134178576, 368.6847745177873, 368.83402468889005, 5219.869503262411, 5360.383555891074, 5390.380106287778, 5422.566194704429, 5455.0, 5204.8698782530455, 5320.707361095138, 5350.8127215547465, 5369.355677318717, 5416.566674666027, 4305.935410968838, 4324.329728892011, 4325.113351762881, 4325.377983256279, 4331.956680433187, 4239.236937351276, 4284.871453856374, 4310.978445107786, 4334.761588112652, 4337.652987760987, 4267.48790145183, 4274.337477690963, 4275.40144379787, 4276.123394704078, 4283.485981682203, 4258.190943720699, 4269.594388533084, 4276.615104640582, 4286.335617979218, 4314.71954322968, 3763.7741735495683, 3845.65389114981, 3849.3456112460667, 3857.3442514772555, 3866.864659736924, 5218.112920803473, 5246.842594722164, 5260.605454590883, 5319.494648008472, 5331.360236771573, 4907.950920490785, 4910.631702622318, 4914.3611330527165, 4914.557689807899, 4922.0, 5503.862403439906, 5630.971845140748, 5644.774209031634, 5659.4340565943485, 5674.404187560288, 4162.293459681547, 4175.5572989801, 4180.310248808943, 4209.200251952119, 4235.512916014636, 5823.5341172706085, 5832.270966129234, 5832.358440571534, 5867.794627188028, 5880.500157486576, 4247.766372849523, 4313.245182093121, 4329.19909816685, 4334.9783251083545, 4337.175936572041, 4348.913021739548, 4352.542982986741, 4360.367746676778, 4366.868993930188, 4375.212461756914, 4870.951290487121, 4884.511548845158, 4900.0, 4912.852614421573, 4915.48387419323, 5477.016971247136, 5637.295338082739, 5639.407862174413, 5682.77268909239, 5699.494810691395, 1425.6792221750022, 1431.3415828718905, 1434.583970648521, 1439.4242303078852, 1442.6321288071474, 1008.4469916328918, 1042.801867645145, 1043.9164866810636, 1053.5943661690305, 1053.731298518888, 5221.060209162387, 5304.098303288451, 5306.681599104066, 5308.362996440452, 5319.547838433777, 5655.30340897729, 5666.744996475169, 5674.631148975303, 5681.0, 5690.715464226772, 5060.898782024413, 5247.737613119405, 5281.20781882713, 5328.6802791832615, 5398.595105367113, 2962.4374915698195, 2977.211039074647, 2982.1799005273724, 2984.865681044358, 2994.6406431228393, 5716.542676585863, 5728.828135155952, 5732.885342293131, 5745.339285982165, 5772.7690892363835, 5679.290088738908, 5989.31122920861, 5995.220621319288, 5997.6401415914315, 6010.939890601038, 5994.490468310155, 6023.524236561982, 6028.728707208186, 6039.63762174271, 6039.78860739872, 5641.407652196624, 5837.94162058391, 5852.94147058524, 5867.383924688017, 5913.881722365614, 5725.93866208173, 5784.652920824764, 5791.884162316815, 5800.332961709458, 5802.883942321215, 5821.534277257894, 5966.731497082555, 5999.5500337473995, 6004.118023348904, 6027.427394397525, 4187.685923555685, 4209.137126889042, 4215.220184265921, 4217.9367309491, 4236.152769446061, 5852.561057920588, 5874.530037597067, 5878.412828536357, 5888.910551547978, 5901.557383196363, 5545.643101681689, 5692.0, 5724.8282551523525, 5772.336181339199, 5777.91333129995, 5652.68910209926, 5665.235193249024, 5673.8297851064535, 5674.092145256739, 5676.489115979582, 5658.538535736968, 5663.263775709132, 5667.489925906688, 5668.404817494104, 5685.687287199078, 5555.472230138131, 5684.237886255274, 5740.885182296414, 5745.2818397700285, 5776.855578610568, 5612.7193640317, 5615.775368985195, 5615.859603509945, 5616.606837521498, 5625.915611265917], "value": 4360.988640893191, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [727.9999999999997, 757.303280981497, 794.1819925476757, 837.777988832959, 849.52426641081, 15590.0, 15755.921220393911, 16236.0, 16242.269097890594, 16318.673626527463, 13712.451501939935, 14719.411223551071, 14907.403703851833, 14912.328945197465, 14926.850731492681, 841.4908980067048, 862.2541501601102, 862.8791969124328, 863.0937515608617, 863.197226579281, 852.799592095857, 855.683397143058, 858.8282343531288, 860.096898256831, 860.2816648098814, 898.2364989758718, 901.6979311930511, 902.2736696958946, 902.9413088149249, 903.6927444668811, 883.5891310540597, 883.8674198870157, 887.5695287785419, 888.8133491966695, 889.4085433186955, 659.7921654678761, 664.2195420381081, 664.6078813500059, 665.2947875252248, 665.5574043261225, 14179.43282268708, 14200.644983875383, 14205.360758765777, 14434.639134021629, 14666.340014699364, 14254.643633909132, 14872.405103795834, 14911.925440372728, 14937.253137343198, 14976.925115374463, 12120.151589388746, 12210.32843193624, 12212.32832194229, 12253.081018923527, 12332.630021099381, 3821.885343439701, 3822.10180607557, 3826.5408151022057, 3892.0853599404118, 3924.352481840493, 38798.41802372967, 46222.53777462216, 51540.22689659658, 56586.43413565853, 64340.67829660822, 11846.940765296118, 11971.940140299417, 12069.637910862688, 12079.27524348542, 12280.938595307145, 20737.0, 20807.791922080887, 20812.47968800792, 20825.271115510885, 20852.165913363297, 7273.745418910313, 8332.62503187358, 8612.397132200811, 8697.0, 8717.564121793885, 4525.886852828706, 4600.631949444037, 4653.278741795028, 4714.339992401066, 4825.686330388514, 3469.427544455187, 3565.7860528368383, 3572.6070132285427, 3580.4987301777774, 3587.0673624857204, 663.0882536512296, 673.1282988529767, 678.5352033856725, 679.2155060904663, 680.0377465885716, 754.528419737664, 773.9148693643695, 774.1832366852911, 781.8514482248355, 790.6797746912509, 9650.0, 10186.388816671024, 10195.643152489627, 10336.948315258525, 10444.843327350096, 657.5068698476143, 685.348918527401, 728.8797348437555, 774.1213722425088, 782.4444644302608, 4957.3059771632, 5032.874178145576, 5042.117629414838, 5051.116054690415, 5087.440381558025, 55944.0, 56601.43398565962, 89373.0, 92083.0, 93783.53108234552, 77187.61406192933, 79438.6028069856, 80449.0, 80740.0, 81037.59481202674, 45983.77008114938, 46649.0, 54700.45299547033, 69710.65144674346, 73426.26573734195, 9336.253099752139, 9812.607495700093, 9922.355046921926, 10009.349392289478, 10022.098011179029, 40562.0, 41312.0, 49321.506784933124, 49403.0, 49502.50497495123, 50562.747186263834, 57765.422345776, 57952.0, 59802.0, 62070.68964655148, 12213.633590992284, 13077.0, 13226.603201903958, 13296.734065318833, 13579.117357371739, 13619.591412257649, 14401.279936003368, 14521.564353069425, 14563.85436145625, 14569.635759106108, 13606.183628982293, 13818.447262109805, 14046.859531404556, 14100.78848817248, 14473.782893256399, 13989.93005035009, 14111.788323174955, 14128.293585320898, 14177.858221417653, 14485.85514144845, 13450.0, 13503.527376541773, 13697.726045479234, 13971.161730295808, 14501.419943202154, 11177.242408066173, 11672.824907626562, 11899.821502677294, 11901.285922844658, 12088.566747753632, 11862.82205766897, 11999.0, 12023.21849079807, 12073.335966521574, 12108.273503589813], "value": 7374.101946550566, "unit": "score"}], "name": "dromaeo_css", "value": 7316.638770380151, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 112.0, 109.0, 111.0, 109.0, 111.0, 110.0, 110.0, 111.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 121.0, 119.0, 161.0, 120.0, 121.0, 123.0, 118.0, 149.0, 120.0], "value": 130.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 163.0, 160.0, 159.0, 159.0, 160.0, 159.0, 162.0, 159.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 107.0, 83.0, 76.0, 75.0, 75.0, 100.0, 74.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 110.0, 82.0, 82.0, 82.0, 98.0, 81.0, 81.0, 103.0], "value": 88.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 85.0, 84.0, 85.0, 85.0, 84.0, 85.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 51.0, 51.0, 50.0, 50.0, 60.0, 53.0, 50.0, 50.0], "value": 51.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 59.0, 59.0, 59.0, 59.0, 60.0, 59.0, 59.0, 60.0, 61.0], "value": 59.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 83.0, 74.0, 74.0, 74.0, 74.0, 74.0, 75.0, 82.0], "value": 75.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 130.0, 127.0, 123.0, 129.0, 129.0, 124.0, 118.0, 169.0, 130.0], "value": 130.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 151.0, 151.0, 150.0, 155.0, 152.0, 152.0, 157.0, 152.0, 151.0], "value": 152.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 64.0, 62.0, 62.0, 63.0, 62.0, 61.0, 60.0, 60.0], "value": 61.8, "unit": "score"}], "name": "kraken", "value": 1448.7, "alertThreshold": 2.0}]} 08:20:36 INFO - Return code: 0 08:20:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:20:36 INFO - # TBPL SUCCESS # 08:20:36 INFO - Running post-action listener: _resource_record_post_action 08:20:36 INFO - [mozharness: 2016-12-21 16:20:36.896449Z] Finished run-tests step (success) 08:20:36 INFO - Running post-run listener: _resource_record_post_run 08:20:36 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 266240; Write bytes: 372363264; Read time: 60; Write time: 512952 08:20:36 INFO - TinderboxPrint: CPU usage
13.0% 08:20:36 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 60 08:20:36 INFO - TinderboxPrint: I/O write bytes / time
372,363,264 / 512,952 08:20:36 INFO - TinderboxPrint: CPU idle
8,298.2 (87.0%) 08:20:36 INFO - TinderboxPrint: CPU user
1,187.8 (12.5%) 08:20:36 INFO - TinderboxPrint: Swap in / out
0 / 0 08:20:36 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 113672192; Read time: 0; Write time: 207860 08:20:36 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 262144; Write bytes: 244961280; Read time: 16; Write time: 285388 08:20:37 INFO - Running post-run listener: _upload_blobber_files 08:20:37 INFO - Blob upload gear active. 08:20:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:20:37 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:20:37 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:20:37 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:20:37 INFO - (blobuploader) - INFO - Open directory for files ... 08:20:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:20:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:20:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:20:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:20:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:20:41 INFO - (blobuploader) - INFO - Done attempting. 08:20:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:20:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:20:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:20:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:20:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:20:42 INFO - (blobuploader) - INFO - Done attempting. 08:20:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:20:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:20:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:20:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:20:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:20:43 INFO - (blobuploader) - INFO - Done attempting. 08:20:43 INFO - (blobuploader) - INFO - Iteration through files over. 08:20:43 INFO - Return code: 0 08:20:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:20:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:20:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8ee925c86810b1383d9f58256ea909d4c5a844cd7222ca5de9aac67402f0cb16f13f3aa093822297d10f44a8af659ca19dace5489c28cbd44f16380400e9f3f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6a041d9911a7a8de90f5c2eb97e3218546231dac23d398908c86a548f1d58839f85d74e226bf012839d3f2869e04480298b986d44752cfd53b53dcf3f4335bd2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4ca115060ea02442edff62cde91b40a6eda9b656ef6339b99ae4e4c042f506924f0106c369790d5f8361813a1a28b76c4e0f326f25ac929db01f63cb70b3c8e5"} 08:20:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:20:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:20:43 INFO - Contents: 08:20:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8ee925c86810b1383d9f58256ea909d4c5a844cd7222ca5de9aac67402f0cb16f13f3aa093822297d10f44a8af659ca19dace5489c28cbd44f16380400e9f3f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6a041d9911a7a8de90f5c2eb97e3218546231dac23d398908c86a548f1d58839f85d74e226bf012839d3f2869e04480298b986d44752cfd53b53dcf3f4335bd2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4ca115060ea02442edff62cde91b40a6eda9b656ef6339b99ae4e4c042f506924f0106c369790d5f8361813a1a28b76c4e0f326f25ac929db01f63cb70b3c8e5"} 08:20:43 INFO - Running post-run listener: copy_logs_to_upload_dir 08:20:43 INFO - Copying logs to upload dir... 08:20:43 INFO - mkdir: /builds/slave/test/build/upload/logs 08:20:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.709473 ========= master_lag: 0.69 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-12-21 08:20:43.672908) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-21 08:20:43.676506) ========= 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=df17445c3590ff7897617a0e00000225-1482333807.805368-1727432444 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/8ee925c86810b1383d9f58256ea909d4c5a844cd7222ca5de9aac67402f0cb16f13f3aa093822297d10f44a8af659ca19dace5489c28cbd44f16380400e9f3f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6a041d9911a7a8de90f5c2eb97e3218546231dac23d398908c86a548f1d58839f85d74e226bf012839d3f2869e04480298b986d44752cfd53b53dcf3f4335bd2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4ca115060ea02442edff62cde91b40a6eda9b656ef6339b99ae4e4c042f506924f0106c369790d5f8361813a1a28b76c4e0f326f25ac929db01f63cb70b3c8e5"} build_url:https://queue.taskcluster.net/v1/task/HDPsacxMS8WzKuWNhkoGrg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011314 build_url: 'https://queue.taskcluster.net/v1/task/HDPsacxMS8WzKuWNhkoGrg/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/8ee925c86810b1383d9f58256ea909d4c5a844cd7222ca5de9aac67402f0cb16f13f3aa093822297d10f44a8af659ca19dace5489c28cbd44f16380400e9f3f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6a041d9911a7a8de90f5c2eb97e3218546231dac23d398908c86a548f1d58839f85d74e226bf012839d3f2869e04480298b986d44752cfd53b53dcf3f4335bd2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4ca115060ea02442edff62cde91b40a6eda9b656ef6339b99ae4e4c042f506924f0106c369790d5f8361813a1a28b76c4e0f326f25ac929db01f63cb70b3c8e5"}' ========= master_lag: 0.14 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-21 08:20:43.829867) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 08:20:43.830224) ========= 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=df17445c3590ff7897617a0e00000225-1482333807.805368-1727432444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004491 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 08:20:43.882175) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-21 08:20:43.882552) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-21 08:20:43.882889) ========= ========= Total master_lag: 0.98 =========