builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-012 starttime: 1476450839.07 results: success (0) buildid: 20161014030204 builduid: 556e162375ac4a82a70e66f019d666d7 revision: 1391a2889aeb2bdd61ad6ef838e65826e35aabc2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 06:13:59.067854) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 06:13:59.068378) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 06:13:59.071720) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 06:13:59.099123) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 06:13:59.099413) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1476448062.840541-928227769 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-14 06:13:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 22.5M=0.001s 2016-10-14 06:13:59 (22.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.142846 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 06:13:59.256134) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 06:13:59.256559) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1476448062.840541-928227769 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018430 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 06:13:59.306547) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 06:13:59.306918) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1391a2889aeb2bdd61ad6ef838e65826e35aabc2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 1391a2889aeb2bdd61ad6ef838e65826e35aabc2 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1476448062.840541-928227769 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-14 06:13:59,573 truncating revision to first 12 chars 2016-10-14 06:13:59,573 Setting DEBUG logging. 2016-10-14 06:13:59,573 attempt 1/10 2016-10-14 06:13:59,573 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1391a2889aeb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-14 06:13:59,886 unpacking tar archive at: mozilla-central-1391a2889aeb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.717655 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 06:14:00.038073) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 06:14:00.038482) ========= script_repo_revision: 1391a2889aeb2bdd61ad6ef838e65826e35aabc2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 06:14:00.039169) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 06:14:00.039476) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 06:14:00.050336) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-14 06:14:00.050651) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1476448062.840541-928227769 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:14:00 INFO - MultiFileLogger online at 20161014 06:14:00 in /builds/slave/test 06:14:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:14:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:14:00 INFO - {'append_to_log': False, 06:14:00 INFO - 'base_work_dir': '/builds/slave/test', 06:14:00 INFO - 'blob_upload_branch': 'Firefox', 06:14:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:14:00 INFO - 'branch': 'Firefox', 06:14:00 INFO - 'buildbot_json_path': 'buildprops.json', 06:14:00 INFO - 'config_files': ('talos/linux_config.py',), 06:14:00 INFO - 'default_actions': ('clobber', 06:14:00 INFO - 'read-buildbot-config', 06:14:00 INFO - 'download-and-extract', 06:14:00 INFO - 'populate-webroot', 06:14:00 INFO - 'create-virtualenv', 06:14:00 INFO - 'install', 06:14:00 INFO - 'run-tests'), 06:14:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:14:00 INFO - 'download_minidump_stackwalk': True, 06:14:00 INFO - 'download_symbols': 'ondemand', 06:14:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:14:00 INFO - 'tooltool.py': '/tools/tooltool.py', 06:14:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:14:00 INFO - '/tools/misc-python/virtualenv.py')}, 06:14:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:14:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:14:00 INFO - 'installer_path': 'installer.exe', 06:14:00 INFO - 'log_level': 'info', 06:14:00 INFO - 'log_name': 'talos', 06:14:00 INFO - 'log_to_console': True, 06:14:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:14:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:14:00 INFO - 'opt_config_files': (), 06:14:00 INFO - 'pip_index': False, 06:14:00 INFO - 'sps_profile': False, 06:14:00 INFO - 'sps_profile_interval': 0, 06:14:00 INFO - 'suite': 'dromaeojs', 06:14:00 INFO - 'system_bits': '32', 06:14:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:14:00 INFO - 'title': 'talos-linux64-ix-012', 06:14:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:14:00 INFO - 'use_talos_json': True, 06:14:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:14:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:14:00 INFO - 'work_dir': 'build'} 06:14:00 INFO - [mozharness: 2016-10-14 13:14:00.416849Z] Running clobber step. 06:14:00 INFO - Running pre-action listener: _resource_record_pre_action 06:14:00 INFO - Running main action method: clobber 06:14:00 INFO - rmtree: /builds/slave/test/build 06:14:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:14:00 INFO - Running post-action listener: _resource_record_post_action 06:14:00 INFO - [mozharness: 2016-10-14 13:14:00.876492Z] Finished clobber step (success) 06:14:00 INFO - [mozharness: 2016-10-14 13:14:00.876593Z] Running read-buildbot-config step. 06:14:00 INFO - Running pre-action listener: _resource_record_pre_action 06:14:00 INFO - Running main action method: read_buildbot_config 06:14:00 INFO - Using buildbot properties: 06:14:00 INFO - { 06:14:00 INFO - "project": "", 06:14:00 INFO - "product": "firefox", 06:14:00 INFO - "script_repo_revision": "production", 06:14:00 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 06:14:00 INFO - "repository": "", 06:14:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 06:14:00 INFO - "buildid": "20161014030204", 06:14:00 INFO - "stage_platform": "linux64-pgo", 06:14:00 INFO - "basedir": "/builds/slave/test", 06:14:00 INFO - "nightly_build": "True", 06:14:00 INFO - "buildnumber": 592, 06:14:00 INFO - "slavename": "talos-linux64-ix-012", 06:14:00 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:14:00 INFO - "platform": "ubuntu64_hw", 06:14:00 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 06:14:00 INFO - "branch": "mozilla-central", 06:14:00 INFO - "repo_path": "mozilla-central", 06:14:00 INFO - "revision": "1391a2889aeb2bdd61ad6ef838e65826e35aabc2", 06:14:00 INFO - "pgo_build": "True", 06:14:00 INFO - "builduid": "556e162375ac4a82a70e66f019d666d7", 06:14:00 INFO - "slavebuilddir": "test" 06:14:00 INFO - } 06:14:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/DdYYgrxgR6KTTj_XUXnDRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 06:14:00 INFO - Running post-action listener: _resource_record_post_action 06:14:00 INFO - [mozharness: 2016-10-14 13:14:00.879109Z] Finished read-buildbot-config step (success) 06:14:00 INFO - [mozharness: 2016-10-14 13:14:00.879196Z] Running download-and-extract step. 06:14:00 INFO - Running pre-action listener: _resource_record_pre_action 06:14:00 INFO - Running main action method: download_and_extract 06:14:00 INFO - mkdir: /builds/slave/test/build/tests 06:14:00 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')]} 06:14:00 INFO - trying https://queue.taskcluster.net/v1/task/DdYYgrxgR6KTTj_XUXnDRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:14:00 INFO - Downloading https://queue.taskcluster.net/v1/task/DdYYgrxgR6KTTj_XUXnDRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:14:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DdYYgrxgR6KTTj_XUXnDRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:14:01 INFO - Downloaded 1361 bytes. 06:14:01 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:14:01 INFO - Using the following test package requirements: 06:14:01 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:14:01 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:14:01 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:14:01 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:01 INFO - u'jsshell-linux-x86_64.zip'], 06:14:01 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:14:01 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:14:01 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:14:01 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:14:01 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:14:01 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:14:01 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:14:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DdYYgrxgR6KTTj_XUXnDRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:14:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DdYYgrxgR6KTTj_XUXnDRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:14:01 INFO - Fetch https://queue.taskcluster.net/v1/task/DdYYgrxgR6KTTj_XUXnDRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:14:02 INFO - Http code: 200 06:14:02 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 06:14:02 INFO - x-amz-cf-id: IqWFZyddmxgBWz2bWGCNbSf1qyIgpdQPniU-llq7iLwZC1JeFi7lHQ== 06:14:02 INFO - x-amz-version-id: AjjGwCDrWsPs09TNcZ9Cn76oI6QvPSMI 06:14:02 INFO - Expected file size: 22122970 06:14:02 INFO - Obtained file size: 22122970 06:14:06 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:14:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DdYYgrxgR6KTTj_XUXnDRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:14:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DdYYgrxgR6KTTj_XUXnDRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:14:06 INFO - Fetch https://queue.taskcluster.net/v1/task/DdYYgrxgR6KTTj_XUXnDRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:14:06 INFO - Http code: 200 06:14:06 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 06:14:06 INFO - x-amz-cf-id: JAhPGOccoVDqXw2eFsF2xof3sEX4zX9jQvMI2nhhloxfM2JaqgpLaA== 06:14:06 INFO - x-amz-version-id: AjjGwCDrWsPs09TNcZ9Cn76oI6QvPSMI 06:14:07 INFO - Expected file size: 22122970 06:14:07 INFO - Obtained file size: 22122970 06:14:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DdYYgrxgR6KTTj_XUXnDRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 06:14:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DdYYgrxgR6KTTj_XUXnDRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:14:11 INFO - Fetch https://queue.taskcluster.net/v1/task/DdYYgrxgR6KTTj_XUXnDRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 06:14:12 INFO - Http code: 200 06:14:12 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 06:14:12 INFO - x-amz-cf-id: S9wswaH2mH4dTMX2JBNaVOMLAkKiY0nDCzV7FiTaAlk1EmZi6W736w== 06:14:12 INFO - x-amz-version-id: UhyrYQSOQPJKonEtzXrvBPtuTv4T6UVw 06:14:12 INFO - Expected file size: 14409006 06:14:12 INFO - Obtained file size: 14409006 06:14:13 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')]} 06:14:13 INFO - trying https://queue.taskcluster.net/v1/task/DdYYgrxgR6KTTj_XUXnDRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:14:13 INFO - Downloading https://queue.taskcluster.net/v1/task/DdYYgrxgR6KTTj_XUXnDRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:14:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DdYYgrxgR6KTTj_XUXnDRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:14:15 INFO - Downloaded 59602227 bytes. 06:14:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DdYYgrxgR6KTTj_XUXnDRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:14:15 INFO - mkdir: /builds/slave/test/properties 06:14:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:14:15 INFO - Writing to file /builds/slave/test/properties/build_url 06:14:15 INFO - Contents: 06:14:15 INFO - build_url:https://queue.taskcluster.net/v1/task/DdYYgrxgR6KTTj_XUXnDRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:14:15 INFO - Running post-action listener: _resource_record_post_action 06:14:15 INFO - Running post-action listener: set_extra_try_arguments 06:14:15 INFO - [mozharness: 2016-10-14 13:14:15.976962Z] Finished download-and-extract step (success) 06:14:15 INFO - [mozharness: 2016-10-14 13:14:15.977227Z] Running populate-webroot step. 06:14:15 INFO - Running pre-action listener: _resource_record_pre_action 06:14:15 INFO - Running main action method: populate_webroot 06:14:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:14:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:14:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:14:15 INFO - '--tppagecycles', 06:14:15 INFO - '7'], 06:14:15 INFO - 'tests': ['tsvgm']}}, 06:14:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:14:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:14:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:14:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:14:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:14:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:14:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:15 INFO - 'talos_options': ['--disable-e10s'], 06:14:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:14:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:14:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:15 INFO - 'talos_options': ['--disable-e10s'], 06:14:15 INFO - 'tests': ['damp', 'tps']}, 06:14:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:15 INFO - 'tests': ['damp', 'tps']}, 06:14:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:14:15 INFO - 'tests': ['dromaeo_dom']}, 06:14:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:14:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:14:15 INFO - 'tests': ['basic_compositor_video']}, 06:14:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:14:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:14:15 INFO - 'tests': ['a11yr', 06:14:15 INFO - 'ts_paint', 06:14:15 INFO - 'tpaint', 06:14:15 INFO - 'sessionrestore', 06:14:15 INFO - 'sessionrestore_no_auto_restore', 06:14:15 INFO - 'tabpaint']}, 06:14:15 INFO - 'other-e10s': {'tests': ['a11yr', 06:14:15 INFO - 'ts_paint', 06:14:15 INFO - 'tpaint', 06:14:15 INFO - 'sessionrestore', 06:14:15 INFO - 'sessionrestore_no_auto_restore', 06:14:15 INFO - 'tabpaint']}, 06:14:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:14:15 INFO - 'ts_paint', 06:14:15 INFO - 'tpaint', 06:14:15 INFO - 'sessionrestore', 06:14:15 INFO - 'sessionrestore_no_auto_restore', 06:14:15 INFO - 'tabpaint']}, 06:14:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:14:15 INFO - 'ts_paint', 06:14:15 INFO - 'tpaint', 06:14:15 INFO - 'sessionrestore', 06:14:15 INFO - 'sessionrestore_no_auto_restore', 06:14:15 INFO - 'tabpaint']}, 06:14:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:14:15 INFO - 'tests': ['a11yr', 06:14:15 INFO - 'ts_paint', 06:14:15 INFO - 'tpaint', 06:14:15 INFO - 'sessionrestore', 06:14:15 INFO - 'sessionrestore_no_auto_restore', 06:14:15 INFO - 'tabpaint']}, 06:14:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:14:15 INFO - 'tests': ['a11yr', 06:14:15 INFO - 'ts_paint', 06:14:15 INFO - 'tpaint', 06:14:15 INFO - 'sessionrestore', 06:14:15 INFO - 'sessionrestore_no_auto_restore', 06:14:15 INFO - 'tabpaint']}, 06:14:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:14:15 INFO - 'tests': ['tsvgx', 06:14:15 INFO - 'tsvgr_opacity', 06:14:15 INFO - 'tart', 06:14:15 INFO - 'tscrollx', 06:14:15 INFO - 'cart']}, 06:14:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:14:15 INFO - 'tsvgr_opacity', 06:14:15 INFO - 'tart', 06:14:15 INFO - 'tscrollx', 06:14:15 INFO - 'cart']}, 06:14:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:15 INFO - 'talos_options': ['--disable-e10s'], 06:14:15 INFO - 'tests': ['tp5o']}, 06:14:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:15 INFO - 'tests': ['tp5o']}, 06:14:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:15 INFO - 'talos_options': ['--disable-e10s', 06:14:15 INFO - '--xperf_path', 06:14:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:14:15 INFO - 'tests': ['tp5n']}, 06:14:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:15 INFO - 'talos_options': ['--xperf_path', 06:14:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:14:15 INFO - 'tests': ['tp5n']}}, 06:14:15 INFO - 'talos.zip': {'path': '', 06:14:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:14:15 INFO - Running post-action listener: _resource_record_post_action 06:14:15 INFO - [mozharness: 2016-10-14 13:14:15.998177Z] Finished populate-webroot step (success) 06:14:15 INFO - [mozharness: 2016-10-14 13:14:15.998266Z] Running create-virtualenv step. 06:14:15 INFO - Running pre-action listener: _resource_record_pre_action 06:14:15 INFO - Running main action method: create_virtualenv 06:14:15 INFO - Creating virtualenv /builds/slave/test/build/venv 06:14:15 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 06:14:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:14:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:14:16 INFO - Using real prefix '/usr' 06:14:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:14:16 INFO - Installing distribute.............................................................................................................................................................................................done. 06:14:18 INFO - Installing pip.................done. 06:14:18 INFO - Return code: 0 06:14:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:14:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:14:18 INFO - Reading from file tmpfile_stdout 06:14:18 INFO - Output received: 06:14:18 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) 06:14:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:14:18 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')]} 06:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:18 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')]} 06:14:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:18 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 0x7fd3a72e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x195e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195b930>, '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 0x195c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x195ccc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1476448062.840541-928227769', '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 06:14:18 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 06:14:18 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 06:14:18 INFO - Using env: {'DISPLAY': ':0', 06:14:18 INFO - 'HOME': '/home/cltbld', 06:14:18 INFO - 'LANG': 'en_US.UTF-8', 06:14:18 INFO - 'LANGUAGE': 'en_US:en', 06:14:18 INFO - 'LOGNAME': 'cltbld', 06:14:18 INFO - 'MAIL': '/var/mail/cltbld', 06:14:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:18 INFO - 'MOZ_NO_REMOTE': '1', 06:14:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:14:18 INFO - 'NO_EM_RESTART': '1', 06:14:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:14:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:18 INFO - 'PWD': '/builds/slave/test', 06:14:18 INFO - 'SHELL': '/bin/bash', 06:14:18 INFO - 'SHLVL': '1', 06:14:18 INFO - 'TERM': 'linux', 06:14:18 INFO - 'TMOUT': '86400', 06:14:18 INFO - 'USER': 'cltbld', 06:14:18 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1476448062.840541-928227769', 06:14:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:18 INFO - '_': '/tools/buildbot/bin/python'} 06:14:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:18 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 06:14:18 INFO - Cleaning up... 06:14:18 INFO - Return code: 0 06:14:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:14:18 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')]} 06:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:18 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')]} 06:14:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd3a72e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x195e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195b930>, '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 0x195c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x195ccc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1476448062.840541-928227769', '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 06:14:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:14:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:14:19 INFO - Using env: {'DISPLAY': ':0', 06:14:19 INFO - 'HOME': '/home/cltbld', 06:14:19 INFO - 'LANG': 'en_US.UTF-8', 06:14:19 INFO - 'LANGUAGE': 'en_US:en', 06:14:19 INFO - 'LOGNAME': 'cltbld', 06:14:19 INFO - 'MAIL': '/var/mail/cltbld', 06:14:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:19 INFO - 'MOZ_NO_REMOTE': '1', 06:14:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:14:19 INFO - 'NO_EM_RESTART': '1', 06:14:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:14:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:19 INFO - 'PWD': '/builds/slave/test', 06:14:19 INFO - 'SHELL': '/bin/bash', 06:14:19 INFO - 'SHLVL': '1', 06:14:19 INFO - 'TERM': 'linux', 06:14:19 INFO - 'TMOUT': '86400', 06:14:19 INFO - 'USER': 'cltbld', 06:14:19 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1476448062.840541-928227769', 06:14:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:19 INFO - '_': '/tools/buildbot/bin/python'} 06:14:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:19 INFO - Downloading/unpacking psutil>=3.1.1 06:14:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:14:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:14:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:14:21 INFO - Installing collected packages: psutil 06:14:21 INFO - Running setup.py install for psutil 06:14:21 INFO - building 'psutil._psutil_linux' extension 06:14:21 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 06:14:21 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 06:14:21 INFO - building 'psutil._psutil_posix' extension 06:14:21 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 06:14:21 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 06:14:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:14:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:14:21 INFO - Successfully installed psutil 06:14:21 INFO - Cleaning up... 06:14:21 INFO - Return code: 0 06:14:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:14: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')]} 06:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14: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')]} 06:14:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3a72e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x195e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195b930>, '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 0x195c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x195ccc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1476448062.840541-928227769', '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 06:14: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:14: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 mozsystemmonitor==0.3 06:14:21 INFO - Using env: {'DISPLAY': ':0', 06:14:21 INFO - 'HOME': '/home/cltbld', 06:14:21 INFO - 'LANG': 'en_US.UTF-8', 06:14:21 INFO - 'LANGUAGE': 'en_US:en', 06:14:21 INFO - 'LOGNAME': 'cltbld', 06:14:21 INFO - 'MAIL': '/var/mail/cltbld', 06:14:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:21 INFO - 'MOZ_NO_REMOTE': '1', 06:14:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:14:21 INFO - 'NO_EM_RESTART': '1', 06:14:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:14:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:21 INFO - 'PWD': '/builds/slave/test', 06:14:21 INFO - 'SHELL': '/bin/bash', 06:14:21 INFO - 'SHLVL': '1', 06:14:21 INFO - 'TERM': 'linux', 06:14:21 INFO - 'TMOUT': '86400', 06:14:21 INFO - 'USER': 'cltbld', 06:14:21 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1476448062.840541-928227769', 06:14:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:21 INFO - '_': '/tools/buildbot/bin/python'} 06:14:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:14:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:14:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:14:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:14:23 INFO - Installing collected packages: mozsystemmonitor 06:14:23 INFO - Running setup.py install for mozsystemmonitor 06:14:24 INFO - Successfully installed mozsystemmonitor 06:14:24 INFO - Cleaning up... 06:14:24 INFO - Return code: 0 06:14:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:14: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')]} 06:14:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14: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')]} 06:14:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14: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', '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 0x7fd3a72e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x195e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195b930>, '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 0x195c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x195ccc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1476448062.840541-928227769', '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 06:14: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:14: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 jsonschema==2.5.1 06:14:24 INFO - Using env: {'DISPLAY': ':0', 06:14:24 INFO - 'HOME': '/home/cltbld', 06:14:24 INFO - 'LANG': 'en_US.UTF-8', 06:14:24 INFO - 'LANGUAGE': 'en_US:en', 06:14:24 INFO - 'LOGNAME': 'cltbld', 06:14:24 INFO - 'MAIL': '/var/mail/cltbld', 06:14:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:24 INFO - 'MOZ_NO_REMOTE': '1', 06:14:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:14:24 INFO - 'NO_EM_RESTART': '1', 06:14:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:14:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:24 INFO - 'PWD': '/builds/slave/test', 06:14:24 INFO - 'SHELL': '/bin/bash', 06:14:24 INFO - 'SHLVL': '1', 06:14:24 INFO - 'TERM': 'linux', 06:14:24 INFO - 'TMOUT': '86400', 06:14:24 INFO - 'USER': 'cltbld', 06:14:24 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1476448062.840541-928227769', 06:14:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:24 INFO - '_': '/tools/buildbot/bin/python'} 06:14:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:24 INFO - Downloading/unpacking jsonschema==2.5.1 06:14: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 06:14: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 06:14: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 06:14: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 06:14: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 06:14: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 06:14:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:14:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:26 INFO - Downloading functools32-3.2.3-2.tar.gz 06:14:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:14:26 INFO - warning: no files found matching '*.txt' 06:14:26 INFO - no previously-included directories found matching 'build' 06:14:26 INFO - no previously-included directories found matching 'dist' 06:14:26 INFO - no previously-included directories found matching '.git*' 06:14:26 INFO - Installing collected packages: jsonschema, functools32 06:14:26 INFO - Running setup.py install for functools32 06:14:26 INFO - warning: no files found matching '*.txt' 06:14:26 INFO - no previously-included directories found matching 'build' 06:14:26 INFO - no previously-included directories found matching 'dist' 06:14:26 INFO - no previously-included directories found matching '.git*' 06:14:26 INFO - Successfully installed jsonschema functools32 06:14:26 INFO - Cleaning up... 06:14:26 INFO - Return code: 0 06:14:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:14:26 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')]} 06:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:26 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')]} 06:14:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:26 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 0x7fd3a72e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x195e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195b930>, '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 0x195c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x195ccc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1476448062.840541-928227769', '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 06:14:26 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 06:14:26 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 06:14:26 INFO - Using env: {'DISPLAY': ':0', 06:14:26 INFO - 'HOME': '/home/cltbld', 06:14:26 INFO - 'LANG': 'en_US.UTF-8', 06:14:26 INFO - 'LANGUAGE': 'en_US:en', 06:14:26 INFO - 'LOGNAME': 'cltbld', 06:14:26 INFO - 'MAIL': '/var/mail/cltbld', 06:14:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:26 INFO - 'MOZ_NO_REMOTE': '1', 06:14:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:14:26 INFO - 'NO_EM_RESTART': '1', 06:14:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:14:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:26 INFO - 'PWD': '/builds/slave/test', 06:14:26 INFO - 'SHELL': '/bin/bash', 06:14:26 INFO - 'SHLVL': '1', 06:14:26 INFO - 'TERM': 'linux', 06:14:26 INFO - 'TMOUT': '86400', 06:14:26 INFO - 'USER': 'cltbld', 06:14:26 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1476448062.840541-928227769', 06:14:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:26 INFO - '_': '/tools/buildbot/bin/python'} 06:14:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:14:26 INFO - Cleaning up... 06:14:26 INFO - Return code: 0 06:14:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:14:26 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')]} 06:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:26 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')]} 06:14:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:26 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 0x7fd3a72e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x195e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195b930>, '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 0x195c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x195ccc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1476448062.840541-928227769', '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 06:14:26 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 06:14:26 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 06:14:26 INFO - Using env: {'DISPLAY': ':0', 06:14:26 INFO - 'HOME': '/home/cltbld', 06:14:26 INFO - 'LANG': 'en_US.UTF-8', 06:14:26 INFO - 'LANGUAGE': 'en_US:en', 06:14:26 INFO - 'LOGNAME': 'cltbld', 06:14:26 INFO - 'MAIL': '/var/mail/cltbld', 06:14:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:26 INFO - 'MOZ_NO_REMOTE': '1', 06:14:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:14:26 INFO - 'NO_EM_RESTART': '1', 06:14:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:14:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:26 INFO - 'PWD': '/builds/slave/test', 06:14:26 INFO - 'SHELL': '/bin/bash', 06:14:26 INFO - 'SHLVL': '1', 06:14:26 INFO - 'TERM': 'linux', 06:14:26 INFO - 'TMOUT': '86400', 06:14:26 INFO - 'USER': 'cltbld', 06:14:26 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1476448062.840541-928227769', 06:14:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:26 INFO - '_': '/tools/buildbot/bin/python'} 06:14:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:27 INFO - Downloading/unpacking blobuploader==1.2.4 06:14: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 06:14: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 06:14: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 06:14: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 06:14: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 06:14: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 06:14:29 INFO - Downloading blobuploader-1.2.4.tar.gz 06:14:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:14:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:14: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 06:14: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 06:14: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 06:14: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 06:14: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 06:14: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 06:14:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:14:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:14: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 06:14: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 06:14: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 06:14: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 06:14: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 06:14: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 06:14:29 INFO - Downloading docopt-0.6.1.tar.gz 06:14:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:14:29 INFO - Installing collected packages: blobuploader, requests, docopt 06:14:29 INFO - Running setup.py install for blobuploader 06:14:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:14:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:14:29 INFO - Running setup.py install for requests 06:14:30 INFO - Running setup.py install for docopt 06:14:30 INFO - Successfully installed blobuploader requests docopt 06:14:30 INFO - Cleaning up... 06:14:30 INFO - Return code: 0 06:14:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:14:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:30 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 0x7fd3a72e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x195e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195b930>, '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 0x195c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x195ccc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1476448062.840541-928227769', '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 06:14:30 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 06:14:30 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 06:14:30 INFO - Using env: {'DISPLAY': ':0', 06:14:30 INFO - 'HOME': '/home/cltbld', 06:14:30 INFO - 'LANG': 'en_US.UTF-8', 06:14:30 INFO - 'LANGUAGE': 'en_US:en', 06:14:30 INFO - 'LOGNAME': 'cltbld', 06:14:30 INFO - 'MAIL': '/var/mail/cltbld', 06:14:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:30 INFO - 'MOZ_NO_REMOTE': '1', 06:14:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:14:30 INFO - 'NO_EM_RESTART': '1', 06:14:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:14:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:30 INFO - 'PWD': '/builds/slave/test', 06:14:30 INFO - 'SHELL': '/bin/bash', 06:14:30 INFO - 'SHLVL': '1', 06:14:30 INFO - 'TERM': 'linux', 06:14:30 INFO - 'TMOUT': '86400', 06:14:30 INFO - 'USER': 'cltbld', 06:14:30 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1476448062.840541-928227769', 06:14:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:30 INFO - '_': '/tools/buildbot/bin/python'} 06:14:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:14:30 INFO - Running setup.py (path:/tmp/pip-g1zlH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:14:30 INFO - Running setup.py (path:/tmp/pip-k6mdwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:14:30 INFO - Running setup.py (path:/tmp/pip-q4dHfB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:14:30 INFO - Running setup.py (path:/tmp/pip-AVWoNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:14:31 INFO - Running setup.py (path:/tmp/pip-7scXRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:14:31 INFO - Running setup.py (path:/tmp/pip-z8COaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:14:31 INFO - Running setup.py (path:/tmp/pip-FLMsB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:14:31 INFO - Running setup.py (path:/tmp/pip-oPjFME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:14:31 INFO - Running setup.py (path:/tmp/pip-jAsQJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:14:31 INFO - Running setup.py (path:/tmp/pip-B2kyjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:14:31 INFO - Running setup.py (path:/tmp/pip-3MpySe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:14:31 INFO - Running setup.py (path:/tmp/pip-vTJvlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:14:31 INFO - Running setup.py (path:/tmp/pip-MpfigX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:14:31 INFO - Running setup.py (path:/tmp/pip-VVOjDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:14:31 INFO - Running setup.py (path:/tmp/pip-NFF2_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:14:31 INFO - Running setup.py (path:/tmp/pip-dOa9qU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:14:31 INFO - Running setup.py (path:/tmp/pip-oA1cr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:14:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:14:31 INFO - Running setup.py install for manifestparser 06:14:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:14:32 INFO - Running setup.py install for mozcrash 06:14:32 INFO - Running setup.py install for mozdebug 06:14:32 INFO - Running setup.py install for mozdevice 06:14:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:14:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:14:32 INFO - Running setup.py install for mozfile 06:14:32 INFO - Running setup.py install for mozhttpd 06:14:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:14:32 INFO - Running setup.py install for mozinfo 06:14:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:14:32 INFO - Running setup.py install for mozInstall 06:14:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:14:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:14:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:14:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:14:32 INFO - Running setup.py install for mozleak 06:14:32 INFO - Running setup.py install for mozlog 06:14:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:14:32 INFO - Running setup.py install for moznetwork 06:14:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:14:33 INFO - Running setup.py install for mozprocess 06:14:33 INFO - Running setup.py install for mozprofile 06:14:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:14:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:14:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:14:33 INFO - Running setup.py install for mozrunner 06:14:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:14:33 INFO - Running setup.py install for mozscreenshot 06:14:33 INFO - Running setup.py install for moztest 06:14:33 INFO - Running setup.py install for mozversion 06:14:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:14:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:14:33 INFO - Cleaning up... 06:14:33 INFO - Return code: 0 06:14:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:14: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')]} 06:14:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14: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')]} 06:14:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:33 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 0x7fd3a72e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x195e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195b930>, '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 0x195c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x195ccc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1476448062.840541-928227769', '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 06:14:33 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 06:14:33 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 06:14:33 INFO - Using env: {'DISPLAY': ':0', 06:14:33 INFO - 'HOME': '/home/cltbld', 06:14:33 INFO - 'LANG': 'en_US.UTF-8', 06:14:33 INFO - 'LANGUAGE': 'en_US:en', 06:14:33 INFO - 'LOGNAME': 'cltbld', 06:14:33 INFO - 'MAIL': '/var/mail/cltbld', 06:14:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:33 INFO - 'MOZ_NO_REMOTE': '1', 06:14:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:14:33 INFO - 'NO_EM_RESTART': '1', 06:14:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:14:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:33 INFO - 'PWD': '/builds/slave/test', 06:14:33 INFO - 'SHELL': '/bin/bash', 06:14:33 INFO - 'SHLVL': '1', 06:14:33 INFO - 'TERM': 'linux', 06:14:33 INFO - 'TMOUT': '86400', 06:14:33 INFO - 'USER': 'cltbld', 06:14:33 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1476448062.840541-928227769', 06:14:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:33 INFO - '_': '/tools/buildbot/bin/python'} 06:14:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:14:33 INFO - Running setup.py (path:/tmp/pip-aebrLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:14:34 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)) 06:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:14:34 INFO - Running setup.py (path:/tmp/pip-Wcmm2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:14:34 INFO - Running setup.py (path:/tmp/pip-Fayt2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:14:34 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)) 06:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:14:34 INFO - Running setup.py (path:/tmp/pip-y8SXfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:14:34 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)) 06:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:14:34 INFO - Running setup.py (path:/tmp/pip-xt9aYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:14:34 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)) 06:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:14:34 INFO - Running setup.py (path:/tmp/pip-lHUzMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:14:34 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)) 06:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:14:34 INFO - Running setup.py (path:/tmp/pip-vd8r3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:14:34 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)) 06:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:14:34 INFO - Running setup.py (path:/tmp/pip-eOjIN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:14:34 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)) 06:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:14:34 INFO - Running setup.py (path:/tmp/pip-f3gjkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:14:34 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)) 06:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:14:34 INFO - Running setup.py (path:/tmp/pip-C32vKY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:14:34 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)) 06:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:14:34 INFO - Running setup.py (path:/tmp/pip-P2FH1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:14:34 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)) 06:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:14:34 INFO - Running setup.py (path:/tmp/pip-SnjBG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:14:34 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)) 06:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:14:34 INFO - Running setup.py (path:/tmp/pip-e4qVpm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:14:34 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)) 06:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:14:34 INFO - Running setup.py (path:/tmp/pip-X3fhGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:14:34 INFO - Running setup.py (path:/tmp/pip-SEbdmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:14:35 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)) 06:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:14:35 INFO - Running setup.py (path:/tmp/pip-m13dJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:14:35 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)) 06:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:14:35 INFO - Running setup.py (path:/tmp/pip-neQpPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:14:35 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)) 06:14:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:14:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:14:35 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)) 06:14:35 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)) 06:14:35 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)) 06:14:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:14:35 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 06:14:35 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 06:14:35 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 06:14:35 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 06:14:35 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 06:14:35 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 06:14:37 INFO - Downloading blessings-1.6.tar.gz 06:14:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:14:37 INFO - Installing collected packages: blessings 06:14:37 INFO - Running setup.py install for blessings 06:14:37 INFO - Successfully installed blessings 06:14:37 INFO - Cleaning up... 06:14:37 INFO - Return code: 0 06:14:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:14:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:14:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:14:37 INFO - Reading from file tmpfile_stdout 06:14:37 INFO - Current package versions: 06:14:37 INFO - argparse == 1.2.1 06:14:37 INFO - blessings == 1.6 06:14:37 INFO - blobuploader == 1.2.4 06:14:37 INFO - docopt == 0.6.1 06:14:37 INFO - functools32 == 3.2.3-2 06:14:37 INFO - jsonschema == 2.5.1 06:14:37 INFO - manifestparser == 1.1 06:14:37 INFO - mozInstall == 1.12 06:14:37 INFO - mozcrash == 0.17 06:14:37 INFO - mozdebug == 0.1 06:14:37 INFO - mozdevice == 0.48 06:14:37 INFO - mozfile == 1.2 06:14:37 INFO - mozhttpd == 0.7 06:14:37 INFO - mozinfo == 0.9 06:14:37 INFO - mozleak == 0.1 06:14:37 INFO - mozlog == 3.4 06:14:37 INFO - moznetwork == 0.27 06:14:37 INFO - mozprocess == 0.23 06:14:37 INFO - mozprofile == 0.28 06:14:37 INFO - mozrunner == 6.12 06:14:37 INFO - mozscreenshot == 0.1 06:14:37 INFO - mozsystemmonitor == 0.3 06:14:37 INFO - moztest == 0.7 06:14:37 INFO - mozversion == 1.4 06:14:37 INFO - psutil == 3.1.1 06:14:37 INFO - requests == 1.2.3 06:14:37 INFO - wsgiref == 0.1.2 06:14:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:14: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')]} 06:14:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14: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')]} 06:14:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:37 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 0x7fd3a72e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x195e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195b930>, '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 0x195c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x195ccc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1476448062.840541-928227769', '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 06:14:37 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 06:14:37 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 06:14:37 INFO - Using env: {'DISPLAY': ':0', 06:14:37 INFO - 'HOME': '/home/cltbld', 06:14:37 INFO - 'LANG': 'en_US.UTF-8', 06:14:37 INFO - 'LANGUAGE': 'en_US:en', 06:14:37 INFO - 'LOGNAME': 'cltbld', 06:14:37 INFO - 'MAIL': '/var/mail/cltbld', 06:14:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:37 INFO - 'MOZ_NO_REMOTE': '1', 06:14:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:14:37 INFO - 'NO_EM_RESTART': '1', 06:14:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:14:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:37 INFO - 'PWD': '/builds/slave/test', 06:14:37 INFO - 'SHELL': '/bin/bash', 06:14:37 INFO - 'SHLVL': '1', 06:14:37 INFO - 'TERM': 'linux', 06:14:37 INFO - 'TMOUT': '86400', 06:14:37 INFO - 'USER': 'cltbld', 06:14:37 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1476448062.840541-928227769', 06:14:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:37 INFO - '_': '/tools/buildbot/bin/python'} 06:14:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:37 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)) 06:14:37 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)) 06:14:37 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)) 06:14:37 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)) 06:14:37 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)) 06:14:37 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)) 06:14:37 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)) 06:14:37 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)) 06:14:37 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)) 06:14:37 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)) 06:14:37 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)) 06:14:37 INFO - Cleaning up... 06:14:37 INFO - Return code: 0 06:14:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:14: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')]} 06:14:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14: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')]} 06:14:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:37 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 0x7fd3a72e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x195e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195b930>, '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 0x195c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x195ccc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1476448062.840541-928227769', '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 06:14:37 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 06:14:37 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 06:14:37 INFO - Using env: {'DISPLAY': ':0', 06:14:37 INFO - 'HOME': '/home/cltbld', 06:14:37 INFO - 'LANG': 'en_US.UTF-8', 06:14:37 INFO - 'LANGUAGE': 'en_US:en', 06:14:37 INFO - 'LOGNAME': 'cltbld', 06:14:37 INFO - 'MAIL': '/var/mail/cltbld', 06:14:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:37 INFO - 'MOZ_NO_REMOTE': '1', 06:14:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:14:37 INFO - 'NO_EM_RESTART': '1', 06:14:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:14:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:37 INFO - 'PWD': '/builds/slave/test', 06:14:37 INFO - 'SHELL': '/bin/bash', 06:14:37 INFO - 'SHLVL': '1', 06:14:37 INFO - 'TERM': 'linux', 06:14:37 INFO - 'TMOUT': '86400', 06:14:37 INFO - 'USER': 'cltbld', 06:14:37 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1476448062.840541-928227769', 06:14:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:37 INFO - '_': '/tools/buildbot/bin/python'} 06:14:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:14:38 INFO - Cleaning up... 06:14:38 INFO - Return code: 0 06:14:38 INFO - Running post-action listener: _resource_record_post_action 06:14:38 INFO - Running post-action listener: _start_resource_monitoring 06:14:38 INFO - Starting resource monitoring. 06:14:38 INFO - [mozharness: 2016-10-14 13:14:38.058578Z] Finished create-virtualenv step (success) 06:14:38 INFO - [mozharness: 2016-10-14 13:14:38.059088Z] Running install step. 06:14:38 INFO - Running pre-action listener: _resource_record_pre_action 06:14:38 INFO - Running main action method: install 06:14:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:14:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:14:38 INFO - Reading from file tmpfile_stdout 06:14:38 INFO - Detecting whether we're running mozinstall >=1.0... 06:14:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:14:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:14:38 INFO - Reading from file tmpfile_stdout 06:14:38 INFO - Output received: 06:14:38 INFO - Usage: mozinstall [options] installer 06:14:38 INFO - Options: 06:14:38 INFO - -h, --help show this help message and exit 06:14:38 INFO - -d DEST, --destination=DEST 06:14:38 INFO - Directory to install application into. [default: 06:14:38 INFO - "/builds/slave/test"] 06:14:38 INFO - --app=APP Application being installed. [default: firefox] 06:14:38 INFO - mkdir: /builds/slave/test/build/application 06:14:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:14:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:14:55 INFO - Reading from file tmpfile_stdout 06:14:55 INFO - Output received: 06:14:55 INFO - /builds/slave/test/build/application/firefox/firefox 06:14:55 INFO - Running post-action listener: _resource_record_post_action 06:14:55 INFO - [mozharness: 2016-10-14 13:14:55.328332Z] Finished install step (success) 06:14:55 INFO - [mozharness: 2016-10-14 13:14:55.328576Z] Running run-tests step. 06:14:55 INFO - Running pre-action listener: _resource_record_pre_action 06:14:55 INFO - Running main action method: run_tests 06:14:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:14:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:14:55 INFO - Python 2.7.3 06:14:55 INFO - Return code: 0 06:14:55 INFO - grabbing minidump binary from tooltool 06:14:55 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')]} 06:14:55 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 0x195b930>, '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 0x195c830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x195ccc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:14:55 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 06:14:55 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 06:14:55 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 06:14:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:14:55 INFO - Return code: 0 06:14:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:14:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:14:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:14:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:14:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:14:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DdYYgrxgR6KTTj_XUXnDRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:14:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DdYYgrxgR6KTTj_XUXnDRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:14:55 INFO - Using env: {'DISPLAY': ':0', 06:14:55 INFO - 'HOME': '/home/cltbld', 06:14:55 INFO - 'LANG': 'en_US.UTF-8', 06:14:55 INFO - 'LANGUAGE': 'en_US:en', 06:14:55 INFO - 'LOGNAME': 'cltbld', 06:14:55 INFO - 'MAIL': '/var/mail/cltbld', 06:14:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:14:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:14:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:55 INFO - 'MOZ_NO_REMOTE': '1', 06:14:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:14:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:14:55 INFO - 'NO_EM_RESTART': '1', 06:14:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:14:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:55 INFO - 'PWD': '/builds/slave/test', 06:14:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:14:55 INFO - 'SHELL': '/bin/bash', 06:14:55 INFO - 'SHLVL': '1', 06:14:55 INFO - 'TERM': 'linux', 06:14:55 INFO - 'TMOUT': '86400', 06:14:55 INFO - 'USER': 'cltbld', 06:14:55 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1476448062.840541-928227769', 06:14:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:55 INFO - '_': '/tools/buildbot/bin/python'} 06:14:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DdYYgrxgR6KTTj_XUXnDRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:14:55 INFO - mozversion application_buildid: 20161014030204 06:14:55 INFO - mozversion application_changeset: 1391a2889aeb2bdd61ad6ef838e65826e35aabc2 06:14:55 INFO - mozversion application_display_name: Nightly 06:14:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:14:55 INFO - mozversion application_name: Firefox 06:14:55 INFO - mozversion application_remotingname: firefox 06:14:55 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:14:55 INFO - mozversion application_vendor: Mozilla 06:14:55 INFO - mozversion application_version: 52.0a1 06:14:55 INFO - mozversion platform_buildid: 20161014030204 06:14:55 INFO - mozversion platform_changeset: 1391a2889aeb2bdd61ad6ef838e65826e35aabc2 06:14:55 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:14:55 INFO - mozversion platform_version: 52.0a1 06:14:55 INFO - using testdate: 1476450895 06:14:55 INFO - actual date: 1476450895 06:14:55 INFO - starting webserver on 'localhost:48034' 06:14:55 INFO - SUITE-START | Running 2 tests 06:14:55 INFO - TEST-START | dromaeo_css 06:14:55 INFO - operating with platform_type : linux_ 06:14:55 INFO - Initialising browser for dromaeo_css test... 06:14:55 INFO - TEST-INFO | started process 16161 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplp43ga/profile http://localhost:48034/getInfo.html) 06:14:59 INFO - PROCESS | 16161 | __metrics Screen width/height:1600/1200 06:14:59 INFO - PROCESS | 16161 | colorDepth:24 06:14:59 INFO - PROCESS | 16161 | Browser inner width/height: 1024/697 06:14:59 INFO - PROCESS | 16161 | __metrics 06:14:59 INFO - PROCESS | 16161 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:14:59 INFO - PROCESS | 16161 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:15:01 INFO - TEST-INFO | 16161: exit 0 06:15:01 INFO - Browser initialized. 06:15:01 INFO - Running cycle 1/1 for dromaeo_css test... 06:15:01 INFO - TEST-INFO | started process 16242 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplp43ga/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:15:13 INFO - PROCESS | 16242 | RSS: Main: 172875776 06:15:13 INFO - PROCESS | 16242 | 06:16:04 INFO - PROCESS | 16242 | 1476450964015 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] 06:18:15 INFO - PROCESS | 16242 | Cycle 1(1): loaded http://localhost:48034/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48034/tests/dromaeo/cssquery-ext.html) 06:18:16 INFO - PROCESS | 16242 | RSS: Main: 298008576 06:18:16 INFO - PROCESS | 16242 | 06:21:19 INFO - PROCESS | 16242 | Cycle 1(1): loaded http://localhost:48034/tests/dromaeo/cssquery-ext.html (next: http://localhost:48034/tests/dromaeo/cssquery-jquery.html) 06:21:20 INFO - PROCESS | 16242 | RSS: Main: 276963328 06:21:20 INFO - PROCESS | 16242 | 06:24:22 INFO - PROCESS | 16242 | Cycle 1(1): loaded http://localhost:48034/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48034/tests/dromaeo/cssquery-mootools.html) 06:24:22 INFO - PROCESS | 16242 | RSS: Main: 216088576 06:24:22 INFO - PROCESS | 16242 | 06:27:24 INFO - PROCESS | 16242 | Cycle 1(1): loaded http://localhost:48034/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48034/tests/dromaeo/cssquery-prototype.html) 06:27:25 INFO - PROCESS | 16242 | RSS: Main: 212930560 06:27:25 INFO - PROCESS | 16242 | 06:30:27 INFO - PROCESS | 16242 | Cycle 1(1): loaded http://localhost:48034/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48034/tests/dromaeo/cssquery-yui.html) 06:30:28 INFO - PROCESS | 16242 | RSS: Main: 216240128 06:30:28 INFO - PROCESS | 16242 | 06:33:31 INFO - PROCESS | 16242 | Cycle 1(1): loaded http://localhost:48034/tests/dromaeo/cssquery-yui.html (next: http://localhost:48034/tests/dromaeo/cssquery-dojo.html) 06:33:31 INFO - PROCESS | 16242 | RSS: Main: 305094656 06:33:31 INFO - PROCESS | 16242 | 06:33:31 INFO - PROCESS | 16242 | __start_tp_report 06:33:31 INFO - PROCESS | 16242 | _x_x_mozilla_page_load 06:33:31 INFO - PROCESS | 16242 | _x_x_mozilla_page_load_details 06:33:31 INFO - PROCESS | 16242 | |i|pagename|runs| 06:33:31 INFO - PROCESS | 16242 | |0;dojo.html;3054.160105970859;3064.8161110333376;3097.101840466265;3097.5663407122993;3110.1758034120953;5164.896702065966;5275.446078161795;5275.551578115865;5368.355797304324;5392.9730351348235;5281.63028587999;5298.337707786527;5300.337457817773;5309.4425085365965;5320.388155362135;4794.592459640935;4815.5906747926465;4820.445648750404;4835.830745923893;4867.634927380443;4755.667103302771;4860.441049279343;4888.02239552091;4922.335484709554;4934.432540257881;4924.581410580087;4933.210686290195;4935.457099719046;4941.160002799533;4995.550400463958;4181.707280490367;4834.734089625087;4886.389201349832;4895.828645997373;4938.975305123451;4644.164050470914;4829.613630909519;4853.854384368439;4870.220764677634;4881.902361952741;5137.3064636274;5160.225966105114;5223.843284701427;5330.120530112566;5342.412334643186;5558.027345214571;5564.916526252109;5585.525230355424;5622.184783206453;5637.126245431965;5670.234518340013;5707.5148612368;5722.456366645162;5731.426857314235;5733.397993210736;5145.742712864342;5200.401953775288;5220.060389129917;5273.709945953009;5329.067413202674;5726.198332233491;5736.799212027559;5736.799212027642;5755.597108202385;5799.043157878903;5526.723663816873;5536.114221724505;5543.390227075019;5557.3886872444;5561.972190139023;5410.972945135328;5457.508824205841;5537.086380747131;5584.21820945068;5614.719264036782;5611.046122159161;5624.240727501817;5661.065924122474;5676.801311954062;5677.886442271131;5627.971860140673;5631.8592035199445;5632.915506267409;5633.126865335797;5633.887322253532;4242.4272723181975;4245.97877010613;4276.080642661843;4326.6754993375625;4382.211201983673;3827.2154208387215;3852.0177354774355;3866.4007078902814;3871.2451072041245;3915.314819906505;5337.572994160536;5370.785168593291;5388.434214407509;5393.4336894626285;5406.107992181324;5433.755481003364;5667.688277144796;5684.204211410406;5692.57305702074;5701.686407247558;5194.1429664105;5194.740262986836;5248.475152484797;5252.737363131828;5259.105951988171;4809.735464549413;4810.388519845891;4813.278008298783;4816.386510518945;4820.373351464287;5693.202951586781;5699;5705.343885453226;5792.1311803229855;5852.882942341044;5645.350784659817;5701.657900525982;5706.172604972338;5758.539316854725;5772.538196944319;5845.152452894392;5853.590248682722;5854.4730974212525;5858.882822343615;5863.237779088691;5302.734863256745;5351.759170837244;5552.416996215339;5560.777568897361;5637.46444087811;5740.225069615715;5752.884942301214;5758.193852860519;5790.536757059509;5817.94182058174;5573.804916827891;5584.916226256691;5587.888242235052;5593.161025846156;5593.524550413098;5354.598405119554;5418.133098704346;5418.349798024262;5583.050881350261;5595.300587426572;5530;5555.50000499957;5601.327840659147;5641.097424412074;5650.830475085754;5610.326760788732;5637.351704553865;5637.49262566371;5638.7462564185535;5643.971780141073;5519.337679478488;5520.282363292747;5522.171674248895;5539.446055394428;5541.612087153861 06:33:31 INFO - PROCESS | 16242 | |1;ext.html;555.3225065420186;593.3028691287738;619.665380694425;638.103464632192;655.5018186178503;31712.682873171263;41647.37528937065;42780.786096069554;42841.35737963929;46172.769136154355;45369.77315113428;45499.77250113753;45521.54478455214;45721;45723.31415028777;8022.839543209132;8781;8930.910690893106;8941.329400295004;8942.19520243178;8058;10231.48842557873;10603.628872989448;10609.310394824312;10953.014228719414;10788.51451684672;10852.82943411317;10854;10854.72863178423;10857;10653.25427220095;10714.732131696692;10721;10727.946360268188;10754.516046777913;10581.10060644846;10644.467776611216;10646.680599582025;10650.988156125233;10651.84022239667;35998.82000590007;36122.09694757626;36161;36179.27641447156;36288.63711362879;3561.679448849616;3625.6374362563533;3851.114243723931;3868.303705333039;4099.1801639672185;31195;31226.37547249065;31408.21479463009;31775.52336714951;31819;4235.661147108255;4316.395704601358;4451.933221001687;4494.595486406207;4509.571590698911;331678;335115;336482;337136;337309;58423.12365314524;58711;58774.41225587775;58775.41633544806;58898.41101589015;60125.699371502866;60721.39278607157;61009;61063.389366105774;61153.69423152945;14388.640283992774;14551.126932384092;14552.927235363755;14565.635859103608;14567.854321456649;10116.949415252877;10346.896531034743;11714.88285117155;11776.293422394683;12009.939950300368;16539.338426462808;17195.742063869053;17332.82667173337;17358.739618905725;17402.129893505527;6043.576949613484;6206.689665516707;6232.688365581703;6250.937490625127;6310.9368906311265;939.7885475767897;1016.575244455037;1034.425893629028;1046.9633562825265;1112.1214240749878;31146.377072458425;31269;31558;31812.36375272528;32106.35787284288;1037.8287582548794;1071.8606581144402;1073.7852429514128;1090.3675867996542;1159.756451145252;15800.209989500709;16088;16172.433964811411;16354.10052447103;16522.42171523991;475552;479896;481246;483579;679647;56604.43395566074;56904.43095568991;57216.141757873665;57427;57520.137197942066;1215.8054711246334;1238.5355491690616;1302.7785276503016;1305.3408028945512;1351.1892864281353;29292;31929.521057184626;32217;34749.47875781815;34751.82624086965;55170.44829551814;55891.16163257473;55943.72028139833;55990.440095598526;56065.719671401384;344443;346000;346023;346534;350251;26775.330616734736;27494.72505275002;27634.578467445113;27760.44479110447;27929.207079291908;35689.46465803067;40529.1894162121;43370.566294337914;44197.33703994507;48696.513034870615;39610.80194599008;42184.36723449212;42641;42882.35676464918;43830.561694382646;40229;40859.79570102249;41019.79490102531;42285.788571058176;42529.14941701211;39723.40298150061;40264.396034058926;40631.7968410156;41080;41646;34383.48424773681;36314;36767.26465470622;37029.81485092557;37206.81396593108;27151.59272610873;27200.007989135156;27953.44566593079;28021.159365219075;28832.135035948955 06:33:31 INFO - PROCESS | 16242 | |2;jquery.html;356.7407053102547;362.4219370104682;388.8988862895647;391.70426328122267;401.7268257584843;13946.093503922239;18454.907725461388;18924;19476.805231947677;20647.793522064814;19417.51456213592;19518.70721939172;19758.407247782554;19947.40157795265;19959.301424450146;5504.697241651697;5781.624194427349;5789.899919015374;5800.390958949313;5802.738876750535;5517.144842549411;5659.292588426447;5663.546916246711;5683.744231509592;5694.886102277952;5659.122835960433;5661.122526008455;5666.5183459406;5668.348139963916;5669.971650141764;5548.91676624851;5654.180143879135;5805.88388232233;5830.854228644275;5848;5496.422875598045;5651.7739290428335;5651.802186923479;5662.37713851476;5662.462066103713;21396.46508837276;22135.225267115573;22731.77268227313;23243.767562324498;23357.41606459835;2102.4008157675144;2172.847900646955;2195.747489038765;2266.1388672304583;2276.169198242646;9734.805303893883;10039.89960100397;10068.244881633907;10644.893551064468;10696.304740191863;1805.6388722255601;1882.632886587116;1899.8290153886217;1921.8270355668058;1953.1308567687386;80687.99999999942;84110.57944710237;86269.56865215696;88147.55926220393;89622;10433.5826566938;10713.571457141627;10808.459577021118;11028;11054.502547385388;15162.924185379003;15194.468193613171;15201.61995950088;15206;15247.771283430757;7407.777766667009;7411.258874112654;7658.387329013665;7789.961050194826;7933.603319833986;7241.637918104074;7305.780826575211;7413.629318534052;7424.331810137113;7530.209328020588;4534.707608331676;4551.453825540956;4553.54464553542;4553.567411095941;4690.390249267642;1810.3301778341834;1911.4456807525662;1912.2924517928177;1919.7504324438014;1940.1754254441805;871.1854416120947;893.2050475077186;928.7817362919709;950.5627411390699;1039.812833689943;17811.376601818873;18700.158492867853;18922.526936826413;19401;19472.318468853522;896.6906417286026;947.8199142162968;962.6101428921298;990.1138481059412;1054.773223756896;9848.803023939481;10785.193410700807;10838.399984065514;10848.254999775758;10869.738918519393;477286;477761.5566910352;510279;512844;518613;91917;93759;94605.52697236469;94775;94790;976.3556053004983;998.4558415663481;1031.185363562792;1038.460000799595;1039.4387031003173;17199.656006880043;17662.94517866654;18139.183736732142;18242.72635910436;18293.725594115833;42060.789696051324;43984.560154398045;44156.558434415245;44479.332810007225;45788.54211457843;60835;61271;61888.69055654873;62365.37634623596;64864;7364.41084713211;7572.507786993828;8351.20663536963;8438.915610844058;8586.570671466527;12673;13443.731125377633;13461.461541538229;13530.458781648624;13756.17462952226;11640.35978021217;11881.524739010343;11903.642890713292;12045.879541204826;12201.450934707782;11301.660950171508;11317.151213658844;11530.192886497865;11683.18217724751;11936.761264774483;11590.42047897585;11632.941835290769;11752.647420577396;11787.292762434281;12224.022078233898;7385.593792341473;7522.849543009219;7531.924680753123;7565.6973721050545;7962.761117166494;11597.362145082101;11635.360055197045;11740.295582265091;11793.941030295136;11959.581414650445 06:33:31 INFO - PROCESS | 16242 | |3;mootools.html;1299.7335546213028;1421.324870686424;1461.9707605847884;1585.1440222279962;1703.5655907743524;7701.34538564222;8576.056633770288;8862;8888.600012999406;9081.046490118542;8865.157810008055;8916.46501209928;8926.06276340983;8948;8960.775980600472;2241.5965126277265;2266.433391652087;2267;2267.30847091637;2270.19408110121;2204.3386983904843;2216.92240771573;2289.610766169755;2294.300238427279;2297.5290065536524;2241.742199647037;2247.606668832948;2253.5154941687533;2258.977410225901;2298.092253559843;2197.099189332374;2208.326460429568;2211.834112441565;2243.921462748804;2247.797698207169;2214.1254204589095;2233.3969828146473;2233.542123864604;2250.437390652337;2251.7860803223666;8730.956345218297;8761.430507017087;8818.823623527558;8828.205461508494;8830;5116.155834287338;5234.7644356004075;5239.79040838366;5246.108161612535;5258.710770907599;3219.3078488125166;3416.265502916885;3447.3277710846396;3465.9133521661906;3489.1451594359546;1069.251523933242;1118.9608363707232;1129.220837622038;1134.2343917855496;1147.432021149528;12275.386230688518;12322.322272275022;12332.321722305269;12385.690357741038;12413.44139513715;4241.766702831313;4389.1346177874275;4540.614047805908;4563.566461186182;4610.354550362952;9575.281853860988;9617.71146865595;9625.56684949179;9625.855612165824;9632.807343853083;5206.479352064839;5207.0366982108435;5214.7914083437;5220.138677118233;5220.9477905220465;4048.797560122041;4267.8292868284925;4368.737875727466;4820.542048505386;4838;3549.378858699717;3593.2813437312643;3650.872219472306;3667.688246499024;3684.2263124743567;1082.7022568793486;1088.5700148441479;1112.4660163121746;1112.7718817642365;1119.652907598647;791.6358475101403;845.4377838737171;930.6230976454547;965.9178969787506;969.1616751510035;5412.945870541244;5716.28546431696;5740.655560666373;5850.912236316459;6118.204633397719;436.6506794564336;442.3276619538284;445.1630933844352;449.21836005350457;451.1946176075755;3802.4866643003393;3946.2896678597554;3957.8416863325147;4036.737612055207;4134.276501612206;10764.407957562253;11127.721806954729;11242.887571124347;11243.044341230923;11260.324380537195;10743.946280268548;10982.176336774774;11078;11102.722431939266;11115.110791136689;8046.114927357986;8105.189481051848;8118.10700822909;8121;8124.309433698202;5316.574674026146;5342.198670199501;5357.758900849549;5380.650257733235;5553.0559804832465;9808.705738827846;9919.752006199902;10030.29787914839;10043.648472303727;10114.494275286354;9188.310876684141;10363.11913487332;10399.220058495492;10399.740006499898;10406.843897341698;6768.7292508299115;7135.607541585263;7306.123265208209;7369.668364923484;7513.173550909505;8448.535330556879;8455.196756308142;8498.830023399621;8526.531040792815;8571.785705357415;7698.769036928901;7724.266194711493;7762.146163922077;7770.961145194238;7789.376849851885;7508.211637777955;7569.772906812805;7661.272179142972;7673.232676732506;7691;6704.262531121671;6739.191297044386;6745.460363171032;6800.081988931629;6852.246252912076;4982.551570358685;5029.321041659329;5090.08378491875;5186.559142472932;5193.169092945111;4945.851624451272;5001.374828146481;5183.377994640517;5241.187615919539;5318.8936221276135 06:33:31 INFO - PROCESS | 16242 | |4;prototype.html;323.705428060465;326.72718280236006;331.14894720568134;331.9170207448139;333.71300681413965;5303.496167864051;5332.57339412847;5333.413324534303;5347.839564813052;5348;5265.657732247401;5277.683338999663;5287.39194992576;5290.709011004393;5292.841214763554;3885.844566217348;4170.728902621335;4171.20747058058;4176.644985176264;4179.495381662599;4102.323116685743;4139.613229568098;4141;4142.689298302639;4158.979205103986;4077.022644017649;4077.7757223352705;4088.1414902870283;4088.7546747195115;4091.161311931062;3892.5718171001167;3977.3238549446664;4016.7790771507557;4128.814203360856;4134.862912699002;3582.247727977128;3592.6586974237666;3596.62235465275;3604.873829415984;3626.1297288650535;5092.949070509285;5120.513551212629;5152.562032227265;5154.793808247666;5179.912218434133;4583.175028494869;4682.27424749161;4682.461516925563;4685.625149988027;4736.431628204603;5511.917321240185;5538.446155384429;5546;5553.6390134641115;5559.8888022239735;3973.5827738087664;3977.105151340954;3982.6415622594104;4001.4998125234347;4001.519817621904;5701.743421546041;5761.423857614247;5786.161006654053;5806.187133801272;5859.501942334907;4056.634902858757;4057.634812866797;4057.8985525361513;4064.4716186895516;4066.3290557057753;4111.301078816608;4112.485939257593;4113.095119073799;4113.300738874398;4114.362273847559;4609.147307748078;4708.835190768306;4724.126036683225;4725.8582242532775;4732.621390288768;5531.230006397995;5557.249771280906;5581.883623275361;5600.35595906476;5604.607677462538;1396.4484028808768;1407.9436822526984;1409.4644035266533;1416.2918540729636;1418.5106138382241;827.7640872351351;882.7087061269766;893.5889490834159;904.7198214526503;907.3648446087765;4671.785335812713;4732.361131247238;4748.881277968078;4759.549326738156;4767.6662633615315;4997.925031124536;5031.320771695774;5035.974820125949;5044.016416798689;5075.213341932006;4756.6670333077045;4777.536286192482;4821.349117869043;4831.782569784368;5146.459621739664;2895.2038189498057;2969;2970.3316753730237;3023.742981846524;3040.9847950760545;5903.675297858573;5916.319623243296;5929.288485381781;5959.076343166729;5969.671668058299;5626.634268772516;5798.362180160179;5824.087956021989;5830.38780928005;5847.298324201038;5878;5882.647041177543;5899.469047785634;5909.320428150818;5912.674802885796;5640.351359593699;5712.542996560348;5720.342160651412;5736.512396446349;5791.884162316645;5476.534494568006;5664;5685.260916080883;5696.914546281892;5698.572607054404;5935.2787691568965;5936.7922122725495;6016.578839481194;6034.698265086816;6044.818655440344;4109.260333140063;4206.137741762993;4207.768572728407;4235.195312890541;4239.618434340924;5689.630174038674;5703.344115426779;5707.229524014205;5731.770729170787;5742;5580.330360356783;5583;5589.860253493695;5591.720413979204;5613.540479475284;5433.891322173456;5599.664020158803;5604.411536788579;5614.326280846324;5625.184348269396;5596.18855265976;5597.384287728265;5600;5610.186522954067;5612.579056570692;5510.8071217507195;5553.278073850373;5590.608657393944;5610.326760788732;5644.745986430538;5361.651492653121;5468.371137319259;5494.5054945055135;5500.22996780459;5524.171374293888 06:33:31 INFO - PROCESS | 16242 | |5;yui.html;675.5980191785887;701.5755467941898;742.3949481172843;769.807548112972;802.77923571018;14559;16454.588635284123;16610.25253863576;16689.08210048447;16695;14851.331690073946;15068.849311506881;15166.545003649908;15217;15235.771463428058;788.286600626434;803.618281316373;803.7468197517793;804.0833449867156;805.9355251579889;651.9543631945766;652.7943697735199;781.8749000159976;803.7910143362739;807.3258828877894;842.8819965204846;858.9527575983318;859.9914000860006;860.2515811244226;861.0442408926087;851.284920666643;852.2627926843267;852.9232369086781;853.1212850763661;853.5348235211825;502.45734606624757;503.23508267433294;583.2679986616769;588.4938952500846;620.944115029645;13496.190228586218;13549.86450135496;13556;13598.796018059737;13775.448982040707;13632.93183534086;14507.637309067357;14558.417663293456;14581.489647862274;14625;12732.87267127326;12831.422585983653;12987.805182922264;13005.154664946747;13398.866011339956;4227.062117495484;4303.837963749801;4305.720128191689;4311.61195492404;4355.3031514957775;76802.23197768007;77002.61498692527;77037;80449.99999999942;80671.59664201642;11448.255863368855;11509.597164099216;11513.654590362303;11911;11976.041916646647;20963;21140.260090896743;21176.682349764767;21178.470538236666;21272.574548508943;8067.233612806774;8086;8141.715039973573;8189.672413103528;8271.2142346477;4515.164694531522;4524.6832721709825;4530.456345238593;4595.333676616939;4595.517470665599;3395.8811441599423;3443.345764304774;3473.6700013498676;3488.720902327808;3492.8253587320532;603.471962033221;606.445102731005;606.8543549548165;611.9388061193933;622.8941080016317;478.2419864514783;489.3687143584736;637.8788030274233;665.2150462454254;682.310866025318;8463.49219046859;8570.228679418882;8920.509371984603;9020.278377729766;9256.398334108262;546.1180193986683;606.5481216493653;622.9283632382244;668.9565178263397;703.968321425537;3813.9809300953316;4174.478190226222;4244.427002354642;4321.935170972438;4371.562843715603;97382;119689;122185;124442;128132;61769;62263.68868155721;93289.60065599022;107909;111869;90968.54515727512;91367;91440.54279728692;92692.07307927104;93981;7728.227177282227;8279.875801862856;8476.27951624119;8488.278496327881;8724.284747920723;35299.82350088233;35392.11519712028;36284.81857590695;39041.21917561576;44580.33129502995;47519.76240118777;48943;59328.110078349724;59665.70167149136;71869.28130718626;12413.565525206935;12628.635626014231;12890.613281601567;12905.161164524276;13038.739225215631;14112.50606228777;14227.573172804832;14392.352344144329;14745.2627368629;14854.925725371304;13521.391537380645;13729.862701372858;13778.65553361134;14029;14042.508512202025;10634.255602107778;12404.441800118835;12971.092023558638;13309.46762129504;14441;13244.20534767917;13476.258805765778;13571.117877337942;13844.020313076824;13852.376643051288;10966.780664386828;11168.720781980515;11511.30932144074;11604.245724027911;11751.236169648946;10535.578576857146;11435.199536032731;11495;11593.88406115928;11774.882251177378 06:33:31 INFO - PROCESS | 16242 | __end_tp_report 06:33:31 INFO - PROCESS | 16242 | __start_cc_report 06:33:31 INFO - PROCESS | 16242 | _x_x_mozilla_cycle_collect,1229 06:33:31 INFO - PROCESS | 16242 | __end_cc_report 06:33:31 INFO - PROCESS | 16242 | __startTimestamp1476452011755__endTimestamp 06:33:31 INFO - PROCESS | 16242 | 06:33:31 INFO - PROCESS | 16242 | ------- Summary: start ------- 06:33:31 INFO - PROCESS | 16242 | Number of tests: 6 06:33:31 INFO - PROCESS | 16242 | 06:33:31 INFO - PROCESS | 16242 | [#0] dojo.html Cycles:165 Average:5253.97 Median:5457.51 stddev:595.19 (10.9%) stddev-sans-first:571.45 06:33:31 INFO - PROCESS | 16242 | Values: 3054.2 3064.8 3097.1 3097.6 3110.2 5164.9 5275.4 5275.6 5368.4 5393.0 5281.6 5298.3 5300.3 5309.4 5320.4 4794.6 4815.6 4820.4 4835.8 4867.6 4755.7 4860.4 4888.0 4922.3 4934.4 4924.6 4933.2 4935.5 4941.2 4995.6 4181.7 4834.7 4886.4 4895.8 4939.0 4644.2 4829.6 4853.9 4870.2 4881.9 5137.3 5160.2 5223.8 5330.1 5342.4 5558.0 5564.9 5585.5 5622.2 5637.1 5670.2 5707.5 5722.5 5731.4 5733.4 5145.7 5200.4 5220.1 5273.7 5329.1 5726.2 5736.8 5736.8 5755.6 5799.0 5526.7 5536.1 5543.4 5557.4 5562.0 5411.0 5457.5 5537.1 5584.2 5614.7 5611.0 5624.2 5661.1 5676.8 5677.9 5628.0 5631.9 5632.9 5633.1 5633.9 4242.4 4246.0 4276.1 4326.7 4382.2 3827.2 3852.0 3866.4 3871.2 3915.3 5337.6 5370.8 5388.4 5393.4 5406.1 5433.8 5667.7 5684.2 5692.6 5701.7 5194.1 5194.7 5248.5 5252.7 5259.1 4809.7 4810.4 4813.3 4816.4 4820.4 5693.2 5699.0 5705.3 5792.1 5852.9 5645.4 5701.7 5706.2 5758.5 5772.5 5845.2 5853.6 5854.5 5858.9 5863.2 5302.7 5351.8 5552.4 5560.8 5637.5 5740.2 5752.9 5758.2 5790.5 5817.9 5573.8 5584.9 5587.9 5593.2 5593.5 5354.6 5418.1 5418.3 5583.1 5595.3 5530.0 5555.5 5601.3 5641.1 5650.8 5610.3 5637.4 5637.5 5638.7 5644.0 5519.3 5520.3 5522.2 5539.4 5541.6 06:33:31 INFO - PROCESS | 16242 | 06:33:31 INFO - PROCESS | 16242 | [#1] ext.html Cycles:180 Average:56667.41 Median:19625.57 stddev:109202.62 (556.4%) stddev-sans-first:109427.69 06:33:31 INFO - PROCESS | 16242 | Values: 555.3 593.3 619.7 638.1 655.5 31712.7 41647.4 42780.8 42841.4 46172.8 45369.8 45499.8 45521.5 45721.0 45723.3 8022.8 8781.0 8930.9 8941.3 8942.2 8058.0 10231.5 10603.6 10609.3 10953.0 10788.5 10852.8 10854.0 10854.7 10857.0 10653.3 10714.7 10721.0 10727.9 10754.5 10581.1 10644.5 10646.7 10651.0 10651.8 35998.8 36122.1 36161.0 36179.3 36288.6 3561.7 3625.6 3851.1 3868.3 4099.2 31195.0 31226.4 31408.2 31775.5 31819.0 4235.7 4316.4 4451.9 4494.6 4509.6 331678.0 335115.0 336482.0 337136.0 337309.0 58423.1 58711.0 58774.4 58775.4 58898.4 60125.7 60721.4 61009.0 61063.4 61153.7 14388.6 14551.1 14552.9 14565.6 14567.9 10116.9 10346.9 11714.9 11776.3 12009.9 16539.3 17195.7 17332.8 17358.7 17402.1 6043.6 6206.7 6232.7 6250.9 6310.9 939.8 1016.6 1034.4 1047.0 1112.1 31146.4 31269.0 31558.0 31812.4 32106.4 1037.8 1071.9 1073.8 1090.4 1159.8 15800.2 16088.0 16172.4 16354.1 16522.4 475552.0 479896.0 481246.0 483579.0 679647.0 56604.4 56904.4 57216.1 57427.0 57520.1 1215.8 1238.5 1302.8 1305.3 1351.2 29292.0 31929.5 32217.0 34749.5 34751.8 55170.4 55891.2 55943.7 55990.4 56065.7 344443.0 346000.0 346023.0 346534.0 350251.0 26775.3 27494.7 27634.6 27760.4 27929.2 35689.5 40529.2 43370.6 44197.3 48696.5 39610.8 42184.4 42641.0 42882.4 43830.6 40229.0 40859.8 41019.8 42285.8 42529.1 39723.4 40264.4 40631.8 41080.0 41646.0 34383.5 36314.0 36767.3 37029.8 37206.8 27151.6 27200.0 27953.4 28021.2 28832.1 06:33:31 INFO - PROCESS | 16242 | 06:33:31 INFO - PROCESS | 16242 | [#2] jquery.html Cycles:180 Average:29528.77 Median:390.30 stddev:82549.98 (21150.3%) stddev-sans-first:82752.49 06:33:31 INFO - PROCESS | 16242 | Values: 356.7 362.4 388.9 391.7 401.7 13946.1 18454.9 18924.0 19476.8 20647.8 19417.5 19518.7 19758.4 19947.4 19959.3 5504.7 5781.6 5789.9 5800.4 5802.7 5517.1 5659.3 5663.5 5683.7 5694.9 5659.1 5661.1 5666.5 5668.3 5670.0 5548.9 5654.2 5805.9 5830.9 5848.0 5496.4 5651.8 5651.8 5662.4 5662.5 21396.5 22135.2 22731.8 23243.8 23357.4 2102.4 2172.8 2195.7 2266.1 2276.2 9734.8 10039.9 10068.2 10644.9 10696.3 1805.6 1882.6 1899.8 1921.8 1953.1 80688.0 84110.6 86269.6 88147.6 89622.0 10433.6 10713.6 10808.5 11028.0 11054.5 15162.9 15194.5 15201.6 15206.0 15247.8 7407.8 7411.3 7658.4 7790.0 7933.6 7241.6 7305.8 7413.6 7424.3 7530.2 4534.7 4551.5 4553.5 4553.6 4690.4 1810.3 1911.4 1912.3 1919.8 1940.2 871.2 893.2 928.8 950.6 1039.8 17811.4 18700.2 18922.5 19401.0 19472.3 896.7 947.8 962.6 990.1 1054.8 9848.8 10785.2 10838.4 10848.3 10869.7 477286.0 477761.6 510279.0 512844.0 518613.0 91917.0 93759.0 94605.5 94775.0 94790.0 976.4 998.5 1031.2 1038.5 1039.4 17199.7 17662.9 18139.2 18242.7 18293.7 42060.8 43984.6 44156.6 44479.3 45788.5 60835.0 61271.0 61888.7 62365.4 64864.0 7364.4 7572.5 8351.2 8438.9 8586.6 12673.0 13443.7 13461.5 13530.5 13756.2 11640.4 11881.5 11903.6 12045.9 12201.5 11301.7 11317.2 11530.2 11683.2 11936.8 11590.4 11632.9 11752.6 11787.3 12224.0 7385.6 7522.8 7531.9 7565.7 7962.8 11597.4 11635.4 11740.3 11793.9 11959.6 06:33:31 INFO - PROCESS | 16242 | 06:33:31 INFO - PROCESS | 16242 | [#3] mootools.html Cycles:180 Average:5683.52 Median:4829.27 stddev:3327.50 (68.9%) stddev-sans-first:3320.53 06:33:31 INFO - PROCESS | 16242 | Values: 1299.7 1421.3 1462.0 1585.1 1703.6 7701.3 8576.1 8862.0 8888.6 9081.0 8865.2 8916.5 8926.1 8948.0 8960.8 2241.6 2266.4 2267.0 2267.3 2270.2 2204.3 2216.9 2289.6 2294.3 2297.5 2241.7 2247.6 2253.5 2259.0 2298.1 2197.1 2208.3 2211.8 2243.9 2247.8 2214.1 2233.4 2233.5 2250.4 2251.8 8731.0 8761.4 8818.8 8828.2 8830.0 5116.2 5234.8 5239.8 5246.1 5258.7 3219.3 3416.3 3447.3 3465.9 3489.1 1069.3 1119.0 1129.2 1134.2 1147.4 12275.4 12322.3 12332.3 12385.7 12413.4 4241.8 4389.1 4540.6 4563.6 4610.4 9575.3 9617.7 9625.6 9625.9 9632.8 5206.5 5207.0 5214.8 5220.1 5220.9 4048.8 4267.8 4368.7 4820.5 4838.0 3549.4 3593.3 3650.9 3667.7 3684.2 1082.7 1088.6 1112.5 1112.8 1119.7 791.6 845.4 930.6 965.9 969.2 5412.9 5716.3 5740.7 5850.9 6118.2 436.7 442.3 445.2 449.2 451.2 3802.5 3946.3 3957.8 4036.7 4134.3 10764.4 11127.7 11242.9 11243.0 11260.3 10743.9 10982.2 11078.0 11102.7 11115.1 8046.1 8105.2 8118.1 8121.0 8124.3 5316.6 5342.2 5357.8 5380.7 5553.1 9808.7 9919.8 10030.3 10043.6 10114.5 9188.3 10363.1 10399.2 10399.7 10406.8 6768.7 7135.6 7306.1 7369.7 7513.2 8448.5 8455.2 8498.8 8526.5 8571.8 7698.8 7724.3 7762.1 7771.0 7789.4 7508.2 7569.8 7661.3 7673.2 7691.0 6704.3 6739.2 6745.5 6800.1 6852.2 4982.6 5029.3 5090.1 5186.6 5193.2 4945.9 5001.4 5183.4 5241.2 5318.9 06:33:31 INFO - PROCESS | 16242 | 06:33:31 INFO - PROCESS | 16242 | [#4] prototype.html Cycles:180 Average:4642.06 Median:5271.67 stddev:1376.93 (26.1%) stddev-sans-first:1342.10 06:33:31 INFO - PROCESS | 16242 | Values: 323.7 326.7 331.1 331.9 333.7 5303.5 5332.6 5333.4 5347.8 5348.0 5265.7 5277.7 5287.4 5290.7 5292.8 3885.8 4170.7 4171.2 4176.6 4179.5 4102.3 4139.6 4141.0 4142.7 4159.0 4077.0 4077.8 4088.1 4088.8 4091.2 3892.6 3977.3 4016.8 4128.8 4134.9 3582.2 3592.7 3596.6 3604.9 3626.1 5092.9 5120.5 5152.6 5154.8 5179.9 4583.2 4682.3 4682.5 4685.6 4736.4 5511.9 5538.4 5546.0 5553.6 5559.9 3973.6 3977.1 3982.6 4001.5 4001.5 5701.7 5761.4 5786.2 5806.2 5859.5 4056.6 4057.6 4057.9 4064.5 4066.3 4111.3 4112.5 4113.1 4113.3 4114.4 4609.1 4708.8 4724.1 4725.9 4732.6 5531.2 5557.2 5581.9 5600.4 5604.6 1396.4 1407.9 1409.5 1416.3 1418.5 827.8 882.7 893.6 904.7 907.4 4671.8 4732.4 4748.9 4759.5 4767.7 4997.9 5031.3 5036.0 5044.0 5075.2 4756.7 4777.5 4821.3 4831.8 5146.5 2895.2 2969.0 2970.3 3023.7 3041.0 5903.7 5916.3 5929.3 5959.1 5969.7 5626.6 5798.4 5824.1 5830.4 5847.3 5878.0 5882.6 5899.5 5909.3 5912.7 5640.4 5712.5 5720.3 5736.5 5791.9 5476.5 5664.0 5685.3 5696.9 5698.6 5935.3 5936.8 6016.6 6034.7 6044.8 4109.3 4206.1 4207.8 4235.2 4239.6 5689.6 5703.3 5707.2 5731.8 5742.0 5580.3 5583.0 5589.9 5591.7 5613.5 5433.9 5599.7 5604.4 5614.3 5625.2 5596.2 5597.4 5600.0 5610.2 5612.6 5510.8 5553.3 5590.6 5610.3 5644.7 5361.7 5468.4 5494.5 5500.2 5524.2 06:33:31 INFO - PROCESS | 16242 | 06:33:31 INFO - PROCESS | 16242 | [#5] yui.html Cycles:180 Average:19870.56 Median:4308.67 stddev:29234.14 (678.5%) stddev-sans-first:29280.62 06:33:31 INFO - PROCESS | 16242 | Values: 675.6 701.6 742.4 769.8 802.8 14559.0 16454.6 16610.3 16689.1 16695.0 14851.3 15068.8 15166.5 15217.0 15235.8 788.3 803.6 803.7 804.1 805.9 652.0 652.8 781.9 803.8 807.3 842.9 859.0 860.0 860.3 861.0 851.3 852.3 852.9 853.1 853.5 502.5 503.2 583.3 588.5 620.9 13496.2 13549.9 13556.0 13598.8 13775.4 13632.9 14507.6 14558.4 14581.5 14625.0 12732.9 12831.4 12987.8 13005.2 13398.9 4227.1 4303.8 4305.7 4311.6 4355.3 76802.2 77002.6 77037.0 80450.0 80671.6 11448.3 11509.6 11513.7 11911.0 11976.0 20963.0 21140.3 21176.7 21178.5 21272.6 8067.2 8086.0 8141.7 8189.7 8271.2 4515.2 4524.7 4530.5 4595.3 4595.5 3395.9 3443.3 3473.7 3488.7 3492.8 603.5 606.4 606.9 611.9 622.9 478.2 489.4 637.9 665.2 682.3 8463.5 8570.2 8920.5 9020.3 9256.4 546.1 606.5 622.9 669.0 704.0 3814.0 4174.5 4244.4 4321.9 4371.6 97382.0 119689.0 122185.0 124442.0 128132.0 61769.0 62263.7 93289.6 107909.0 111869.0 90968.5 91367.0 91440.5 92692.1 93981.0 7728.2 8279.9 8476.3 8488.3 8724.3 35299.8 35392.1 36284.8 39041.2 44580.3 47519.8 48943.0 59328.1 59665.7 71869.3 12413.6 12628.6 12890.6 12905.2 13038.7 14112.5 14227.6 14392.4 14745.3 14854.9 13521.4 13729.9 13778.7 14029.0 14042.5 10634.3 12404.4 12971.1 13309.5 14441.0 13244.2 13476.3 13571.1 13844.0 13852.4 10966.8 11168.7 11511.3 11604.2 11751.2 10535.6 11435.2 11495.0 11593.9 11774.9 06:33:31 INFO - PROCESS | 16242 | -------- Summary: end -------- 06:33:31 INFO - PROCESS | 16242 | 06:33:32 INFO - TEST-INFO | 16242: exit 0 06:33:32 INFO - TEST-OK | dromaeo_css | took 1117108ms 06:33:32 INFO - TEST-START | kraken 06:33:32 INFO - operating with platform_type : linux_ 06:33:32 INFO - Initialising browser for kraken test... 06:33:32 INFO - TEST-INFO | started process 16555 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphESBlY/profile http://localhost:48034/getInfo.html) 06:33:36 INFO - PROCESS | 16555 | __metrics Screen width/height:1600/1200 06:33:36 INFO - PROCESS | 16555 | colorDepth:24 06:33:36 INFO - PROCESS | 16555 | Browser inner width/height: 1024/697 06:33:36 INFO - PROCESS | 16555 | __metrics 06:33:36 INFO - PROCESS | 16555 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:33:36 INFO - PROCESS | 16555 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:33:38 INFO - TEST-INFO | 16555: exit 0 06:33:38 INFO - Browser initialized. 06:33:38 INFO - Running cycle 1/1 for kraken test... 06:33:38 INFO - TEST-INFO | started process 16639 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphESBlY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:33:50 INFO - PROCESS | 16639 | RSS: Main: 172232704 06:33:50 INFO - PROCESS | 16639 | 06:33:52 INFO - PROCESS | 16639 | Cycle 1(1): loaded http://localhost:48034/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48034/tests/kraken/driver.html?testName=audio-beat-detection) 06:33:53 INFO - PROCESS | 16639 | RSS: Main: 229203968 06:33:53 INFO - PROCESS | 16639 | 06:33:56 INFO - PROCESS | 16639 | Cycle 1(1): loaded http://localhost:48034/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48034/tests/kraken/driver.html?testName=audio-dft) 06:33:56 INFO - PROCESS | 16639 | RSS: Main: 216129536 06:33:56 INFO - PROCESS | 16639 | 06:34:00 INFO - PROCESS | 16639 | Cycle 1(1): loaded http://localhost:48034/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48034/tests/kraken/driver.html?testName=audio-fft) 06:34:00 INFO - PROCESS | 16639 | RSS: Main: 297873408 06:34:00 INFO - PROCESS | 16639 | 06:34:02 INFO - PROCESS | 16639 | Cycle 1(1): loaded http://localhost:48034/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48034/tests/kraken/driver.html?testName=audio-oscillator) 06:34:03 INFO - PROCESS | 16639 | RSS: Main: 209059840 06:34:03 INFO - PROCESS | 16639 | 06:34:05 INFO - PROCESS | 16639 | Cycle 1(1): loaded http://localhost:48034/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48034/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:34:06 INFO - PROCESS | 16639 | RSS: Main: 211689472 06:34:06 INFO - PROCESS | 16639 | 06:34:09 INFO - PROCESS | 16639 | Cycle 1(1): loaded http://localhost:48034/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48034/tests/kraken/driver.html?testName=imaging-darkroom) 06:34:09 INFO - PROCESS | 16639 | RSS: Main: 247754752 06:34:09 INFO - PROCESS | 16639 | 06:34:13 INFO - PROCESS | 16639 | Cycle 1(1): loaded http://localhost:48034/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48034/tests/kraken/driver.html?testName=imaging-desaturate) 06:34:13 INFO - PROCESS | 16639 | RSS: Main: 247140352 06:34:13 INFO - PROCESS | 16639 | 06:34:16 INFO - PROCESS | 16639 | Cycle 1(1): loaded http://localhost:48034/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48034/tests/kraken/driver.html?testName=json-parse-financial) 06:34:16 INFO - PROCESS | 16639 | RSS: Main: 245985280 06:34:16 INFO - PROCESS | 16639 | 06:34:18 INFO - PROCESS | 16639 | Cycle 1(1): loaded http://localhost:48034/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48034/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:34:19 INFO - PROCESS | 16639 | RSS: Main: 208764928 06:34:19 INFO - PROCESS | 16639 | 06:34:20 INFO - PROCESS | 16639 | Cycle 1(1): loaded http://localhost:48034/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48034/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:34:21 INFO - PROCESS | 16639 | RSS: Main: 216231936 06:34:21 INFO - PROCESS | 16639 | 06:34:23 INFO - PROCESS | 16639 | Cycle 1(1): loaded http://localhost:48034/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48034/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:34:23 INFO - PROCESS | 16639 | RSS: Main: 225185792 06:34:23 INFO - PROCESS | 16639 | 06:34:26 INFO - PROCESS | 16639 | Cycle 1(1): loaded http://localhost:48034/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48034/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:34:27 INFO - PROCESS | 16639 | RSS: Main: 235266048 06:34:27 INFO - PROCESS | 16639 | 06:34:30 INFO - PROCESS | 16639 | Cycle 1(1): loaded http://localhost:48034/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48034/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:34:30 INFO - PROCESS | 16639 | RSS: Main: 230715392 06:34:30 INFO - PROCESS | 16639 | 06:34:32 INFO - PROCESS | 16639 | Cycle 1(1): loaded http://localhost:48034/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48034/tests/kraken/driver.html?testName=ai-astar) 06:34:32 INFO - PROCESS | 16639 | RSS: Main: 281686016 06:34:32 INFO - PROCESS | 16639 | 06:34:32 INFO - PROCESS | 16639 | __start_tp_report 06:34:32 INFO - PROCESS | 16639 | _x_x_mozilla_page_load 06:34:32 INFO - PROCESS | 16639 | _x_x_mozilla_page_load_details 06:34:32 INFO - PROCESS | 16639 | |i|pagename|runs| 06:34:32 INFO - PROCESS | 16639 | |0;ai-astar;104;109;111;109;110;110;111;110;110;114 06:34:32 INFO - PROCESS | 16639 | |1;audio-beat-detection;149;129;121;169;132;123;129;128;164;124 06:34:32 INFO - PROCESS | 16639 | |2;audio-dft;161;160;160;160;161;162;163;162;161;163 06:34:32 INFO - PROCESS | 16639 | |3;audio-fft;75;76;77;115;75;76;76;76;98;75 06:34:32 INFO - PROCESS | 16639 | |4;audio-oscillator;83;82;116;83;83;84;111;84;84;122 06:34:32 INFO - PROCESS | 16639 | |5;imaging-gaussian-blur;117;116;117;116;116;117;116;117;116;117 06:34:32 INFO - PROCESS | 16639 | |6;imaging-darkroom;146;146;146;146;146;147;146;146;145;146 06:34:32 INFO - PROCESS | 16639 | |7;imaging-desaturate;85;85;85;85;85;85;84;85;85;84 06:34:32 INFO - PROCESS | 16639 | |8;json-parse-financial;53;53;54;52;53;56;64;54;54;54 06:34:32 INFO - PROCESS | 16639 | |9;json-stringify-tinderbox;60;61;61;61;62;61;61;61;61;61 06:34:32 INFO - PROCESS | 16639 | |10;stanford-crypto-aes;81;86;80;80;80;79;80;81;88;82 06:34:32 INFO - PROCESS | 16639 | |11;stanford-crypto-ccm;132;131;130;136;128;136;142;137;178;143 06:34:32 INFO - PROCESS | 16639 | |12;stanford-crypto-pbkdf2;175;167;167;166;168;176;169;170;168;167 06:34:32 INFO - PROCESS | 16639 | |13;stanford-crypto-sha256-iterative;66;66;66;66;67;69;67;66;64;65 06:34:32 INFO - PROCESS | 16639 | __end_tp_report 06:34:32 INFO - PROCESS | 16639 | __start_cc_report 06:34:32 INFO - PROCESS | 16639 | _x_x_mozilla_cycle_collect,1700 06:34:32 INFO - PROCESS | 16639 | __end_cc_report 06:34:32 INFO - PROCESS | 16639 | __startTimestamp1476452072764__endTimestamp 06:34:32 INFO - PROCESS | 16639 | 06:34:32 INFO - PROCESS | 16639 | ------- Summary: start ------- 06:34:32 INFO - PROCESS | 16639 | Number of tests: 14 06:34:32 INFO - PROCESS | 16639 | 06:34:32 INFO - PROCESS | 16639 | [#0] ai-astar Cycles:10 Average:109.80 Median:110.00 stddev:2.49 (2.3%) stddev-sans-first:1.51 06:34:32 INFO - PROCESS | 16639 | Values: 104.0 109.0 111.0 109.0 110.0 110.0 111.0 110.0 110.0 114.0 06:34:32 INFO - PROCESS | 16639 | 06:34:32 INFO - PROCESS | 16639 | [#1] audio-beat-detection Cycles:10 Average:136.80 Median:130.50 stddev:17.49 (13.4%) stddev-sans-first:17.98 06:34:32 INFO - PROCESS | 16639 | Values: 149.0 129.0 121.0 169.0 132.0 123.0 129.0 128.0 164.0 124.0 06:34:32 INFO - PROCESS | 16639 | 06:34:32 INFO - PROCESS | 16639 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:1.16 (0.7%) stddev-sans-first:1.22 06:34:32 INFO - PROCESS | 16639 | Values: 161.0 160.0 160.0 160.0 161.0 162.0 163.0 162.0 161.0 163.0 06:34:32 INFO - PROCESS | 16639 | 06:34:32 INFO - PROCESS | 16639 | [#3] audio-fft Cycles:10 Average:81.90 Median:76.00 stddev:13.58 (17.9%) stddev-sans-first:14.18 06:34:32 INFO - PROCESS | 16639 | Values: 75.0 76.0 77.0 115.0 75.0 76.0 76.0 76.0 98.0 75.0 06:34:32 INFO - PROCESS | 16639 | 06:34:32 INFO - PROCESS | 16639 | [#4] audio-oscillator Cycles:10 Average:93.20 Median:83.00 stddev:16.19 (19.5%) stddev-sans-first:16.74 06:34:32 INFO - PROCESS | 16639 | Values: 83.0 82.0 116.0 83.0 83.0 84.0 111.0 84.0 84.0 122.0 06:34:32 INFO - PROCESS | 16639 | 06:34:32 INFO - PROCESS | 16639 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 06:34:32 INFO - PROCESS | 16639 | Values: 117.0 116.0 117.0 116.0 116.0 117.0 116.0 117.0 116.0 117.0 06:34:32 INFO - PROCESS | 16639 | 06:34:32 INFO - PROCESS | 16639 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 06:34:32 INFO - PROCESS | 16639 | Values: 146.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 145.0 146.0 06:34:32 INFO - PROCESS | 16639 | 06:34:32 INFO - PROCESS | 16639 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 06:34:32 INFO - PROCESS | 16639 | Values: 85.0 85.0 85.0 85.0 85.0 85.0 84.0 85.0 85.0 84.0 06:34:32 INFO - PROCESS | 16639 | 06:34:32 INFO - PROCESS | 16639 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:54.00 stddev:3.43 (6.4%) stddev-sans-first:3.59 06:34:32 INFO - PROCESS | 16639 | Values: 53.0 53.0 54.0 52.0 53.0 56.0 64.0 54.0 54.0 54.0 06:34:32 INFO - PROCESS | 16639 | 06:34:32 INFO - PROCESS | 16639 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:61.00 stddev:0.47 (0.8%) stddev-sans-first:0.33 06:34:32 INFO - PROCESS | 16639 | Values: 60.0 61.0 61.0 61.0 62.0 61.0 61.0 61.0 61.0 61.0 06:34:32 INFO - PROCESS | 16639 | 06:34:32 INFO - PROCESS | 16639 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:81.00 stddev:2.95 (3.6%) stddev-sans-first:3.11 06:34:32 INFO - PROCESS | 16639 | Values: 81.0 86.0 80.0 80.0 80.0 79.0 80.0 81.0 88.0 82.0 06:34:32 INFO - PROCESS | 16639 | 06:34:32 INFO - PROCESS | 16639 | [#11] stanford-crypto-ccm Cycles:10 Average:139.30 Median:136.50 stddev:14.46 (10.6%) stddev-sans-first:15.10 06:34:32 INFO - PROCESS | 16639 | Values: 132.0 131.0 130.0 136.0 128.0 136.0 142.0 137.0 178.0 143.0 06:34:32 INFO - PROCESS | 16639 | 06:34:32 INFO - PROCESS | 16639 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.30 Median:168.50 stddev:3.47 (2.1%) stddev-sans-first:3.00 06:34:32 INFO - PROCESS | 16639 | Values: 175.0 167.0 167.0 166.0 168.0 176.0 169.0 170.0 168.0 167.0 06:34:32 INFO - PROCESS | 16639 | 06:34:32 INFO - PROCESS | 16639 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.00 stddev:1.32 (2.0%) stddev-sans-first:1.39 06:34:32 INFO - PROCESS | 16639 | Values: 66.0 66.0 66.0 66.0 67.0 69.0 67.0 66.0 64.0 65.0 06:34:32 INFO - PROCESS | 16639 | -------- Summary: end -------- 06:34:32 INFO - PROCESS | 16639 | 06:34:33 INFO - TEST-INFO | 16639: exit 0 06:34:34 INFO - TEST-OK | kraken | took 61292ms 06:34:34 INFO - SUITE-END | took 1178s 06:34:34 INFO - Completed test suite (00:19:38) 06:34:34 INFO - javascript benchmark 06:34:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3054.160105970859, 3064.8161110333376, 3097.101840466265, 3097.5663407122993, 3110.1758034120953, 5164.896702065966, 5275.446078161795, 5275.551578115865, 5368.355797304324, 5392.9730351348235, 5281.63028587999, 5298.337707786527, 5300.337457817773, 5309.4425085365965, 5320.388155362135, 4794.592459640935, 4815.5906747926465, 4820.445648750404, 4835.830745923893, 4867.634927380443, 4755.667103302771, 4860.441049279343, 4888.02239552091, 4922.335484709554, 4934.432540257881, 4924.581410580087, 4933.210686290195, 4935.457099719046, 4941.160002799533, 4995.550400463958, 4181.707280490367, 4834.734089625087, 4886.389201349832, 4895.828645997373, 4938.975305123451, 4644.164050470914, 4829.613630909519, 4853.854384368439, 4870.220764677634, 4881.902361952741, 5137.3064636274, 5160.225966105114, 5223.843284701427, 5330.120530112566, 5342.412334643186, 5558.027345214571, 5564.916526252109, 5585.525230355424, 5622.184783206453, 5637.126245431965, 5670.234518340013, 5707.5148612368, 5722.456366645162, 5731.426857314235, 5733.397993210736, 5145.742712864342, 5200.401953775288, 5220.060389129917, 5273.709945953009, 5329.067413202674, 5726.198332233491, 5736.799212027559, 5736.799212027642, 5755.597108202385, 5799.043157878903, 5526.723663816873, 5536.114221724505, 5543.390227075019, 5557.3886872444, 5561.972190139023, 5410.972945135328, 5457.508824205841, 5537.086380747131, 5584.21820945068, 5614.719264036782, 5611.046122159161, 5624.240727501817, 5661.065924122474, 5676.801311954062, 5677.886442271131, 5627.971860140673, 5631.8592035199445, 5632.915506267409, 5633.126865335797, 5633.887322253532, 4242.4272723181975, 4245.97877010613, 4276.080642661843, 4326.6754993375625, 4382.211201983673, 3827.2154208387215, 3852.0177354774355, 3866.4007078902814, 3871.2451072041245, 3915.314819906505, 5337.572994160536, 5370.785168593291, 5388.434214407509, 5393.4336894626285, 5406.107992181324, 5433.755481003364, 5667.688277144796, 5684.204211410406, 5692.57305702074, 5701.686407247558, 5194.1429664105, 5194.740262986836, 5248.475152484797, 5252.737363131828, 5259.105951988171, 4809.735464549413, 4810.388519845891, 4813.278008298783, 4816.386510518945, 4820.373351464287, 5693.202951586781, 5699.0, 5705.343885453226, 5792.1311803229855, 5852.882942341044, 5645.350784659817, 5701.657900525982, 5706.172604972338, 5758.539316854725, 5772.538196944319, 5845.152452894392, 5853.590248682722, 5854.4730974212525, 5858.882822343615, 5863.237779088691, 5302.734863256745, 5351.759170837244, 5552.416996215339, 5560.777568897361, 5637.46444087811, 5740.225069615715, 5752.884942301214, 5758.193852860519, 5790.536757059509, 5817.94182058174, 5573.804916827891, 5584.916226256691, 5587.888242235052, 5593.161025846156, 5593.524550413098, 5354.598405119554, 5418.133098704346, 5418.349798024262, 5583.050881350261, 5595.300587426572, 5530.0, 5555.50000499957, 5601.327840659147, 5641.097424412074, 5650.830475085754, 5610.326760788732, 5637.351704553865, 5637.49262566371, 5638.7462564185535, 5643.971780141073, 5519.337679478488, 5520.282363292747, 5522.171674248895, 5539.446055394428, 5541.612087153861], "value": 5214.283312299222, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.3225065420186, 593.3028691287738, 619.665380694425, 638.103464632192, 655.5018186178503, 31712.682873171263, 41647.37528937065, 42780.786096069554, 42841.35737963929, 46172.769136154355, 45369.77315113428, 45499.77250113753, 45521.54478455214, 45721.0, 45723.31415028777, 8022.839543209132, 8781.0, 8930.910690893106, 8941.329400295004, 8942.19520243178, 8058.0, 10231.48842557873, 10603.628872989448, 10609.310394824312, 10953.014228719414, 10788.51451684672, 10852.82943411317, 10854.0, 10854.72863178423, 10857.0, 10653.25427220095, 10714.732131696692, 10721.0, 10727.946360268188, 10754.516046777913, 10581.10060644846, 10644.467776611216, 10646.680599582025, 10650.988156125233, 10651.84022239667, 35998.82000590007, 36122.09694757626, 36161.0, 36179.27641447156, 36288.63711362879, 3561.679448849616, 3625.6374362563533, 3851.114243723931, 3868.303705333039, 4099.1801639672185, 31195.0, 31226.37547249065, 31408.21479463009, 31775.52336714951, 31819.0, 4235.661147108255, 4316.395704601358, 4451.933221001687, 4494.595486406207, 4509.571590698911, 331678.0, 335115.0, 336482.0, 337136.0, 337309.0, 58423.12365314524, 58711.0, 58774.41225587775, 58775.41633544806, 58898.41101589015, 60125.699371502866, 60721.39278607157, 61009.0, 61063.389366105774, 61153.69423152945, 14388.640283992774, 14551.126932384092, 14552.927235363755, 14565.635859103608, 14567.854321456649, 10116.949415252877, 10346.896531034743, 11714.88285117155, 11776.293422394683, 12009.939950300368, 16539.338426462808, 17195.742063869053, 17332.82667173337, 17358.739618905725, 17402.129893505527, 6043.576949613484, 6206.689665516707, 6232.688365581703, 6250.937490625127, 6310.9368906311265, 939.7885475767897, 1016.575244455037, 1034.425893629028, 1046.9633562825265, 1112.1214240749878, 31146.377072458425, 31269.0, 31558.0, 31812.36375272528, 32106.35787284288, 1037.8287582548794, 1071.8606581144402, 1073.7852429514128, 1090.3675867996542, 1159.756451145252, 15800.209989500709, 16088.0, 16172.433964811411, 16354.10052447103, 16522.42171523991, 475552.0, 479896.0, 481246.0, 483579.0, 679647.0, 56604.43395566074, 56904.43095568991, 57216.141757873665, 57427.0, 57520.137197942066, 1215.8054711246334, 1238.5355491690616, 1302.7785276503016, 1305.3408028945512, 1351.1892864281353, 29292.0, 31929.521057184626, 32217.0, 34749.47875781815, 34751.82624086965, 55170.44829551814, 55891.16163257473, 55943.72028139833, 55990.440095598526, 56065.719671401384, 344443.0, 346000.0, 346023.0, 346534.0, 350251.0, 26775.330616734736, 27494.72505275002, 27634.578467445113, 27760.44479110447, 27929.207079291908, 35689.46465803067, 40529.1894162121, 43370.566294337914, 44197.33703994507, 48696.513034870615, 39610.80194599008, 42184.36723449212, 42641.0, 42882.35676464918, 43830.561694382646, 40229.0, 40859.79570102249, 41019.79490102531, 42285.788571058176, 42529.14941701211, 39723.40298150061, 40264.396034058926, 40631.7968410156, 41080.0, 41646.0, 34383.48424773681, 36314.0, 36767.26465470622, 37029.81485092557, 37206.81396593108, 27151.59272610873, 27200.007989135156, 27953.44566593079, 28021.159365219075, 28832.135035948955], "value": 19897.771925444922, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.7407053102547, 362.4219370104682, 388.8988862895647, 391.70426328122267, 401.7268257584843, 13946.093503922239, 18454.907725461388, 18924.0, 19476.805231947677, 20647.793522064814, 19417.51456213592, 19518.70721939172, 19758.407247782554, 19947.40157795265, 19959.301424450146, 5504.697241651697, 5781.624194427349, 5789.899919015374, 5800.390958949313, 5802.738876750535, 5517.144842549411, 5659.292588426447, 5663.546916246711, 5683.744231509592, 5694.886102277952, 5659.122835960433, 5661.122526008455, 5666.5183459406, 5668.348139963916, 5669.971650141764, 5548.91676624851, 5654.180143879135, 5805.88388232233, 5830.854228644275, 5848.0, 5496.422875598045, 5651.7739290428335, 5651.802186923479, 5662.37713851476, 5662.462066103713, 21396.46508837276, 22135.225267115573, 22731.77268227313, 23243.767562324498, 23357.41606459835, 2102.4008157675144, 2172.847900646955, 2195.747489038765, 2266.1388672304583, 2276.169198242646, 9734.805303893883, 10039.89960100397, 10068.244881633907, 10644.893551064468, 10696.304740191863, 1805.6388722255601, 1882.632886587116, 1899.8290153886217, 1921.8270355668058, 1953.1308567687386, 80687.99999999942, 84110.57944710237, 86269.56865215696, 88147.55926220393, 89622.0, 10433.5826566938, 10713.571457141627, 10808.459577021118, 11028.0, 11054.502547385388, 15162.924185379003, 15194.468193613171, 15201.61995950088, 15206.0, 15247.771283430757, 7407.777766667009, 7411.258874112654, 7658.387329013665, 7789.961050194826, 7933.603319833986, 7241.637918104074, 7305.780826575211, 7413.629318534052, 7424.331810137113, 7530.209328020588, 4534.707608331676, 4551.453825540956, 4553.54464553542, 4553.567411095941, 4690.390249267642, 1810.3301778341834, 1911.4456807525662, 1912.2924517928177, 1919.7504324438014, 1940.1754254441805, 871.1854416120947, 893.2050475077186, 928.7817362919709, 950.5627411390699, 1039.812833689943, 17811.376601818873, 18700.158492867853, 18922.526936826413, 19401.0, 19472.318468853522, 896.6906417286026, 947.8199142162968, 962.6101428921298, 990.1138481059412, 1054.773223756896, 9848.803023939481, 10785.193410700807, 10838.399984065514, 10848.254999775758, 10869.738918519393, 477286.0, 477761.5566910352, 510279.0, 512844.0, 518613.0, 91917.0, 93759.0, 94605.52697236469, 94775.0, 94790.0, 976.3556053004983, 998.4558415663481, 1031.185363562792, 1038.460000799595, 1039.4387031003173, 17199.656006880043, 17662.94517866654, 18139.183736732142, 18242.72635910436, 18293.725594115833, 42060.789696051324, 43984.560154398045, 44156.558434415245, 44479.332810007225, 45788.54211457843, 60835.0, 61271.0, 61888.69055654873, 62365.37634623596, 64864.0, 7364.41084713211, 7572.507786993828, 8351.20663536963, 8438.915610844058, 8586.570671466527, 12673.0, 13443.731125377633, 13461.461541538229, 13530.458781648624, 13756.17462952226, 11640.35978021217, 11881.524739010343, 11903.642890713292, 12045.879541204826, 12201.450934707782, 11301.660950171508, 11317.151213658844, 11530.192886497865, 11683.18217724751, 11936.761264774483, 11590.42047897585, 11632.941835290769, 11752.647420577396, 11787.292762434281, 12224.022078233898, 7385.593792341473, 7522.849543009219, 7531.924680753123, 7565.6973721050545, 7962.761117166494, 11597.362145082101, 11635.360055197045, 11740.295582265091, 11793.941030295136, 11959.581414650445], "value": 9120.493326910728, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1299.7335546213028, 1421.324870686424, 1461.9707605847884, 1585.1440222279962, 1703.5655907743524, 7701.34538564222, 8576.056633770288, 8862.0, 8888.600012999406, 9081.046490118542, 8865.157810008055, 8916.46501209928, 8926.06276340983, 8948.0, 8960.775980600472, 2241.5965126277265, 2266.433391652087, 2267.0, 2267.30847091637, 2270.19408110121, 2204.3386983904843, 2216.92240771573, 2289.610766169755, 2294.300238427279, 2297.5290065536524, 2241.742199647037, 2247.606668832948, 2253.5154941687533, 2258.977410225901, 2298.092253559843, 2197.099189332374, 2208.326460429568, 2211.834112441565, 2243.921462748804, 2247.797698207169, 2214.1254204589095, 2233.3969828146473, 2233.542123864604, 2250.437390652337, 2251.7860803223666, 8730.956345218297, 8761.430507017087, 8818.823623527558, 8828.205461508494, 8830.0, 5116.155834287338, 5234.7644356004075, 5239.79040838366, 5246.108161612535, 5258.710770907599, 3219.3078488125166, 3416.265502916885, 3447.3277710846396, 3465.9133521661906, 3489.1451594359546, 1069.251523933242, 1118.9608363707232, 1129.220837622038, 1134.2343917855496, 1147.432021149528, 12275.386230688518, 12322.322272275022, 12332.321722305269, 12385.690357741038, 12413.44139513715, 4241.766702831313, 4389.1346177874275, 4540.614047805908, 4563.566461186182, 4610.354550362952, 9575.281853860988, 9617.71146865595, 9625.56684949179, 9625.855612165824, 9632.807343853083, 5206.479352064839, 5207.0366982108435, 5214.7914083437, 5220.138677118233, 5220.9477905220465, 4048.797560122041, 4267.8292868284925, 4368.737875727466, 4820.542048505386, 4838.0, 3549.378858699717, 3593.2813437312643, 3650.872219472306, 3667.688246499024, 3684.2263124743567, 1082.7022568793486, 1088.5700148441479, 1112.4660163121746, 1112.7718817642365, 1119.652907598647, 791.6358475101403, 845.4377838737171, 930.6230976454547, 965.9178969787506, 969.1616751510035, 5412.945870541244, 5716.28546431696, 5740.655560666373, 5850.912236316459, 6118.204633397719, 436.6506794564336, 442.3276619538284, 445.1630933844352, 449.21836005350457, 451.1946176075755, 3802.4866643003393, 3946.2896678597554, 3957.8416863325147, 4036.737612055207, 4134.276501612206, 10764.407957562253, 11127.721806954729, 11242.887571124347, 11243.044341230923, 11260.324380537195, 10743.946280268548, 10982.176336774774, 11078.0, 11102.722431939266, 11115.110791136689, 8046.114927357986, 8105.189481051848, 8118.10700822909, 8121.0, 8124.309433698202, 5316.574674026146, 5342.198670199501, 5357.758900849549, 5380.650257733235, 5553.0559804832465, 9808.705738827846, 9919.752006199902, 10030.29787914839, 10043.648472303727, 10114.494275286354, 9188.310876684141, 10363.11913487332, 10399.220058495492, 10399.740006499898, 10406.843897341698, 6768.7292508299115, 7135.607541585263, 7306.123265208209, 7369.668364923484, 7513.173550909505, 8448.535330556879, 8455.196756308142, 8498.830023399621, 8526.531040792815, 8571.785705357415, 7698.769036928901, 7724.266194711493, 7762.146163922077, 7770.961145194238, 7789.376849851885, 7508.211637777955, 7569.772906812805, 7661.272179142972, 7673.232676732506, 7691.0, 6704.262531121671, 6739.191297044386, 6745.460363171032, 6800.081988931629, 6852.246252912076, 4982.551570358685, 5029.321041659329, 5090.08378491875, 5186.559142472932, 5193.169092945111, 4945.851624451272, 5001.374828146481, 5183.377994640517, 5241.187615919539, 5318.8936221276135], "value": 4428.23275713087, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.705428060465, 326.72718280236006, 331.14894720568134, 331.9170207448139, 333.71300681413965, 5303.496167864051, 5332.57339412847, 5333.413324534303, 5347.839564813052, 5348.0, 5265.657732247401, 5277.683338999663, 5287.39194992576, 5290.709011004393, 5292.841214763554, 3885.844566217348, 4170.728902621335, 4171.20747058058, 4176.644985176264, 4179.495381662599, 4102.323116685743, 4139.613229568098, 4141.0, 4142.689298302639, 4158.979205103986, 4077.022644017649, 4077.7757223352705, 4088.1414902870283, 4088.7546747195115, 4091.161311931062, 3892.5718171001167, 3977.3238549446664, 4016.7790771507557, 4128.814203360856, 4134.862912699002, 3582.247727977128, 3592.6586974237666, 3596.62235465275, 3604.873829415984, 3626.1297288650535, 5092.949070509285, 5120.513551212629, 5152.562032227265, 5154.793808247666, 5179.912218434133, 4583.175028494869, 4682.27424749161, 4682.461516925563, 4685.625149988027, 4736.431628204603, 5511.917321240185, 5538.446155384429, 5546.0, 5553.6390134641115, 5559.8888022239735, 3973.5827738087664, 3977.105151340954, 3982.6415622594104, 4001.4998125234347, 4001.519817621904, 5701.743421546041, 5761.423857614247, 5786.161006654053, 5806.187133801272, 5859.501942334907, 4056.634902858757, 4057.634812866797, 4057.8985525361513, 4064.4716186895516, 4066.3290557057753, 4111.301078816608, 4112.485939257593, 4113.095119073799, 4113.300738874398, 4114.362273847559, 4609.147307748078, 4708.835190768306, 4724.126036683225, 4725.8582242532775, 4732.621390288768, 5531.230006397995, 5557.249771280906, 5581.883623275361, 5600.35595906476, 5604.607677462538, 1396.4484028808768, 1407.9436822526984, 1409.4644035266533, 1416.2918540729636, 1418.5106138382241, 827.7640872351351, 882.7087061269766, 893.5889490834159, 904.7198214526503, 907.3648446087765, 4671.785335812713, 4732.361131247238, 4748.881277968078, 4759.549326738156, 4767.6662633615315, 4997.925031124536, 5031.320771695774, 5035.974820125949, 5044.016416798689, 5075.213341932006, 4756.6670333077045, 4777.536286192482, 4821.349117869043, 4831.782569784368, 5146.459621739664, 2895.2038189498057, 2969.0, 2970.3316753730237, 3023.742981846524, 3040.9847950760545, 5903.675297858573, 5916.319623243296, 5929.288485381781, 5959.076343166729, 5969.671668058299, 5626.634268772516, 5798.362180160179, 5824.087956021989, 5830.38780928005, 5847.298324201038, 5878.0, 5882.647041177543, 5899.469047785634, 5909.320428150818, 5912.674802885796, 5640.351359593699, 5712.542996560348, 5720.342160651412, 5736.512396446349, 5791.884162316645, 5476.534494568006, 5664.0, 5685.260916080883, 5696.914546281892, 5698.572607054404, 5935.2787691568965, 5936.7922122725495, 6016.578839481194, 6034.698265086816, 6044.818655440344, 4109.260333140063, 4206.137741762993, 4207.768572728407, 4235.195312890541, 4239.618434340924, 5689.630174038674, 5703.344115426779, 5707.229524014205, 5731.770729170787, 5742.0, 5580.330360356783, 5583.0, 5589.860253493695, 5591.720413979204, 5613.540479475284, 5433.891322173456, 5599.664020158803, 5604.411536788579, 5614.326280846324, 5625.184348269396, 5596.18855265976, 5597.384287728265, 5600.0, 5610.186522954067, 5612.579056570692, 5510.8071217507195, 5553.278073850373, 5590.608657393944, 5610.326760788732, 5644.745986430538, 5361.651492653121, 5468.371137319259, 5494.5054945055135, 5500.22996780459, 5524.171374293888], "value": 4199.697768978692, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [675.5980191785887, 701.5755467941898, 742.3949481172843, 769.807548112972, 802.77923571018, 14559.0, 16454.588635284123, 16610.25253863576, 16689.08210048447, 16695.0, 14851.331690073946, 15068.849311506881, 15166.545003649908, 15217.0, 15235.771463428058, 788.286600626434, 803.618281316373, 803.7468197517793, 804.0833449867156, 805.9355251579889, 651.9543631945766, 652.7943697735199, 781.8749000159976, 803.7910143362739, 807.3258828877894, 842.8819965204846, 858.9527575983318, 859.9914000860006, 860.2515811244226, 861.0442408926087, 851.284920666643, 852.2627926843267, 852.9232369086781, 853.1212850763661, 853.5348235211825, 502.45734606624757, 503.23508267433294, 583.2679986616769, 588.4938952500846, 620.944115029645, 13496.190228586218, 13549.86450135496, 13556.0, 13598.796018059737, 13775.448982040707, 13632.93183534086, 14507.637309067357, 14558.417663293456, 14581.489647862274, 14625.0, 12732.87267127326, 12831.422585983653, 12987.805182922264, 13005.154664946747, 13398.866011339956, 4227.062117495484, 4303.837963749801, 4305.720128191689, 4311.61195492404, 4355.3031514957775, 76802.23197768007, 77002.61498692527, 77037.0, 80449.99999999942, 80671.59664201642, 11448.255863368855, 11509.597164099216, 11513.654590362303, 11911.0, 11976.041916646647, 20963.0, 21140.260090896743, 21176.682349764767, 21178.470538236666, 21272.574548508943, 8067.233612806774, 8086.0, 8141.715039973573, 8189.672413103528, 8271.2142346477, 4515.164694531522, 4524.6832721709825, 4530.456345238593, 4595.333676616939, 4595.517470665599, 3395.8811441599423, 3443.345764304774, 3473.6700013498676, 3488.720902327808, 3492.8253587320532, 603.471962033221, 606.445102731005, 606.8543549548165, 611.9388061193933, 622.8941080016317, 478.2419864514783, 489.3687143584736, 637.8788030274233, 665.2150462454254, 682.310866025318, 8463.49219046859, 8570.228679418882, 8920.509371984603, 9020.278377729766, 9256.398334108262, 546.1180193986683, 606.5481216493653, 622.9283632382244, 668.9565178263397, 703.968321425537, 3813.9809300953316, 4174.478190226222, 4244.427002354642, 4321.935170972438, 4371.562843715603, 97382.0, 119689.0, 122185.0, 124442.0, 128132.0, 61769.0, 62263.68868155721, 93289.60065599022, 107909.0, 111869.0, 90968.54515727512, 91367.0, 91440.54279728692, 92692.07307927104, 93981.0, 7728.227177282227, 8279.875801862856, 8476.27951624119, 8488.278496327881, 8724.284747920723, 35299.82350088233, 35392.11519712028, 36284.81857590695, 39041.21917561576, 44580.33129502995, 47519.76240118777, 48943.0, 59328.110078349724, 59665.70167149136, 71869.28130718626, 12413.565525206935, 12628.635626014231, 12890.613281601567, 12905.161164524276, 13038.739225215631, 14112.50606228777, 14227.573172804832, 14392.352344144329, 14745.2627368629, 14854.925725371304, 13521.391537380645, 13729.862701372858, 13778.65553361134, 14029.0, 14042.508512202025, 10634.255602107778, 12404.441800118835, 12971.092023558638, 13309.46762129504, 14441.0, 13244.20534767917, 13476.258805765778, 13571.117877337942, 13844.020313076824, 13852.376643051288, 10966.780664386828, 11168.720781980515, 11511.30932144074, 11604.245724027911, 11751.236169648946, 10535.578576857146, 11435.199536032731, 11495.0, 11593.88406115928, 11774.882251177378], "value": 7264.426118724054, "unit": "score"}], "name": "dromaeo_css", "value": 7097.722389219993, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 109.0, 111.0, 109.0, 110.0, 110.0, 111.0, 110.0, 110.0, 114.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 129.0, 121.0, 169.0, 132.0, 123.0, 129.0, 128.0, 164.0, 124.0], "value": 136.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 160.0, 161.0, 162.0, 163.0, 162.0, 161.0, 163.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 115.0, 75.0, 76.0, 76.0, 76.0, 98.0, 75.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 116.0, 83.0, 83.0, 84.0, 111.0, 84.0, 84.0, 122.0], "value": 93.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 145.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 84.0, 85.0, 85.0, 84.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 54.0, 52.0, 53.0, 56.0, 64.0, 54.0, 54.0, 54.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 61.0, 62.0, 61.0, 61.0, 61.0, 61.0, 61.0], "value": 61.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 86.0, 80.0, 80.0, 80.0, 79.0, 80.0, 81.0, 88.0, 82.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 131.0, 130.0, 136.0, 128.0, 136.0, 142.0, 137.0, 178.0, 143.0], "value": 139.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 167.0, 167.0, 166.0, 168.0, 176.0, 169.0, 170.0, 168.0, 167.0], "value": 169.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 67.0, 69.0, 67.0, 66.0, 64.0, 65.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1502.5, "alertThreshold": 2.0}]} 06:34:34 INFO - Return code: 0 06:34:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:34:34 INFO - # TBPL SUCCESS # 06:34:34 INFO - Running post-action listener: _resource_record_post_action 06:34:34 INFO - [mozharness: 2016-10-14 13:34:34.583616Z] Finished run-tests step (success) 06:34:34 INFO - Running post-run listener: _resource_record_post_run 06:34:34 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 403734528; Read time: 16; Write time: 207648 06:34:34 INFO - TinderboxPrint: CPU usage
13.0% 06:34:34 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 06:34:34 INFO - TinderboxPrint: I/O write bytes / time
403,734,528 / 207,648 06:34:34 INFO - TinderboxPrint: CPU idle
8,296.5 (86.9%) 06:34:34 INFO - TinderboxPrint: CPU user
1,196.5 (12.5%) 06:34:34 INFO - TinderboxPrint: Swap in / out
0 / 0 06:34:34 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 115253248; Read time: 0; Write time: 56676 06:34:34 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 288481280; Read time: 0; Write time: 150972 06:34:35 INFO - Running post-run listener: _upload_blobber_files 06:34:35 INFO - Blob upload gear active. 06:34:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:34:35 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 06:34:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:34:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:34:35 INFO - (blobuploader) - INFO - Open directory for files ... 06:34:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:34:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:34:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:34:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:34:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:34:36 INFO - (blobuploader) - INFO - Done attempting. 06:34:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:34:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:34:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:34:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:34:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:34:40 INFO - (blobuploader) - INFO - Done attempting. 06:34:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:34:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:34:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:34:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:34:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:34:41 INFO - (blobuploader) - INFO - Done attempting. 06:34:41 INFO - (blobuploader) - INFO - Iteration through files over. 06:34:41 INFO - Return code: 0 06:34:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:34:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:34:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/67d3dbffcc3a5b30186df2d85d292a96e331fd821863e9d55156280a7f64da46b6f4368556daa675dae5cf7a5176779d174aaaa42fbda6e464ed5cf31aabcb4e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/595771d4415bf5aecb98e314adf6dcf3ab95cccc9d4785a3572d7018080a0f980465b4b9b3c8c2bb906ef07e84850e1f3c5fe03fed454f677cc0d33a0e50e343", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/53050adb404c7c6fc27f741d4d332b015027ab2b78d078e60f0b3bd921900975841071152c01f737f81d5366fc5f41ea4397dcd18354512b66d5bf52d4499ac0"} 06:34:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:34:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:34:41 INFO - Contents: 06:34:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/67d3dbffcc3a5b30186df2d85d292a96e331fd821863e9d55156280a7f64da46b6f4368556daa675dae5cf7a5176779d174aaaa42fbda6e464ed5cf31aabcb4e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/595771d4415bf5aecb98e314adf6dcf3ab95cccc9d4785a3572d7018080a0f980465b4b9b3c8c2bb906ef07e84850e1f3c5fe03fed454f677cc0d33a0e50e343", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/53050adb404c7c6fc27f741d4d332b015027ab2b78d078e60f0b3bd921900975841071152c01f737f81d5366fc5f41ea4397dcd18354512b66d5bf52d4499ac0"} 06:34:41 INFO - Running post-run listener: copy_logs_to_upload_dir 06:34:41 INFO - Copying logs to upload dir... 06:34:41 INFO - mkdir: /builds/slave/test/build/upload/logs 06:34:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.949967 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-14 06:34:41.017134) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 06:34:41.021134) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1476448062.840541-928227769 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/67d3dbffcc3a5b30186df2d85d292a96e331fd821863e9d55156280a7f64da46b6f4368556daa675dae5cf7a5176779d174aaaa42fbda6e464ed5cf31aabcb4e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/595771d4415bf5aecb98e314adf6dcf3ab95cccc9d4785a3572d7018080a0f980465b4b9b3c8c2bb906ef07e84850e1f3c5fe03fed454f677cc0d33a0e50e343", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/53050adb404c7c6fc27f741d4d332b015027ab2b78d078e60f0b3bd921900975841071152c01f737f81d5366fc5f41ea4397dcd18354512b66d5bf52d4499ac0"} build_url:https://queue.taskcluster.net/v1/task/DdYYgrxgR6KTTj_XUXnDRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011176 build_url: 'https://queue.taskcluster.net/v1/task/DdYYgrxgR6KTTj_XUXnDRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/67d3dbffcc3a5b30186df2d85d292a96e331fd821863e9d55156280a7f64da46b6f4368556daa675dae5cf7a5176779d174aaaa42fbda6e464ed5cf31aabcb4e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/595771d4415bf5aecb98e314adf6dcf3ab95cccc9d4785a3572d7018080a0f980465b4b9b3c8c2bb906ef07e84850e1f3c5fe03fed454f677cc0d33a0e50e343", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/53050adb404c7c6fc27f741d4d332b015027ab2b78d078e60f0b3bd921900975841071152c01f737f81d5366fc5f41ea4397dcd18354512b66d5bf52d4499ac0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 06:34:41.046515) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 06:34:41.046855) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1476448062.840541-928227769 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004456 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 06:34:41.130705) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 06:34:41.131045) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 06:34:41.131358) ========= ========= Total master_lag: 0.17 =========