builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-047 starttime: 1475375153.33 results: success (0) buildid: 20161001163004 builduid: af16b59cdd074c4186629162aa2ef9d9 revision: 7c576fe3279d87543f0a03b844eba7bc215e17f1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-01 19:25:53.328897) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-01 19:25:53.329366) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-01 19:25:53.329765) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-01 19:25:53.430768) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 19:25:53.431066) ========= 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=03627c79f6bb3d1578c4a402000001ba-1475374680.345992-1261431849 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-01 19:25:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 66.6M=0s 2016-10-01 19:25:54 (66.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.129166 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 19:25:53.575436) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 19:25:53.575771) ========= 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=03627c79f6bb3d1578c4a402000001ba-1475374680.345992-1261431849 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018405 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 19:25:53.630810) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-01 19:25:53.631184) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7c576fe3279d87543f0a03b844eba7bc215e17f1 --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 7c576fe3279d87543f0a03b844eba7bc215e17f1 --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=03627c79f6bb3d1578c4a402000001ba-1475374680.345992-1261431849 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-01 19:25:54,397 truncating revision to first 12 chars 2016-10-01 19:25:54,397 Setting DEBUG logging. 2016-10-01 19:25:54,397 attempt 1/10 2016-10-01 19:25:54,397 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7c576fe3279d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-01 19:25:55,512 unpacking tar archive at: mozilla-central-7c576fe3279d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.464323 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-01 19:25:55.109429) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-01 19:25:55.109795) ========= script_repo_revision: 7c576fe3279d87543f0a03b844eba7bc215e17f1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-01 19:25:55.110226) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-01 19:25:55.110673) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-01 19:25:55.120211) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-10-01 19:25:55.120520) ========= /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=03627c79f6bb3d1578c4a402000001ba-1475374680.345992-1261431849 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:25:55 INFO - MultiFileLogger online at 20161001 19:25:55 in /builds/slave/test 19:25:55 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 19:25:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:25:55 INFO - {'append_to_log': False, 19:25:55 INFO - 'base_work_dir': '/builds/slave/test', 19:25:55 INFO - 'blob_upload_branch': 'Firefox', 19:25:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:25:55 INFO - 'branch': 'Firefox', 19:25:55 INFO - 'buildbot_json_path': 'buildprops.json', 19:25:55 INFO - 'config_files': ('talos/linux_config.py',), 19:25:55 INFO - 'default_actions': ('clobber', 19:25:55 INFO - 'read-buildbot-config', 19:25:55 INFO - 'download-and-extract', 19:25:55 INFO - 'populate-webroot', 19:25:55 INFO - 'create-virtualenv', 19:25:55 INFO - 'install', 19:25:55 INFO - 'run-tests'), 19:25:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:25:55 INFO - 'download_minidump_stackwalk': True, 19:25:55 INFO - 'download_symbols': 'ondemand', 19:25:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:25:55 INFO - 'tooltool.py': '/tools/tooltool.py', 19:25:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:25:55 INFO - '/tools/misc-python/virtualenv.py')}, 19:25:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:25:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:25:55 INFO - 'installer_path': 'installer.exe', 19:25:55 INFO - 'log_level': 'info', 19:25:55 INFO - 'log_name': 'talos', 19:25:55 INFO - 'log_to_console': True, 19:25:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:25:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:25:55 INFO - 'opt_config_files': (), 19:25:55 INFO - 'pip_index': False, 19:25:55 INFO - 'sps_profile': False, 19:25:55 INFO - 'sps_profile_interval': 0, 19:25:55 INFO - 'suite': 'dromaeojs', 19:25:55 INFO - 'system_bits': '32', 19:25:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:25:55 INFO - 'title': 'talos-linux64-ix-047', 19:25:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:25:55 INFO - 'use_talos_json': True, 19:25:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:25:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:25:55 INFO - 'work_dir': 'build'} 19:25:55 INFO - [mozharness: 2016-10-02 02:25:55.991452Z] Running clobber step. 19:25:55 INFO - Running pre-action listener: _resource_record_pre_action 19:25:55 INFO - Running main action method: clobber 19:25:55 INFO - rmtree: /builds/slave/test/build 19:25:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:25:56 INFO - Running post-action listener: _resource_record_post_action 19:25:56 INFO - [mozharness: 2016-10-02 02:25:56.452068Z] Finished clobber step (success) 19:25:56 INFO - [mozharness: 2016-10-02 02:25:56.452195Z] Running read-buildbot-config step. 19:25:56 INFO - Running pre-action listener: _resource_record_pre_action 19:25:56 INFO - Running main action method: read_buildbot_config 19:25:56 INFO - Using buildbot properties: 19:25:56 INFO - { 19:25:56 INFO - "project": "", 19:25:56 INFO - "product": "firefox", 19:25:56 INFO - "script_repo_revision": "production", 19:25:56 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 19:25:56 INFO - "repository": "", 19:25:56 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 19:25:56 INFO - "buildid": "20161001163004", 19:25:56 INFO - "pgo_build": "True", 19:25:56 INFO - "basedir": "/builds/slave/test", 19:25:56 INFO - "buildnumber": 897, 19:25:56 INFO - "slavename": "talos-linux64-ix-047", 19:25:56 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:25:56 INFO - "platform": "ubuntu64_hw", 19:25:56 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 19:25:56 INFO - "branch": "mozilla-central", 19:25:56 INFO - "repo_path": "mozilla-central", 19:25:56 INFO - "revision": "7c576fe3279d87543f0a03b844eba7bc215e17f1", 19:25:56 INFO - "stage_platform": "linux64-pgo", 19:25:56 INFO - "builduid": "af16b59cdd074c4186629162aa2ef9d9", 19:25:56 INFO - "slavebuilddir": "test" 19:25:56 INFO - } 19:25:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/EZurryZCS2eSmn07k7kvmw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 19:25:56 INFO - Running post-action listener: _resource_record_post_action 19:25:56 INFO - [mozharness: 2016-10-02 02:25:56.454641Z] Finished read-buildbot-config step (success) 19:25:56 INFO - [mozharness: 2016-10-02 02:25:56.454729Z] Running download-and-extract step. 19:25:56 INFO - Running pre-action listener: _resource_record_pre_action 19:25:56 INFO - Running main action method: download_and_extract 19:25:56 INFO - mkdir: /builds/slave/test/build/tests 19:25:56 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')]} 19:25:56 INFO - trying https://queue.taskcluster.net/v1/task/EZurryZCS2eSmn07k7kvmw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 19:25:56 INFO - Downloading https://queue.taskcluster.net/v1/task/EZurryZCS2eSmn07k7kvmw/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 19:25:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EZurryZCS2eSmn07k7kvmw/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 19:25:57 INFO - Downloaded 1361 bytes. 19:25:57 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 19:25:57 INFO - Using the following test package requirements: 19:25:57 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 19:25:57 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:25:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:25:57 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:25:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:25:57 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:25:57 INFO - u'jsshell-linux-x86_64.zip'], 19:25:57 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:25:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:25:57 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 19:25:57 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:25:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:25:57 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:25:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:25:57 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:25:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:25:57 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:25:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:25:57 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:25:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EZurryZCS2eSmn07k7kvmw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 19:25:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EZurryZCS2eSmn07k7kvmw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:25:57 INFO - Fetch https://queue.taskcluster.net/v1/task/EZurryZCS2eSmn07k7kvmw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 19:25:57 INFO - Http code: 200 19:25:57 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 19:25:57 INFO - x-amz-cf-id: JqsVhJE6eu0RqQtPtLmnTjVFRaAwj-ZMW2WcbYoZSnN2d46L-lVbhw== 19:25:57 INFO - x-amz-version-id: I55CuiXf9.RDGW6LL5lpzV2tnw9Qzecd 19:25:57 INFO - Expected file size: 21991296 19:25:57 INFO - Obtained file size: 21991296 19:26:01 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 19:26:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EZurryZCS2eSmn07k7kvmw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 19:26:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EZurryZCS2eSmn07k7kvmw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:26:01 INFO - Fetch https://queue.taskcluster.net/v1/task/EZurryZCS2eSmn07k7kvmw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 19:26:02 INFO - Http code: 200 19:26:02 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 19:26:02 INFO - x-amz-cf-id: nYTPPXWPiCAw2pkyq-nyEd6Af27nXpub63V8suI8RGAwZEbWRRgP6Q== 19:26:02 INFO - x-amz-version-id: I55CuiXf9.RDGW6LL5lpzV2tnw9Qzecd 19:26:02 INFO - Expected file size: 21991296 19:26:02 INFO - Obtained file size: 21991296 19:26:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EZurryZCS2eSmn07k7kvmw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 19:26:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EZurryZCS2eSmn07k7kvmw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:26:07 INFO - Fetch https://queue.taskcluster.net/v1/task/EZurryZCS2eSmn07k7kvmw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 19:26:07 INFO - Http code: 200 19:26:07 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 19:26:07 INFO - x-amz-cf-id: nWIScb_VkQoDxiNrMduKxPhVRe0ytLgrcWCVkhgirdP06TC4ZFHHcA== 19:26:07 INFO - x-amz-version-id: .vKAlR4_xhemkZIWSuLncGZhaSBW2.Dk 19:26:08 INFO - Expected file size: 14408522 19:26:08 INFO - Obtained file size: 14408522 19:26:09 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')]} 19:26:09 INFO - trying https://queue.taskcluster.net/v1/task/EZurryZCS2eSmn07k7kvmw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 19:26:09 INFO - Downloading https://queue.taskcluster.net/v1/task/EZurryZCS2eSmn07k7kvmw/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 19:26:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EZurryZCS2eSmn07k7kvmw/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 19:26:11 INFO - Downloaded 59681667 bytes. 19:26:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EZurryZCS2eSmn07k7kvmw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 19:26:11 INFO - mkdir: /builds/slave/test/properties 19:26:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:26:11 INFO - Writing to file /builds/slave/test/properties/build_url 19:26:11 INFO - Contents: 19:26:11 INFO - build_url:https://queue.taskcluster.net/v1/task/EZurryZCS2eSmn07k7kvmw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 19:26:12 INFO - Running post-action listener: _resource_record_post_action 19:26:12 INFO - Running post-action listener: set_extra_try_arguments 19:26:12 INFO - [mozharness: 2016-10-02 02:26:12.464304Z] Finished download-and-extract step (success) 19:26:12 INFO - [mozharness: 2016-10-02 02:26:12.464531Z] Running populate-webroot step. 19:26:12 INFO - Running pre-action listener: _resource_record_pre_action 19:26:12 INFO - Running main action method: populate_webroot 19:26:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:26:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:26:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:26:12 INFO - '--tppagecycles', 19:26:12 INFO - '7'], 19:26:12 INFO - 'tests': ['tsvgm']}}, 19:26:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:26:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:26:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:26:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:26:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:26:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:26:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:26:12 INFO - 'talos_options': ['--disable-e10s'], 19:26:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:26:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:26:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:26:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:26:12 INFO - 'talos_options': ['--disable-e10s'], 19:26:12 INFO - 'tests': ['damp', 'tps']}, 19:26:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:26:12 INFO - 'tests': ['damp', 'tps']}, 19:26:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:26:12 INFO - 'tests': ['dromaeo_dom']}, 19:26:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:26:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:26:12 INFO - 'tests': ['basic_compositor_video']}, 19:26:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:26:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:26:12 INFO - 'tests': ['a11yr', 19:26:12 INFO - 'ts_paint', 19:26:12 INFO - 'tpaint', 19:26:12 INFO - 'sessionrestore', 19:26:12 INFO - 'sessionrestore_no_auto_restore', 19:26:12 INFO - 'tabpaint']}, 19:26:12 INFO - 'other-e10s': {'tests': ['a11yr', 19:26:12 INFO - 'ts_paint', 19:26:12 INFO - 'tpaint', 19:26:12 INFO - 'sessionrestore', 19:26:12 INFO - 'sessionrestore_no_auto_restore', 19:26:12 INFO - 'tabpaint']}, 19:26:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:26:12 INFO - 'ts_paint', 19:26:12 INFO - 'tpaint', 19:26:12 INFO - 'sessionrestore', 19:26:12 INFO - 'sessionrestore_no_auto_restore', 19:26:12 INFO - 'tabpaint']}, 19:26:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:26:12 INFO - 'ts_paint', 19:26:12 INFO - 'tpaint', 19:26:12 INFO - 'sessionrestore', 19:26:12 INFO - 'sessionrestore_no_auto_restore', 19:26:12 INFO - 'tabpaint']}, 19:26:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:26:12 INFO - 'tests': ['a11yr', 19:26:12 INFO - 'ts_paint', 19:26:12 INFO - 'tpaint', 19:26:12 INFO - 'sessionrestore', 19:26:12 INFO - 'sessionrestore_no_auto_restore', 19:26:12 INFO - 'tabpaint']}, 19:26:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:26:12 INFO - 'tests': ['a11yr', 19:26:12 INFO - 'ts_paint', 19:26:12 INFO - 'tpaint', 19:26:12 INFO - 'sessionrestore', 19:26:12 INFO - 'sessionrestore_no_auto_restore', 19:26:12 INFO - 'tabpaint']}, 19:26:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:26:12 INFO - 'tests': ['tsvgx', 19:26:12 INFO - 'tsvgr_opacity', 19:26:12 INFO - 'tart', 19:26:12 INFO - 'tscrollx', 19:26:12 INFO - 'cart']}, 19:26:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:26:12 INFO - 'tsvgr_opacity', 19:26:12 INFO - 'tart', 19:26:12 INFO - 'tscrollx', 19:26:12 INFO - 'cart']}, 19:26:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:26:12 INFO - 'talos_options': ['--disable-e10s'], 19:26:12 INFO - 'tests': ['tp5o']}, 19:26:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:26:12 INFO - 'tests': ['tp5o']}, 19:26:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:26:12 INFO - 'talos_options': ['--disable-e10s', 19:26:12 INFO - '--xperf_path', 19:26:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:26:12 INFO - 'tests': ['tp5n']}, 19:26:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:26:12 INFO - 'talos_options': ['--xperf_path', 19:26:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:26:12 INFO - 'tests': ['tp5n']}}, 19:26:12 INFO - 'talos.zip': {'path': '', 19:26:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:26:12 INFO - Running post-action listener: _resource_record_post_action 19:26:12 INFO - [mozharness: 2016-10-02 02:26:12.480100Z] Finished populate-webroot step (success) 19:26:12 INFO - [mozharness: 2016-10-02 02:26:12.480189Z] Running create-virtualenv step. 19:26:12 INFO - Running pre-action listener: _resource_record_pre_action 19:26:12 INFO - Running main action method: create_virtualenv 19:26:12 INFO - Creating virtualenv /builds/slave/test/build/venv 19:26:12 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 19:26:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:26:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:26:12 INFO - Using real prefix '/usr' 19:26:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:26:13 INFO - Installing distribute.............................................................................................................................................................................................done. 19:26:15 INFO - Installing pip.................done. 19:26:15 INFO - Return code: 0 19:26:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:26:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:26:15 INFO - Reading from file tmpfile_stdout 19:26:15 INFO - Output received: 19:26:15 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) 19:26:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:26:15 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')]} 19:26:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:26:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:15 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')]} 19:26:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:26:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:15 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 0x7f4b91df0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1062790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f930>, '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 0x1060830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060cc0>, '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': '03627c79f6bb3d1578c4a402000001ba-1475374680.345992-1261431849', '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 19:26:15 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 19:26:15 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 19:26:15 INFO - Using env: {'DISPLAY': ':0', 19:26:15 INFO - 'HOME': '/home/cltbld', 19:26:15 INFO - 'LANG': 'en_US.UTF-8', 19:26:15 INFO - 'LANGUAGE': 'en_US:en', 19:26:15 INFO - 'LOGNAME': 'cltbld', 19:26:15 INFO - 'MAIL': '/var/mail/cltbld', 19:26:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:26:15 INFO - 'MOZ_NO_REMOTE': '1', 19:26:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:26:15 INFO - 'NO_EM_RESTART': '1', 19:26:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:26:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:26:15 INFO - 'PWD': '/builds/slave/test', 19:26:15 INFO - 'SHELL': '/bin/bash', 19:26:15 INFO - 'SHLVL': '1', 19:26:15 INFO - 'TERM': 'linux', 19:26:15 INFO - 'TMOUT': '86400', 19:26:15 INFO - 'USER': 'cltbld', 19:26:15 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1475374680.345992-1261431849', 19:26:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:26:15 INFO - '_': '/tools/buildbot/bin/python'} 19:26:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:26:15 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 19:26:15 INFO - Cleaning up... 19:26:15 INFO - Return code: 0 19:26:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:26:15 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')]} 19:26:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:26:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:15 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')]} 19:26:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:26:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:15 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 0x7f4b91df0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1062790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f930>, '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 0x1060830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060cc0>, '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': '03627c79f6bb3d1578c4a402000001ba-1475374680.345992-1261431849', '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 19:26:15 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 19:26:15 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 19:26:15 INFO - Using env: {'DISPLAY': ':0', 19:26:15 INFO - 'HOME': '/home/cltbld', 19:26:15 INFO - 'LANG': 'en_US.UTF-8', 19:26:15 INFO - 'LANGUAGE': 'en_US:en', 19:26:15 INFO - 'LOGNAME': 'cltbld', 19:26:15 INFO - 'MAIL': '/var/mail/cltbld', 19:26:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:26:15 INFO - 'MOZ_NO_REMOTE': '1', 19:26:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:26:15 INFO - 'NO_EM_RESTART': '1', 19:26:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:26:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:26:15 INFO - 'PWD': '/builds/slave/test', 19:26:15 INFO - 'SHELL': '/bin/bash', 19:26:15 INFO - 'SHLVL': '1', 19:26:15 INFO - 'TERM': 'linux', 19:26:15 INFO - 'TMOUT': '86400', 19:26:15 INFO - 'USER': 'cltbld', 19:26:15 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1475374680.345992-1261431849', 19:26:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:26:15 INFO - '_': '/tools/buildbot/bin/python'} 19:26:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:26:15 INFO - Downloading/unpacking psutil>=3.1.1 19:26:15 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 19:26:15 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 19:26:15 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 19:26:15 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 19:26:15 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 19:26:15 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 19:26:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:26:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:26:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:26:17 INFO - Installing collected packages: psutil 19:26:17 INFO - Running setup.py install for psutil 19:26:17 INFO - building 'psutil._psutil_linux' extension 19:26:17 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 19:26:17 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 19:26:17 INFO - building 'psutil._psutil_posix' extension 19:26:17 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 19:26:18 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 19:26:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:26:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:26:18 INFO - Successfully installed psutil 19:26:18 INFO - Cleaning up... 19:26:18 INFO - Return code: 0 19:26:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:26: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')]} 19:26:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:26:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26: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')]} 19:26:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:26:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4b91df0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1062790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f930>, '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 0x1060830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060cc0>, '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': '03627c79f6bb3d1578c4a402000001ba-1475374680.345992-1261431849', '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 19:26: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:26: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 mozsystemmonitor==0.3 19:26:18 INFO - Using env: {'DISPLAY': ':0', 19:26:18 INFO - 'HOME': '/home/cltbld', 19:26:18 INFO - 'LANG': 'en_US.UTF-8', 19:26:18 INFO - 'LANGUAGE': 'en_US:en', 19:26:18 INFO - 'LOGNAME': 'cltbld', 19:26:18 INFO - 'MAIL': '/var/mail/cltbld', 19:26:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:26:18 INFO - 'MOZ_NO_REMOTE': '1', 19:26:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:26:18 INFO - 'NO_EM_RESTART': '1', 19:26:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:26:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:26:18 INFO - 'PWD': '/builds/slave/test', 19:26:18 INFO - 'SHELL': '/bin/bash', 19:26:18 INFO - 'SHLVL': '1', 19:26:18 INFO - 'TERM': 'linux', 19:26:18 INFO - 'TMOUT': '86400', 19:26:18 INFO - 'USER': 'cltbld', 19:26:18 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1475374680.345992-1261431849', 19:26:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:26:18 INFO - '_': '/tools/buildbot/bin/python'} 19:26:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:26:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:26:18 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 19:26:18 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 19:26:18 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 19:26:18 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 19:26:18 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 19:26:18 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 19:26:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:26:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:26:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:26:20 INFO - Installing collected packages: mozsystemmonitor 19:26:20 INFO - Running setup.py install for mozsystemmonitor 19:26:20 INFO - Successfully installed mozsystemmonitor 19:26:20 INFO - Cleaning up... 19:26:20 INFO - Return code: 0 19:26:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:26:20 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')]} 19:26:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:26:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:20 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')]} 19:26:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:26:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:20 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 0x7f4b91df0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1062790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f930>, '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 0x1060830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060cc0>, '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': '03627c79f6bb3d1578c4a402000001ba-1475374680.345992-1261431849', '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 19:26:20 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 19:26:20 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 19:26:20 INFO - Using env: {'DISPLAY': ':0', 19:26:20 INFO - 'HOME': '/home/cltbld', 19:26:20 INFO - 'LANG': 'en_US.UTF-8', 19:26:20 INFO - 'LANGUAGE': 'en_US:en', 19:26:20 INFO - 'LOGNAME': 'cltbld', 19:26:20 INFO - 'MAIL': '/var/mail/cltbld', 19:26:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:26:20 INFO - 'MOZ_NO_REMOTE': '1', 19:26:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:26:20 INFO - 'NO_EM_RESTART': '1', 19:26:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:26:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:26:20 INFO - 'PWD': '/builds/slave/test', 19:26:20 INFO - 'SHELL': '/bin/bash', 19:26:20 INFO - 'SHLVL': '1', 19:26:20 INFO - 'TERM': 'linux', 19:26:20 INFO - 'TMOUT': '86400', 19:26:20 INFO - 'USER': 'cltbld', 19:26:20 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1475374680.345992-1261431849', 19:26:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:26:20 INFO - '_': '/tools/buildbot/bin/python'} 19:26:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:26:20 INFO - Downloading/unpacking jsonschema==2.5.1 19:26:20 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 19:26:20 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 19:26:20 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 19:26:20 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 19:26:20 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 19:26:20 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 19:26:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:26:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:26: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 19:26: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 19:26: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 19:26: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 19:26: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 19:26: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 19:26:22 INFO - Downloading functools32-3.2.3-2.tar.gz 19:26:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:26:22 INFO - warning: no files found matching '*.txt' 19:26:22 INFO - no previously-included directories found matching 'build' 19:26:22 INFO - no previously-included directories found matching 'dist' 19:26:22 INFO - no previously-included directories found matching '.git*' 19:26:22 INFO - Installing collected packages: jsonschema, functools32 19:26:23 INFO - Running setup.py install for functools32 19:26:23 INFO - warning: no files found matching '*.txt' 19:26:23 INFO - no previously-included directories found matching 'build' 19:26:23 INFO - no previously-included directories found matching 'dist' 19:26:23 INFO - no previously-included directories found matching '.git*' 19:26:23 INFO - Successfully installed jsonschema functools32 19:26:23 INFO - Cleaning up... 19:26:23 INFO - Return code: 0 19:26:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:26:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:26:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:26:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:26:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:26:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:23 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 0x7f4b91df0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1062790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f930>, '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 0x1060830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060cc0>, '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': '03627c79f6bb3d1578c4a402000001ba-1475374680.345992-1261431849', '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 19:26:23 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 19:26:23 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 19:26:23 INFO - Using env: {'DISPLAY': ':0', 19:26:23 INFO - 'HOME': '/home/cltbld', 19:26:23 INFO - 'LANG': 'en_US.UTF-8', 19:26:23 INFO - 'LANGUAGE': 'en_US:en', 19:26:23 INFO - 'LOGNAME': 'cltbld', 19:26:23 INFO - 'MAIL': '/var/mail/cltbld', 19:26:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:26:23 INFO - 'MOZ_NO_REMOTE': '1', 19:26:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:26:23 INFO - 'NO_EM_RESTART': '1', 19:26:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:26:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:26:23 INFO - 'PWD': '/builds/slave/test', 19:26:23 INFO - 'SHELL': '/bin/bash', 19:26:23 INFO - 'SHLVL': '1', 19:26:23 INFO - 'TERM': 'linux', 19:26:23 INFO - 'TMOUT': '86400', 19:26:23 INFO - 'USER': 'cltbld', 19:26:23 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1475374680.345992-1261431849', 19:26:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:26:23 INFO - '_': '/tools/buildbot/bin/python'} 19:26:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:26:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:26:23 INFO - Cleaning up... 19:26:23 INFO - Return code: 0 19:26:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:26:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:26:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:26:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:26:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:26:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:23 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 0x7f4b91df0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1062790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f930>, '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 0x1060830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060cc0>, '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': '03627c79f6bb3d1578c4a402000001ba-1475374680.345992-1261431849', '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 19:26:23 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 19:26:23 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 19:26:23 INFO - Using env: {'DISPLAY': ':0', 19:26:23 INFO - 'HOME': '/home/cltbld', 19:26:23 INFO - 'LANG': 'en_US.UTF-8', 19:26:23 INFO - 'LANGUAGE': 'en_US:en', 19:26:23 INFO - 'LOGNAME': 'cltbld', 19:26:23 INFO - 'MAIL': '/var/mail/cltbld', 19:26:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:26:23 INFO - 'MOZ_NO_REMOTE': '1', 19:26:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:26:23 INFO - 'NO_EM_RESTART': '1', 19:26:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:26:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:26:23 INFO - 'PWD': '/builds/slave/test', 19:26:23 INFO - 'SHELL': '/bin/bash', 19:26:23 INFO - 'SHLVL': '1', 19:26:23 INFO - 'TERM': 'linux', 19:26:23 INFO - 'TMOUT': '86400', 19:26:23 INFO - 'USER': 'cltbld', 19:26:23 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1475374680.345992-1261431849', 19:26:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:26:23 INFO - '_': '/tools/buildbot/bin/python'} 19:26:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:26:23 INFO - Downloading/unpacking blobuploader==1.2.4 19:26:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:25 INFO - Downloading blobuploader-1.2.4.tar.gz 19:26:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:26:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:26:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:26:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:26: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 19:26: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 19:26: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 19:26: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 19:26: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 19:26: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 19:26:26 INFO - Downloading docopt-0.6.1.tar.gz 19:26:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:26:26 INFO - Installing collected packages: blobuploader, requests, docopt 19:26:26 INFO - Running setup.py install for blobuploader 19:26:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:26:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:26:26 INFO - Running setup.py install for requests 19:26:26 INFO - Running setup.py install for docopt 19:26:26 INFO - Successfully installed blobuploader requests docopt 19:26:26 INFO - Cleaning up... 19:26:26 INFO - Return code: 0 19:26:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:26: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')]} 19:26:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:26:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26: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')]} 19:26:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:26:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:26 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 0x7f4b91df0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1062790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f930>, '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 0x1060830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060cc0>, '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': '03627c79f6bb3d1578c4a402000001ba-1475374680.345992-1261431849', '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 19:26:26 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 19:26:26 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 19:26:26 INFO - Using env: {'DISPLAY': ':0', 19:26:26 INFO - 'HOME': '/home/cltbld', 19:26:26 INFO - 'LANG': 'en_US.UTF-8', 19:26:26 INFO - 'LANGUAGE': 'en_US:en', 19:26:26 INFO - 'LOGNAME': 'cltbld', 19:26:26 INFO - 'MAIL': '/var/mail/cltbld', 19:26:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:26:26 INFO - 'MOZ_NO_REMOTE': '1', 19:26:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:26:26 INFO - 'NO_EM_RESTART': '1', 19:26:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:26:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:26:26 INFO - 'PWD': '/builds/slave/test', 19:26:26 INFO - 'SHELL': '/bin/bash', 19:26:26 INFO - 'SHLVL': '1', 19:26:26 INFO - 'TERM': 'linux', 19:26:26 INFO - 'TMOUT': '86400', 19:26:26 INFO - 'USER': 'cltbld', 19:26:26 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1475374680.345992-1261431849', 19:26:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:26:26 INFO - '_': '/tools/buildbot/bin/python'} 19:26:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:26:27 INFO - Running setup.py (path:/tmp/pip-5Qvk5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:26:27 INFO - Running setup.py (path:/tmp/pip-kOCJgk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:26:27 INFO - Running setup.py (path:/tmp/pip-TK5jbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:26:27 INFO - Running setup.py (path:/tmp/pip-nfkQ1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:26:27 INFO - Running setup.py (path:/tmp/pip-BpGY7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:26:27 INFO - Running setup.py (path:/tmp/pip-pYZjzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:26:27 INFO - Running setup.py (path:/tmp/pip-AFvNIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:26:27 INFO - Running setup.py (path:/tmp/pip-xUKl1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:26:27 INFO - Running setup.py (path:/tmp/pip-vX7usv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:26:27 INFO - Running setup.py (path:/tmp/pip-PgztsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:26:27 INFO - Running setup.py (path:/tmp/pip-16oeiv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:26:27 INFO - Running setup.py (path:/tmp/pip-Bj9Ecc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:26:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:26:28 INFO - Running setup.py (path:/tmp/pip-_4hxrd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:26:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:26:28 INFO - Running setup.py (path:/tmp/pip-CbxAF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:26:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:26:28 INFO - Running setup.py (path:/tmp/pip-f6ldav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:26:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:26:28 INFO - Running setup.py (path:/tmp/pip-JzDXQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:26:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:26:28 INFO - Running setup.py (path:/tmp/pip-0kOSop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:26:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:26:28 INFO - Running setup.py install for manifestparser 19:26:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:26:28 INFO - Running setup.py install for mozcrash 19:26:28 INFO - Running setup.py install for mozdebug 19:26:28 INFO - Running setup.py install for mozdevice 19:26:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:26:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:26:28 INFO - Running setup.py install for mozfile 19:26:28 INFO - Running setup.py install for mozhttpd 19:26:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:26:28 INFO - Running setup.py install for mozinfo 19:26:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:26:29 INFO - Running setup.py install for mozInstall 19:26:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:26:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:26:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:26:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:26:29 INFO - Running setup.py install for mozleak 19:26:29 INFO - Running setup.py install for mozlog 19:26:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:26:29 INFO - Running setup.py install for moznetwork 19:26:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:26:29 INFO - Running setup.py install for mozprocess 19:26:29 INFO - Running setup.py install for mozprofile 19:26:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:26:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:26:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:26:29 INFO - Running setup.py install for mozrunner 19:26:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:26:29 INFO - Running setup.py install for mozscreenshot 19:26:29 INFO - Running setup.py install for moztest 19:26:30 INFO - Running setup.py install for mozversion 19:26:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:26:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:26:30 INFO - Cleaning up... 19:26:30 INFO - Return code: 0 19:26:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:26: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')]} 19:26:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:26:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26: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')]} 19:26:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:26:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:30 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 0x7f4b91df0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1062790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f930>, '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 0x1060830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060cc0>, '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': '03627c79f6bb3d1578c4a402000001ba-1475374680.345992-1261431849', '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 19:26:30 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 19:26:30 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 19:26:30 INFO - Using env: {'DISPLAY': ':0', 19:26:30 INFO - 'HOME': '/home/cltbld', 19:26:30 INFO - 'LANG': 'en_US.UTF-8', 19:26:30 INFO - 'LANGUAGE': 'en_US:en', 19:26:30 INFO - 'LOGNAME': 'cltbld', 19:26:30 INFO - 'MAIL': '/var/mail/cltbld', 19:26:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:26:30 INFO - 'MOZ_NO_REMOTE': '1', 19:26:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:26:30 INFO - 'NO_EM_RESTART': '1', 19:26:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:26:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:26:30 INFO - 'PWD': '/builds/slave/test', 19:26:30 INFO - 'SHELL': '/bin/bash', 19:26:30 INFO - 'SHLVL': '1', 19:26:30 INFO - 'TERM': 'linux', 19:26:30 INFO - 'TMOUT': '86400', 19:26:30 INFO - 'USER': 'cltbld', 19:26:30 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1475374680.345992-1261431849', 19:26:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:26:30 INFO - '_': '/tools/buildbot/bin/python'} 19:26:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:26:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:26:30 INFO - Running setup.py (path:/tmp/pip-iqkQsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:26:30 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)) 19:26:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:26:30 INFO - Running setup.py (path:/tmp/pip-xxx8iJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:26:30 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)) 19:26:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:26:30 INFO - Running setup.py (path:/tmp/pip-EMMDY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:26:30 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)) 19:26:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:26:30 INFO - Running setup.py (path:/tmp/pip-Cj3obD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:26:30 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)) 19:26:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:26:30 INFO - Running setup.py (path:/tmp/pip-ws7D3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:26:30 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)) 19:26:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:26:30 INFO - Running setup.py (path:/tmp/pip-IdoG6g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:26:30 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)) 19:26:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:26:30 INFO - Running setup.py (path:/tmp/pip-uTuVSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:26:30 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)) 19:26:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:26:30 INFO - Running setup.py (path:/tmp/pip-6LIlgY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:26:30 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)) 19:26:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:26:30 INFO - Running setup.py (path:/tmp/pip-Osw59I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:26:31 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)) 19:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:26:31 INFO - Running setup.py (path:/tmp/pip-8PQXc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:26:31 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)) 19:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:26:31 INFO - Running setup.py (path:/tmp/pip-0p7qjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:26:31 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)) 19:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:26:31 INFO - Running setup.py (path:/tmp/pip-WcWnFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:26:31 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)) 19:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:26:31 INFO - Running setup.py (path:/tmp/pip-c2nBB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:26:31 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)) 19:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:26:31 INFO - Running setup.py (path:/tmp/pip-Tsp5LW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:26:31 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)) 19:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:26:31 INFO - Running setup.py (path:/tmp/pip-lIWFHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:26:31 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)) 19:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:26:31 INFO - Running setup.py (path:/tmp/pip-gzYVIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:26:31 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)) 19:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:26:31 INFO - Running setup.py (path:/tmp/pip-WfDhAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:26:31 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)) 19:26:31 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)) 19:26:31 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)) 19:26:31 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)) 19:26:31 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)) 19:26:31 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)) 19:26:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:26:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:33 INFO - Downloading blessings-1.6.tar.gz 19:26:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:26:33 INFO - Installing collected packages: blessings 19:26:33 INFO - Running setup.py install for blessings 19:26:33 INFO - Successfully installed blessings 19:26:33 INFO - Cleaning up... 19:26:33 INFO - Return code: 0 19:26:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:26:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:26:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:26:34 INFO - Reading from file tmpfile_stdout 19:26:34 INFO - Current package versions: 19:26:34 INFO - argparse == 1.2.1 19:26:34 INFO - blessings == 1.6 19:26:34 INFO - blobuploader == 1.2.4 19:26:34 INFO - docopt == 0.6.1 19:26:34 INFO - functools32 == 3.2.3-2 19:26:34 INFO - jsonschema == 2.5.1 19:26:34 INFO - manifestparser == 1.1 19:26:34 INFO - mozInstall == 1.12 19:26:34 INFO - mozcrash == 0.17 19:26:34 INFO - mozdebug == 0.1 19:26:34 INFO - mozdevice == 0.48 19:26:34 INFO - mozfile == 1.2 19:26:34 INFO - mozhttpd == 0.7 19:26:34 INFO - mozinfo == 0.9 19:26:34 INFO - mozleak == 0.1 19:26:34 INFO - mozlog == 3.4 19:26:34 INFO - moznetwork == 0.27 19:26:34 INFO - mozprocess == 0.23 19:26:34 INFO - mozprofile == 0.28 19:26:34 INFO - mozrunner == 6.12 19:26:34 INFO - mozscreenshot == 0.1 19:26:34 INFO - mozsystemmonitor == 0.3 19:26:34 INFO - moztest == 0.7 19:26:34 INFO - mozversion == 1.4 19:26:34 INFO - psutil == 3.1.1 19:26:34 INFO - requests == 1.2.3 19:26:34 INFO - wsgiref == 0.1.2 19:26:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:26:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:26:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:26:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:26:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:26:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:34 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 0x7f4b91df0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1062790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f930>, '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 0x1060830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060cc0>, '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': '03627c79f6bb3d1578c4a402000001ba-1475374680.345992-1261431849', '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 19:26:34 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 19:26:34 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 19:26:34 INFO - Using env: {'DISPLAY': ':0', 19:26:34 INFO - 'HOME': '/home/cltbld', 19:26:34 INFO - 'LANG': 'en_US.UTF-8', 19:26:34 INFO - 'LANGUAGE': 'en_US:en', 19:26:34 INFO - 'LOGNAME': 'cltbld', 19:26:34 INFO - 'MAIL': '/var/mail/cltbld', 19:26:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:26:34 INFO - 'MOZ_NO_REMOTE': '1', 19:26:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:26:34 INFO - 'NO_EM_RESTART': '1', 19:26:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:26:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:26:34 INFO - 'PWD': '/builds/slave/test', 19:26:34 INFO - 'SHELL': '/bin/bash', 19:26:34 INFO - 'SHLVL': '1', 19:26:34 INFO - 'TERM': 'linux', 19:26:34 INFO - 'TMOUT': '86400', 19:26:34 INFO - 'USER': 'cltbld', 19:26:34 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1475374680.345992-1261431849', 19:26:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:26:34 INFO - '_': '/tools/buildbot/bin/python'} 19:26:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:26:34 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)) 19:26:34 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)) 19:26:34 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)) 19:26:34 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)) 19:26:34 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)) 19:26:34 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)) 19:26:34 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)) 19:26:34 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)) 19:26:34 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)) 19:26:34 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)) 19:26:34 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)) 19:26:34 INFO - Cleaning up... 19:26:34 INFO - Return code: 0 19:26:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:26:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:26:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:26:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:26:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:26:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:34 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 0x7f4b91df0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1062790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f930>, '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 0x1060830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060cc0>, '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': '03627c79f6bb3d1578c4a402000001ba-1475374680.345992-1261431849', '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 19:26:34 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 19:26:34 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 19:26:34 INFO - Using env: {'DISPLAY': ':0', 19:26:34 INFO - 'HOME': '/home/cltbld', 19:26:34 INFO - 'LANG': 'en_US.UTF-8', 19:26:34 INFO - 'LANGUAGE': 'en_US:en', 19:26:34 INFO - 'LOGNAME': 'cltbld', 19:26:34 INFO - 'MAIL': '/var/mail/cltbld', 19:26:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:26:34 INFO - 'MOZ_NO_REMOTE': '1', 19:26:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:26:34 INFO - 'NO_EM_RESTART': '1', 19:26:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:26:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:26:34 INFO - 'PWD': '/builds/slave/test', 19:26:34 INFO - 'SHELL': '/bin/bash', 19:26:34 INFO - 'SHLVL': '1', 19:26:34 INFO - 'TERM': 'linux', 19:26:34 INFO - 'TMOUT': '86400', 19:26:34 INFO - 'USER': 'cltbld', 19:26:34 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1475374680.345992-1261431849', 19:26:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:26:34 INFO - '_': '/tools/buildbot/bin/python'} 19:26:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:26:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:26:34 INFO - Cleaning up... 19:26:34 INFO - Return code: 0 19:26:34 INFO - Running post-action listener: _resource_record_post_action 19:26:34 INFO - Running post-action listener: _start_resource_monitoring 19:26:34 INFO - Starting resource monitoring. 19:26:34 INFO - [mozharness: 2016-10-02 02:26:34.514470Z] Finished create-virtualenv step (success) 19:26:34 INFO - [mozharness: 2016-10-02 02:26:34.514987Z] Running install step. 19:26:34 INFO - Running pre-action listener: _resource_record_pre_action 19:26:34 INFO - Running main action method: install 19:26:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:26:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:26:34 INFO - Reading from file tmpfile_stdout 19:26:34 INFO - Detecting whether we're running mozinstall >=1.0... 19:26:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:26:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:26:34 INFO - Reading from file tmpfile_stdout 19:26:34 INFO - Output received: 19:26:34 INFO - Usage: mozinstall [options] installer 19:26:34 INFO - Options: 19:26:34 INFO - -h, --help show this help message and exit 19:26:34 INFO - -d DEST, --destination=DEST 19:26:34 INFO - Directory to install application into. [default: 19:26:34 INFO - "/builds/slave/test"] 19:26:34 INFO - --app=APP Application being installed. [default: firefox] 19:26:34 INFO - mkdir: /builds/slave/test/build/application 19:26:34 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'] 19:26:34 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 19:26:52 INFO - Reading from file tmpfile_stdout 19:26:52 INFO - Output received: 19:26:52 INFO - /builds/slave/test/build/application/firefox/firefox 19:26:52 INFO - Running post-action listener: _resource_record_post_action 19:26:52 INFO - [mozharness: 2016-10-02 02:26:52.405366Z] Finished install step (success) 19:26:52 INFO - [mozharness: 2016-10-02 02:26:52.405609Z] Running run-tests step. 19:26:52 INFO - Running pre-action listener: _resource_record_pre_action 19:26:52 INFO - Running main action method: run_tests 19:26:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:26:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:26:52 INFO - Python 2.7.3 19:26:52 INFO - Return code: 0 19:26:52 INFO - grabbing minidump binary from tooltool 19:26:52 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')]} 19:26:52 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 0x105f930>, '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 0x1060830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:26:52 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 19:26:52 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 19:26:52 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 19:26:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:26:52 INFO - Return code: 0 19:26:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:26:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:26:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:26:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:26:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:26:52 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/EZurryZCS2eSmn07k7kvmw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 19:26:52 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/EZurryZCS2eSmn07k7kvmw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --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 19:26:52 INFO - Using env: {'DISPLAY': ':0', 19:26:52 INFO - 'HOME': '/home/cltbld', 19:26:52 INFO - 'LANG': 'en_US.UTF-8', 19:26:52 INFO - 'LANGUAGE': 'en_US:en', 19:26:52 INFO - 'LOGNAME': 'cltbld', 19:26:52 INFO - 'MAIL': '/var/mail/cltbld', 19:26:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:26:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:26:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:26:52 INFO - 'MOZ_NO_REMOTE': '1', 19:26:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:26:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:26:52 INFO - 'NO_EM_RESTART': '1', 19:26:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:26:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:26:52 INFO - 'PWD': '/builds/slave/test', 19:26:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:26:52 INFO - 'SHELL': '/bin/bash', 19:26:52 INFO - 'SHLVL': '1', 19:26:52 INFO - 'TERM': 'linux', 19:26:52 INFO - 'TMOUT': '86400', 19:26:52 INFO - 'USER': 'cltbld', 19:26:52 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1475374680.345992-1261431849', 19:26:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:26:52 INFO - '_': '/tools/buildbot/bin/python'} 19:26:52 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/EZurryZCS2eSmn07k7kvmw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 19:26:52 INFO - mozversion application_buildid: 20161001163004 19:26:52 INFO - mozversion application_changeset: 7c576fe3279d87543f0a03b844eba7bc215e17f1 19:26:52 INFO - mozversion application_display_name: Nightly 19:26:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:26:52 INFO - mozversion application_name: Firefox 19:26:52 INFO - mozversion application_remotingname: firefox 19:26:52 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:26:52 INFO - mozversion application_vendor: Mozilla 19:26:52 INFO - mozversion application_version: 52.0a1 19:26:52 INFO - mozversion platform_buildid: 20161001163004 19:26:52 INFO - mozversion platform_changeset: 7c576fe3279d87543f0a03b844eba7bc215e17f1 19:26:52 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:26:52 INFO - mozversion platform_version: 52.0a1 19:26:52 INFO - using testdate: 1475375212 19:26:52 INFO - actual date: 1475375212 19:26:52 INFO - starting webserver on 'localhost:33636' 19:26:52 INFO - SUITE-START | Running 2 tests 19:26:52 INFO - TEST-START | dromaeo_css 19:26:52 INFO - operating with platform_type : linux_ 19:26:52 INFO - Initialising browser for dromaeo_css test... 19:26:52 INFO - TEST-INFO | started process 21722 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZhxNWw/profile http://localhost:33636/getInfo.html) 19:26:57 INFO - PROCESS | 21722 | __metrics Screen width/height:1600/1200 19:26:57 INFO - PROCESS | 21722 | colorDepth:24 19:26:57 INFO - PROCESS | 21722 | Browser inner width/height: 1024/697 19:26:57 INFO - PROCESS | 21722 | __metrics 19:26:57 INFO - PROCESS | 21722 | 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" 19:26:57 INFO - PROCESS | 21722 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:26:58 INFO - PROCESS | 21722 | console.error: PushService: 19:26:58 INFO - PROCESS | 21722 | stateChangeProcessEnqueue: Error transitioning state 19:26:58 INFO - PROCESS | 21722 | UnknownError 19:26:58 INFO - TEST-INFO | 21722: exit 0 19:26:58 INFO - Browser initialized. 19:26:58 INFO - Running cycle 1/1 for dromaeo_css test... 19:26:58 INFO - TEST-INFO | started process 21804 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZhxNWw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:27:10 INFO - PROCESS | 21804 | RSS: Main: 175722496 19:27:10 INFO - PROCESS | 21804 | 19:28:02 INFO - PROCESS | 21804 | 1475375282174 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] 19:30:12 INFO - PROCESS | 21804 | Cycle 1(1): loaded http://localhost:33636/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33636/tests/dromaeo/cssquery-ext.html) 19:30:13 INFO - PROCESS | 21804 | RSS: Main: 326504448 19:30:13 INFO - PROCESS | 21804 | 19:33:16 INFO - PROCESS | 21804 | Cycle 1(1): loaded http://localhost:33636/tests/dromaeo/cssquery-ext.html (next: http://localhost:33636/tests/dromaeo/cssquery-jquery.html) 19:33:16 INFO - PROCESS | 21804 | RSS: Main: 278859776 19:33:16 INFO - PROCESS | 21804 | 19:36:18 INFO - PROCESS | 21804 | Cycle 1(1): loaded http://localhost:33636/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33636/tests/dromaeo/cssquery-mootools.html) 19:36:19 INFO - PROCESS | 21804 | RSS: Main: 214827008 19:36:19 INFO - PROCESS | 21804 | 19:39:21 INFO - PROCESS | 21804 | Cycle 1(1): loaded http://localhost:33636/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33636/tests/dromaeo/cssquery-prototype.html) 19:39:22 INFO - PROCESS | 21804 | RSS: Main: 245751808 19:39:22 INFO - PROCESS | 21804 | 19:42:24 INFO - PROCESS | 21804 | Cycle 1(1): loaded http://localhost:33636/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33636/tests/dromaeo/cssquery-yui.html) 19:42:25 INFO - PROCESS | 21804 | RSS: Main: 217100288 19:42:25 INFO - PROCESS | 21804 | 19:45:28 INFO - PROCESS | 21804 | Cycle 1(1): loaded http://localhost:33636/tests/dromaeo/cssquery-yui.html (next: http://localhost:33636/tests/dromaeo/cssquery-dojo.html) 19:45:28 INFO - PROCESS | 21804 | RSS: Main: 309395456 19:45:28 INFO - PROCESS | 21804 | 19:45:28 INFO - PROCESS | 21804 | __start_tp_report 19:45:28 INFO - PROCESS | 21804 | _x_x_mozilla_page_load 19:45:28 INFO - PROCESS | 21804 | _x_x_mozilla_page_load_details 19:45:28 INFO - PROCESS | 21804 | |i|pagename|runs| 19:45:28 INFO - PROCESS | 21804 | |0;dojo.html;2962.73335399814;3004.8948286809964;3008.623922009748;3031.075521965802;3057.2662560985355;4950.504949505048;5037.0933232018315;5109.335786347774;5164.870878228046;5175.068487672217;5075.593952483801;5111.386633603964;5207.713575753332;5223;5293.920591191126;4735.100330937128;4817.951820481803;4847.442544107429;4862.051899879525;4874.488178741234;4754.762261886909;4765.547273009059;4798.664093513456;4829.951700482985;4861.392325959255;4859.757012149378;4877.170880950229;4879.560839524442;4919.237518184687;4936.580390666798;4574.542545745432;4627.884302892421;4628.143793398232;4818.831340903087;4863.805447782084;4656.5343465653505;4702.294655801623;4720.268358404453;4727.196376615949;4756.833510827139;5218.504242096995;5235.162374020177;5235.528802407802;5240.187770895517;5246.658967167122;5225.059489291926;5522.530584900288;5540.418256083093;5546.084895992157;5548.44515548446;5310.468953104697;5368.651037682538;5373;5384.5692344612335;5387.24578559002;5041.823536176216;5044.697318160922;5046.646734728571;5054.292399064171;5134.255532947702;5647.350554686182;5668.149777533403;5693.68684722336;5735.913961290584;5746.88506229873;5400.702961337164;5416.756245968941;5460.945390546123;5469.917951230735;5474.479924407175;5241.606879484054;5256.421793602701;5543.695096769636;5543.889122217533;5613.831585052373;5372.811951581676;5427.1316589345515;5428.430014848463;5441.265429167091;5502.807401741;5415.431379705153;5421.756020979065;5428.022955867903;5445.482679145475;5493.450654934474;4244.2996905510245;4286.39990401344;4289.721168124124;4295.22685916538;4336.9783151084675;3709.9797555672408;3737;3828.5979972103087;3839.9808000959815;3881.378979363288;5293.57651387888;5295.682259064469;5299.8410047698635;5301.416844147141;5335.599830012765;5593.888122237532;5634.943650563524;5639.238702775073;5641.153826925994;5703.258576385043;5031.295618613397;5087.414947281036;5214.270002199695;5317.627766056339;5330.946690533123;4876.146674331978;4902.90194196114;4908.41099068107;4950.405951285797;4962.5533701967;5758.827235182951;5785.30576330843;5787.884242315215;5796.681182534917;5799.9130013049;5195.506426889439;5307.336582927134;5616.494515493625;5637.295338082739;5685.71571421419;5668.914966275427;5727.341355744143;5757.021306377842;5771.595988280948;5848.356680765028;5496.945030549803;5504.256925315191;5505.394406615189;5506.119020956788;5506.531944784738;5314.707691077027;5604.635698679573;5611.354694210218;5616;5619.831405057855;5238.869028274324;5325.467453254643;5353.437889021752;5370.865728356823;5454.04554203005;5331.866703332447;5376.193570964387;5377.435369286169;5380.704061276668;5383.434739352469;5263.710495922761;5327.786888524571;5332.33345831771;5333.610558311255;5393.622446428869;5235.581153507786;5309.33633295838;5446.264754258124;5490.917636235539;5499.642523235977;5414.431484694051;5419.972900135474;5421.241026256248;5421.593380496557;5472.042392581203 19:45:28 INFO - PROCESS | 21804 | |1;ext.html;544.9767461193497;564.8841987392585;598.3448124303886;603.1736520966274;613.4509613895563;30044.24889377764;41176.38235426467;41791;41831.37252941201;41988.58011419885;42920.78539607298;43334.566654333445;43400.13199736003;43478.78260608701;43557;8038.919610803905;8217.7123800667;8862.06948270432;9022.684206052789;9022.729318120433;10673.733156671067;10905.83641245378;10954.178436617245;10960.56157753689;10965.013148816604;10786.73033174169;10876.728081797939;10881.075108615778;10884;10889.618863339785;10631.627893023746;10698.893011069946;10705.892941070606;10716.249862509627;10758.408287544182;10505.369677819279;10550.577976880915;10571.471426428725;10571.682849514527;10579.629712960086;41136.38295425571;41166.79416602928;41333;41494.792526037476;41538;3220.6940340667834;3282.901512954615;3411.249525104498;3423.2126610879386;3454.447288433864;28636.427271454453;30603.540946885816;31167.844160779052;31279;32281.35437291241;4165.333546632554;4275.251830929575;4366.585174408426;4396.912061758747;4407.801648925774;327565;329552;331448.3427582871;332083;332110;55594;56022.71988640031;56198.7190064047;56345.71827140838;56510.43489565134;60054.69972650196;60185.39814601798;60230.09654855093;60269.09596356058;60395;13752.174869507862;13931;13940.233287169303;14214.644633884029;14226.857731422553;8958.283337332998;9083.091690830865;10259.333143345659;10611.946940265248;10962.506687199095;17448.302067917142;17657.735133973;17821.198046087957;18022.098895055195;18040.819591804175;6965.5124141309625;7024.733498922923;7031.714692724782;7055.7177712891935;7134.750283740044;843.599290337085;946.342292106979;953.3279038277998;965.7247684409909;1004.382304882492;29654;30695.693043069285;30733.38533229323;31117.066318652505;31458;1000.5947591225565;1009.8586197932295;1016.4358780876537;1099.0328510910347;1109.2678831970861;15207.543773686586;15927.522174334788;16054.025476563507;16137.919310403608;16276.430324938807;546718;552261;554671;557180;557892;54188.72905635525;54848;54894.17658735122;54905;54986.60107191415;1165.9008984236434;1212.3756265523264;1250.6310638361888;1306.3207132291345;1306.6276111308232;29333.85333073321;30919.227019323796;31053;31223.843880781358;31670.683293166774;46605.3009204869;46838.29742553933;46921.53078469308;47066.52933470622;47124.29313560368;395381;395952;396843;397699;400398;27391;27977;28693.556773187353;28931.276718082216;28967.710322896502;44619.776901115285;44884.551154488036;45190.54809451995;45333;46407.303890442345;38194.809025954695;38245.003480162624;38792.80603596964;39715.80142099271;39761.40357894692;36963.81518092392;37936.24127517379;38188;38467.2306553873;41648.58351416447;37760.433593496666;38182.23635527329;38301.61698382981;38344.23311533698;39407.60592394039;32613;35378.46932296069;35549.82225088858;35614.28771424505;36017.819910900274;26757.197284081507;26783.732162678123;26892;26927.730722693304;27334.726652734014 19:45:28 INFO - PROCESS | 21804 | |2;jquery.html;369.64698712729347;376.9151940813317;388.8638976358274;393.484535258811;407.1246819338422;14177.503787367445;17935.192916318763;18907.62184756306;19051.999999999964;20161.798382016175;17692;17791.466256012307;18753;19079.809201907978;19084.33204837831;5521.475459831319;5749.080147176453;5787.47912687858;5809.215755872967;5811.535077193815;4031.23406552754;4315.115401342718;4343.500497442803;5403.054465468547;5475.206095116206;6416.486681065504;6416.711247993828;6427.871442571146;6430.742770289183;6440.967795161017;6226.59527130735;6370.777022804226;6430.903536446957;6431.774887878902;6434.935650643481;5658.264425624684;5700.714964251771;5704;5706.9156860196845;5710;22468.77531224683;22883.42791430211;23038.308850734506;23119.537609247887;23302.3009309721;2192.725909261342;2262.9207977720866;2338.3218866528687;2357.398863289867;2997.1607949774098;10469.31949423285;11023.559057637685;11315.773684526346;13490;13926.303684815719;1895.9175894620737;1915.7701075870846;1943.4752616793387;2009.24191332584;2023.836294130866;70497.2950270496;72997.63501182513;79396.60301698455;82284.17715822885;82358.17641823566;10829.404382758867;10834.837477437844;10856.294340867818;11109.834042106708;11128.387938663289;15353.385864565293;15573.844261557238;15747.842521574867;15750.291236894367;15778.842211577738;7722.53664780115;7803.843923121506;7903.407244456574;7929.444938854225;8020.478668886503;6923.446124310043;7029.718811247493;7151.678174482056;7169.673610382096;7189.209186989427;4705.153072446992;4729.739864307496;4770.546798054179;4781.402324709411;4831.9275210871865;1948.39599724086;1960.1963195089945;1984.9702254466195;1986.9006549672458;2020.454477291123;832.6169961817511;902.6118768929423;964.1611797736015;973.1484950668165;991.2862738828032;18062.458126256235;18697.719534206997;18930.05349732508;19210.135543900557;19581.412557623295;904.2765787370209;934.8083642853335;950.458238803889;955.7515046088067;1018.2159737002614;10237.18102551794;10760.892391076146;10772.08437282824;10824.72938176536;10887.782244355069;405718;412665;425392;426781;429547;90411.54794225987;91340;95787.52106239424;98116;99266.99999999856;941.2093841173447;984.3995162950595;1031.9122874555746;1050.6847945616437;1051.5530899367739;16248.268827902537;16316.42892498757;16956.541301511457;17143.142842857556;17163.570910727332;40304.59695403009;41344.79327603343;41573.79213104036;41669.58330416657;43079.7846010768;54796.72601636966;56857.71571142118;57034.42965570291;57524;58970;7697.191794861459;7825.295723384923;8243.670253189804;8250.669973201246;8318.70884519039;11118.221724479208;11779.116566257393;12045.217060891015;12046.099149123072;12577.93711031439;10121.392716437038;10421.895781042396;10476.528556214836;10747.623833165802;10774.084202842847;10424.374537527772;10708.625198118028;10742.40916749555;10761.623343182951;11270.605528806453;10375.118114960313;10402.635907743193;10464.476776161313;10506.737331566772;10789.676309710721;7421.443391745533;7615.238476152341;7745.883811742941;8204.343652507905;8363.03825060126;8458.196471335214;10633.840492392466;10736;10882.564697412015;11167.776644467227 19:45:28 INFO - PROCESS | 21804 | |3;mootools.html;1285.0940087238498;1424.8860091192703;1432.376916041522;1538.7999560057192;1733.713937200362;7518.2105878882685;8560.186782255683;8864.955675221614;8875.733727988163;9127.406718563305;8930.285577153829;8963.686270980517;8988.235999940012;9023.413478123917;9028.097190280969;2346.5306938612302;2380.321608341623;2390.8924098415614;2392.461696118377;2402.231285988484;2271.318604418676;2299.4481324482085;2389.0443822471066;2389.7251816041203;2392.7487613800563;2365.195833416638;2369.5971684813535;2376.6197408414655;2409.108629806965;2418.51629674065;2278.9886050569808;2287.7597852225526;2293;2304.274153641606;2329.906803727849;2236.630955892292;2270.080617349976;2278.4303924018996;2280.04238219948;2286.691296674944;8633.913660863374;8759.423303805312;8863;8938.86591701125;8953;5258.2638430619745;5427.701476418795;5430.348358197002;5521.365043020064;5543.085390910495;3375.814330211862;3421.230223199785;3457.94813077804;3458.4293591557616;3480.860765569374;1050.9264351495399;1089.1178145702006;2085.8122768950716;2139.6520192278763;2200.5378870437225;12576.245425274512;12656.493740250378;12668.239905605693;12687.873121268762;12704.618861434079;4494.325851122358;4527.117212143667;4695.154872123051;4728.763561821896;4738.857834264978;9890.456024918698;9895.505224738734;9898.356606820533;9901.108900198873;9901.60393584263;5389.784408623689;5401.054815407288;5403.864903377447;5406.675599464044;5407.540359069523;4117.279476091732;4253.2769429197115;4288.892777680583;4378.058717375779;5027.120253955543;3608.8736894208578;3721.292954338667;3730.962690373116;3810.180811125566;3842.6733727632904;1116.7822274656364;1129.4296380328046;1130.0620484997432;1139.065965907964;1160.3154139057997;898.4923518212189;948.4878165790534;966.5795379010153;981.1611072532882;1015.1827778638267;5884.911726324109;5891.204687367236;5980.760769569256;6062.302835173923;6208.00671892504;419.5971867007707;425.09666957714853;433.41272575659525;434.27909669947735;451.07079416402314;3764.698824094066;3928.332183528807;4158.147579746144;4179.26862799009;4182.769947652848;10991.120710343153;11268.21122521432;11432.657020289405;11439.256448330832;11466;11315.03822175108;11317.377544235145;11319.886801131883;11375.886241137649;11388.259763115371;8266.173382661806;8326.542040187847;8428;8429.704960326359;8448.197421245095;5807.8548036299435;5826.271716035496;5844.386339434468;5924.555658325557;5964.821055368172;9733.075357840993;10355.741106472096;10379.948100259451;10457.215708821717;10538.420386878795;8874.201321881063;10238.436885971343;10608.257421980696;10615;10616.946915265684;6836.282190370139;7499.362554182955;7635.847283054197;7728.574928378768;7956.880646790419;8629.39594228423;8662.956685216534;8686.91313086861;8705.390622656354;8728.56357182151;7506.624668766649;7697.268759467842;7710.845783084194;7762.223777622193;7791.727289544839;7606.733764318223;7609.429292803173;7622.085349758065;7626.96186519086;7739.032620922385;6981.790546283416;7016.964915175391;7266.273372662691;7307.634618268959;7327.120745510573;5258.553022993088;5335.973320133375;5358.142697168434;5375.086235339923;5388.191771234189;5200.531952124327;5205.687658740488;5284.867878303073;5328.641196494869;5425.945740542702 19:45:28 INFO - PROCESS | 21804 | |4;prototype.html;333.2407664537629;334.05129432411945;344.11733902539976;344.614032283842;346.6014083803627;5102.974485127578;5242.501962313579;5282.947170528303;5316.415194328625;5319.351001189634;5070.442251352349;5175.8188463403785;5218.582513398928;5233.607479439048;5249.448807875176;4185.916281674365;4209.705320627558;4211.452511173543;4224.408582798403;4225.112726327475;3931.862384816532;4001.7398869073563;4177.373393990895;4205.306124489455;4215.156968606276;4137.689673274502;4148.751074935499;4150.817017150112;4164.083901541671;4167.416561681367;4134.400511925754;4136.110736191718;4144.937825932613;4154.234450358601;4165.66674666026;3485.721142308609;3754.6433088856515;3756.7370284080125;3759.6992240620957;3763.419363867155;5110.805746408495;5124.948750512522;5129.3075434816565;5140.460251673558;5157;4736.59738922192;4740.810367585293;4742.383490146293;4742.620590352763;4752.1921273383605;5323.1749078892835;5478.643888147298;5484.341878974508;5486.835394938158;5500.147477141049;3982.920341593181;4005.2590270799706;4008.939865902014;4011.237864805707;4033.7781422021776;5665.320161580596;5700.543956483513;5709.257796486471;5713.942860571383;5716.114002329646;3980.721349505565;4080.367543030835;4116.374032257241;4119.958800412018;4123.587641235912;4070.247004304213;4076.429299898017;4113.465249517543;4124.505059392892;4125.793710314472;4620.584147426681;4621.2837010263465;4622.838200662961;4642.560806150104;4672;5363.419439796483;5413.593980451482;5422.240886275925;5462.289902312754;5474.671519708831;1377.2769296119618;1426.4579459805207;1435.8994870358974;1437.6629734347157;1441.358595425026;903.5617725403174;928.9581968811419;934.4299977014016;943.6649989253854;946.5976959792199;4753.786079626425;4754.334393184957;4770.61835053195;4772.236442169236;4806.4712881583;4943.456219815817;4979.477154898684;5002.699838009731;5006.6495345325475;5025.9644843838305;4400.405945197357;4712.387389639393;4717.528247175255;4744.390585178207;4789.353437285922;2644.598362867683;2665.466906618645;2665.520636046974;2675.622054641861;2677.638518799976;5150.450526989164;5180.352455943007;5181.512873820588;5191.988646584971;5217.217417387346;4755.025219829927;5017.774200161001;5079.6698214615935;5082.983403319351;5100.138449465918;5119.283300337956;5123.769430375568;5136.2552429898205;5139.743012849342;5171.534561889448;4941.431735350337;5044.293798868088;5058.822941197041;5059.367579052619;5085.7711402986215;4822.903541929071;4942.28336891156;4969.751512424292;5282.418933917189;5659.057290209151;5839.532837373085;5908.704564771659;5911.172435858897;5919.674417906885;5920.8815823684145;3937.9803100984313;4115.42384066237;4116.094459218967;4216.704830661824;4256.87229383119;5648.57635677334;5659.688717120598;5661.433856614471;5663.292088488939;5668.688222147822;5471.370792358771;5506.807261745819;5515.70380960482;5545.085060965057;5569.164625306074;5370.382406023357;5464.508194262536;5504.201890725903;5505.532029777353;5512.283403157564;5421.322334708161;5421.457854214547;5442.673439593637;5448.237246785532;5450.591205659671;5317.415084340642;5496.120620700829;5532.419095994863;5540.501354877919;5542.889142217053;5387.838364849061;5391.568674505952;5417.972910135424;5431.864203394946;5436.8640783979135 19:45:28 INFO - PROCESS | 21804 | |5;yui.html;687.336720065137;700.7582384077494;718.3104219948849;731.7658349328213;764.2128607534235;14991.175485348302;16401.261943212554;16450.917745411272;16488.917555412238;16506.009639421627;13069.803952940714;13205.141665791716;13224.93387533061;13234.470621175165;13245.933770331136;628.1457218183267;646.2180761278859;730.7077169132363;748.5321673953779;751.1024325930515;760.4562737642584;761.3034073822446;761.603965937712;764.8432071425373;769.3422124083911;814.767791179514;815.2906970935265;816.4448175240834;816.742726041298;817.0358976407837;808.4340961327035;812.6424373275798;813.2924355810424;813.4590497319275;813.5200231863199;485.04204196711567;493.8740621141622;569.5756661287368;585.2538014032101;591.0720169334147;14414.207218602973;14425;14436.061655992327;14436.206008669518;14436.278186090758;12301.446434910451;12522.874771252262;12673.239605623692;12852.742945141139;13216.207027578375;12464.626061218178;12496.937515312366;12526.436310366056;12690.619281421572;12981.41583628739;4201.386807345681;4356.128774245132;4458.665600080007;4478.350639157304;4489.1021795641;76004.61997690031;76139;76514.23485765127;76811;76876;10681.732956676145;11023.83464248037;11101.167412443938;11411.942940285246;11460;17460.825391746173;17493.825061749474;17557.297708091788;17559.473215803548;17585.472435826945;7911.920880791234;8145;8177.95911020453;8301.667933282723;8324.62539185738;4308.870733877989;4410.867673969786;4417.425734654475;4430.756308403069;4439.134368798053;3497.3529896969144;3585.229175727231;3593.047842321787;3602.7297952653657;3791.696664266852;701.8596280743872;703.549728173969;708.373089815517;711.0436462957417;713.9036230108973;642.7814543055383;658.8207109274441;661.4708233413346;670.1020632352573;685.8216863615496;9649.421034737938;9703.951480242553;9733.415995040321;9813.214942804558;9964.451955142391;614.2904944788776;663.3532306001609;672.9865402692017;691.8892977123636;721.4336745654741;4258.254805409041;4509.481409637933;4546;4606.30905364198;4647.661212320661;122223.38888305501;123527;123593.38203308926;125563.37218314032;126825.36587317004;91522.54238728764;92537;93336;106976.46511767547;107460.46269768757;74086.62956685181;75635.62182189163;80708;82072;82468.58765706133;9477.715668529956;9894.109530142321;9944.254180936314;10025.5488503019;10250.53872575721;48131.75934120307;48665.51334486751;48772.75613621909;48792;48882;49482.505174947786;54367;62442.375576243656;65317;66730.33269667241;12935.288559128961;12940.417681204557;12999.350032498149;13133.408996595368;13626;13804.792928106288;13952.232627205196;14005.159690418608;14567.781483277971;14879.62800929942;12664.493420263087;12798.360081996048;12878.806817897552;13119.147255428366;13356.866431335951;12175.573854915036;12347.87563161278;12579.74840503203;12736.598974112654;12808.487660493476;12656.810147847606;12857.292848893401;13360.663933606562;13412.93293533526;13496.797548036591;8881.605164581093;9505.192058674813;9644.517774111408;9716.854247186156;9751.3661611995;9075.863862041942;9325.533723313943;9647.855282170913;10148.898511015092;10428.634997775041 19:45:28 INFO - PROCESS | 21804 | __end_tp_report 19:45:28 INFO - PROCESS | 21804 | __start_cc_report 19:45:28 INFO - PROCESS | 21804 | _x_x_mozilla_cycle_collect,1404 19:45:28 INFO - PROCESS | 21804 | __end_cc_report 19:45:28 INFO - PROCESS | 21804 | __startTimestamp1475376328545__endTimestamp 19:45:28 INFO - PROCESS | 21804 | 19:45:28 INFO - PROCESS | 21804 | ------- Summary: start ------- 19:45:28 INFO - PROCESS | 21804 | Number of tests: 6 19:45:28 INFO - PROCESS | 21804 | 19:45:28 INFO - PROCESS | 21804 | [#0] dojo.html Cycles:165 Average:5149.57 Median:5314.71 stddev:567.23 (10.7%) stddev-sans-first:542.41 19:45:28 INFO - PROCESS | 21804 | Values: 2962.7 3004.9 3008.6 3031.1 3057.3 4950.5 5037.1 5109.3 5164.9 5175.1 5075.6 5111.4 5207.7 5223.0 5293.9 4735.1 4818.0 4847.4 4862.1 4874.5 4754.8 4765.5 4798.7 4830.0 4861.4 4859.8 4877.2 4879.6 4919.2 4936.6 4574.5 4627.9 4628.1 4818.8 4863.8 4656.5 4702.3 4720.3 4727.2 4756.8 5218.5 5235.2 5235.5 5240.2 5246.7 5225.1 5522.5 5540.4 5546.1 5548.4 5310.5 5368.7 5373.0 5384.6 5387.2 5041.8 5044.7 5046.6 5054.3 5134.3 5647.4 5668.1 5693.7 5735.9 5746.9 5400.7 5416.8 5460.9 5469.9 5474.5 5241.6 5256.4 5543.7 5543.9 5613.8 5372.8 5427.1 5428.4 5441.3 5502.8 5415.4 5421.8 5428.0 5445.5 5493.5 4244.3 4286.4 4289.7 4295.2 4337.0 3710.0 3737.0 3828.6 3840.0 3881.4 5293.6 5295.7 5299.8 5301.4 5335.6 5593.9 5634.9 5639.2 5641.2 5703.3 5031.3 5087.4 5214.3 5317.6 5330.9 4876.1 4902.9 4908.4 4950.4 4962.6 5758.8 5785.3 5787.9 5796.7 5799.9 5195.5 5307.3 5616.5 5637.3 5685.7 5668.9 5727.3 5757.0 5771.6 5848.4 5496.9 5504.3 5505.4 5506.1 5506.5 5314.7 5604.6 5611.4 5616.0 5619.8 5238.9 5325.5 5353.4 5370.9 5454.0 5331.9 5376.2 5377.4 5380.7 5383.4 5263.7 5327.8 5332.3 5333.6 5393.6 5235.6 5309.3 5446.3 5490.9 5499.6 5414.4 5420.0 5421.2 5421.6 5472.0 19:45:28 INFO - PROCESS | 21804 | 19:45:28 INFO - PROCESS | 21804 | [#1] ext.html Cycles:180 Average:58209.04 Median:37362.12 stddev:116096.06 (310.7%) stddev-sans-first:116341.01 19:45:28 INFO - PROCESS | 21804 | Values: 545.0 564.9 598.3 603.2 613.5 30044.2 41176.4 41791.0 41831.4 41988.6 42920.8 43334.6 43400.1 43478.8 43557.0 8038.9 8217.7 8862.1 9022.7 9022.7 10673.7 10905.8 10954.2 10960.6 10965.0 10786.7 10876.7 10881.1 10884.0 10889.6 10631.6 10698.9 10705.9 10716.2 10758.4 10505.4 10550.6 10571.5 10571.7 10579.6 41136.4 41166.8 41333.0 41494.8 41538.0 3220.7 3282.9 3411.2 3423.2 3454.4 28636.4 30603.5 31167.8 31279.0 32281.4 4165.3 4275.3 4366.6 4396.9 4407.8 327565.0 329552.0 331448.3 332083.0 332110.0 55594.0 56022.7 56198.7 56345.7 56510.4 60054.7 60185.4 60230.1 60269.1 60395.0 13752.2 13931.0 13940.2 14214.6 14226.9 8958.3 9083.1 10259.3 10611.9 10962.5 17448.3 17657.7 17821.2 18022.1 18040.8 6965.5 7024.7 7031.7 7055.7 7134.8 843.6 946.3 953.3 965.7 1004.4 29654.0 30695.7 30733.4 31117.1 31458.0 1000.6 1009.9 1016.4 1099.0 1109.3 15207.5 15927.5 16054.0 16137.9 16276.4 546718.0 552261.0 554671.0 557180.0 557892.0 54188.7 54848.0 54894.2 54905.0 54986.6 1165.9 1212.4 1250.6 1306.3 1306.6 29333.9 30919.2 31053.0 31223.8 31670.7 46605.3 46838.3 46921.5 47066.5 47124.3 395381.0 395952.0 396843.0 397699.0 400398.0 27391.0 27977.0 28693.6 28931.3 28967.7 44619.8 44884.6 45190.5 45333.0 46407.3 38194.8 38245.0 38792.8 39715.8 39761.4 36963.8 37936.2 38188.0 38467.2 41648.6 37760.4 38182.2 38301.6 38344.2 39407.6 32613.0 35378.5 35549.8 35614.3 36017.8 26757.2 26783.7 26892.0 26927.7 27334.7 19:45:28 INFO - PROCESS | 21804 | 19:45:28 INFO - PROCESS | 21804 | [#2] jquery.html Cycles:180 Average:26777.43 Median:391.17 stddev:69764.45 (17834.6%) stddev-sans-first:69931.98 19:45:28 INFO - PROCESS | 21804 | Values: 369.6 376.9 388.9 393.5 407.1 14177.5 17935.2 18907.6 19052.0 20161.8 17692.0 17791.5 18753.0 19079.8 19084.3 5521.5 5749.1 5787.5 5809.2 5811.5 4031.2 4315.1 4343.5 5403.1 5475.2 6416.5 6416.7 6427.9 6430.7 6441.0 6226.6 6370.8 6430.9 6431.8 6434.9 5658.3 5700.7 5704.0 5706.9 5710.0 22468.8 22883.4 23038.3 23119.5 23302.3 2192.7 2262.9 2338.3 2357.4 2997.2 10469.3 11023.6 11315.8 13490.0 13926.3 1895.9 1915.8 1943.5 2009.2 2023.8 70497.3 72997.6 79396.6 82284.2 82358.2 10829.4 10834.8 10856.3 11109.8 11128.4 15353.4 15573.8 15747.8 15750.3 15778.8 7722.5 7803.8 7903.4 7929.4 8020.5 6923.4 7029.7 7151.7 7169.7 7189.2 4705.2 4729.7 4770.5 4781.4 4831.9 1948.4 1960.2 1985.0 1986.9 2020.5 832.6 902.6 964.2 973.1 991.3 18062.5 18697.7 18930.1 19210.1 19581.4 904.3 934.8 950.5 955.8 1018.2 10237.2 10760.9 10772.1 10824.7 10887.8 405718.0 412665.0 425392.0 426781.0 429547.0 90411.5 91340.0 95787.5 98116.0 99267.0 941.2 984.4 1031.9 1050.7 1051.6 16248.3 16316.4 16956.5 17143.1 17163.6 40304.6 41344.8 41573.8 41669.6 43079.8 54796.7 56857.7 57034.4 57524.0 58970.0 7697.2 7825.3 8243.7 8250.7 8318.7 11118.2 11779.1 12045.2 12046.1 12577.9 10121.4 10421.9 10476.5 10747.6 10774.1 10424.4 10708.6 10742.4 10761.6 11270.6 10375.1 10402.6 10464.5 10506.7 10789.7 7421.4 7615.2 7745.9 8204.3 8363.0 8458.2 10633.8 10736.0 10882.6 11167.8 19:45:28 INFO - PROCESS | 21804 | 19:45:28 INFO - PROCESS | 21804 | [#3] mootools.html Cycles:180 Average:5840.38 Median:4711.96 stddev:3368.49 (71.5%) stddev-sans-first:3360.54 19:45:28 INFO - PROCESS | 21804 | Values: 1285.1 1424.9 1432.4 1538.8 1733.7 7518.2 8560.2 8865.0 8875.7 9127.4 8930.3 8963.7 8988.2 9023.4 9028.1 2346.5 2380.3 2390.9 2392.5 2402.2 2271.3 2299.4 2389.0 2389.7 2392.7 2365.2 2369.6 2376.6 2409.1 2418.5 2279.0 2287.8 2293.0 2304.3 2329.9 2236.6 2270.1 2278.4 2280.0 2286.7 8633.9 8759.4 8863.0 8938.9 8953.0 5258.3 5427.7 5430.3 5521.4 5543.1 3375.8 3421.2 3457.9 3458.4 3480.9 1050.9 1089.1 2085.8 2139.7 2200.5 12576.2 12656.5 12668.2 12687.9 12704.6 4494.3 4527.1 4695.2 4728.8 4738.9 9890.5 9895.5 9898.4 9901.1 9901.6 5389.8 5401.1 5403.9 5406.7 5407.5 4117.3 4253.3 4288.9 4378.1 5027.1 3608.9 3721.3 3731.0 3810.2 3842.7 1116.8 1129.4 1130.1 1139.1 1160.3 898.5 948.5 966.6 981.2 1015.2 5884.9 5891.2 5980.8 6062.3 6208.0 419.6 425.1 433.4 434.3 451.1 3764.7 3928.3 4158.1 4179.3 4182.8 10991.1 11268.2 11432.7 11439.3 11466.0 11315.0 11317.4 11319.9 11375.9 11388.3 8266.2 8326.5 8428.0 8429.7 8448.2 5807.9 5826.3 5844.4 5924.6 5964.8 9733.1 10355.7 10379.9 10457.2 10538.4 8874.2 10238.4 10608.3 10615.0 10616.9 6836.3 7499.4 7635.8 7728.6 7956.9 8629.4 8663.0 8686.9 8705.4 8728.6 7506.6 7697.3 7710.8 7762.2 7791.7 7606.7 7609.4 7622.1 7627.0 7739.0 6981.8 7017.0 7266.3 7307.6 7327.1 5258.6 5336.0 5358.1 5375.1 5388.2 5200.5 5205.7 5284.9 5328.6 5425.9 19:45:28 INFO - PROCESS | 21804 | 19:45:28 INFO - PROCESS | 21804 | [#4] prototype.html Cycles:180 Average:4510.33 Median:5035.13 stddev:1292.15 (25.7%) stddev-sans-first:1257.17 19:45:28 INFO - PROCESS | 21804 | Values: 333.2 334.1 344.1 344.6 346.6 5103.0 5242.5 5282.9 5316.4 5319.4 5070.4 5175.8 5218.6 5233.6 5249.4 4185.9 4209.7 4211.5 4224.4 4225.1 3931.9 4001.7 4177.4 4205.3 4215.2 4137.7 4148.8 4150.8 4164.1 4167.4 4134.4 4136.1 4144.9 4154.2 4165.7 3485.7 3754.6 3756.7 3759.7 3763.4 5110.8 5124.9 5129.3 5140.5 5157.0 4736.6 4740.8 4742.4 4742.6 4752.2 5323.2 5478.6 5484.3 5486.8 5500.1 3982.9 4005.3 4008.9 4011.2 4033.8 5665.3 5700.5 5709.3 5713.9 5716.1 3980.7 4080.4 4116.4 4120.0 4123.6 4070.2 4076.4 4113.5 4124.5 4125.8 4620.6 4621.3 4622.8 4642.6 4672.0 5363.4 5413.6 5422.2 5462.3 5474.7 1377.3 1426.5 1435.9 1437.7 1441.4 903.6 929.0 934.4 943.7 946.6 4753.8 4754.3 4770.6 4772.2 4806.5 4943.5 4979.5 5002.7 5006.6 5026.0 4400.4 4712.4 4717.5 4744.4 4789.4 2644.6 2665.5 2665.5 2675.6 2677.6 5150.5 5180.4 5181.5 5192.0 5217.2 4755.0 5017.8 5079.7 5083.0 5100.1 5119.3 5123.8 5136.3 5139.7 5171.5 4941.4 5044.3 5058.8 5059.4 5085.8 4822.9 4942.3 4969.8 5282.4 5659.1 5839.5 5908.7 5911.2 5919.7 5920.9 3938.0 4115.4 4116.1 4216.7 4256.9 5648.6 5659.7 5661.4 5663.3 5668.7 5471.4 5506.8 5515.7 5545.1 5569.2 5370.4 5464.5 5504.2 5505.5 5512.3 5421.3 5421.5 5442.7 5448.2 5450.6 5317.4 5496.1 5532.4 5540.5 5542.9 5387.8 5391.6 5418.0 5431.9 5436.9 19:45:28 INFO - PROCESS | 21804 | 19:45:28 INFO - PROCESS | 21804 | [#5] yui.html Cycles:180 Average:20020.40 Median:26389.71 stddev:29723.23 (112.6%) stddev-sans-first:29771.16 19:45:28 INFO - PROCESS | 21804 | Values: 687.3 700.8 718.3 731.8 764.2 14991.2 16401.3 16450.9 16488.9 16506.0 13069.8 13205.1 13224.9 13234.5 13245.9 628.1 646.2 730.7 748.5 751.1 760.5 761.3 761.6 764.8 769.3 814.8 815.3 816.4 816.7 817.0 808.4 812.6 813.3 813.5 813.5 485.0 493.9 569.6 585.3 591.1 14414.2 14425.0 14436.1 14436.2 14436.3 12301.4 12522.9 12673.2 12852.7 13216.2 12464.6 12496.9 12526.4 12690.6 12981.4 4201.4 4356.1 4458.7 4478.4 4489.1 76004.6 76139.0 76514.2 76811.0 76876.0 10681.7 11023.8 11101.2 11411.9 11460.0 17460.8 17493.8 17557.3 17559.5 17585.5 7911.9 8145.0 8178.0 8301.7 8324.6 4308.9 4410.9 4417.4 4430.8 4439.1 3497.4 3585.2 3593.0 3602.7 3791.7 701.9 703.5 708.4 711.0 713.9 642.8 658.8 661.5 670.1 685.8 9649.4 9704.0 9733.4 9813.2 9964.5 614.3 663.4 673.0 691.9 721.4 4258.3 4509.5 4546.0 4606.3 4647.7 122223.4 123527.0 123593.4 125563.4 126825.4 91522.5 92537.0 93336.0 106976.5 107460.5 74086.6 75635.6 80708.0 82072.0 82468.6 9477.7 9894.1 9944.3 10025.5 10250.5 48131.8 48665.5 48772.8 48792.0 48882.0 49482.5 54367.0 62442.4 65317.0 66730.3 12935.3 12940.4 12999.4 13133.4 13626.0 13804.8 13952.2 14005.2 14567.8 14879.6 12664.5 12798.4 12878.8 13119.1 13356.9 12175.6 12347.9 12579.7 12736.6 12808.5 12656.8 12857.3 13360.7 13412.9 13496.8 8881.6 9505.2 9644.5 9716.9 9751.4 9075.9 9325.5 9647.9 10148.9 10428.6 19:45:28 INFO - PROCESS | 21804 | -------- Summary: end -------- 19:45:28 INFO - PROCESS | 21804 | 19:45:29 INFO - TEST-INFO | 21804: exit 0 19:45:29 INFO - TEST-OK | dromaeo_css | took 1116798ms 19:45:29 INFO - TEST-START | kraken 19:45:29 INFO - operating with platform_type : linux_ 19:45:29 INFO - Initialising browser for kraken test... 19:45:29 INFO - TEST-INFO | started process 22111 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpexT7OH/profile http://localhost:33636/getInfo.html) 19:45:34 INFO - PROCESS | 22111 | __metrics Screen width/height:1600/1200 19:45:34 INFO - PROCESS | 22111 | colorDepth:24 19:45:34 INFO - PROCESS | 22111 | Browser inner width/height: 1024/697 19:45:34 INFO - PROCESS | 22111 | __metrics 19:45:34 INFO - PROCESS | 22111 | 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" 19:45:34 INFO - PROCESS | 22111 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:45:35 INFO - PROCESS | 22111 | console.error: PushService: 19:45:35 INFO - PROCESS | 22111 | stateChangeProcessEnqueue: Error transitioning state 19:45:35 INFO - PROCESS | 22111 | UnknownError 19:45:35 INFO - TEST-INFO | 22111: exit 0 19:45:35 INFO - Browser initialized. 19:45:35 INFO - Running cycle 1/1 for kraken test... 19:45:35 INFO - TEST-INFO | started process 22193 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpexT7OH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:45:47 INFO - PROCESS | 22193 | RSS: Main: 174006272 19:45:47 INFO - PROCESS | 22193 | 19:45:50 INFO - PROCESS | 22193 | Cycle 1(1): loaded http://localhost:33636/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33636/tests/kraken/driver.html?testName=audio-beat-detection) 19:45:51 INFO - PROCESS | 22193 | RSS: Main: 232955904 19:45:51 INFO - PROCESS | 22193 | 19:45:53 INFO - PROCESS | 22193 | Cycle 1(1): loaded http://localhost:33636/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33636/tests/kraken/driver.html?testName=audio-dft) 19:45:54 INFO - PROCESS | 22193 | RSS: Main: 217628672 19:45:54 INFO - PROCESS | 22193 | 19:45:57 INFO - PROCESS | 22193 | Cycle 1(1): loaded http://localhost:33636/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33636/tests/kraken/driver.html?testName=audio-fft) 19:45:58 INFO - PROCESS | 22193 | RSS: Main: 299425792 19:45:58 INFO - PROCESS | 22193 | 19:46:00 INFO - PROCESS | 22193 | Cycle 1(1): loaded http://localhost:33636/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33636/tests/kraken/driver.html?testName=audio-oscillator) 19:46:00 INFO - PROCESS | 22193 | RSS: Main: 209395712 19:46:00 INFO - PROCESS | 22193 | 19:46:03 INFO - PROCESS | 22193 | Cycle 1(1): loaded http://localhost:33636/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33636/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:46:03 INFO - PROCESS | 22193 | RSS: Main: 213028864 19:46:03 INFO - PROCESS | 22193 | 19:46:06 INFO - PROCESS | 22193 | Cycle 1(1): loaded http://localhost:33636/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33636/tests/kraken/driver.html?testName=imaging-darkroom) 19:46:07 INFO - PROCESS | 22193 | RSS: Main: 249495552 19:46:07 INFO - PROCESS | 22193 | 19:46:10 INFO - PROCESS | 22193 | Cycle 1(1): loaded http://localhost:33636/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33636/tests/kraken/driver.html?testName=imaging-desaturate) 19:46:11 INFO - PROCESS | 22193 | RSS: Main: 248578048 19:46:11 INFO - PROCESS | 22193 | 19:46:14 INFO - PROCESS | 22193 | Cycle 1(1): loaded http://localhost:33636/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33636/tests/kraken/driver.html?testName=json-parse-financial) 19:46:14 INFO - PROCESS | 22193 | RSS: Main: 248905728 19:46:14 INFO - PROCESS | 22193 | 19:46:16 INFO - PROCESS | 22193 | Cycle 1(1): loaded http://localhost:33636/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33636/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:46:16 INFO - PROCESS | 22193 | RSS: Main: 210710528 19:46:16 INFO - PROCESS | 22193 | 19:46:18 INFO - PROCESS | 22193 | Cycle 1(1): loaded http://localhost:33636/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33636/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:46:19 INFO - PROCESS | 22193 | RSS: Main: 217133056 19:46:19 INFO - PROCESS | 22193 | 19:46:21 INFO - PROCESS | 22193 | Cycle 1(1): loaded http://localhost:33636/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33636/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:46:22 INFO - PROCESS | 22193 | RSS: Main: 222519296 19:46:22 INFO - PROCESS | 22193 | 19:46:24 INFO - PROCESS | 22193 | Cycle 1(1): loaded http://localhost:33636/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33636/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:46:25 INFO - PROCESS | 22193 | RSS: Main: 217350144 19:46:25 INFO - PROCESS | 22193 | 19:46:28 INFO - PROCESS | 22193 | Cycle 1(1): loaded http://localhost:33636/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33636/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:46:28 INFO - PROCESS | 22193 | RSS: Main: 221462528 19:46:28 INFO - PROCESS | 22193 | 19:46:30 INFO - PROCESS | 22193 | Cycle 1(1): loaded http://localhost:33636/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33636/tests/kraken/driver.html?testName=ai-astar) 19:46:30 INFO - PROCESS | 22193 | RSS: Main: 272896000 19:46:30 INFO - PROCESS | 22193 | 19:46:30 INFO - PROCESS | 22193 | __start_tp_report 19:46:30 INFO - PROCESS | 22193 | _x_x_mozilla_page_load 19:46:30 INFO - PROCESS | 22193 | _x_x_mozilla_page_load_details 19:46:30 INFO - PROCESS | 22193 | |i|pagename|runs| 19:46:30 INFO - PROCESS | 22193 | |0;ai-astar;108;111;111;110;112;111;112;111;112;110 19:46:30 INFO - PROCESS | 22193 | |1;audio-beat-detection;153;126;125;179;130;123;123;123;166;127 19:46:30 INFO - PROCESS | 22193 | |2;audio-dft;160;160;160;160;160;162;162;162;162;163 19:46:30 INFO - PROCESS | 22193 | |3;audio-fft;75;75;76;109;77;76;76;76;113;76 19:46:30 INFO - PROCESS | 22193 | |4;audio-oscillator;83;84;110;84;83;83;101;84;83;114 19:46:30 INFO - PROCESS | 22193 | |5;imaging-gaussian-blur;118;117;117;116;117;117;117;116;116;117 19:46:30 INFO - PROCESS | 22193 | |6;imaging-darkroom;146;146;146;146;146;146;146;146;146;146 19:46:30 INFO - PROCESS | 22193 | |7;imaging-desaturate;96;96;96;96;95;96;96;96;96;95 19:46:30 INFO - PROCESS | 22193 | |8;json-parse-financial;53;52;63;51;51;53;52;52;52;51 19:46:30 INFO - PROCESS | 22193 | |9;json-stringify-tinderbox;61;61;62;61;61;61;62;62;62;62 19:46:30 INFO - PROCESS | 22193 | |10;stanford-crypto-aes;80;82;85;89;79;78;78;78;79;86 19:46:30 INFO - PROCESS | 22193 | |11;stanford-crypto-ccm;139;131;126;129;129;128;130;127;164;131 19:46:30 INFO - PROCESS | 22193 | |12;stanford-crypto-pbkdf2;167;168;164;166;165;163;166;167;167;163 19:46:30 INFO - PROCESS | 22193 | |13;stanford-crypto-sha256-iterative;67;66;65;66;64;65;65;65;65;64 19:46:30 INFO - PROCESS | 22193 | __end_tp_report 19:46:30 INFO - PROCESS | 22193 | __start_cc_report 19:46:30 INFO - PROCESS | 22193 | _x_x_mozilla_cycle_collect,1633 19:46:30 INFO - PROCESS | 22193 | __end_cc_report 19:46:30 INFO - PROCESS | 22193 | __startTimestamp1475376390666__endTimestamp 19:46:30 INFO - PROCESS | 22193 | 19:46:30 INFO - PROCESS | 22193 | ------- Summary: start ------- 19:46:30 INFO - PROCESS | 22193 | Number of tests: 14 19:46:30 INFO - PROCESS | 22193 | 19:46:30 INFO - PROCESS | 22193 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:1.23 (1.1%) stddev-sans-first:0.78 19:46:30 INFO - PROCESS | 22193 | Values: 108.0 111.0 111.0 110.0 112.0 111.0 112.0 111.0 112.0 110.0 19:46:30 INFO - PROCESS | 22193 | 19:46:30 INFO - PROCESS | 22193 | [#1] audio-beat-detection Cycles:10 Average:137.50 Median:128.50 stddev:20.71 (16.1%) stddev-sans-first:21.19 19:46:30 INFO - PROCESS | 22193 | Values: 153.0 126.0 125.0 179.0 130.0 123.0 123.0 123.0 166.0 127.0 19:46:30 INFO - PROCESS | 22193 | 19:46:30 INFO - PROCESS | 22193 | [#2] audio-dft Cycles:10 Average:161.10 Median:162.00 stddev:1.20 (0.7%) stddev-sans-first:1.20 19:46:30 INFO - PROCESS | 22193 | Values: 160.0 160.0 160.0 160.0 160.0 162.0 162.0 162.0 162.0 163.0 19:46:30 INFO - PROCESS | 22193 | 19:46:30 INFO - PROCESS | 22193 | [#3] audio-fft Cycles:10 Average:82.90 Median:76.00 stddev:14.85 (19.5%) stddev-sans-first:15.47 19:46:30 INFO - PROCESS | 22193 | Values: 75.0 75.0 76.0 109.0 77.0 76.0 76.0 76.0 113.0 76.0 19:46:30 INFO - PROCESS | 22193 | 19:46:30 INFO - PROCESS | 22193 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:83.00 stddev:12.44 (15.0%) stddev-sans-first:12.86 19:46:30 INFO - PROCESS | 22193 | Values: 83.0 84.0 110.0 84.0 83.0 83.0 101.0 84.0 83.0 114.0 19:46:30 INFO - PROCESS | 22193 | 19:46:30 INFO - PROCESS | 22193 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.50 19:46:30 INFO - PROCESS | 22193 | Values: 118.0 117.0 117.0 116.0 117.0 117.0 117.0 116.0 116.0 117.0 19:46:30 INFO - PROCESS | 22193 | 19:46:30 INFO - PROCESS | 22193 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 19:46:30 INFO - PROCESS | 22193 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 19:46:30 INFO - PROCESS | 22193 | 19:46:30 INFO - PROCESS | 22193 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 19:46:30 INFO - PROCESS | 22193 | Values: 96.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 95.0 19:46:30 INFO - PROCESS | 22193 | 19:46:30 INFO - PROCESS | 22193 | [#8] json-parse-financial Cycles:10 Average:53.00 Median:52.00 stddev:3.59 (6.9%) stddev-sans-first:3.81 19:46:30 INFO - PROCESS | 22193 | Values: 53.0 52.0 63.0 51.0 51.0 53.0 52.0 52.0 52.0 51.0 19:46:30 INFO - PROCESS | 22193 | 19:46:30 INFO - PROCESS | 22193 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:62.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 19:46:30 INFO - PROCESS | 22193 | Values: 61.0 61.0 62.0 61.0 61.0 61.0 62.0 62.0 62.0 62.0 19:46:30 INFO - PROCESS | 22193 | 19:46:30 INFO - PROCESS | 22193 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:81.00 stddev:3.95 (4.9%) stddev-sans-first:4.16 19:46:30 INFO - PROCESS | 22193 | Values: 80.0 82.0 85.0 89.0 79.0 78.0 78.0 78.0 79.0 86.0 19:46:30 INFO - PROCESS | 22193 | 19:46:30 INFO - PROCESS | 22193 | [#11] stanford-crypto-ccm Cycles:10 Average:133.40 Median:130.50 stddev:11.33 (8.7%) stddev-sans-first:11.83 19:46:30 INFO - PROCESS | 22193 | Values: 139.0 131.0 126.0 129.0 129.0 128.0 130.0 127.0 164.0 131.0 19:46:30 INFO - PROCESS | 22193 | 19:46:30 INFO - PROCESS | 22193 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.60 Median:166.50 stddev:1.78 (1.1%) stddev-sans-first:1.81 19:46:30 INFO - PROCESS | 22193 | Values: 167.0 168.0 164.0 166.0 165.0 163.0 166.0 167.0 167.0 163.0 19:46:30 INFO - PROCESS | 22193 | 19:46:30 INFO - PROCESS | 22193 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:65.00 stddev:0.92 (1.4%) stddev-sans-first:0.71 19:46:30 INFO - PROCESS | 22193 | Values: 67.0 66.0 65.0 66.0 64.0 65.0 65.0 65.0 65.0 64.0 19:46:30 INFO - PROCESS | 22193 | -------- Summary: end -------- 19:46:30 INFO - PROCESS | 22193 | 19:46:31 INFO - TEST-INFO | 22193: exit 0 19:46:31 INFO - TEST-OK | kraken | took 62400ms 19:46:31 INFO - SUITE-END | took 1179s 19:46:32 INFO - Completed test suite (00:19:39) 19:46:32 INFO - javascript benchmark 19:46:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2962.73335399814, 3004.8948286809964, 3008.623922009748, 3031.075521965802, 3057.2662560985355, 4950.504949505048, 5037.0933232018315, 5109.335786347774, 5164.870878228046, 5175.068487672217, 5075.593952483801, 5111.386633603964, 5207.713575753332, 5223.0, 5293.920591191126, 4735.100330937128, 4817.951820481803, 4847.442544107429, 4862.051899879525, 4874.488178741234, 4754.762261886909, 4765.547273009059, 4798.664093513456, 4829.951700482985, 4861.392325959255, 4859.757012149378, 4877.170880950229, 4879.560839524442, 4919.237518184687, 4936.580390666798, 4574.542545745432, 4627.884302892421, 4628.143793398232, 4818.831340903087, 4863.805447782084, 4656.5343465653505, 4702.294655801623, 4720.268358404453, 4727.196376615949, 4756.833510827139, 5218.504242096995, 5235.162374020177, 5235.528802407802, 5240.187770895517, 5246.658967167122, 5225.059489291926, 5522.530584900288, 5540.418256083093, 5546.084895992157, 5548.44515548446, 5310.468953104697, 5368.651037682538, 5373.0, 5384.5692344612335, 5387.24578559002, 5041.823536176216, 5044.697318160922, 5046.646734728571, 5054.292399064171, 5134.255532947702, 5647.350554686182, 5668.149777533403, 5693.68684722336, 5735.913961290584, 5746.88506229873, 5400.702961337164, 5416.756245968941, 5460.945390546123, 5469.917951230735, 5474.479924407175, 5241.606879484054, 5256.421793602701, 5543.695096769636, 5543.889122217533, 5613.831585052373, 5372.811951581676, 5427.1316589345515, 5428.430014848463, 5441.265429167091, 5502.807401741, 5415.431379705153, 5421.756020979065, 5428.022955867903, 5445.482679145475, 5493.450654934474, 4244.2996905510245, 4286.39990401344, 4289.721168124124, 4295.22685916538, 4336.9783151084675, 3709.9797555672408, 3737.0, 3828.5979972103087, 3839.9808000959815, 3881.378979363288, 5293.57651387888, 5295.682259064469, 5299.8410047698635, 5301.416844147141, 5335.599830012765, 5593.888122237532, 5634.943650563524, 5639.238702775073, 5641.153826925994, 5703.258576385043, 5031.295618613397, 5087.414947281036, 5214.270002199695, 5317.627766056339, 5330.946690533123, 4876.146674331978, 4902.90194196114, 4908.41099068107, 4950.405951285797, 4962.5533701967, 5758.827235182951, 5785.30576330843, 5787.884242315215, 5796.681182534917, 5799.9130013049, 5195.506426889439, 5307.336582927134, 5616.494515493625, 5637.295338082739, 5685.71571421419, 5668.914966275427, 5727.341355744143, 5757.021306377842, 5771.595988280948, 5848.356680765028, 5496.945030549803, 5504.256925315191, 5505.394406615189, 5506.119020956788, 5506.531944784738, 5314.707691077027, 5604.635698679573, 5611.354694210218, 5616.0, 5619.831405057855, 5238.869028274324, 5325.467453254643, 5353.437889021752, 5370.865728356823, 5454.04554203005, 5331.866703332447, 5376.193570964387, 5377.435369286169, 5380.704061276668, 5383.434739352469, 5263.710495922761, 5327.786888524571, 5332.33345831771, 5333.610558311255, 5393.622446428869, 5235.581153507786, 5309.33633295838, 5446.264754258124, 5490.917636235539, 5499.642523235977, 5414.431484694051, 5419.972900135474, 5421.241026256248, 5421.593380496557, 5472.042392581203], "value": 5112.562046509044, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.9767461193497, 564.8841987392585, 598.3448124303886, 603.1736520966274, 613.4509613895563, 30044.24889377764, 41176.38235426467, 41791.0, 41831.37252941201, 41988.58011419885, 42920.78539607298, 43334.566654333445, 43400.13199736003, 43478.78260608701, 43557.0, 8038.919610803905, 8217.7123800667, 8862.06948270432, 9022.684206052789, 9022.729318120433, 10673.733156671067, 10905.83641245378, 10954.178436617245, 10960.56157753689, 10965.013148816604, 10786.73033174169, 10876.728081797939, 10881.075108615778, 10884.0, 10889.618863339785, 10631.627893023746, 10698.893011069946, 10705.892941070606, 10716.249862509627, 10758.408287544182, 10505.369677819279, 10550.577976880915, 10571.471426428725, 10571.682849514527, 10579.629712960086, 41136.38295425571, 41166.79416602928, 41333.0, 41494.792526037476, 41538.0, 3220.6940340667834, 3282.901512954615, 3411.249525104498, 3423.2126610879386, 3454.447288433864, 28636.427271454453, 30603.540946885816, 31167.844160779052, 31279.0, 32281.35437291241, 4165.333546632554, 4275.251830929575, 4366.585174408426, 4396.912061758747, 4407.801648925774, 327565.0, 329552.0, 331448.3427582871, 332083.0, 332110.0, 55594.0, 56022.71988640031, 56198.7190064047, 56345.71827140838, 56510.43489565134, 60054.69972650196, 60185.39814601798, 60230.09654855093, 60269.09596356058, 60395.0, 13752.174869507862, 13931.0, 13940.233287169303, 14214.644633884029, 14226.857731422553, 8958.283337332998, 9083.091690830865, 10259.333143345659, 10611.946940265248, 10962.506687199095, 17448.302067917142, 17657.735133973, 17821.198046087957, 18022.098895055195, 18040.819591804175, 6965.5124141309625, 7024.733498922923, 7031.714692724782, 7055.7177712891935, 7134.750283740044, 843.599290337085, 946.342292106979, 953.3279038277998, 965.7247684409909, 1004.382304882492, 29654.0, 30695.693043069285, 30733.38533229323, 31117.066318652505, 31458.0, 1000.5947591225565, 1009.8586197932295, 1016.4358780876537, 1099.0328510910347, 1109.2678831970861, 15207.543773686586, 15927.522174334788, 16054.025476563507, 16137.919310403608, 16276.430324938807, 546718.0, 552261.0, 554671.0, 557180.0, 557892.0, 54188.72905635525, 54848.0, 54894.17658735122, 54905.0, 54986.60107191415, 1165.9008984236434, 1212.3756265523264, 1250.6310638361888, 1306.3207132291345, 1306.6276111308232, 29333.85333073321, 30919.227019323796, 31053.0, 31223.843880781358, 31670.683293166774, 46605.3009204869, 46838.29742553933, 46921.53078469308, 47066.52933470622, 47124.29313560368, 395381.0, 395952.0, 396843.0, 397699.0, 400398.0, 27391.0, 27977.0, 28693.556773187353, 28931.276718082216, 28967.710322896502, 44619.776901115285, 44884.551154488036, 45190.54809451995, 45333.0, 46407.303890442345, 38194.809025954695, 38245.003480162624, 38792.80603596964, 39715.80142099271, 39761.40357894692, 36963.81518092392, 37936.24127517379, 38188.0, 38467.2306553873, 41648.58351416447, 37760.433593496666, 38182.23635527329, 38301.61698382981, 38344.23311533698, 39407.60592394039, 32613.0, 35378.46932296069, 35549.82225088858, 35614.28771424505, 36017.819910900274, 26757.197284081507, 26783.732162678123, 26892.0, 26927.730722693304, 27334.726652734014], "value": 19559.738978110676, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.64698712729347, 376.9151940813317, 388.8638976358274, 393.484535258811, 407.1246819338422, 14177.503787367445, 17935.192916318763, 18907.62184756306, 19051.999999999964, 20161.798382016175, 17692.0, 17791.466256012307, 18753.0, 19079.809201907978, 19084.33204837831, 5521.475459831319, 5749.080147176453, 5787.47912687858, 5809.215755872967, 5811.535077193815, 4031.23406552754, 4315.115401342718, 4343.500497442803, 5403.054465468547, 5475.206095116206, 6416.486681065504, 6416.711247993828, 6427.871442571146, 6430.742770289183, 6440.967795161017, 6226.59527130735, 6370.777022804226, 6430.903536446957, 6431.774887878902, 6434.935650643481, 5658.264425624684, 5700.714964251771, 5704.0, 5706.9156860196845, 5710.0, 22468.77531224683, 22883.42791430211, 23038.308850734506, 23119.537609247887, 23302.3009309721, 2192.725909261342, 2262.9207977720866, 2338.3218866528687, 2357.398863289867, 2997.1607949774098, 10469.31949423285, 11023.559057637685, 11315.773684526346, 13490.0, 13926.303684815719, 1895.9175894620737, 1915.7701075870846, 1943.4752616793387, 2009.24191332584, 2023.836294130866, 70497.2950270496, 72997.63501182513, 79396.60301698455, 82284.17715822885, 82358.17641823566, 10829.404382758867, 10834.837477437844, 10856.294340867818, 11109.834042106708, 11128.387938663289, 15353.385864565293, 15573.844261557238, 15747.842521574867, 15750.291236894367, 15778.842211577738, 7722.53664780115, 7803.843923121506, 7903.407244456574, 7929.444938854225, 8020.478668886503, 6923.446124310043, 7029.718811247493, 7151.678174482056, 7169.673610382096, 7189.209186989427, 4705.153072446992, 4729.739864307496, 4770.546798054179, 4781.402324709411, 4831.9275210871865, 1948.39599724086, 1960.1963195089945, 1984.9702254466195, 1986.9006549672458, 2020.454477291123, 832.6169961817511, 902.6118768929423, 964.1611797736015, 973.1484950668165, 991.2862738828032, 18062.458126256235, 18697.719534206997, 18930.05349732508, 19210.135543900557, 19581.412557623295, 904.2765787370209, 934.8083642853335, 950.458238803889, 955.7515046088067, 1018.2159737002614, 10237.18102551794, 10760.892391076146, 10772.08437282824, 10824.72938176536, 10887.782244355069, 405718.0, 412665.0, 425392.0, 426781.0, 429547.0, 90411.54794225987, 91340.0, 95787.52106239424, 98116.0, 99266.99999999856, 941.2093841173447, 984.3995162950595, 1031.9122874555746, 1050.6847945616437, 1051.5530899367739, 16248.268827902537, 16316.42892498757, 16956.541301511457, 17143.142842857556, 17163.570910727332, 40304.59695403009, 41344.79327603343, 41573.79213104036, 41669.58330416657, 43079.7846010768, 54796.72601636966, 56857.71571142118, 57034.42965570291, 57524.0, 58970.0, 7697.191794861459, 7825.295723384923, 8243.670253189804, 8250.669973201246, 8318.70884519039, 11118.221724479208, 11779.116566257393, 12045.217060891015, 12046.099149123072, 12577.93711031439, 10121.392716437038, 10421.895781042396, 10476.528556214836, 10747.623833165802, 10774.084202842847, 10424.374537527772, 10708.625198118028, 10742.40916749555, 10761.623343182951, 11270.605528806453, 10375.118114960313, 10402.635907743193, 10464.476776161313, 10506.737331566772, 10789.676309710721, 7421.443391745533, 7615.238476152341, 7745.883811742941, 8204.343652507905, 8363.03825060126, 8458.196471335214, 10633.840492392466, 10736.0, 10882.564697412015, 11167.776644467227], "value": 8974.46039282826, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1285.0940087238498, 1424.8860091192703, 1432.376916041522, 1538.7999560057192, 1733.713937200362, 7518.2105878882685, 8560.186782255683, 8864.955675221614, 8875.733727988163, 9127.406718563305, 8930.285577153829, 8963.686270980517, 8988.235999940012, 9023.413478123917, 9028.097190280969, 2346.5306938612302, 2380.321608341623, 2390.8924098415614, 2392.461696118377, 2402.231285988484, 2271.318604418676, 2299.4481324482085, 2389.0443822471066, 2389.7251816041203, 2392.7487613800563, 2365.195833416638, 2369.5971684813535, 2376.6197408414655, 2409.108629806965, 2418.51629674065, 2278.9886050569808, 2287.7597852225526, 2293.0, 2304.274153641606, 2329.906803727849, 2236.630955892292, 2270.080617349976, 2278.4303924018996, 2280.04238219948, 2286.691296674944, 8633.913660863374, 8759.423303805312, 8863.0, 8938.86591701125, 8953.0, 5258.2638430619745, 5427.701476418795, 5430.348358197002, 5521.365043020064, 5543.085390910495, 3375.814330211862, 3421.230223199785, 3457.94813077804, 3458.4293591557616, 3480.860765569374, 1050.9264351495399, 1089.1178145702006, 2085.8122768950716, 2139.6520192278763, 2200.5378870437225, 12576.245425274512, 12656.493740250378, 12668.239905605693, 12687.873121268762, 12704.618861434079, 4494.325851122358, 4527.117212143667, 4695.154872123051, 4728.763561821896, 4738.857834264978, 9890.456024918698, 9895.505224738734, 9898.356606820533, 9901.108900198873, 9901.60393584263, 5389.784408623689, 5401.054815407288, 5403.864903377447, 5406.675599464044, 5407.540359069523, 4117.279476091732, 4253.2769429197115, 4288.892777680583, 4378.058717375779, 5027.120253955543, 3608.8736894208578, 3721.292954338667, 3730.962690373116, 3810.180811125566, 3842.6733727632904, 1116.7822274656364, 1129.4296380328046, 1130.0620484997432, 1139.065965907964, 1160.3154139057997, 898.4923518212189, 948.4878165790534, 966.5795379010153, 981.1611072532882, 1015.1827778638267, 5884.911726324109, 5891.204687367236, 5980.760769569256, 6062.302835173923, 6208.00671892504, 419.5971867007707, 425.09666957714853, 433.41272575659525, 434.27909669947735, 451.07079416402314, 3764.698824094066, 3928.332183528807, 4158.147579746144, 4179.26862799009, 4182.769947652848, 10991.120710343153, 11268.21122521432, 11432.657020289405, 11439.256448330832, 11466.0, 11315.03822175108, 11317.377544235145, 11319.886801131883, 11375.886241137649, 11388.259763115371, 8266.173382661806, 8326.542040187847, 8428.0, 8429.704960326359, 8448.197421245095, 5807.8548036299435, 5826.271716035496, 5844.386339434468, 5924.555658325557, 5964.821055368172, 9733.075357840993, 10355.741106472096, 10379.948100259451, 10457.215708821717, 10538.420386878795, 8874.201321881063, 10238.436885971343, 10608.257421980696, 10615.0, 10616.946915265684, 6836.282190370139, 7499.362554182955, 7635.847283054197, 7728.574928378768, 7956.880646790419, 8629.39594228423, 8662.956685216534, 8686.91313086861, 8705.390622656354, 8728.56357182151, 7506.624668766649, 7697.268759467842, 7710.845783084194, 7762.223777622193, 7791.727289544839, 7606.733764318223, 7609.429292803173, 7622.085349758065, 7626.96186519086, 7739.032620922385, 6981.790546283416, 7016.964915175391, 7266.273372662691, 7307.634618268959, 7327.120745510573, 5258.553022993088, 5335.973320133375, 5358.142697168434, 5375.086235339923, 5388.191771234189, 5200.531952124327, 5205.687658740488, 5284.867878303073, 5328.641196494869, 5425.945740542702], "value": 4595.195066353743, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.2407664537629, 334.05129432411945, 344.11733902539976, 344.614032283842, 346.6014083803627, 5102.974485127578, 5242.501962313579, 5282.947170528303, 5316.415194328625, 5319.351001189634, 5070.442251352349, 5175.8188463403785, 5218.582513398928, 5233.607479439048, 5249.448807875176, 4185.916281674365, 4209.705320627558, 4211.452511173543, 4224.408582798403, 4225.112726327475, 3931.862384816532, 4001.7398869073563, 4177.373393990895, 4205.306124489455, 4215.156968606276, 4137.689673274502, 4148.751074935499, 4150.817017150112, 4164.083901541671, 4167.416561681367, 4134.400511925754, 4136.110736191718, 4144.937825932613, 4154.234450358601, 4165.66674666026, 3485.721142308609, 3754.6433088856515, 3756.7370284080125, 3759.6992240620957, 3763.419363867155, 5110.805746408495, 5124.948750512522, 5129.3075434816565, 5140.460251673558, 5157.0, 4736.59738922192, 4740.810367585293, 4742.383490146293, 4742.620590352763, 4752.1921273383605, 5323.1749078892835, 5478.643888147298, 5484.341878974508, 5486.835394938158, 5500.147477141049, 3982.920341593181, 4005.2590270799706, 4008.939865902014, 4011.237864805707, 4033.7781422021776, 5665.320161580596, 5700.543956483513, 5709.257796486471, 5713.942860571383, 5716.114002329646, 3980.721349505565, 4080.367543030835, 4116.374032257241, 4119.958800412018, 4123.587641235912, 4070.247004304213, 4076.429299898017, 4113.465249517543, 4124.505059392892, 4125.793710314472, 4620.584147426681, 4621.2837010263465, 4622.838200662961, 4642.560806150104, 4672.0, 5363.419439796483, 5413.593980451482, 5422.240886275925, 5462.289902312754, 5474.671519708831, 1377.2769296119618, 1426.4579459805207, 1435.8994870358974, 1437.6629734347157, 1441.358595425026, 903.5617725403174, 928.9581968811419, 934.4299977014016, 943.6649989253854, 946.5976959792199, 4753.786079626425, 4754.334393184957, 4770.61835053195, 4772.236442169236, 4806.4712881583, 4943.456219815817, 4979.477154898684, 5002.699838009731, 5006.6495345325475, 5025.9644843838305, 4400.405945197357, 4712.387389639393, 4717.528247175255, 4744.390585178207, 4789.353437285922, 2644.598362867683, 2665.466906618645, 2665.520636046974, 2675.622054641861, 2677.638518799976, 5150.450526989164, 5180.352455943007, 5181.512873820588, 5191.988646584971, 5217.217417387346, 4755.025219829927, 5017.774200161001, 5079.6698214615935, 5082.983403319351, 5100.138449465918, 5119.283300337956, 5123.769430375568, 5136.2552429898205, 5139.743012849342, 5171.534561889448, 4941.431735350337, 5044.293798868088, 5058.822941197041, 5059.367579052619, 5085.7711402986215, 4822.903541929071, 4942.28336891156, 4969.751512424292, 5282.418933917189, 5659.057290209151, 5839.532837373085, 5908.704564771659, 5911.172435858897, 5919.674417906885, 5920.8815823684145, 3937.9803100984313, 4115.42384066237, 4116.094459218967, 4216.704830661824, 4256.87229383119, 5648.57635677334, 5659.688717120598, 5661.433856614471, 5663.292088488939, 5668.688222147822, 5471.370792358771, 5506.807261745819, 5515.70380960482, 5545.085060965057, 5569.164625306074, 5370.382406023357, 5464.508194262536, 5504.201890725903, 5505.532029777353, 5512.283403157564, 5421.322334708161, 5421.457854214547, 5442.673439593637, 5448.237246785532, 5450.591205659671, 5317.415084340642, 5496.120620700829, 5532.419095994863, 5540.501354877919, 5542.889142217053, 5387.838364849061, 5391.568674505952, 5417.972910135424, 5431.864203394946, 5436.8640783979135], "value": 4104.943916229627, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [687.336720065137, 700.7582384077494, 718.3104219948849, 731.7658349328213, 764.2128607534235, 14991.175485348302, 16401.261943212554, 16450.917745411272, 16488.917555412238, 16506.009639421627, 13069.803952940714, 13205.141665791716, 13224.93387533061, 13234.470621175165, 13245.933770331136, 628.1457218183267, 646.2180761278859, 730.7077169132363, 748.5321673953779, 751.1024325930515, 760.4562737642584, 761.3034073822446, 761.603965937712, 764.8432071425373, 769.3422124083911, 814.767791179514, 815.2906970935265, 816.4448175240834, 816.742726041298, 817.0358976407837, 808.4340961327035, 812.6424373275798, 813.2924355810424, 813.4590497319275, 813.5200231863199, 485.04204196711567, 493.8740621141622, 569.5756661287368, 585.2538014032101, 591.0720169334147, 14414.207218602973, 14425.0, 14436.061655992327, 14436.206008669518, 14436.278186090758, 12301.446434910451, 12522.874771252262, 12673.239605623692, 12852.742945141139, 13216.207027578375, 12464.626061218178, 12496.937515312366, 12526.436310366056, 12690.619281421572, 12981.41583628739, 4201.386807345681, 4356.128774245132, 4458.665600080007, 4478.350639157304, 4489.1021795641, 76004.61997690031, 76139.0, 76514.23485765127, 76811.0, 76876.0, 10681.732956676145, 11023.83464248037, 11101.167412443938, 11411.942940285246, 11460.0, 17460.825391746173, 17493.825061749474, 17557.297708091788, 17559.473215803548, 17585.472435826945, 7911.920880791234, 8145.0, 8177.95911020453, 8301.667933282723, 8324.62539185738, 4308.870733877989, 4410.867673969786, 4417.425734654475, 4430.756308403069, 4439.134368798053, 3497.3529896969144, 3585.229175727231, 3593.047842321787, 3602.7297952653657, 3791.696664266852, 701.8596280743872, 703.549728173969, 708.373089815517, 711.0436462957417, 713.9036230108973, 642.7814543055383, 658.8207109274441, 661.4708233413346, 670.1020632352573, 685.8216863615496, 9649.421034737938, 9703.951480242553, 9733.415995040321, 9813.214942804558, 9964.451955142391, 614.2904944788776, 663.3532306001609, 672.9865402692017, 691.8892977123636, 721.4336745654741, 4258.254805409041, 4509.481409637933, 4546.0, 4606.30905364198, 4647.661212320661, 122223.38888305501, 123527.0, 123593.38203308926, 125563.37218314032, 126825.36587317004, 91522.54238728764, 92537.0, 93336.0, 106976.46511767547, 107460.46269768757, 74086.62956685181, 75635.62182189163, 80708.0, 82072.0, 82468.58765706133, 9477.715668529956, 9894.109530142321, 9944.254180936314, 10025.5488503019, 10250.53872575721, 48131.75934120307, 48665.51334486751, 48772.75613621909, 48792.0, 48882.0, 49482.505174947786, 54367.0, 62442.375576243656, 65317.0, 66730.33269667241, 12935.288559128961, 12940.417681204557, 12999.350032498149, 13133.408996595368, 13626.0, 13804.792928106288, 13952.232627205196, 14005.159690418608, 14567.781483277971, 14879.62800929942, 12664.493420263087, 12798.360081996048, 12878.806817897552, 13119.147255428366, 13356.866431335951, 12175.573854915036, 12347.87563161278, 12579.74840503203, 12736.598974112654, 12808.487660493476, 12656.810147847606, 12857.292848893401, 13360.663933606562, 13412.93293533526, 13496.797548036591, 8881.605164581093, 9505.192058674813, 9644.517774111408, 9716.854247186156, 9751.3661611995, 9075.863862041942, 9325.533723313943, 9647.855282170913, 10148.898511015092, 10428.634997775041], "value": 7230.175482543616, "unit": "score"}], "name": "dromaeo_css", "value": 7046.433417317609, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 111.0, 111.0, 110.0, 112.0, 111.0, 112.0, 111.0, 112.0, 110.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 126.0, 125.0, 179.0, 130.0, 123.0, 123.0, 123.0, 166.0, 127.0], "value": 137.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 160.0, 160.0, 162.0, 162.0, 162.0, 162.0, 163.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 109.0, 77.0, 76.0, 76.0, 76.0, 113.0, 76.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 110.0, 84.0, 83.0, 83.0, 101.0, 84.0, 83.0, 114.0], "value": 90.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 63.0, 51.0, 51.0, 53.0, 52.0, 52.0, 52.0, 51.0], "value": 53.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 62.0, 61.0, 61.0, 61.0, 62.0, 62.0, 62.0, 62.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 82.0, 85.0, 89.0, 79.0, 78.0, 78.0, 78.0, 79.0, 86.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 131.0, 126.0, 129.0, 129.0, 128.0, 130.0, 127.0, 164.0, 131.0], "value": 133.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 168.0, 164.0, 166.0, 165.0, 163.0, 166.0, 167.0, 167.0, 163.0], "value": 165.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 65.0, 66.0, 64.0, 65.0, 65.0, 65.0, 65.0, 64.0], "value": 65.2, "unit": "score"}], "name": "kraken", "value": 1501.8999999999999, "alertThreshold": 2.0}]} 19:46:32 INFO - Return code: 0 19:46:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:46:32 INFO - # TBPL SUCCESS # 19:46:32 INFO - Running post-action listener: _resource_record_post_action 19:46:32 INFO - [mozharness: 2016-10-02 02:46:32.455613Z] Finished run-tests step (success) 19:46:32 INFO - Running post-run listener: _resource_record_post_run 19:46:32 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392282112; Read time: 12; Write time: 284756 19:46:32 INFO - TinderboxPrint: CPU usage
13.1% 19:46:32 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 19:46:32 INFO - TinderboxPrint: I/O write bytes / time
392,282,112 / 284,756 19:46:32 INFO - TinderboxPrint: CPU idle
8,298.2 (86.9%) 19:46:32 INFO - TinderboxPrint: CPU user
1,201.3 (12.6%) 19:46:32 INFO - TinderboxPrint: Swap in / out
0 / 0 19:46:32 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 103755776; Read time: 0; Write time: 80692 19:46:32 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288526336; Read time: 12; Write time: 204064 19:46:33 INFO - Running post-run listener: _upload_blobber_files 19:46:33 INFO - Blob upload gear active. 19:46:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:46:33 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:46:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:46:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:46:33 INFO - (blobuploader) - INFO - Open directory for files ... 19:46:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:46:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:46:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:46:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:46:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:46:36 INFO - (blobuploader) - INFO - Done attempting. 19:46:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:46:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:46:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:46:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:46:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:46:37 INFO - (blobuploader) - INFO - Done attempting. 19:46:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:46:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:46:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:46:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:46:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:46:38 INFO - (blobuploader) - INFO - Done attempting. 19:46:38 INFO - (blobuploader) - INFO - Iteration through files over. 19:46:38 INFO - Return code: 0 19:46:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:46:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:46:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2a3230535bb3974c970fbe4dcfc08c18cbe7ebb879637dfd5b8cb1ba085421039183c064ec2d2770e035a169cabe16d2b5d7bc9503c89d7698cddfe36c1ef136", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2afdc50bc0e58304024f360282e3459c6dcc32845b27b118ec1221d0e9254262ab30afec12faae703f08629babd0fad5031e3b13a6777eec096b78b9f9089891", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f985a0bcb491bb2b73e748ad87a278a0b11e40e7844170adebab4c8ea48972d451e297babeefb581a89187c79ec938f3cc92ab2abe9cb413af855330c953be0"} 19:46:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:46:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:46:38 INFO - Contents: 19:46:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2a3230535bb3974c970fbe4dcfc08c18cbe7ebb879637dfd5b8cb1ba085421039183c064ec2d2770e035a169cabe16d2b5d7bc9503c89d7698cddfe36c1ef136", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2afdc50bc0e58304024f360282e3459c6dcc32845b27b118ec1221d0e9254262ab30afec12faae703f08629babd0fad5031e3b13a6777eec096b78b9f9089891", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f985a0bcb491bb2b73e748ad87a278a0b11e40e7844170adebab4c8ea48972d451e297babeefb581a89187c79ec938f3cc92ab2abe9cb413af855330c953be0"} 19:46:38 INFO - Running post-run listener: copy_logs_to_upload_dir 19:46:38 INFO - Copying logs to upload dir... 19:46:38 INFO - mkdir: /builds/slave/test/build/upload/logs 19:46:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.565347 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-10-01 19:46:37.707061) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-01 19:46:37.711231) ========= 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=03627c79f6bb3d1578c4a402000001ba-1475374680.345992-1261431849 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/2a3230535bb3974c970fbe4dcfc08c18cbe7ebb879637dfd5b8cb1ba085421039183c064ec2d2770e035a169cabe16d2b5d7bc9503c89d7698cddfe36c1ef136", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2afdc50bc0e58304024f360282e3459c6dcc32845b27b118ec1221d0e9254262ab30afec12faae703f08629babd0fad5031e3b13a6777eec096b78b9f9089891", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f985a0bcb491bb2b73e748ad87a278a0b11e40e7844170adebab4c8ea48972d451e297babeefb581a89187c79ec938f3cc92ab2abe9cb413af855330c953be0"} build_url:https://queue.taskcluster.net/v1/task/EZurryZCS2eSmn07k7kvmw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011155 build_url: 'https://queue.taskcluster.net/v1/task/EZurryZCS2eSmn07k7kvmw/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/2a3230535bb3974c970fbe4dcfc08c18cbe7ebb879637dfd5b8cb1ba085421039183c064ec2d2770e035a169cabe16d2b5d7bc9503c89d7698cddfe36c1ef136", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2afdc50bc0e58304024f360282e3459c6dcc32845b27b118ec1221d0e9254262ab30afec12faae703f08629babd0fad5031e3b13a6777eec096b78b9f9089891", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f985a0bcb491bb2b73e748ad87a278a0b11e40e7844170adebab4c8ea48972d451e297babeefb581a89187c79ec938f3cc92ab2abe9cb413af855330c953be0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-01 19:46:37.736404) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 19:46:37.736748) ========= 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=03627c79f6bb3d1578c4a402000001ba-1475374680.345992-1261431849 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004480 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 19:46:37.818704) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-01 19:46:37.819014) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-01 19:46:37.819363) ========= ========= Total master_lag: 0.18 =========