builder: larch_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-005 starttime: 1475870777.02 results: success (0) buildid: 20161007113100 builduid: d87b637329c447ddab13a697c31a1695 revision: 259c110bf47100196fd28e35c47c4e23bf9ad0a9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 13:06:17.021248) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 13:06:17.021775) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 13:06:17.022106) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 13:06:17.037540) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 13:06:17.037945) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1475870776.943327-372654948 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-07 13:06:17-- 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% 46.3M=0s 2016-10-07 13:06:17 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.150534 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 13:06:17.202420) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 13:06:17.202784) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1475870776.943327-372654948 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016236 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 13:06:17.252856) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-07 13:06:17.253349) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev 259c110bf47100196fd28e35c47c4e23bf9ad0a9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev 259c110bf47100196fd28e35c47c4e23bf9ad0a9 --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=7fc86f70bae03e018da0b1d8000001c4-1475870776.943327-372654948 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-07 13:06:17,881 truncating revision to first 12 chars 2016-10-07 13:06:17,881 Setting DEBUG logging. 2016-10-07 13:06:17,881 attempt 1/10 2016-10-07 13:06:17,882 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/259c110bf471?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-07 13:06:18,640 unpacking tar archive at: larch-259c110bf471/testing/mozharness/ program finished with exit code 0 elapsedTime=1.132640 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-07 13:06:18.400999) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 13:06:18.401643) ========= script_repo_revision: 259c110bf47100196fd28e35c47c4e23bf9ad0a9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 13:06:18.402392) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 13:06:18.402857) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 13:06:18.415504) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-07 13:06:18.416098) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch-Non-PGO 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', 'Larch-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Larch-Non-PGO'] 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=7fc86f70bae03e018da0b1d8000001c4-1475870776.943327-372654948 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:06:19 INFO - MultiFileLogger online at 20161007 13:06:19 in /builds/slave/test 13:06:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch-Non-PGO 13:06:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:06:19 INFO - {'append_to_log': False, 13:06:19 INFO - 'base_work_dir': '/builds/slave/test', 13:06:19 INFO - 'blob_upload_branch': 'Larch-Non-PGO', 13:06:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:06:19 INFO - 'branch': 'Larch-Non-PGO', 13:06:19 INFO - 'buildbot_json_path': 'buildprops.json', 13:06:19 INFO - 'config_files': ('talos/linux_config.py',), 13:06:19 INFO - 'default_actions': ('clobber', 13:06:19 INFO - 'read-buildbot-config', 13:06:19 INFO - 'download-and-extract', 13:06:19 INFO - 'populate-webroot', 13:06:19 INFO - 'create-virtualenv', 13:06:19 INFO - 'install', 13:06:19 INFO - 'run-tests'), 13:06:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:06:19 INFO - 'download_minidump_stackwalk': True, 13:06:19 INFO - 'download_symbols': 'ondemand', 13:06:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:06:19 INFO - 'tooltool.py': '/tools/tooltool.py', 13:06:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:06:19 INFO - '/tools/misc-python/virtualenv.py')}, 13:06:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:06:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:06:19 INFO - 'installer_path': 'installer.exe', 13:06:19 INFO - 'log_level': 'info', 13:06:19 INFO - 'log_name': 'talos', 13:06:19 INFO - 'log_to_console': True, 13:06:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:06:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:06:19 INFO - 'opt_config_files': (), 13:06:19 INFO - 'pip_index': False, 13:06:19 INFO - 'sps_profile': False, 13:06:19 INFO - 'sps_profile_interval': 0, 13:06:19 INFO - 'suite': 'dromaeojs', 13:06:19 INFO - 'system_bits': '32', 13:06:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:06:19 INFO - 'title': 'talos-linux64-ix-005', 13:06:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:06:19 INFO - 'use_talos_json': True, 13:06:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:06:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:06:19 INFO - 'work_dir': 'build'} 13:06:19 INFO - [mozharness: 2016-10-07 20:06:19.136453Z] Running clobber step. 13:06:19 INFO - Running pre-action listener: _resource_record_pre_action 13:06:19 INFO - Running main action method: clobber 13:06:19 INFO - rmtree: /builds/slave/test/build 13:06:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:06:19 INFO - Running post-action listener: _resource_record_post_action 13:06:19 INFO - [mozharness: 2016-10-07 20:06:19.596898Z] Finished clobber step (success) 13:06:19 INFO - [mozharness: 2016-10-07 20:06:19.596999Z] Running read-buildbot-config step. 13:06:19 INFO - Running pre-action listener: _resource_record_pre_action 13:06:19 INFO - Running main action method: read_buildbot_config 13:06:19 INFO - Using buildbot properties: 13:06:19 INFO - { 13:06:19 INFO - "project": "", 13:06:19 INFO - "product": "firefox", 13:06:19 INFO - "script_repo_revision": "production", 13:06:19 INFO - "builddir": "larch_ubuntu64_hw_test-dromaeojs", 13:06:19 INFO - "repository": "", 13:06:19 INFO - "buildername": "Ubuntu HW 12.04 x64 larch talos dromaeojs", 13:06:19 INFO - "buildid": "20161007113100", 13:06:19 INFO - "pgo_build": "False", 13:06:19 INFO - "basedir": "/builds/slave/test", 13:06:19 INFO - "buildnumber": 6, 13:06:19 INFO - "slavename": "talos-linux64-ix-005", 13:06:19 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:06:19 INFO - "platform": "ubuntu64_hw", 13:06:19 INFO - "scheduler": "tests-larch-linux64-talos", 13:06:19 INFO - "branch": "larch", 13:06:19 INFO - "repo_path": "projects/larch", 13:06:19 INFO - "revision": "259c110bf47100196fd28e35c47c4e23bf9ad0a9", 13:06:19 INFO - "stage_platform": "linux64", 13:06:19 INFO - "builduid": "d87b637329c447ddab13a697c31a1695", 13:06:19 INFO - "slavebuilddir": "test" 13:06:19 INFO - } 13:06:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/HmWIxuYTRfS3svN6UIExnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 13:06:19 INFO - Running post-action listener: _resource_record_post_action 13:06:19 INFO - [mozharness: 2016-10-07 20:06:19.599433Z] Finished read-buildbot-config step (success) 13:06:19 INFO - [mozharness: 2016-10-07 20:06:19.599522Z] Running download-and-extract step. 13:06:19 INFO - Running pre-action listener: _resource_record_pre_action 13:06:19 INFO - Running main action method: download_and_extract 13:06:19 INFO - mkdir: /builds/slave/test/build/tests 13:06:19 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')]} 13:06:19 INFO - trying https://queue.taskcluster.net/v1/task/HmWIxuYTRfS3svN6UIExnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 13:06:19 INFO - Downloading https://queue.taskcluster.net/v1/task/HmWIxuYTRfS3svN6UIExnw/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 13:06:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HmWIxuYTRfS3svN6UIExnw/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 13:06:20 INFO - Downloaded 1361 bytes. 13:06:20 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 13:06:20 INFO - Using the following test package requirements: 13:06:20 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 13:06:20 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:06:20 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:06:20 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:06:20 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:06:20 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:06:20 INFO - u'jsshell-linux-x86_64.zip'], 13:06:20 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:06:20 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:06:20 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 13:06:20 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:06:20 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:06:20 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:06:20 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:06:20 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:06:20 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:06:20 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:06:20 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:06:20 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:06:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HmWIxuYTRfS3svN6UIExnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 13:06:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HmWIxuYTRfS3svN6UIExnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:06:20 INFO - Fetch https://queue.taskcluster.net/v1/task/HmWIxuYTRfS3svN6UIExnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 13:06:20 INFO - Http code: 200 13:06:20 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 13:06:20 INFO - x-amz-cf-id: 1YKz0Fx_BGxFg_nU1RS3e4IBu3NCdfvNph5Yhc0-p9gtrb3Cyi3g6Q== 13:06:20 INFO - x-amz-version-id: ledFm5ZGJ2erqTUOPFQ9rO8tBW2GhDhI 13:06:20 INFO - Expected file size: 20420581 13:06:20 INFO - Obtained file size: 20420581 13:06:24 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 13:06:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HmWIxuYTRfS3svN6UIExnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 13:06:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HmWIxuYTRfS3svN6UIExnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:06:24 INFO - Fetch https://queue.taskcluster.net/v1/task/HmWIxuYTRfS3svN6UIExnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 13:06:25 INFO - Http code: 200 13:06:25 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 13:06:25 INFO - x-amz-cf-id: hJTgkqLfLljBscWMriqAlKSegs4x1EbZO39JAgp5ZolbCUu9HHPbuQ== 13:06:25 INFO - x-amz-version-id: ledFm5ZGJ2erqTUOPFQ9rO8tBW2GhDhI 13:06:25 INFO - Expected file size: 20420581 13:06:25 INFO - Obtained file size: 20420581 13:06:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HmWIxuYTRfS3svN6UIExnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 13:06:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HmWIxuYTRfS3svN6UIExnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:06:30 INFO - Fetch https://queue.taskcluster.net/v1/task/HmWIxuYTRfS3svN6UIExnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 13:06:30 INFO - Http code: 200 13:06:30 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 13:06:30 INFO - x-amz-cf-id: Cf74ACutm6ULZhMI0qzcUisglB5blCFZl-BeJajlHyNKxK4aWdEyqg== 13:06:30 INFO - x-amz-version-id: _3jg.7vNlViTEqE73kxi6GtNn8YImg3A 13:06:30 INFO - Expected file size: 14408522 13:06:30 INFO - Obtained file size: 14408522 13:06:31 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')]} 13:06:31 INFO - trying https://queue.taskcluster.net/v1/task/HmWIxuYTRfS3svN6UIExnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:06:31 INFO - Downloading https://queue.taskcluster.net/v1/task/HmWIxuYTRfS3svN6UIExnw/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 13:06:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HmWIxuYTRfS3svN6UIExnw/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 13:06:32 INFO - Downloaded 55812306 bytes. 13:06:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HmWIxuYTRfS3svN6UIExnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:06:32 INFO - mkdir: /builds/slave/test/properties 13:06:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:06:32 INFO - Writing to file /builds/slave/test/properties/build_url 13:06:32 INFO - Contents: 13:06:32 INFO - build_url:https://queue.taskcluster.net/v1/task/HmWIxuYTRfS3svN6UIExnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:06:32 INFO - Running post-action listener: _resource_record_post_action 13:06:32 INFO - Running post-action listener: set_extra_try_arguments 13:06:32 INFO - [mozharness: 2016-10-07 20:06:32.963536Z] Finished download-and-extract step (success) 13:06:32 INFO - [mozharness: 2016-10-07 20:06:32.963761Z] Running populate-webroot step. 13:06:32 INFO - Running pre-action listener: _resource_record_pre_action 13:06:32 INFO - Running main action method: populate_webroot 13:06:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:06:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:06:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:06:32 INFO - '--tppagecycles', 13:06:32 INFO - '7'], 13:06:32 INFO - 'tests': ['tsvgm']}}, 13:06:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:06:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:06:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:06:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:06:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:06:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:06:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:06:32 INFO - 'talos_options': ['--disable-e10s'], 13:06:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:06:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:06:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:06:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:06:32 INFO - 'talos_options': ['--disable-e10s'], 13:06:32 INFO - 'tests': ['damp', 'tps']}, 13:06:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:06:32 INFO - 'tests': ['damp', 'tps']}, 13:06:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:06:32 INFO - 'tests': ['dromaeo_dom']}, 13:06:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:06:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:06:32 INFO - 'tests': ['basic_compositor_video']}, 13:06:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:06:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:06:32 INFO - 'tests': ['a11yr', 13:06:32 INFO - 'ts_paint', 13:06:32 INFO - 'tpaint', 13:06:32 INFO - 'sessionrestore', 13:06:32 INFO - 'sessionrestore_no_auto_restore', 13:06:32 INFO - 'tabpaint']}, 13:06:32 INFO - 'other-e10s': {'tests': ['a11yr', 13:06:32 INFO - 'ts_paint', 13:06:32 INFO - 'tpaint', 13:06:32 INFO - 'sessionrestore', 13:06:32 INFO - 'sessionrestore_no_auto_restore', 13:06:32 INFO - 'tabpaint']}, 13:06:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:06:32 INFO - 'ts_paint', 13:06:32 INFO - 'tpaint', 13:06:32 INFO - 'sessionrestore', 13:06:32 INFO - 'sessionrestore_no_auto_restore', 13:06:32 INFO - 'tabpaint']}, 13:06:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:06:32 INFO - 'ts_paint', 13:06:32 INFO - 'tpaint', 13:06:32 INFO - 'sessionrestore', 13:06:32 INFO - 'sessionrestore_no_auto_restore', 13:06:32 INFO - 'tabpaint']}, 13:06:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:06:32 INFO - 'tests': ['a11yr', 13:06:32 INFO - 'ts_paint', 13:06:32 INFO - 'tpaint', 13:06:32 INFO - 'sessionrestore', 13:06:32 INFO - 'sessionrestore_no_auto_restore', 13:06:32 INFO - 'tabpaint']}, 13:06:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:06:32 INFO - 'tests': ['a11yr', 13:06:32 INFO - 'ts_paint', 13:06:32 INFO - 'tpaint', 13:06:32 INFO - 'sessionrestore', 13:06:32 INFO - 'sessionrestore_no_auto_restore', 13:06:32 INFO - 'tabpaint']}, 13:06:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:06:32 INFO - 'tests': ['tsvgx', 13:06:32 INFO - 'tsvgr_opacity', 13:06:32 INFO - 'tart', 13:06:32 INFO - 'tscrollx', 13:06:32 INFO - 'cart']}, 13:06:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:06:32 INFO - 'tsvgr_opacity', 13:06:32 INFO - 'tart', 13:06:32 INFO - 'tscrollx', 13:06:32 INFO - 'cart']}, 13:06:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:06:32 INFO - 'talos_options': ['--disable-e10s'], 13:06:32 INFO - 'tests': ['tp5o']}, 13:06:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:06:32 INFO - 'tests': ['tp5o']}, 13:06:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:06:32 INFO - 'talos_options': ['--disable-e10s', 13:06:32 INFO - '--xperf_path', 13:06:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:06:32 INFO - 'tests': ['tp5n']}, 13:06:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:06:32 INFO - 'talos_options': ['--xperf_path', 13:06:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:06:32 INFO - 'tests': ['tp5n']}}, 13:06:32 INFO - 'talos.zip': {'path': '', 13:06:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:06:32 INFO - Running post-action listener: _resource_record_post_action 13:06:32 INFO - [mozharness: 2016-10-07 20:06:32.979827Z] Finished populate-webroot step (success) 13:06:32 INFO - [mozharness: 2016-10-07 20:06:32.979916Z] Running create-virtualenv step. 13:06:32 INFO - Running pre-action listener: _resource_record_pre_action 13:06:32 INFO - Running main action method: create_virtualenv 13:06:32 INFO - Creating virtualenv /builds/slave/test/build/venv 13:06:32 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 13:06:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:06:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:06:33 INFO - Using real prefix '/usr' 13:06:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:06:33 INFO - Installing distribute.............................................................................................................................................................................................done. 13:06:35 INFO - Installing pip.................done. 13:06:35 INFO - Return code: 0 13:06:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:06:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:06:35 INFO - Reading from file tmpfile_stdout 13:06:35 INFO - Output received: 13:06:35 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) 13:06:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:06:35 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')]} 13:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:35 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')]} 13:06:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:35 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 0x7f4373318f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13beca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bbf60>, '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 0x13bcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13bd1d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1475870776.943327-372654948', '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 13:06:35 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 13:06:35 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 13:06:35 INFO - Using env: {'DISPLAY': ':0', 13:06:35 INFO - 'HOME': '/home/cltbld', 13:06:35 INFO - 'LANG': 'en_US.UTF-8', 13:06:35 INFO - 'LANGUAGE': 'en_US:en', 13:06:35 INFO - 'LOGNAME': 'cltbld', 13:06:35 INFO - 'MAIL': '/var/mail/cltbld', 13:06:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:35 INFO - 'MOZ_NO_REMOTE': '1', 13:06:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:06:35 INFO - 'NO_EM_RESTART': '1', 13:06:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:06:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:06:35 INFO - 'PWD': '/builds/slave/test', 13:06:35 INFO - 'SHELL': '/bin/bash', 13:06:35 INFO - 'SHLVL': '1', 13:06:35 INFO - 'TERM': 'linux', 13:06:35 INFO - 'TMOUT': '86400', 13:06:35 INFO - 'USER': 'cltbld', 13:06:35 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1475870776.943327-372654948', 13:06:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:35 INFO - '_': '/tools/buildbot/bin/python'} 13:06:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:35 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 13:06:35 INFO - Cleaning up... 13:06:36 INFO - Return code: 0 13:06:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:06:36 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')]} 13:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:36 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')]} 13:06:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:36 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 0x7f4373318f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13beca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bbf60>, '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 0x13bcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13bd1d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1475870776.943327-372654948', '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 13:06:36 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 13:06:36 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 13:06:36 INFO - Using env: {'DISPLAY': ':0', 13:06:36 INFO - 'HOME': '/home/cltbld', 13:06:36 INFO - 'LANG': 'en_US.UTF-8', 13:06:36 INFO - 'LANGUAGE': 'en_US:en', 13:06:36 INFO - 'LOGNAME': 'cltbld', 13:06:36 INFO - 'MAIL': '/var/mail/cltbld', 13:06:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:36 INFO - 'MOZ_NO_REMOTE': '1', 13:06:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:06:36 INFO - 'NO_EM_RESTART': '1', 13:06:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:06:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:06:36 INFO - 'PWD': '/builds/slave/test', 13:06:36 INFO - 'SHELL': '/bin/bash', 13:06:36 INFO - 'SHLVL': '1', 13:06:36 INFO - 'TERM': 'linux', 13:06:36 INFO - 'TMOUT': '86400', 13:06:36 INFO - 'USER': 'cltbld', 13:06:36 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1475870776.943327-372654948', 13:06:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:36 INFO - '_': '/tools/buildbot/bin/python'} 13:06:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:36 INFO - Downloading/unpacking psutil>=3.1.1 13:06:36 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 13:06:36 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 13:06:36 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 13:06:36 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 13:06:36 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 13:06:36 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 13:06:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:06:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:06:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:06:38 INFO - Installing collected packages: psutil 13:06:38 INFO - Running setup.py install for psutil 13:06:38 INFO - building 'psutil._psutil_linux' extension 13:06:38 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 13:06:38 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 13:06:38 INFO - building 'psutil._psutil_posix' extension 13:06:38 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 13:06:38 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 13:06:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:06:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:06:38 INFO - Successfully installed psutil 13:06:38 INFO - Cleaning up... 13:06:38 INFO - Return code: 0 13:06:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:06:38 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')]} 13:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:38 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')]} 13:06:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:38 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 0x7f4373318f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13beca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bbf60>, '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 0x13bcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13bd1d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1475870776.943327-372654948', '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 13:06:38 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 13:06:38 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 13:06:38 INFO - Using env: {'DISPLAY': ':0', 13:06:38 INFO - 'HOME': '/home/cltbld', 13:06:38 INFO - 'LANG': 'en_US.UTF-8', 13:06:38 INFO - 'LANGUAGE': 'en_US:en', 13:06:38 INFO - 'LOGNAME': 'cltbld', 13:06:38 INFO - 'MAIL': '/var/mail/cltbld', 13:06:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:38 INFO - 'MOZ_NO_REMOTE': '1', 13:06:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:06:38 INFO - 'NO_EM_RESTART': '1', 13:06:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:06:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:06:38 INFO - 'PWD': '/builds/slave/test', 13:06:38 INFO - 'SHELL': '/bin/bash', 13:06:38 INFO - 'SHLVL': '1', 13:06:38 INFO - 'TERM': 'linux', 13:06:38 INFO - 'TMOUT': '86400', 13:06:38 INFO - 'USER': 'cltbld', 13:06:38 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1475870776.943327-372654948', 13:06:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:38 INFO - '_': '/tools/buildbot/bin/python'} 13:06:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:06:39 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 13:06:39 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 13:06:39 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 13:06:39 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 13:06:39 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 13:06:39 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 13:06:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:06:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:06:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:06:40 INFO - Installing collected packages: mozsystemmonitor 13:06:40 INFO - Running setup.py install for mozsystemmonitor 13:06:41 INFO - Successfully installed mozsystemmonitor 13:06:41 INFO - Cleaning up... 13:06:41 INFO - Return code: 0 13:06:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:06:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:06:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:06:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4373318f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13beca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bbf60>, '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 0x13bcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13bd1d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1475870776.943327-372654948', '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 13:06:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:06:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:06:41 INFO - Using env: {'DISPLAY': ':0', 13:06:41 INFO - 'HOME': '/home/cltbld', 13:06:41 INFO - 'LANG': 'en_US.UTF-8', 13:06:41 INFO - 'LANGUAGE': 'en_US:en', 13:06:41 INFO - 'LOGNAME': 'cltbld', 13:06:41 INFO - 'MAIL': '/var/mail/cltbld', 13:06:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:41 INFO - 'MOZ_NO_REMOTE': '1', 13:06:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:06:41 INFO - 'NO_EM_RESTART': '1', 13:06:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:06:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:06:41 INFO - 'PWD': '/builds/slave/test', 13:06:41 INFO - 'SHELL': '/bin/bash', 13:06:41 INFO - 'SHLVL': '1', 13:06:41 INFO - 'TERM': 'linux', 13:06:41 INFO - 'TMOUT': '86400', 13:06:41 INFO - 'USER': 'cltbld', 13:06:41 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1475870776.943327-372654948', 13:06:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:41 INFO - '_': '/tools/buildbot/bin/python'} 13:06:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:41 INFO - Downloading/unpacking jsonschema==2.5.1 13:06:41 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 13:06:41 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 13:06:41 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 13:06:41 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 13:06:41 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 13:06:41 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 13:06:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:06:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:06:43 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 13:06:43 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 13:06:43 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 13:06:43 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 13:06:43 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 13:06:43 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 13:06:43 INFO - Downloading functools32-3.2.3-2.tar.gz 13:06:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:06:43 INFO - warning: no files found matching '*.txt' 13:06:43 INFO - no previously-included directories found matching 'build' 13:06:43 INFO - no previously-included directories found matching 'dist' 13:06:43 INFO - no previously-included directories found matching '.git*' 13:06:43 INFO - Installing collected packages: jsonschema, functools32 13:06:43 INFO - Running setup.py install for functools32 13:06:43 INFO - warning: no files found matching '*.txt' 13:06:43 INFO - no previously-included directories found matching 'build' 13:06:43 INFO - no previously-included directories found matching 'dist' 13:06:43 INFO - no previously-included directories found matching '.git*' 13:06:43 INFO - Successfully installed jsonschema functools32 13:06:43 INFO - Cleaning up... 13:06:43 INFO - Return code: 0 13:06:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:06:43 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')]} 13:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:43 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')]} 13:06:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:43 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 0x7f4373318f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13beca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bbf60>, '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 0x13bcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13bd1d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1475870776.943327-372654948', '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 13:06:43 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 13:06:43 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 13:06:43 INFO - Using env: {'DISPLAY': ':0', 13:06:43 INFO - 'HOME': '/home/cltbld', 13:06:43 INFO - 'LANG': 'en_US.UTF-8', 13:06:43 INFO - 'LANGUAGE': 'en_US:en', 13:06:43 INFO - 'LOGNAME': 'cltbld', 13:06:43 INFO - 'MAIL': '/var/mail/cltbld', 13:06:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:43 INFO - 'MOZ_NO_REMOTE': '1', 13:06:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:06:43 INFO - 'NO_EM_RESTART': '1', 13:06:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:06:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:06:43 INFO - 'PWD': '/builds/slave/test', 13:06:43 INFO - 'SHELL': '/bin/bash', 13:06:43 INFO - 'SHLVL': '1', 13:06:43 INFO - 'TERM': 'linux', 13:06:43 INFO - 'TMOUT': '86400', 13:06:43 INFO - 'USER': 'cltbld', 13:06:43 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1475870776.943327-372654948', 13:06:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:43 INFO - '_': '/tools/buildbot/bin/python'} 13:06:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:06:43 INFO - Cleaning up... 13:06:43 INFO - Return code: 0 13:06:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:06:43 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')]} 13:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:43 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')]} 13:06:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:43 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 0x7f4373318f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13beca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bbf60>, '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 0x13bcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13bd1d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1475870776.943327-372654948', '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 13:06:43 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 13:06:43 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 13:06:43 INFO - Using env: {'DISPLAY': ':0', 13:06:43 INFO - 'HOME': '/home/cltbld', 13:06:43 INFO - 'LANG': 'en_US.UTF-8', 13:06:43 INFO - 'LANGUAGE': 'en_US:en', 13:06:43 INFO - 'LOGNAME': 'cltbld', 13:06:43 INFO - 'MAIL': '/var/mail/cltbld', 13:06:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:43 INFO - 'MOZ_NO_REMOTE': '1', 13:06:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:06:43 INFO - 'NO_EM_RESTART': '1', 13:06:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:06:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:06:43 INFO - 'PWD': '/builds/slave/test', 13:06:43 INFO - 'SHELL': '/bin/bash', 13:06:43 INFO - 'SHLVL': '1', 13:06:43 INFO - 'TERM': 'linux', 13:06:43 INFO - 'TMOUT': '86400', 13:06:43 INFO - 'USER': 'cltbld', 13:06:43 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1475870776.943327-372654948', 13:06:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:43 INFO - '_': '/tools/buildbot/bin/python'} 13:06:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:44 INFO - Downloading/unpacking blobuploader==1.2.4 13:06:44 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 13:06:44 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 13:06:44 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 13:06:44 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 13:06:44 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 13:06:44 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 13:06:45 INFO - Downloading blobuploader-1.2.4.tar.gz 13:06:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:06:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:06:46 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 13:06:46 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 13:06:46 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 13:06:46 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 13:06:46 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 13:06:46 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 13:06:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:06:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:06:46 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 13:06:46 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 13:06:46 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 13:06:46 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 13:06:46 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 13:06:46 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 13:06:46 INFO - Downloading docopt-0.6.1.tar.gz 13:06:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:06:46 INFO - Installing collected packages: blobuploader, requests, docopt 13:06:46 INFO - Running setup.py install for blobuploader 13:06:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:06:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:06:46 INFO - Running setup.py install for requests 13:06:47 INFO - Running setup.py install for docopt 13:06:47 INFO - Successfully installed blobuploader requests docopt 13:06:47 INFO - Cleaning up... 13:06:47 INFO - Return code: 0 13:06:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:06:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:06:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:47 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 0x7f4373318f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13beca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bbf60>, '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 0x13bcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13bd1d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1475870776.943327-372654948', '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 13:06:47 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 13:06:47 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 13:06:47 INFO - Using env: {'DISPLAY': ':0', 13:06:47 INFO - 'HOME': '/home/cltbld', 13:06:47 INFO - 'LANG': 'en_US.UTF-8', 13:06:47 INFO - 'LANGUAGE': 'en_US:en', 13:06:47 INFO - 'LOGNAME': 'cltbld', 13:06:47 INFO - 'MAIL': '/var/mail/cltbld', 13:06:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:47 INFO - 'MOZ_NO_REMOTE': '1', 13:06:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:06:47 INFO - 'NO_EM_RESTART': '1', 13:06:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:06:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:06:47 INFO - 'PWD': '/builds/slave/test', 13:06:47 INFO - 'SHELL': '/bin/bash', 13:06:47 INFO - 'SHLVL': '1', 13:06:47 INFO - 'TERM': 'linux', 13:06:47 INFO - 'TMOUT': '86400', 13:06:47 INFO - 'USER': 'cltbld', 13:06:47 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1475870776.943327-372654948', 13:06:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:47 INFO - '_': '/tools/buildbot/bin/python'} 13:06:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:06:47 INFO - Running setup.py (path:/tmp/pip-Lrmape-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:06:47 INFO - Running setup.py (path:/tmp/pip-5ceyJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:06:47 INFO - Running setup.py (path:/tmp/pip-9Bizwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:06:47 INFO - Running setup.py (path:/tmp/pip-_531GS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:06:47 INFO - Running setup.py (path:/tmp/pip-lCZAMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:06:47 INFO - Running setup.py (path:/tmp/pip-IdxTCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:06:48 INFO - Running setup.py (path:/tmp/pip-gOHoJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:06:48 INFO - Running setup.py (path:/tmp/pip-cN4lar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:06:48 INFO - Running setup.py (path:/tmp/pip-hhfSok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:06:48 INFO - Running setup.py (path:/tmp/pip-uUbH7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:06:48 INFO - Running setup.py (path:/tmp/pip-7PANz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:06:48 INFO - Running setup.py (path:/tmp/pip-9p8OIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:06:48 INFO - Running setup.py (path:/tmp/pip-jbrf29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:06:48 INFO - Running setup.py (path:/tmp/pip-GCEkfg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:06:48 INFO - Running setup.py (path:/tmp/pip-QMOerp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:06:48 INFO - Running setup.py (path:/tmp/pip-HAZPU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:06:48 INFO - Running setup.py (path:/tmp/pip-NjwQjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:06:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:06:48 INFO - Running setup.py install for manifestparser 13:06:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:06:48 INFO - Running setup.py install for mozcrash 13:06:49 INFO - Running setup.py install for mozdebug 13:06:49 INFO - Running setup.py install for mozdevice 13:06:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:06:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:06:49 INFO - Running setup.py install for mozfile 13:06:49 INFO - Running setup.py install for mozhttpd 13:06:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:06:49 INFO - Running setup.py install for mozinfo 13:06:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:06:49 INFO - Running setup.py install for mozInstall 13:06:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:06:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:06:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:06:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:06:49 INFO - Running setup.py install for mozleak 13:06:49 INFO - Running setup.py install for mozlog 13:06:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:06:49 INFO - Running setup.py install for moznetwork 13:06:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:06:49 INFO - Running setup.py install for mozprocess 13:06:50 INFO - Running setup.py install for mozprofile 13:06:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:06:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:06:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:06:50 INFO - Running setup.py install for mozrunner 13:06:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:06:50 INFO - Running setup.py install for mozscreenshot 13:06:50 INFO - Running setup.py install for moztest 13:06:50 INFO - Running setup.py install for mozversion 13:06:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:06:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:06:50 INFO - Cleaning up... 13:06:50 INFO - Return code: 0 13:06:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:06:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:06:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:50 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 0x7f4373318f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13beca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bbf60>, '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 0x13bcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13bd1d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1475870776.943327-372654948', '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 13:06:50 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 13:06:50 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 13:06:50 INFO - Using env: {'DISPLAY': ':0', 13:06:50 INFO - 'HOME': '/home/cltbld', 13:06:50 INFO - 'LANG': 'en_US.UTF-8', 13:06:50 INFO - 'LANGUAGE': 'en_US:en', 13:06:50 INFO - 'LOGNAME': 'cltbld', 13:06:50 INFO - 'MAIL': '/var/mail/cltbld', 13:06:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:50 INFO - 'MOZ_NO_REMOTE': '1', 13:06:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:06:50 INFO - 'NO_EM_RESTART': '1', 13:06:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:06:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:06:50 INFO - 'PWD': '/builds/slave/test', 13:06:50 INFO - 'SHELL': '/bin/bash', 13:06:50 INFO - 'SHLVL': '1', 13:06:50 INFO - 'TERM': 'linux', 13:06:50 INFO - 'TMOUT': '86400', 13:06:50 INFO - 'USER': 'cltbld', 13:06:50 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1475870776.943327-372654948', 13:06:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:50 INFO - '_': '/tools/buildbot/bin/python'} 13:06:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:06:50 INFO - Running setup.py (path:/tmp/pip-dADvsd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:06:50 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)) 13:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:06:50 INFO - Running setup.py (path:/tmp/pip-q67D4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:06:50 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)) 13:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:06:51 INFO - Running setup.py (path:/tmp/pip-wnFGRl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:06:51 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)) 13:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:06:51 INFO - Running setup.py (path:/tmp/pip-X8btMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:06:51 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)) 13:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:06:51 INFO - Running setup.py (path:/tmp/pip-YJwkVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:06:51 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)) 13:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:06:51 INFO - Running setup.py (path:/tmp/pip-8F3Ywc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:06:51 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)) 13:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:06:51 INFO - Running setup.py (path:/tmp/pip-MnhzJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:06:51 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)) 13:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:06:51 INFO - Running setup.py (path:/tmp/pip-HcR0b6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:06:51 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)) 13:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:06:51 INFO - Running setup.py (path:/tmp/pip-FmKBJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:06:51 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)) 13:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:06:51 INFO - Running setup.py (path:/tmp/pip-a_nK1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:06:51 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)) 13:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:06:51 INFO - Running setup.py (path:/tmp/pip-ZcUiqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:06:51 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)) 13:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:06:51 INFO - Running setup.py (path:/tmp/pip-ZLhNkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:06:51 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)) 13:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:06:51 INFO - Running setup.py (path:/tmp/pip-UMZD_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:06:51 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)) 13:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:06:51 INFO - Running setup.py (path:/tmp/pip-W9B70M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:06:51 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)) 13:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:06:51 INFO - Running setup.py (path:/tmp/pip-KdbY20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:06:51 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)) 13:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:06:51 INFO - Running setup.py (path:/tmp/pip-e05A6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:06:52 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)) 13:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:06:52 INFO - Running setup.py (path:/tmp/pip-8Ijpe9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:06:52 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)) 13:06:52 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)) 13:06:52 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)) 13:06:52 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)) 13:06:52 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)) 13:06:52 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)) 13:06:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:06:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:06:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:06:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:06:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:06:54 INFO - Downloading blessings-1.6.tar.gz 13:06:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:06:54 INFO - Installing collected packages: blessings 13:06:54 INFO - Running setup.py install for blessings 13:06:54 INFO - Successfully installed blessings 13:06:54 INFO - Cleaning up... 13:06:54 INFO - Return code: 0 13:06:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:06:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:06:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:06:54 INFO - Reading from file tmpfile_stdout 13:06:54 INFO - Current package versions: 13:06:54 INFO - argparse == 1.2.1 13:06:54 INFO - blessings == 1.6 13:06:54 INFO - blobuploader == 1.2.4 13:06:54 INFO - docopt == 0.6.1 13:06:54 INFO - functools32 == 3.2.3-2 13:06:54 INFO - jsonschema == 2.5.1 13:06:54 INFO - manifestparser == 1.1 13:06:54 INFO - mozInstall == 1.12 13:06:54 INFO - mozcrash == 0.17 13:06:54 INFO - mozdebug == 0.1 13:06:54 INFO - mozdevice == 0.48 13:06:54 INFO - mozfile == 1.2 13:06:54 INFO - mozhttpd == 0.7 13:06:54 INFO - mozinfo == 0.9 13:06:54 INFO - mozleak == 0.1 13:06:54 INFO - mozlog == 3.4 13:06:54 INFO - moznetwork == 0.27 13:06:54 INFO - mozprocess == 0.23 13:06:54 INFO - mozprofile == 0.28 13:06:54 INFO - mozrunner == 6.12 13:06:54 INFO - mozscreenshot == 0.1 13:06:54 INFO - mozsystemmonitor == 0.3 13:06:54 INFO - moztest == 0.7 13:06:54 INFO - mozversion == 1.4 13:06:54 INFO - psutil == 3.1.1 13:06:54 INFO - requests == 1.2.3 13:06:54 INFO - wsgiref == 0.1.2 13:06:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:06:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:06:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:54 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 0x7f4373318f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13beca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bbf60>, '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 0x13bcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13bd1d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1475870776.943327-372654948', '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 13:06:54 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 13:06:54 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 13:06:54 INFO - Using env: {'DISPLAY': ':0', 13:06:54 INFO - 'HOME': '/home/cltbld', 13:06:54 INFO - 'LANG': 'en_US.UTF-8', 13:06:54 INFO - 'LANGUAGE': 'en_US:en', 13:06:54 INFO - 'LOGNAME': 'cltbld', 13:06:54 INFO - 'MAIL': '/var/mail/cltbld', 13:06:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:54 INFO - 'MOZ_NO_REMOTE': '1', 13:06:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:06:54 INFO - 'NO_EM_RESTART': '1', 13:06:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:06:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:06:54 INFO - 'PWD': '/builds/slave/test', 13:06:54 INFO - 'SHELL': '/bin/bash', 13:06:54 INFO - 'SHLVL': '1', 13:06:54 INFO - 'TERM': 'linux', 13:06:54 INFO - 'TMOUT': '86400', 13:06:54 INFO - 'USER': 'cltbld', 13:06:54 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1475870776.943327-372654948', 13:06:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:54 INFO - '_': '/tools/buildbot/bin/python'} 13:06:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:54 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)) 13:06:54 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)) 13:06:54 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)) 13:06:54 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)) 13:06:54 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)) 13:06:54 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)) 13:06:54 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)) 13:06:54 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)) 13:06:54 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)) 13:06:54 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)) 13:06:54 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)) 13:06:54 INFO - Cleaning up... 13:06:54 INFO - Return code: 0 13:06:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:06:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:06:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:54 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 0x7f4373318f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13beca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13bbf60>, '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 0x13bcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13bd1d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1475870776.943327-372654948', '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 13:06:54 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 13:06:54 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 13:06:54 INFO - Using env: {'DISPLAY': ':0', 13:06:54 INFO - 'HOME': '/home/cltbld', 13:06:54 INFO - 'LANG': 'en_US.UTF-8', 13:06:54 INFO - 'LANGUAGE': 'en_US:en', 13:06:54 INFO - 'LOGNAME': 'cltbld', 13:06:54 INFO - 'MAIL': '/var/mail/cltbld', 13:06:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:54 INFO - 'MOZ_NO_REMOTE': '1', 13:06:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:06:54 INFO - 'NO_EM_RESTART': '1', 13:06:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:06:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:06:54 INFO - 'PWD': '/builds/slave/test', 13:06:54 INFO - 'SHELL': '/bin/bash', 13:06:54 INFO - 'SHLVL': '1', 13:06:54 INFO - 'TERM': 'linux', 13:06:54 INFO - 'TMOUT': '86400', 13:06:54 INFO - 'USER': 'cltbld', 13:06:54 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1475870776.943327-372654948', 13:06:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:54 INFO - '_': '/tools/buildbot/bin/python'} 13:06:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:06:54 INFO - Cleaning up... 13:06:54 INFO - Return code: 0 13:06:54 INFO - Running post-action listener: _resource_record_post_action 13:06:54 INFO - Running post-action listener: _start_resource_monitoring 13:06:54 INFO - Starting resource monitoring. 13:06:54 INFO - [mozharness: 2016-10-07 20:06:54.992340Z] Finished create-virtualenv step (success) 13:06:54 INFO - [mozharness: 2016-10-07 20:06:54.992848Z] Running install step. 13:06:54 INFO - Running pre-action listener: _resource_record_pre_action 13:06:54 INFO - Running main action method: install 13:06:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:06:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:06:55 INFO - Reading from file tmpfile_stdout 13:06:55 INFO - Detecting whether we're running mozinstall >=1.0... 13:06:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:06:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:06:55 INFO - Reading from file tmpfile_stdout 13:06:55 INFO - Output received: 13:06:55 INFO - Usage: mozinstall [options] installer 13:06:55 INFO - Options: 13:06:55 INFO - -h, --help show this help message and exit 13:06:55 INFO - -d DEST, --destination=DEST 13:06:55 INFO - Directory to install application into. [default: 13:06:55 INFO - "/builds/slave/test"] 13:06:55 INFO - --app=APP Application being installed. [default: firefox] 13:06:55 INFO - mkdir: /builds/slave/test/build/application 13:06:55 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'] 13:06:55 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 13:07:11 INFO - Reading from file tmpfile_stdout 13:07:11 INFO - Output received: 13:07:11 INFO - /builds/slave/test/build/application/firefox/firefox 13:07:11 INFO - Running post-action listener: _resource_record_post_action 13:07:11 INFO - [mozharness: 2016-10-07 20:07:11.425757Z] Finished install step (success) 13:07:11 INFO - [mozharness: 2016-10-07 20:07:11.426002Z] Running run-tests step. 13:07:11 INFO - Running pre-action listener: _resource_record_pre_action 13:07:11 INFO - Running main action method: run_tests 13:07:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:07:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:07:11 INFO - Python 2.7.3 13:07:11 INFO - Return code: 0 13:07:11 INFO - grabbing minidump binary from tooltool 13:07:11 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')]} 13:07:11 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 0x13bbf60>, '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 0x13bcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13bd1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:07:11 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 13:07:11 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 13:07:11 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 13:07:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:07:11 INFO - Return code: 0 13:07:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:07:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:07:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:07:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:07:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:07:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HmWIxuYTRfS3svN6UIExnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 13:07:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Larch-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HmWIxuYTRfS3svN6UIExnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --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 13:07:11 INFO - Using env: {'DISPLAY': ':0', 13:07:11 INFO - 'HOME': '/home/cltbld', 13:07:11 INFO - 'LANG': 'en_US.UTF-8', 13:07:11 INFO - 'LANGUAGE': 'en_US:en', 13:07:11 INFO - 'LOGNAME': 'cltbld', 13:07:11 INFO - 'MAIL': '/var/mail/cltbld', 13:07:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:07:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:07:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:11 INFO - 'MOZ_NO_REMOTE': '1', 13:07:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:07:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:11 INFO - 'NO_EM_RESTART': '1', 13:07:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:11 INFO - 'PWD': '/builds/slave/test', 13:07:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:07:11 INFO - 'SHELL': '/bin/bash', 13:07:11 INFO - 'SHLVL': '1', 13:07:11 INFO - 'TERM': 'linux', 13:07:11 INFO - 'TMOUT': '86400', 13:07:11 INFO - 'USER': 'cltbld', 13:07:11 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1475870776.943327-372654948', 13:07:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:11 INFO - '_': '/tools/buildbot/bin/python'} 13:07:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HmWIxuYTRfS3svN6UIExnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 13:07:11 INFO - mozversion application_buildid: 20161007113100 13:07:11 INFO - mozversion application_changeset: 259c110bf47100196fd28e35c47c4e23bf9ad0a9 13:07:11 INFO - mozversion application_display_name: Nightly 13:07:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:07:11 INFO - mozversion application_name: Firefox 13:07:11 INFO - mozversion application_remotingname: firefox 13:07:11 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 13:07:11 INFO - mozversion application_vendor: Mozilla 13:07:11 INFO - mozversion application_version: 52.0a1 13:07:11 INFO - mozversion platform_buildid: 20161007113100 13:07:11 INFO - mozversion platform_changeset: 259c110bf47100196fd28e35c47c4e23bf9ad0a9 13:07:11 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 13:07:11 INFO - mozversion platform_version: 52.0a1 13:07:11 INFO - using testdate: 1475870831 13:07:11 INFO - actual date: 1475870831 13:07:11 INFO - starting webserver on 'localhost:34024' 13:07:11 INFO - SUITE-START | Running 2 tests 13:07:11 INFO - TEST-START | dromaeo_css 13:07:11 INFO - operating with platform_type : linux_ 13:07:11 INFO - Initialising browser for dromaeo_css test... 13:07:11 INFO - TEST-INFO | started process 14989 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY4QeaS/profile http://localhost:34024/getInfo.html) 13:07:16 INFO - PROCESS | 14989 | __metrics Screen width/height:1600/1200 13:07:16 INFO - PROCESS | 14989 | colorDepth:24 13:07:16 INFO - PROCESS | 14989 | Browser inner width/height: 1024/697 13:07:16 INFO - PROCESS | 14989 | __metrics 13:07:16 INFO - PROCESS | 14989 | 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" 13:07:16 INFO - PROCESS | 14989 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:07:17 INFO - PROCESS | 14989 | console.error: PushService: 13:07:17 INFO - PROCESS | 14989 | stateChangeProcessEnqueue: Error transitioning state 13:07:17 INFO - PROCESS | 14989 | UnknownError 13:07:18 INFO - TEST-INFO | 14989: exit 0 13:07:18 INFO - Browser initialized. 13:07:18 INFO - Running cycle 1/1 for dromaeo_css test... 13:07:18 INFO - TEST-INFO | started process 15067 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY4QeaS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:07:30 INFO - PROCESS | 15067 | RSS: Main: 177573888 13:07:30 INFO - PROCESS | 15067 | 13:08:21 INFO - PROCESS | 15067 | 1475870901180 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] 13:10:35 INFO - PROCESS | 15067 | Cycle 1(1): loaded http://localhost:34024/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34024/tests/dromaeo/cssquery-ext.html) 13:10:36 INFO - PROCESS | 15067 | RSS: Main: 311369728 13:10:36 INFO - PROCESS | 15067 | 13:13:39 INFO - PROCESS | 15067 | Cycle 1(1): loaded http://localhost:34024/tests/dromaeo/cssquery-ext.html (next: http://localhost:34024/tests/dromaeo/cssquery-jquery.html) 13:13:39 INFO - PROCESS | 15067 | RSS: Main: 283262976 13:13:39 INFO - PROCESS | 15067 | 13:16:42 INFO - PROCESS | 15067 | Cycle 1(1): loaded http://localhost:34024/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34024/tests/dromaeo/cssquery-mootools.html) 13:16:42 INFO - PROCESS | 15067 | RSS: Main: 220504064 13:16:42 INFO - PROCESS | 15067 | 13:19:44 INFO - PROCESS | 15067 | Cycle 1(1): loaded http://localhost:34024/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34024/tests/dromaeo/cssquery-prototype.html) 13:19:45 INFO - PROCESS | 15067 | RSS: Main: 222117888 13:19:45 INFO - PROCESS | 15067 | 13:22:48 INFO - PROCESS | 15067 | Cycle 1(1): loaded http://localhost:34024/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34024/tests/dromaeo/cssquery-yui.html) 13:22:49 INFO - PROCESS | 15067 | RSS: Main: 221757440 13:22:49 INFO - PROCESS | 15067 | 13:25:52 INFO - PROCESS | 15067 | Cycle 1(1): loaded http://localhost:34024/tests/dromaeo/cssquery-yui.html (next: http://localhost:34024/tests/dromaeo/cssquery-dojo.html) 13:25:52 INFO - PROCESS | 15067 | RSS: Main: 314875904 13:25:52 INFO - PROCESS | 15067 | 13:25:52 INFO - PROCESS | 15067 | __start_tp_report 13:25:52 INFO - PROCESS | 15067 | _x_x_mozilla_page_load 13:25:52 INFO - PROCESS | 15067 | _x_x_mozilla_page_load_details 13:25:52 INFO - PROCESS | 15067 | |i|pagename|runs| 13:25:52 INFO - PROCESS | 15067 | |0;dojo.html;2578.7292334304902;2608.608708693697;2630.9736902630966;2636.3277364272108;2652.244110428527;4495.370648109268;4563.3839431676715;4696.718196908184;4737.028909073644;4737.644676649252;4605.79273932673;4715.952840471594;4759.666823322369;4788.186008378575;4832.347633069535;4268.253055715253;4283.37891005804;4316.956830431687;4330.307150855863;4352.499462561815;4359.237133501624;4390.100029493946;4395.494518130424;4406.052698669785;4416.86749397517;4200.4539409876525;4312.310030395153;4321.308590625485;4337.783110844461;4414.161309351213;4211.115665710205;4291.24903141952;4296.9140617187795;4297.656187505024;4312.159128969852;4276.957230427687;4282.272013757669;4282.614564689193;4283.229018776619;4291.592298731647;4632.675712700112;4688.2733176357715;4698.530146985308;4705.952940470585;4767.404074490689;5026.321446604698;5038.168702164138;5049.242613607951;5051.747412629354;5095.668781529189;4861.368022157097;5070.72111033893;5075.213341932006;5082.79668813247;5146.433892271847;4542.727436353796;4626.768661566908;4637.373954516164;4644.349791029259;4745.667803253739;5079.74601269935;5111.846644600668;5132.589392848563;5133.024725302181;5195.480451954774;4916.434610019822;4924.359833221658;4926.729029903389;4928.926066109011;4985.302057711923;4877.853664390074;4915.139850526144;4919.2129259318335;4991.176455884738;5035.471275516092;4992.650514463952;5029.145045342228;5051.570616497565;5068.873278168076;5084.644074914794;5001.949590585945;5025.597952163818;5027.1705168647495;5027.2207807789855;5071.746412679351;4165.062860856283;4197.034682023091;4199.496060472763;4317.805698743564;4319.913601728011;3685.94471082934;3719.423489359154;3724.4413337998976;3761.360568703327;3766.8304926278383;4246.787660616957;4250.298700714347;4300.053988122608;4300.849470268526;4301.268784306675;4974.32846565709;4974.751262436864;4990.675606085593;4990.975045124751;5049.040682270357;4142.399352093929;4186.351115577029;4187.350960601112;4232.047789247456;4278.7004909656025;4460.687751857339;4506.459224893034;4539.387182730356;4542.250528662734;4600.263957766741;4686.81252749893;4719.10337035962;4721.339012538316;4727.267273572465;4778.402699662543;4898.975505122594;5019.247112933089;5048.974755126201;5059.215821547666;5115.283860259492;4643.883902902319;4647.697899636512;4660.487346391962;4664.300354946785;4692.014676917749;4918.754062296799;4932.4081110267;4933.087378834927;4991.376077990251;4993.450720420823;5022.573081288131;5024.824131155392;5028.170351892043;5029.396472423333;5095.312132862016;4743.881402964954;4776.832810851603;4798.592119669867;4879.658423910292;4949.208126699711;4842.878928026827;4857.684250523705;4888.828890988798;4893.314935908905;4952.851414457572;4788.545088216614;4791.496892826203;4791.832285869978;4799.616030717604;4861.708297502161;4796.496367881462;4838;4849.660523763303;4920.92618610714;4987.526185012418;4788.353572267839;4819.325294458708;4833.202521583899;4916.532929371704;4918.311436398979 13:25:52 INFO - PROCESS | 15067 | |1;ext.html;554.6090006545386;559.8180591307824;562.2662425534676;566.9914951275731;575.2464271803935;28437.14688559344;38472.80763596181;39984.00039998998;40099.799501002526;44120.779396103055;40980.79509602448;41387.58612413875;41397.58602413975;41410.37884431736;41489.58510414895;7624.703800353939;7766.37868970481;7771.805704857367;7772.106207786092;7772.222777722211;7210.567365958033;7406.407487400995;9807.558659860324;10004.449755263458;10030.498475076254;10086.899131008706;10180.949095254551;10182.592696292177;10184.592616295377;10198.184145268398;10038.046385593394;10111.595536178544;10114.797704045952;10117.291789574732;10123.797524049478;9879.456629885353;9962.452065136415;9967.259003773948;9977.052180042885;9978.750531236705;37636.623633763586;37904.81047594772;37944.81027594872;37959.62040379616;37982;2820.562812764025;2907.3749143933946;3100.193949573105;3221.983890080535;3338.532605435241;27916.16251512458;28539.57190642142;28706.569401458994;28732.569011464635;28772;3219.951700724491;3285.227971426713;3340.816255105968;3349.7152742016956;3397.915052123692;172374;172973;173437;173452;173595.13202433908;47589.76205118952;47856;47860.28209576859;47880.5211947883;47898;29653.406931861242;30161.547576786365;30244.395112097634;30244.84877575598;57231.42768572344;14078.536256155132;14319.212443315717;14327.78508322376;14330.355134018993;14334.133173365368;9764.707058788248;9886.851697224547;11126.221164518405;11210.887891120985;11212.887871121347;15831.683366332609;15947.681046379008;15980.680386392207;17387.478375648752;18016.90991545034;6572.34276572339;6652.434543063797;6653.733850646016;6774.559653622498;7011.404030657452;771.699037375424;822.7038266224155;823.2749598827779;882.2721254964551;950.2493030505823;26487.867560662075;28548.85725571359;28647;28748;28825.855870720512;882.3999680217386;903.1420150856582;910.5219759626117;946.2146418472652;946.3848498476045;14501.927490362481;15135.848641513443;15238.847611523743;15241.390344386322;15365.464698324651;401796;403577;403777;404887;407363;50668;50970.74514627403;51254.487455124974;51282.23076653853;51289.487105129214;1126.695792136135;1165.3648761425043;1183.7277426192024;1184.117832214988;1201.471352604851;26377.868110659325;27845.860770696017;28461;28674;28807.855960720062;44218.3367249498;44798.328025079;44844.775776120914;44916;44938;276041.61979189975;277415;277606;277997;278010;38866.61133388743;39283.607163928;39356.606433935296;39373.60626393814;39416.2116757669;38415.6158438412;42107.57892421159;42529.57470425256;42935.35596965985;44459.3324400537;35782.64217357793;36425.635743642226;36536;36546.451803222444;36764.26471470609;35631;35925;36157;36180.4572931401;37046.44430333493;35659;36081.639183607826;36185;36502.4524632136;37116;31308.53037204398;33229;33311;33940.49089263712;34201.144971375914;25522.872385638697;25615.743842562082;25824.354391140372;25914.611280830424;26019.349516262246 13:25:52 INFO - PROCESS | 15067 | |2;jquery.html;334.89116037287886;347.1373636513264;354.08292522367066;357.1695807248148;373.9027852758282;12193.695157621063;13145.40845661945;15770.211489425526;16523.99999999997;17733.202005909734;15258.542243732678;15370.385184592631;15478.226088695577;17184.22670979806;17365.565860853483;4078.4697989261504;4808.591269742067;5042.596592272609;5044.545990860822;5045.873853153664;5780.161876527901;5942.227510423639;5975.25309336333;5987.371326010772;5992.670403127848;5092.439831618519;5362.410134885179;5953.315368732608;5953.672548009858;5956.970215148918;5420.295361603005;5453.64551304164;5461.290032295816;5461.317335333083;5464.617476776627;4496.392986946753;4756.595689366408;4790.712557246577;5272.393674727417;5280.6039547034125;19606.901965490222;19978.600427991503;20009.399718008484;20073;20235.494112647153;1686.4434736537037;1750.9299628014992;1874.9531261718566;1962.6957821537685;2006.4482267376588;8498.957505212435;8797.956010219972;9042.547872606343;9244.815103697889;9402.576884040167;1571.4735563586212;1678.4628918746007;1680.5714542791509;1685.4859267923277;1694.1529235382309;65924.34075659278;67788;69211.3078869215;72052.27947720508;74705.62647186729;9182.17360437564;9254.953725231331;9545.379550329206;9608.711738647851;9814;13310.534131305358;13335.199888006557;13354.933225334005;13372.732545349234;13391.665208369868;6767.35710107539;6889.827754306182;6970.302969702989;7106.467014973898;7152.356287934111;6583.670816459254;6601.240857301472;6740.460763138937;6746;6779.2881747416795;4030.1133750574827;4125.587441255911;4141.7722025288895;4210.694684647769;4252.425922500484;1671.9080450575336;1760.3838656470134;1793.609952286962;1874.175362840346;1876.596531745654;665.0323778901686;692.9272426395257;838.5429940682343;918.9172974432333;923.5382308845577;16244.59388515273;16320.510384688478;17089.743653845202;17773.555661108574;17966.730499042525;816.1063635319316;818.8771684247411;833.7165363776345;856.4347530629755;902.9706135006098;9265.119813617695;9280.67517636893;9797.167240784613;9906.653267135616;10087.49562521871;259080;265709;266262;363093;363662;74488.62755686187;75854.10364740925;76615;77210.61394692991;78739.21260787318;866.1987661413168;876.9667268506587;897.9326550508607;907.6006557114848;907.7186072317603;11604.593839215588;14559.490417835748;14601.634959126106;15686.76469852976;16186.919065404598;38192.61807381891;38466.615333846305;39093.60906391013;39416;39686.801565991984;48252.7587362075;49015.75492122517;49307.75346123247;49525.75237123791;49609.75195124001;6452.22573291208;6721.1598550181225;6948.5483443576;7403.370713489198;7852.803679908048;11438.256513326607;11994.700132496757;12423.565175218824;12511.249325040526;12519.812202817147;10291.53688084023;10463.424511651932;10542.683719488121;10547.683569492927;10730.409827459565;10545.367277963347;10581.788364232518;10599.364038157735;10638.84041739359;10849.403282819521;9799.951000244953;10418.218633602359;10551.261411701107;10833.891661083288;10949.178811589003;6870.793876183722;6896.310368963264;6922.307769223037;6977.197622273504;6997.965010174917;9514.23886089125;10295.3822770634;10624.52189651483;10654.946725266323;11042.227044106836 13:25:52 INFO - PROCESS | 15067 | |3;mootools.html;1297.8247936528571;1354.5056054540094;1356.9807179026666;1576.7556028815538;1608.364695945101;6935.375816176543;7463.477556571042;7474.364679002291;7476.738314159005;7482.513636613617;6170.8148755537295;6329.4619957303685;6989.790306290819;7201.1358636963505;7362.558246505213;1953.1308567687386;1963.862529622927;1973.891435971021;1974.3583335415976;1987.07600965551;1907.8092190780949;1954.5895361974003;1958.4124762571244;1967.7048442733562;1970.9310174143907;1678.102215314807;1694.2460605030767;1933.9903300483547;2002.1290738528714;2002.349236498144;1945.085809669453;1962.3229985654925;1963.9410817675493;1964.4597735622676;1966.8918209498472;1909.6371689378973;1955.1495099631563;1956.7456230690061;1958.4516335426104;1960.029785256293;7000.194977577593;7061.470389720792;7065.646717664147;7070.7525236616475;7107.857842843114;4164.3961625564425;4358.411614432042;4359.04101097758;4362.738235705868;4369.191699535564;2620.475904819044;2692.219256415637;2730.795190360731;2730.84980326082;2733.562629979214;789.1122487201898;801.1627848897915;820.6143112737004;845.3913182508645;847.3221422861748;9452.385594936375;9480.336376453652;9480.857787133198;9507.239420846316;9517.381370210915;3649.817509124533;3728.12389088564;3839.4816699745734;3870.4581358609817;3873.8063096845044;8355.373346999;8366.07973122956;8376.371772117116;8379.832403351898;8386.37102217324;4342.41377414045;4345.652347812167;4355.542668019875;4356.302991521341;4356.738595684269;3969.900752481211;3972.324704800191;3973.2450834341385;3974.4038394241097;3975.2447035063246;3256.690614391629;3419.4612424409115;3426.5716785401823;3439.6560343965402;3474.357243909885;1039.599754094664;1079.5897558927713;1090.6128324444867;1092.6667366453307;1094.1520321750547;587.9088741245114;687.4363022321648;765.8698021336386;789.8578255913876;804.6821505505293;4665.043666048452;4710.905781884343;4731.526847315241;4772.976135119302;4816.95183048165;797.7606717984581;802.1577343789115;815.7267315449272;821.0762891746784;822.3174764945081;3176.4758814795764;3287.6547962463596;3387.542681737934;3405.3359594879257;3415;8526.488410695378;8925.375223734407;8935.151160639729;8947.060558641379;8953.820923581492;8818.603162857687;8852.070532594114;8855.424397414276;8860.069692682175;8871.733847984571;6690.330966903368;6701.396874281338;6762.120924279812;6787.321267873173;6853.588784672936;4725.40932383452;4746.145693775154;4764.880877978078;4767.094252092092;4856.854294371175;8128.75613731589;8194.467359621605;8248.793780155544;8257.917420825715;8288.046874609498;7476.214997425192;7795.766127016199;7806.57063861493;8337.416380853525;8370.66517339324;6310.337414571588;6454.838629034311;6465.418112369909;6467.514936379696;6469.191351081115;6898.103246577913;6956.339147780953;6961;6961;6962.373386395248;6121.326654068138;6171.9691401542705;6206.72069756853;6236.095766113797;6236.968815155895;6133.141360209664;6192.195014648067;6229.781957631461;6333.778317759041;6373.74505019794;5501.202325662836;5539.667619942655;5609.551235901036;5628.352739434854;5749.482546570829;4282.293421585528;4334.45819272591;4403.273459879084;4410.09593033421;4483.484399294123;4379.627731642719;4391.692581519263;4462.531434199363;4531.954680453153;4541.341505481752 13:25:52 INFO - PROCESS | 15067 | |4;prototype.html;281.19437810672423;283.947469718102;289.55697782392934;290.40901764908415;291.0555248219528;4786.353842231298;4821.325014497973;4830.806767729296;4857.781399837007;4886.951130488694;4809.326694262806;4810.086083644105;4818.108649899771;4824.914394261289;4842.975785121078;3562.2341196642715;3696.6488183622646;3705.4256590228556;3824.9808750956277;3825.445310429986;3777.848886044555;3806.60030696777;3806.8667596634123;3807.923841523168;3817.2938006468894;3786.734928555002;3791.3365161096835;3792.317382871082;3797.316483033053;3810.771353718772;3613.927721445583;3659.79871107089;3698.981505092457;3821.445890345898;3825.617438256166;3309.8841540546205;3317.717993970515;3324.202191474053;3340.7160391366765;3343.7157841583494;4639;4647.884507718157;4666;4668.906621867578;4671.813127474897;4168.624823765876;4257.233697934371;4262.595053469915;4268.637165840876;4285.46431696038;4983.782216913475;4994.325766021613;5003.824866129705;5007.6244281678655;5009.4239162496415;3597.94603080954;3609.2240168363664;3621.3481573316794;3625.5830579483168;3625.782453052825;5259.815906443295;5269.868253293698;5289.603279754034;5290.497402746733;5290.81482148123;3606.6032736398975;3663.8383353821373;3699.6855267302044;3708.3683179400978;3709.7201465494363;3753.49327840738;3754.962450375516;3755.962440375616;3756.492873462102;3759.4924685167152;4263.381809637585;4286.164197981426;4288.206681763883;4288.606202984042;4305.720128191658;4837.298591704183;5004.149294619923;5021.72380519075;5057;5086.237064440364;1272.5037235478171;1295.7149427126017;1295.7861952777687;1300.2458574027041;1300.938013248992;806.4032615864219;828.9668413263402;835.7910522369408;836.652789092532;844.907060223375;3964.9801750991637;3976.701747368959;4224.345226489899;4330.155619654201;4366.602687140148;5126.897462050738;5180.9740951295;5196.53231209193;5220.3735551734035;5243.161094224905;4426.667999900021;4426.84506042287;4429.734215947054;4431.202383570923;4443.133588950123;2616.947661046768;2724.441489494649;2726.877290521931;2742.6297449844415;2756.379814541712;4806.255030470283;4824.855254342376;4837.443693975238;4868.318435419044;4869.756512174448;5298.655587386807;5301.416844147141;5305.840824775263;5316.76074576645;5321.441248668912;4700.2244629635725;4810.759462026885;4834;4843.467218606021;4872.829450969199;5157.381114266162;5170.405403378509;5190.6107041972755;5201.583873290203;5202.245674377118;5095.108356037605;5109.642325037212;5112.872178195426;5115.823360627002;5125.5899528036925;4710.633916164411;4820.975895120502;4843.539863712942;4845.6608037437045;4856;3687.580281591553;3701.5373078365205;3709.647583479565;3712.888613341604;3715.2723983347873;5207.3490813648295;5214.8957020860125;5229.973850130725;5238.266642669953;5244.711540865289;4840.757962101951;4987.401511818605;5027.748612569284;5040.269160971712;5076.619253556072;5015.949840501548;5032.547070763649;5035.546800787946;5039.344885165052;5044;4976.183692952119;4989.330708071165;4993.400791904995;4998;4999.125153098121;4817.975910120427;4859.757012149449;5084.3644544431945;5100.285959965682;5102;4852.902941941212;4869.415670119608;4970.105381031449;5002.274670172732;5016.573591244785 13:25:52 INFO - PROCESS | 15067 | |5;yui.html;608.1151923950653;633.6008314761702;633.9207599050119;641.8940874755666;650.2749434380667;12496.062795290343;13147.6713082173;13490.730185396285;13497.527586534474;13512.662183445418;12899.742005159891;12958.028147888923;12958.15771974821;12962;13036.478540858354;617.3456136495307;633.395107672172;745.0872680965828;752.6989204318289;768.6694721269852;755.7619349904762;776.316841179761;777.0675189772268;777.2305417636527;777.3276116159537;818.8812622169781;819.3772732723114;819.4509678515409;820.0282665041915;820.2863508747398;651.661136209171;671.0136099933139;790.1821614628889;806.0287353738789;818.1450384348341;601.2094096263444;601.6390165900468;601.969901504923;602.1810337940398;602.3253955569746;12159.817602735966;12168.51325946961;12201.633950981484;12205.511779528808;12226.877731222752;11940.462679179458;12414.503419863195;12638.49446022158;13010.414531346112;13247.933760331136;10998.505067271992;11221.158413119048;11311.943440282828;11635.30188188703;11856.288622682581;4002.5397079335958;4009.3585026395635;4026.6778657707314;4052.918941621151;4065.6747460203114;62217.377826222066;62642;62861.37138628647;63013.68493157505;64160;9486.573104210327;9616.23070154386;10180.643677471253;10320.845187322197;10733.570657173781;19152.52118697016;19176.424707258804;19179.61640767177;19181.232750690095;19257.4222773317;6279.403456671609;6429.228492580826;6522.934770652328;6554.901676474857;6578.440832529192;3527.7354198434705;3549.8757543485854;3552.626974167727;3558.7508874378545;3618.9819050905103;2668.986655066751;2749.8625068746883;2764.129299270723;2767.6263704400053;2805.4809860175933;494.6216144649346;500.5845148526714;508.8371721049303;511.2254933775333;513.8175947538645;455.87007702805204;549.9120140777536;584.7018020809418;611.1535523300261;635.9109724638554;7968.521888686697;8834.823303534022;8839.508882913162;8983.966843812914;9027.097290271051;592.703648175912;604.7036951893629;608.2032537376051;611.2084850119106;644.2816259870211;3895.2599006188734;4215.515215750167;4216.746995180299;4298.290782020994;4299.398084268205;53650.46349536533;57101;57285;57313.713431432574;59812;86081.5695921529;87336.56331718301;87376;88474.55762721274;90156.54921725481;47223;69920.75594330445;74797.62601187069;77324.61337693501;77333.61333193298;7276.381507571916;7786.221377862168;7845.960770196112;7878.330341921001;7949.523028618301;42417.575824241365;42855.785721071195;43277;43417.56582434135;45192.096158076;55865.44134558603;62585;62685.05972410326;63060;63223;10213.795724085625;10320.638777642747;10476.793901508196;10507.842382364424;10573.365598064142;11073.50169242402;11183.440827958408;11645.88354116448;11754.823677644672;11871.821922670993;10615.31000484966;10821.18841086906;11184.384858832842;11190.440477976232;11248.7750244993;10846.728831779268;10992.450377480935;11067.446627668423;11427.657170284905;11429.428528573704;10004.899951000396;10018.345138538147;10326;10740;10749.462526873469;8555.657773688983;8730.956345218234;8954.68658596972;8971.82056358856;9245.907540924505;9081.228095611947;9622.37454565451;9644.807103858024;9671.758206044906;9768.681228034124 13:25:52 INFO - PROCESS | 15067 | __end_tp_report 13:25:52 INFO - PROCESS | 15067 | __start_cc_report 13:25:52 INFO - PROCESS | 15067 | _x_x_mozilla_cycle_collect,1266 13:25:52 INFO - PROCESS | 15067 | __end_cc_report 13:25:52 INFO - PROCESS | 15067 | __startTimestamp1475871952752__endTimestamp 13:25:52 INFO - PROCESS | 15067 | 13:25:52 INFO - PROCESS | 15067 | ------- Summary: start ------- 13:25:52 INFO - PROCESS | 15067 | Number of tests: 6 13:25:52 INFO - PROCESS | 15067 | 13:25:52 INFO - PROCESS | 15067 | [#0] dojo.html Cycles:165 Average:4629.46 Median:4767.40 stddev:489.48 (10.3%) stddev-sans-first:463.79 13:25:52 INFO - PROCESS | 15067 | Values: 2578.7 2608.6 2631.0 2636.3 2652.2 4495.4 4563.4 4696.7 4737.0 4737.6 4605.8 4716.0 4759.7 4788.2 4832.3 4268.3 4283.4 4317.0 4330.3 4352.5 4359.2 4390.1 4395.5 4406.1 4416.9 4200.5 4312.3 4321.3 4337.8 4414.2 4211.1 4291.2 4296.9 4297.7 4312.2 4277.0 4282.3 4282.6 4283.2 4291.6 4632.7 4688.3 4698.5 4706.0 4767.4 5026.3 5038.2 5049.2 5051.7 5095.7 4861.4 5070.7 5075.2 5082.8 5146.4 4542.7 4626.8 4637.4 4644.3 4745.7 5079.7 5111.8 5132.6 5133.0 5195.5 4916.4 4924.4 4926.7 4928.9 4985.3 4877.9 4915.1 4919.2 4991.2 5035.5 4992.7 5029.1 5051.6 5068.9 5084.6 5001.9 5025.6 5027.2 5027.2 5071.7 4165.1 4197.0 4199.5 4317.8 4319.9 3685.9 3719.4 3724.4 3761.4 3766.8 4246.8 4250.3 4300.1 4300.8 4301.3 4974.3 4974.8 4990.7 4991.0 5049.0 4142.4 4186.4 4187.4 4232.0 4278.7 4460.7 4506.5 4539.4 4542.3 4600.3 4686.8 4719.1 4721.3 4727.3 4778.4 4899.0 5019.2 5049.0 5059.2 5115.3 4643.9 4647.7 4660.5 4664.3 4692.0 4918.8 4932.4 4933.1 4991.4 4993.5 5022.6 5024.8 5028.2 5029.4 5095.3 4743.9 4776.8 4798.6 4879.7 4949.2 4842.9 4857.7 4888.8 4893.3 4952.9 4788.5 4791.5 4791.8 4799.6 4861.7 4796.5 4838.0 4849.7 4920.9 4987.5 4788.4 4819.3 4833.2 4916.5 4918.3 13:25:52 INFO - PROCESS | 15067 | 13:25:52 INFO - PROCESS | 15067 | [#1] ext.html Cycles:180 Average:44601.37 Median:36168.73 stddev:79182.86 (218.9%) stddev-sans-first:79335.92 13:25:52 INFO - PROCESS | 15067 | Values: 554.6 559.8 562.3 567.0 575.2 28437.1 38472.8 39984.0 40099.8 44120.8 40980.8 41387.6 41397.6 41410.4 41489.6 7624.7 7766.4 7771.8 7772.1 7772.2 7210.6 7406.4 9807.6 10004.4 10030.5 10086.9 10180.9 10182.6 10184.6 10198.2 10038.0 10111.6 10114.8 10117.3 10123.8 9879.5 9962.5 9967.3 9977.1 9978.8 37636.6 37904.8 37944.8 37959.6 37982.0 2820.6 2907.4 3100.2 3222.0 3338.5 27916.2 28539.6 28706.6 28732.6 28772.0 3220.0 3285.2 3340.8 3349.7 3397.9 172374.0 172973.0 173437.0 173452.0 173595.1 47589.8 47856.0 47860.3 47880.5 47898.0 29653.4 30161.5 30244.4 30244.8 57231.4 14078.5 14319.2 14327.8 14330.4 14334.1 9764.7 9886.9 11126.2 11210.9 11212.9 15831.7 15947.7 15980.7 17387.5 18016.9 6572.3 6652.4 6653.7 6774.6 7011.4 771.7 822.7 823.3 882.3 950.2 26487.9 28548.9 28647.0 28748.0 28825.9 882.4 903.1 910.5 946.2 946.4 14501.9 15135.8 15238.8 15241.4 15365.5 401796.0 403577.0 403777.0 404887.0 407363.0 50668.0 50970.7 51254.5 51282.2 51289.5 1126.7 1165.4 1183.7 1184.1 1201.5 26377.9 27845.9 28461.0 28674.0 28807.9 44218.3 44798.3 44844.8 44916.0 44938.0 276041.6 277415.0 277606.0 277997.0 278010.0 38866.6 39283.6 39356.6 39373.6 39416.2 38415.6 42107.6 42529.6 42935.4 44459.3 35782.6 36425.6 36536.0 36546.5 36764.3 35631.0 35925.0 36157.0 36180.5 37046.4 35659.0 36081.6 36185.0 36502.5 37116.0 31308.5 33229.0 33311.0 33940.5 34201.1 25522.9 25615.7 25824.4 25914.6 26019.3 13:25:52 INFO - PROCESS | 15067 | 13:25:52 INFO - PROCESS | 15067 | [#2] jquery.html Cycles:180 Average:21765.85 Median:4626.49 stddev:51509.59 (1113.4%) stddev-sans-first:51628.95 13:25:52 INFO - PROCESS | 15067 | Values: 334.9 347.1 354.1 357.2 373.9 12193.7 13145.4 15770.2 16524.0 17733.2 15258.5 15370.4 15478.2 17184.2 17365.6 4078.5 4808.6 5042.6 5044.5 5045.9 5780.2 5942.2 5975.3 5987.4 5992.7 5092.4 5362.4 5953.3 5953.7 5957.0 5420.3 5453.6 5461.3 5461.3 5464.6 4496.4 4756.6 4790.7 5272.4 5280.6 19606.9 19978.6 20009.4 20073.0 20235.5 1686.4 1750.9 1875.0 1962.7 2006.4 8499.0 8798.0 9042.5 9244.8 9402.6 1571.5 1678.5 1680.6 1685.5 1694.2 65924.3 67788.0 69211.3 72052.3 74705.6 9182.2 9255.0 9545.4 9608.7 9814.0 13310.5 13335.2 13354.9 13372.7 13391.7 6767.4 6889.8 6970.3 7106.5 7152.4 6583.7 6601.2 6740.5 6746.0 6779.3 4030.1 4125.6 4141.8 4210.7 4252.4 1671.9 1760.4 1793.6 1874.2 1876.6 665.0 692.9 838.5 918.9 923.5 16244.6 16320.5 17089.7 17773.6 17966.7 816.1 818.9 833.7 856.4 903.0 9265.1 9280.7 9797.2 9906.7 10087.5 259080.0 265709.0 266262.0 363093.0 363662.0 74488.6 75854.1 76615.0 77210.6 78739.2 866.2 877.0 897.9 907.6 907.7 11604.6 14559.5 14601.6 15686.8 16186.9 38192.6 38466.6 39093.6 39416.0 39686.8 48252.8 49015.8 49307.8 49525.8 49609.8 6452.2 6721.2 6948.5 7403.4 7852.8 11438.3 11994.7 12423.6 12511.2 12519.8 10291.5 10463.4 10542.7 10547.7 10730.4 10545.4 10581.8 10599.4 10638.8 10849.4 9800.0 10418.2 10551.3 10833.9 10949.2 6870.8 6896.3 6922.3 6977.2 6998.0 9514.2 10295.4 10624.5 10654.9 11042.2 13:25:52 INFO - PROCESS | 15067 | 13:25:52 INFO - PROCESS | 15067 | [#3] mootools.html Cycles:180 Average:4721.87 Median:5520.43 stddev:2624.19 (47.5%) stddev-sans-first:2618.93 13:25:52 INFO - PROCESS | 15067 | Values: 1297.8 1354.5 1357.0 1576.8 1608.4 6935.4 7463.5 7474.4 7476.7 7482.5 6170.8 6329.5 6989.8 7201.1 7362.6 1953.1 1963.9 1973.9 1974.4 1987.1 1907.8 1954.6 1958.4 1967.7 1970.9 1678.1 1694.2 1934.0 2002.1 2002.3 1945.1 1962.3 1963.9 1964.5 1966.9 1909.6 1955.1 1956.7 1958.5 1960.0 7000.2 7061.5 7065.6 7070.8 7107.9 4164.4 4358.4 4359.0 4362.7 4369.2 2620.5 2692.2 2730.8 2730.8 2733.6 789.1 801.2 820.6 845.4 847.3 9452.4 9480.3 9480.9 9507.2 9517.4 3649.8 3728.1 3839.5 3870.5 3873.8 8355.4 8366.1 8376.4 8379.8 8386.4 4342.4 4345.7 4355.5 4356.3 4356.7 3969.9 3972.3 3973.2 3974.4 3975.2 3256.7 3419.5 3426.6 3439.7 3474.4 1039.6 1079.6 1090.6 1092.7 1094.2 587.9 687.4 765.9 789.9 804.7 4665.0 4710.9 4731.5 4773.0 4817.0 797.8 802.2 815.7 821.1 822.3 3176.5 3287.7 3387.5 3405.3 3415.0 8526.5 8925.4 8935.2 8947.1 8953.8 8818.6 8852.1 8855.4 8860.1 8871.7 6690.3 6701.4 6762.1 6787.3 6853.6 4725.4 4746.1 4764.9 4767.1 4856.9 8128.8 8194.5 8248.8 8257.9 8288.0 7476.2 7795.8 7806.6 8337.4 8370.7 6310.3 6454.8 6465.4 6467.5 6469.2 6898.1 6956.3 6961.0 6961.0 6962.4 6121.3 6172.0 6206.7 6236.1 6237.0 6133.1 6192.2 6229.8 6333.8 6373.7 5501.2 5539.7 5609.6 5628.4 5749.5 4282.3 4334.5 4403.3 4410.1 4483.5 4379.6 4391.7 4462.5 4532.0 4541.3 13:25:52 INFO - PROCESS | 15067 | 13:25:52 INFO - PROCESS | 15067 | [#4] prototype.html Cycles:180 Average:4178.84 Median:4810.42 stddev:1215.37 (25.3%) stddev-sans-first:1183.05 13:25:52 INFO - PROCESS | 15067 | Values: 281.2 283.9 289.6 290.4 291.1 4786.4 4821.3 4830.8 4857.8 4887.0 4809.3 4810.1 4818.1 4824.9 4843.0 3562.2 3696.6 3705.4 3825.0 3825.4 3777.8 3806.6 3806.9 3807.9 3817.3 3786.7 3791.3 3792.3 3797.3 3810.8 3613.9 3659.8 3699.0 3821.4 3825.6 3309.9 3317.7 3324.2 3340.7 3343.7 4639.0 4647.9 4666.0 4668.9 4671.8 4168.6 4257.2 4262.6 4268.6 4285.5 4983.8 4994.3 5003.8 5007.6 5009.4 3597.9 3609.2 3621.3 3625.6 3625.8 5259.8 5269.9 5289.6 5290.5 5290.8 3606.6 3663.8 3699.7 3708.4 3709.7 3753.5 3755.0 3756.0 3756.5 3759.5 4263.4 4286.2 4288.2 4288.6 4305.7 4837.3 5004.1 5021.7 5057.0 5086.2 1272.5 1295.7 1295.8 1300.2 1300.9 806.4 829.0 835.8 836.7 844.9 3965.0 3976.7 4224.3 4330.2 4366.6 5126.9 5181.0 5196.5 5220.4 5243.2 4426.7 4426.8 4429.7 4431.2 4443.1 2616.9 2724.4 2726.9 2742.6 2756.4 4806.3 4824.9 4837.4 4868.3 4869.8 5298.7 5301.4 5305.8 5316.8 5321.4 4700.2 4810.8 4834.0 4843.5 4872.8 5157.4 5170.4 5190.6 5201.6 5202.2 5095.1 5109.6 5112.9 5115.8 5125.6 4710.6 4821.0 4843.5 4845.7 4856.0 3687.6 3701.5 3709.6 3712.9 3715.3 5207.3 5214.9 5230.0 5238.3 5244.7 4840.8 4987.4 5027.7 5040.3 5076.6 5015.9 5032.5 5035.5 5039.3 5044.0 4976.2 4989.3 4993.4 4998.0 4999.1 4818.0 4859.8 5084.4 5100.3 5102.0 4852.9 4869.4 4970.1 5002.3 5016.6 13:25:52 INFO - PROCESS | 15067 | 13:25:52 INFO - PROCESS | 15067 | [#5] yui.html Cycles:180 Average:16393.87 Median:27100.19 stddev:22508.33 (83.1%) stddev-sans-first:22540.27 13:25:52 INFO - PROCESS | 15067 | Values: 608.1 633.6 633.9 641.9 650.3 12496.1 13147.7 13490.7 13497.5 13512.7 12899.7 12958.0 12958.2 12962.0 13036.5 617.3 633.4 745.1 752.7 768.7 755.8 776.3 777.1 777.2 777.3 818.9 819.4 819.5 820.0 820.3 651.7 671.0 790.2 806.0 818.1 601.2 601.6 602.0 602.2 602.3 12159.8 12168.5 12201.6 12205.5 12226.9 11940.5 12414.5 12638.5 13010.4 13247.9 10998.5 11221.2 11311.9 11635.3 11856.3 4002.5 4009.4 4026.7 4052.9 4065.7 62217.4 62642.0 62861.4 63013.7 64160.0 9486.6 9616.2 10180.6 10320.8 10733.6 19152.5 19176.4 19179.6 19181.2 19257.4 6279.4 6429.2 6522.9 6554.9 6578.4 3527.7 3549.9 3552.6 3558.8 3619.0 2669.0 2749.9 2764.1 2767.6 2805.5 494.6 500.6 508.8 511.2 513.8 455.9 549.9 584.7 611.2 635.9 7968.5 8834.8 8839.5 8984.0 9027.1 592.7 604.7 608.2 611.2 644.3 3895.3 4215.5 4216.7 4298.3 4299.4 53650.5 57101.0 57285.0 57313.7 59812.0 86081.6 87336.6 87376.0 88474.6 90156.5 47223.0 69920.8 74797.6 77324.6 77333.6 7276.4 7786.2 7846.0 7878.3 7949.5 42417.6 42855.8 43277.0 43417.6 45192.1 55865.4 62585.0 62685.1 63060.0 63223.0 10213.8 10320.6 10476.8 10507.8 10573.4 11073.5 11183.4 11645.9 11754.8 11871.8 10615.3 10821.2 11184.4 11190.4 11248.8 10846.7 10992.5 11067.4 11427.7 11429.4 10004.9 10018.3 10326.0 10740.0 10749.5 8555.7 8731.0 8954.7 8971.8 9245.9 9081.2 9622.4 9644.8 9671.8 9768.7 13:25:52 INFO - PROCESS | 15067 | -------- Summary: end -------- 13:25:52 INFO - PROCESS | 15067 | 13:25:53 INFO - TEST-INFO | 15067: exit 0 13:25:53 INFO - TEST-OK | dromaeo_css | took 1122038ms 13:25:53 INFO - TEST-START | kraken 13:25:53 INFO - operating with platform_type : linux_ 13:25:53 INFO - Initialising browser for kraken test... 13:25:53 INFO - TEST-INFO | started process 15375 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnI3ptA/profile http://localhost:34024/getInfo.html) 13:25:58 INFO - PROCESS | 15375 | __metrics Screen width/height:1600/1200 13:25:58 INFO - PROCESS | 15375 | colorDepth:24 13:25:58 INFO - PROCESS | 15375 | Browser inner width/height: 1024/697 13:25:58 INFO - PROCESS | 15375 | __metrics 13:25:58 INFO - PROCESS | 15375 | 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" 13:25:58 INFO - PROCESS | 15375 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:26:00 INFO - TEST-INFO | 15375: exit 0 13:26:00 INFO - Browser initialized. 13:26:00 INFO - Running cycle 1/1 for kraken test... 13:26:00 INFO - TEST-INFO | started process 15456 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnI3ptA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:26:12 INFO - PROCESS | 15456 | RSS: Main: 177614848 13:26:12 INFO - PROCESS | 15456 | 13:26:15 INFO - PROCESS | 15456 | Cycle 1(1): loaded http://localhost:34024/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34024/tests/kraken/driver.html?testName=audio-beat-detection) 13:26:16 INFO - PROCESS | 15456 | RSS: Main: 244641792 13:26:16 INFO - PROCESS | 15456 | 13:26:18 INFO - PROCESS | 15456 | Cycle 1(1): loaded http://localhost:34024/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34024/tests/kraken/driver.html?testName=audio-dft) 13:26:19 INFO - PROCESS | 15456 | RSS: Main: 221220864 13:26:19 INFO - PROCESS | 15456 | 13:26:22 INFO - PROCESS | 15456 | Cycle 1(1): loaded http://localhost:34024/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34024/tests/kraken/driver.html?testName=audio-fft) 13:26:23 INFO - PROCESS | 15456 | RSS: Main: 303263744 13:26:23 INFO - PROCESS | 15456 | 13:26:25 INFO - PROCESS | 15456 | Cycle 1(1): loaded http://localhost:34024/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34024/tests/kraken/driver.html?testName=audio-oscillator) 13:26:26 INFO - PROCESS | 15456 | RSS: Main: 211849216 13:26:26 INFO - PROCESS | 15456 | 13:26:28 INFO - PROCESS | 15456 | Cycle 1(1): loaded http://localhost:34024/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34024/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:26:29 INFO - PROCESS | 15456 | RSS: Main: 215957504 13:26:29 INFO - PROCESS | 15456 | 13:26:32 INFO - PROCESS | 15456 | Cycle 1(1): loaded http://localhost:34024/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34024/tests/kraken/driver.html?testName=imaging-darkroom) 13:26:32 INFO - PROCESS | 15456 | RSS: Main: 253161472 13:26:32 INFO - PROCESS | 15456 | 13:26:36 INFO - PROCESS | 15456 | Cycle 1(1): loaded http://localhost:34024/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34024/tests/kraken/driver.html?testName=imaging-desaturate) 13:26:36 INFO - PROCESS | 15456 | RSS: Main: 246800384 13:26:36 INFO - PROCESS | 15456 | 13:26:39 INFO - PROCESS | 15456 | Cycle 1(1): loaded http://localhost:34024/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34024/tests/kraken/driver.html?testName=json-parse-financial) 13:26:40 INFO - PROCESS | 15456 | RSS: Main: 249040896 13:26:40 INFO - PROCESS | 15456 | 13:26:42 INFO - PROCESS | 15456 | Cycle 1(1): loaded http://localhost:34024/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34024/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:26:42 INFO - PROCESS | 15456 | RSS: Main: 212717568 13:26:42 INFO - PROCESS | 15456 | 13:26:44 INFO - PROCESS | 15456 | Cycle 1(1): loaded http://localhost:34024/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34024/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:26:45 INFO - PROCESS | 15456 | RSS: Main: 219877376 13:26:45 INFO - PROCESS | 15456 | 13:26:47 INFO - PROCESS | 15456 | Cycle 1(1): loaded http://localhost:34024/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34024/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:26:48 INFO - PROCESS | 15456 | RSS: Main: 229687296 13:26:48 INFO - PROCESS | 15456 | 13:26:50 INFO - PROCESS | 15456 | Cycle 1(1): loaded http://localhost:34024/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34024/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:26:51 INFO - PROCESS | 15456 | RSS: Main: 238346240 13:26:51 INFO - PROCESS | 15456 | 13:26:54 INFO - PROCESS | 15456 | Cycle 1(1): loaded http://localhost:34024/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34024/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:26:55 INFO - PROCESS | 15456 | RSS: Main: 234614784 13:26:55 INFO - PROCESS | 15456 | 13:26:56 INFO - PROCESS | 15456 | Cycle 1(1): loaded http://localhost:34024/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34024/tests/kraken/driver.html?testName=ai-astar) 13:26:57 INFO - PROCESS | 15456 | RSS: Main: 284823552 13:26:57 INFO - PROCESS | 15456 | 13:26:57 INFO - PROCESS | 15456 | __start_tp_report 13:26:57 INFO - PROCESS | 15456 | _x_x_mozilla_page_load 13:26:57 INFO - PROCESS | 15456 | _x_x_mozilla_page_load_details 13:26:57 INFO - PROCESS | 15456 | |i|pagename|runs| 13:26:57 INFO - PROCESS | 15456 | |0;ai-astar;112;117;114;115;116;115;114;117;114;115 13:26:57 INFO - PROCESS | 15456 | |1;audio-beat-detection;160;128;126;164;131;127;129;128;170;132 13:26:57 INFO - PROCESS | 15456 | |2;audio-dft;160;160;162;161;161;162;161;161;161;160 13:26:57 INFO - PROCESS | 15456 | |3;audio-fft;76;78;77;109;77;78;78;76;100;77 13:26:57 INFO - PROCESS | 15456 | |4;audio-oscillator;85;83;115;83;84;84;111;84;83;108 13:26:57 INFO - PROCESS | 15456 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;117;116;117 13:26:57 INFO - PROCESS | 15456 | |6;imaging-darkroom;146;146;146;146;147;146;146;145;146;146 13:26:57 INFO - PROCESS | 15456 | |7;imaging-desaturate;95;94;95;95;94;95;94;96;95;95 13:26:57 INFO - PROCESS | 15456 | |8;json-parse-financial;65;62;62;63;62;65;64;65;64;64 13:26:57 INFO - PROCESS | 15456 | |9;json-stringify-tinderbox;67;67;66;66;68;66;67;67;66;66 13:26:57 INFO - PROCESS | 15456 | |10;stanford-crypto-aes;83;84;83;85;84;83;83;82;82;82 13:26:57 INFO - PROCESS | 15456 | |11;stanford-crypto-ccm;142;138;139;138;139;140;139;139;182;150 13:26:57 INFO - PROCESS | 15456 | |12;stanford-crypto-pbkdf2;175;178;174;177;181;174;174;177;175;175 13:26:57 INFO - PROCESS | 15456 | |13;stanford-crypto-sha256-iterative;70;69;70;73;70;70;69;74;68;74 13:26:57 INFO - PROCESS | 15456 | __end_tp_report 13:26:57 INFO - PROCESS | 15456 | __start_cc_report 13:26:57 INFO - PROCESS | 15456 | _x_x_mozilla_cycle_collect,1930 13:26:57 INFO - PROCESS | 15456 | __end_cc_report 13:26:57 INFO - PROCESS | 15456 | __startTimestamp1475872017233__endTimestamp 13:26:57 INFO - PROCESS | 15456 | 13:26:57 INFO - PROCESS | 15456 | ------- Summary: start ------- 13:26:57 INFO - PROCESS | 15456 | Number of tests: 14 13:26:57 INFO - PROCESS | 15456 | 13:26:57 INFO - PROCESS | 15456 | [#0] ai-astar Cycles:10 Average:114.90 Median:115.00 stddev:1.52 (1.3%) stddev-sans-first:1.20 13:26:57 INFO - PROCESS | 15456 | Values: 112.0 117.0 114.0 115.0 116.0 115.0 114.0 117.0 114.0 115.0 13:26:57 INFO - PROCESS | 15456 | 13:26:57 INFO - PROCESS | 15456 | [#1] audio-beat-detection Cycles:10 Average:139.50 Median:131.50 stddev:17.61 (13.4%) stddev-sans-first:17.05 13:26:57 INFO - PROCESS | 15456 | Values: 160.0 128.0 126.0 164.0 131.0 127.0 129.0 128.0 170.0 132.0 13:26:57 INFO - PROCESS | 15456 | 13:26:57 INFO - PROCESS | 15456 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 13:26:57 INFO - PROCESS | 15456 | Values: 160.0 160.0 162.0 161.0 161.0 162.0 161.0 161.0 161.0 160.0 13:26:57 INFO - PROCESS | 15456 | 13:26:57 INFO - PROCESS | 15456 | [#3] audio-fft Cycles:10 Average:82.60 Median:77.00 stddev:11.76 (15.3%) stddev-sans-first:12.23 13:26:57 INFO - PROCESS | 15456 | Values: 76.0 78.0 77.0 109.0 77.0 78.0 78.0 76.0 100.0 77.0 13:26:57 INFO - PROCESS | 15456 | 13:26:57 INFO - PROCESS | 15456 | [#4] audio-oscillator Cycles:10 Average:92.00 Median:83.50 stddev:13.46 (16.1%) stddev-sans-first:14.03 13:26:57 INFO - PROCESS | 15456 | Values: 85.0 83.0 115.0 83.0 84.0 84.0 111.0 84.0 83.0 108.0 13:26:57 INFO - PROCESS | 15456 | 13:26:57 INFO - PROCESS | 15456 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 13:26:57 INFO - PROCESS | 15456 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 117.0 13:26:57 INFO - PROCESS | 15456 | 13:26:57 INFO - PROCESS | 15456 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 13:26:57 INFO - PROCESS | 15456 | Values: 146.0 146.0 146.0 146.0 147.0 146.0 146.0 145.0 146.0 146.0 13:26:57 INFO - PROCESS | 15456 | 13:26:57 INFO - PROCESS | 15456 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 13:26:57 INFO - PROCESS | 15456 | Values: 95.0 94.0 95.0 95.0 94.0 95.0 94.0 96.0 95.0 95.0 13:26:57 INFO - PROCESS | 15456 | 13:26:57 INFO - PROCESS | 15456 | [#8] json-parse-financial Cycles:10 Average:63.60 Median:64.00 stddev:1.26 (2.0%) stddev-sans-first:1.24 13:26:57 INFO - PROCESS | 15456 | Values: 65.0 62.0 62.0 63.0 62.0 65.0 64.0 65.0 64.0 64.0 13:26:57 INFO - PROCESS | 15456 | 13:26:57 INFO - PROCESS | 15456 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:67.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 13:26:57 INFO - PROCESS | 15456 | Values: 67.0 67.0 66.0 66.0 68.0 66.0 67.0 67.0 66.0 66.0 13:26:57 INFO - PROCESS | 15456 | 13:26:57 INFO - PROCESS | 15456 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:83.00 stddev:0.99 (1.2%) stddev-sans-first:1.05 13:26:57 INFO - PROCESS | 15456 | Values: 83.0 84.0 83.0 85.0 84.0 83.0 83.0 82.0 82.0 82.0 13:26:57 INFO - PROCESS | 15456 | 13:26:57 INFO - PROCESS | 15456 | [#11] stanford-crypto-ccm Cycles:10 Average:144.60 Median:139.50 stddev:13.62 (9.8%) stddev-sans-first:14.41 13:26:57 INFO - PROCESS | 15456 | Values: 142.0 138.0 139.0 138.0 139.0 140.0 139.0 139.0 182.0 150.0 13:26:57 INFO - PROCESS | 15456 | 13:26:57 INFO - PROCESS | 15456 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.00 Median:176.00 stddev:2.26 (1.3%) stddev-sans-first:2.37 13:26:57 INFO - PROCESS | 15456 | Values: 175.0 178.0 174.0 177.0 181.0 174.0 174.0 177.0 175.0 175.0 13:26:57 INFO - PROCESS | 15456 | 13:26:57 INFO - PROCESS | 15456 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.70 Median:70.00 stddev:2.16 (3.1%) stddev-sans-first:2.28 13:26:57 INFO - PROCESS | 15456 | Values: 70.0 69.0 70.0 73.0 70.0 70.0 69.0 74.0 68.0 74.0 13:26:57 INFO - PROCESS | 15456 | -------- Summary: end -------- 13:26:57 INFO - PROCESS | 15456 | 13:26:58 INFO - TEST-INFO | 15456: exit 0 13:26:58 INFO - TEST-OK | kraken | took 64860ms 13:26:58 INFO - SUITE-END | took 1186s 13:26:58 INFO - Completed test suite (00:19:47) 13:26:58 INFO - javascript benchmark 13:26:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2578.7292334304902, 2608.608708693697, 2630.9736902630966, 2636.3277364272108, 2652.244110428527, 4495.370648109268, 4563.3839431676715, 4696.718196908184, 4737.028909073644, 4737.644676649252, 4605.79273932673, 4715.952840471594, 4759.666823322369, 4788.186008378575, 4832.347633069535, 4268.253055715253, 4283.37891005804, 4316.956830431687, 4330.307150855863, 4352.499462561815, 4359.237133501624, 4390.100029493946, 4395.494518130424, 4406.052698669785, 4416.86749397517, 4200.4539409876525, 4312.310030395153, 4321.308590625485, 4337.783110844461, 4414.161309351213, 4211.115665710205, 4291.24903141952, 4296.9140617187795, 4297.656187505024, 4312.159128969852, 4276.957230427687, 4282.272013757669, 4282.614564689193, 4283.229018776619, 4291.592298731647, 4632.675712700112, 4688.2733176357715, 4698.530146985308, 4705.952940470585, 4767.404074490689, 5026.321446604698, 5038.168702164138, 5049.242613607951, 5051.747412629354, 5095.668781529189, 4861.368022157097, 5070.72111033893, 5075.213341932006, 5082.79668813247, 5146.433892271847, 4542.727436353796, 4626.768661566908, 4637.373954516164, 4644.349791029259, 4745.667803253739, 5079.74601269935, 5111.846644600668, 5132.589392848563, 5133.024725302181, 5195.480451954774, 4916.434610019822, 4924.359833221658, 4926.729029903389, 4928.926066109011, 4985.302057711923, 4877.853664390074, 4915.139850526144, 4919.2129259318335, 4991.176455884738, 5035.471275516092, 4992.650514463952, 5029.145045342228, 5051.570616497565, 5068.873278168076, 5084.644074914794, 5001.949590585945, 5025.597952163818, 5027.1705168647495, 5027.2207807789855, 5071.746412679351, 4165.062860856283, 4197.034682023091, 4199.496060472763, 4317.805698743564, 4319.913601728011, 3685.94471082934, 3719.423489359154, 3724.4413337998976, 3761.360568703327, 3766.8304926278383, 4246.787660616957, 4250.298700714347, 4300.053988122608, 4300.849470268526, 4301.268784306675, 4974.32846565709, 4974.751262436864, 4990.675606085593, 4990.975045124751, 5049.040682270357, 4142.399352093929, 4186.351115577029, 4187.350960601112, 4232.047789247456, 4278.7004909656025, 4460.687751857339, 4506.459224893034, 4539.387182730356, 4542.250528662734, 4600.263957766741, 4686.81252749893, 4719.10337035962, 4721.339012538316, 4727.267273572465, 4778.402699662543, 4898.975505122594, 5019.247112933089, 5048.974755126201, 5059.215821547666, 5115.283860259492, 4643.883902902319, 4647.697899636512, 4660.487346391962, 4664.300354946785, 4692.014676917749, 4918.754062296799, 4932.4081110267, 4933.087378834927, 4991.376077990251, 4993.450720420823, 5022.573081288131, 5024.824131155392, 5028.170351892043, 5029.396472423333, 5095.312132862016, 4743.881402964954, 4776.832810851603, 4798.592119669867, 4879.658423910292, 4949.208126699711, 4842.878928026827, 4857.684250523705, 4888.828890988798, 4893.314935908905, 4952.851414457572, 4788.545088216614, 4791.496892826203, 4791.832285869978, 4799.616030717604, 4861.708297502161, 4796.496367881462, 4838.0, 4849.660523763303, 4920.92618610714, 4987.526185012418, 4788.353572267839, 4819.325294458708, 4833.202521583899, 4916.532929371704, 4918.311436398979], "value": 4598.143671559915, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.6090006545386, 559.8180591307824, 562.2662425534676, 566.9914951275731, 575.2464271803935, 28437.14688559344, 38472.80763596181, 39984.00039998998, 40099.799501002526, 44120.779396103055, 40980.79509602448, 41387.58612413875, 41397.58602413975, 41410.37884431736, 41489.58510414895, 7624.703800353939, 7766.37868970481, 7771.805704857367, 7772.106207786092, 7772.222777722211, 7210.567365958033, 7406.407487400995, 9807.558659860324, 10004.449755263458, 10030.498475076254, 10086.899131008706, 10180.949095254551, 10182.592696292177, 10184.592616295377, 10198.184145268398, 10038.046385593394, 10111.595536178544, 10114.797704045952, 10117.291789574732, 10123.797524049478, 9879.456629885353, 9962.452065136415, 9967.259003773948, 9977.052180042885, 9978.750531236705, 37636.623633763586, 37904.81047594772, 37944.81027594872, 37959.62040379616, 37982.0, 2820.562812764025, 2907.3749143933946, 3100.193949573105, 3221.983890080535, 3338.532605435241, 27916.16251512458, 28539.57190642142, 28706.569401458994, 28732.569011464635, 28772.0, 3219.951700724491, 3285.227971426713, 3340.816255105968, 3349.7152742016956, 3397.915052123692, 172374.0, 172973.0, 173437.0, 173452.0, 173595.13202433908, 47589.76205118952, 47856.0, 47860.28209576859, 47880.5211947883, 47898.0, 29653.406931861242, 30161.547576786365, 30244.395112097634, 30244.84877575598, 57231.42768572344, 14078.536256155132, 14319.212443315717, 14327.78508322376, 14330.355134018993, 14334.133173365368, 9764.707058788248, 9886.851697224547, 11126.221164518405, 11210.887891120985, 11212.887871121347, 15831.683366332609, 15947.681046379008, 15980.680386392207, 17387.478375648752, 18016.90991545034, 6572.34276572339, 6652.434543063797, 6653.733850646016, 6774.559653622498, 7011.404030657452, 771.699037375424, 822.7038266224155, 823.2749598827779, 882.2721254964551, 950.2493030505823, 26487.867560662075, 28548.85725571359, 28647.0, 28748.0, 28825.855870720512, 882.3999680217386, 903.1420150856582, 910.5219759626117, 946.2146418472652, 946.3848498476045, 14501.927490362481, 15135.848641513443, 15238.847611523743, 15241.390344386322, 15365.464698324651, 401796.0, 403577.0, 403777.0, 404887.0, 407363.0, 50668.0, 50970.74514627403, 51254.487455124974, 51282.23076653853, 51289.487105129214, 1126.695792136135, 1165.3648761425043, 1183.7277426192024, 1184.117832214988, 1201.471352604851, 26377.868110659325, 27845.860770696017, 28461.0, 28674.0, 28807.855960720062, 44218.3367249498, 44798.328025079, 44844.775776120914, 44916.0, 44938.0, 276041.61979189975, 277415.0, 277606.0, 277997.0, 278010.0, 38866.61133388743, 39283.607163928, 39356.606433935296, 39373.60626393814, 39416.2116757669, 38415.6158438412, 42107.57892421159, 42529.57470425256, 42935.35596965985, 44459.3324400537, 35782.64217357793, 36425.635743642226, 36536.0, 36546.451803222444, 36764.26471470609, 35631.0, 35925.0, 36157.0, 36180.4572931401, 37046.44430333493, 35659.0, 36081.639183607826, 36185.0, 36502.4524632136, 37116.0, 31308.53037204398, 33229.0, 33311.0, 33940.49089263712, 34201.144971375914, 25522.872385638697, 25615.743842562082, 25824.354391140372, 25914.611280830424, 26019.349516262246], "value": 17578.525387208418, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.89116037287886, 347.1373636513264, 354.08292522367066, 357.1695807248148, 373.9027852758282, 12193.695157621063, 13145.40845661945, 15770.211489425526, 16523.99999999997, 17733.202005909734, 15258.542243732678, 15370.385184592631, 15478.226088695577, 17184.22670979806, 17365.565860853483, 4078.4697989261504, 4808.591269742067, 5042.596592272609, 5044.545990860822, 5045.873853153664, 5780.161876527901, 5942.227510423639, 5975.25309336333, 5987.371326010772, 5992.670403127848, 5092.439831618519, 5362.410134885179, 5953.315368732608, 5953.672548009858, 5956.970215148918, 5420.295361603005, 5453.64551304164, 5461.290032295816, 5461.317335333083, 5464.617476776627, 4496.392986946753, 4756.595689366408, 4790.712557246577, 5272.393674727417, 5280.6039547034125, 19606.901965490222, 19978.600427991503, 20009.399718008484, 20073.0, 20235.494112647153, 1686.4434736537037, 1750.9299628014992, 1874.9531261718566, 1962.6957821537685, 2006.4482267376588, 8498.957505212435, 8797.956010219972, 9042.547872606343, 9244.815103697889, 9402.576884040167, 1571.4735563586212, 1678.4628918746007, 1680.5714542791509, 1685.4859267923277, 1694.1529235382309, 65924.34075659278, 67788.0, 69211.3078869215, 72052.27947720508, 74705.62647186729, 9182.17360437564, 9254.953725231331, 9545.379550329206, 9608.711738647851, 9814.0, 13310.534131305358, 13335.199888006557, 13354.933225334005, 13372.732545349234, 13391.665208369868, 6767.35710107539, 6889.827754306182, 6970.302969702989, 7106.467014973898, 7152.356287934111, 6583.670816459254, 6601.240857301472, 6740.460763138937, 6746.0, 6779.2881747416795, 4030.1133750574827, 4125.587441255911, 4141.7722025288895, 4210.694684647769, 4252.425922500484, 1671.9080450575336, 1760.3838656470134, 1793.609952286962, 1874.175362840346, 1876.596531745654, 665.0323778901686, 692.9272426395257, 838.5429940682343, 918.9172974432333, 923.5382308845577, 16244.59388515273, 16320.510384688478, 17089.743653845202, 17773.555661108574, 17966.730499042525, 816.1063635319316, 818.8771684247411, 833.7165363776345, 856.4347530629755, 902.9706135006098, 9265.119813617695, 9280.67517636893, 9797.167240784613, 9906.653267135616, 10087.49562521871, 259080.0, 265709.0, 266262.0, 363093.0, 363662.0, 74488.62755686187, 75854.10364740925, 76615.0, 77210.61394692991, 78739.21260787318, 866.1987661413168, 876.9667268506587, 897.9326550508607, 907.6006557114848, 907.7186072317603, 11604.593839215588, 14559.490417835748, 14601.634959126106, 15686.76469852976, 16186.919065404598, 38192.61807381891, 38466.615333846305, 39093.60906391013, 39416.0, 39686.801565991984, 48252.7587362075, 49015.75492122517, 49307.75346123247, 49525.75237123791, 49609.75195124001, 6452.22573291208, 6721.1598550181225, 6948.5483443576, 7403.370713489198, 7852.803679908048, 11438.256513326607, 11994.700132496757, 12423.565175218824, 12511.249325040526, 12519.812202817147, 10291.53688084023, 10463.424511651932, 10542.683719488121, 10547.683569492927, 10730.409827459565, 10545.367277963347, 10581.788364232518, 10599.364038157735, 10638.84041739359, 10849.403282819521, 9799.951000244953, 10418.218633602359, 10551.261411701107, 10833.891661083288, 10949.178811589003, 6870.793876183722, 6896.310368963264, 6922.307769223037, 6977.197622273504, 6997.965010174917, 9514.23886089125, 10295.3822770634, 10624.52189651483, 10654.946725266323, 11042.227044106836], "value": 7986.216160478433, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1297.8247936528571, 1354.5056054540094, 1356.9807179026666, 1576.7556028815538, 1608.364695945101, 6935.375816176543, 7463.477556571042, 7474.364679002291, 7476.738314159005, 7482.513636613617, 6170.8148755537295, 6329.4619957303685, 6989.790306290819, 7201.1358636963505, 7362.558246505213, 1953.1308567687386, 1963.862529622927, 1973.891435971021, 1974.3583335415976, 1987.07600965551, 1907.8092190780949, 1954.5895361974003, 1958.4124762571244, 1967.7048442733562, 1970.9310174143907, 1678.102215314807, 1694.2460605030767, 1933.9903300483547, 2002.1290738528714, 2002.349236498144, 1945.085809669453, 1962.3229985654925, 1963.9410817675493, 1964.4597735622676, 1966.8918209498472, 1909.6371689378973, 1955.1495099631563, 1956.7456230690061, 1958.4516335426104, 1960.029785256293, 7000.194977577593, 7061.470389720792, 7065.646717664147, 7070.7525236616475, 7107.857842843114, 4164.3961625564425, 4358.411614432042, 4359.04101097758, 4362.738235705868, 4369.191699535564, 2620.475904819044, 2692.219256415637, 2730.795190360731, 2730.84980326082, 2733.562629979214, 789.1122487201898, 801.1627848897915, 820.6143112737004, 845.3913182508645, 847.3221422861748, 9452.385594936375, 9480.336376453652, 9480.857787133198, 9507.239420846316, 9517.381370210915, 3649.817509124533, 3728.12389088564, 3839.4816699745734, 3870.4581358609817, 3873.8063096845044, 8355.373346999, 8366.07973122956, 8376.371772117116, 8379.832403351898, 8386.37102217324, 4342.41377414045, 4345.652347812167, 4355.542668019875, 4356.302991521341, 4356.738595684269, 3969.900752481211, 3972.324704800191, 3973.2450834341385, 3974.4038394241097, 3975.2447035063246, 3256.690614391629, 3419.4612424409115, 3426.5716785401823, 3439.6560343965402, 3474.357243909885, 1039.599754094664, 1079.5897558927713, 1090.6128324444867, 1092.6667366453307, 1094.1520321750547, 587.9088741245114, 687.4363022321648, 765.8698021336386, 789.8578255913876, 804.6821505505293, 4665.043666048452, 4710.905781884343, 4731.526847315241, 4772.976135119302, 4816.95183048165, 797.7606717984581, 802.1577343789115, 815.7267315449272, 821.0762891746784, 822.3174764945081, 3176.4758814795764, 3287.6547962463596, 3387.542681737934, 3405.3359594879257, 3415.0, 8526.488410695378, 8925.375223734407, 8935.151160639729, 8947.060558641379, 8953.820923581492, 8818.603162857687, 8852.070532594114, 8855.424397414276, 8860.069692682175, 8871.733847984571, 6690.330966903368, 6701.396874281338, 6762.120924279812, 6787.321267873173, 6853.588784672936, 4725.40932383452, 4746.145693775154, 4764.880877978078, 4767.094252092092, 4856.854294371175, 8128.75613731589, 8194.467359621605, 8248.793780155544, 8257.917420825715, 8288.046874609498, 7476.214997425192, 7795.766127016199, 7806.57063861493, 8337.416380853525, 8370.66517339324, 6310.337414571588, 6454.838629034311, 6465.418112369909, 6467.514936379696, 6469.191351081115, 6898.103246577913, 6956.339147780953, 6961.0, 6961.0, 6962.373386395248, 6121.326654068138, 6171.9691401542705, 6206.72069756853, 6236.095766113797, 6236.968815155895, 6133.141360209664, 6192.195014648067, 6229.781957631461, 6333.778317759041, 6373.74505019794, 5501.202325662836, 5539.667619942655, 5609.551235901036, 5628.352739434854, 5749.482546570829, 4282.293421585528, 4334.45819272591, 4403.273459879084, 4410.09593033421, 4483.484399294123, 4379.627731642719, 4391.692581519263, 4462.531434199363, 4531.954680453153, 4541.341505481752], "value": 3800.909725789045, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [281.19437810672423, 283.947469718102, 289.55697782392934, 290.40901764908415, 291.0555248219528, 4786.353842231298, 4821.325014497973, 4830.806767729296, 4857.781399837007, 4886.951130488694, 4809.326694262806, 4810.086083644105, 4818.108649899771, 4824.914394261289, 4842.975785121078, 3562.2341196642715, 3696.6488183622646, 3705.4256590228556, 3824.9808750956277, 3825.445310429986, 3777.848886044555, 3806.60030696777, 3806.8667596634123, 3807.923841523168, 3817.2938006468894, 3786.734928555002, 3791.3365161096835, 3792.317382871082, 3797.316483033053, 3810.771353718772, 3613.927721445583, 3659.79871107089, 3698.981505092457, 3821.445890345898, 3825.617438256166, 3309.8841540546205, 3317.717993970515, 3324.202191474053, 3340.7160391366765, 3343.7157841583494, 4639.0, 4647.884507718157, 4666.0, 4668.906621867578, 4671.813127474897, 4168.624823765876, 4257.233697934371, 4262.595053469915, 4268.637165840876, 4285.46431696038, 4983.782216913475, 4994.325766021613, 5003.824866129705, 5007.6244281678655, 5009.4239162496415, 3597.94603080954, 3609.2240168363664, 3621.3481573316794, 3625.5830579483168, 3625.782453052825, 5259.815906443295, 5269.868253293698, 5289.603279754034, 5290.497402746733, 5290.81482148123, 3606.6032736398975, 3663.8383353821373, 3699.6855267302044, 3708.3683179400978, 3709.7201465494363, 3753.49327840738, 3754.962450375516, 3755.962440375616, 3756.492873462102, 3759.4924685167152, 4263.381809637585, 4286.164197981426, 4288.206681763883, 4288.606202984042, 4305.720128191658, 4837.298591704183, 5004.149294619923, 5021.72380519075, 5057.0, 5086.237064440364, 1272.5037235478171, 1295.7149427126017, 1295.7861952777687, 1300.2458574027041, 1300.938013248992, 806.4032615864219, 828.9668413263402, 835.7910522369408, 836.652789092532, 844.907060223375, 3964.9801750991637, 3976.701747368959, 4224.345226489899, 4330.155619654201, 4366.602687140148, 5126.897462050738, 5180.9740951295, 5196.53231209193, 5220.3735551734035, 5243.161094224905, 4426.667999900021, 4426.84506042287, 4429.734215947054, 4431.202383570923, 4443.133588950123, 2616.947661046768, 2724.441489494649, 2726.877290521931, 2742.6297449844415, 2756.379814541712, 4806.255030470283, 4824.855254342376, 4837.443693975238, 4868.318435419044, 4869.756512174448, 5298.655587386807, 5301.416844147141, 5305.840824775263, 5316.76074576645, 5321.441248668912, 4700.2244629635725, 4810.759462026885, 4834.0, 4843.467218606021, 4872.829450969199, 5157.381114266162, 5170.405403378509, 5190.6107041972755, 5201.583873290203, 5202.245674377118, 5095.108356037605, 5109.642325037212, 5112.872178195426, 5115.823360627002, 5125.5899528036925, 4710.633916164411, 4820.975895120502, 4843.539863712942, 4845.6608037437045, 4856.0, 3687.580281591553, 3701.5373078365205, 3709.647583479565, 3712.888613341604, 3715.2723983347873, 5207.3490813648295, 5214.8957020860125, 5229.973850130725, 5238.266642669953, 5244.711540865289, 4840.757962101951, 4987.401511818605, 5027.748612569284, 5040.269160971712, 5076.619253556072, 5015.949840501548, 5032.547070763649, 5035.546800787946, 5039.344885165052, 5044.0, 4976.183692952119, 4989.330708071165, 4993.400791904995, 4998.0, 4999.125153098121, 4817.975910120427, 4859.757012149449, 5084.3644544431945, 5100.285959965682, 5102.0, 4852.902941941212, 4869.415670119608, 4970.105381031449, 5002.274670172732, 5016.573591244785], "value": 3787.755410698046, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [608.1151923950653, 633.6008314761702, 633.9207599050119, 641.8940874755666, 650.2749434380667, 12496.062795290343, 13147.6713082173, 13490.730185396285, 13497.527586534474, 13512.662183445418, 12899.742005159891, 12958.028147888923, 12958.15771974821, 12962.0, 13036.478540858354, 617.3456136495307, 633.395107672172, 745.0872680965828, 752.6989204318289, 768.6694721269852, 755.7619349904762, 776.316841179761, 777.0675189772268, 777.2305417636527, 777.3276116159537, 818.8812622169781, 819.3772732723114, 819.4509678515409, 820.0282665041915, 820.2863508747398, 651.661136209171, 671.0136099933139, 790.1821614628889, 806.0287353738789, 818.1450384348341, 601.2094096263444, 601.6390165900468, 601.969901504923, 602.1810337940398, 602.3253955569746, 12159.817602735966, 12168.51325946961, 12201.633950981484, 12205.511779528808, 12226.877731222752, 11940.462679179458, 12414.503419863195, 12638.49446022158, 13010.414531346112, 13247.933760331136, 10998.505067271992, 11221.158413119048, 11311.943440282828, 11635.30188188703, 11856.288622682581, 4002.5397079335958, 4009.3585026395635, 4026.6778657707314, 4052.918941621151, 4065.6747460203114, 62217.377826222066, 62642.0, 62861.37138628647, 63013.68493157505, 64160.0, 9486.573104210327, 9616.23070154386, 10180.643677471253, 10320.845187322197, 10733.570657173781, 19152.52118697016, 19176.424707258804, 19179.61640767177, 19181.232750690095, 19257.4222773317, 6279.403456671609, 6429.228492580826, 6522.934770652328, 6554.901676474857, 6578.440832529192, 3527.7354198434705, 3549.8757543485854, 3552.626974167727, 3558.7508874378545, 3618.9819050905103, 2668.986655066751, 2749.8625068746883, 2764.129299270723, 2767.6263704400053, 2805.4809860175933, 494.6216144649346, 500.5845148526714, 508.8371721049303, 511.2254933775333, 513.8175947538645, 455.87007702805204, 549.9120140777536, 584.7018020809418, 611.1535523300261, 635.9109724638554, 7968.521888686697, 8834.823303534022, 8839.508882913162, 8983.966843812914, 9027.097290271051, 592.703648175912, 604.7036951893629, 608.2032537376051, 611.2084850119106, 644.2816259870211, 3895.2599006188734, 4215.515215750167, 4216.746995180299, 4298.290782020994, 4299.398084268205, 53650.46349536533, 57101.0, 57285.0, 57313.713431432574, 59812.0, 86081.5695921529, 87336.56331718301, 87376.0, 88474.55762721274, 90156.54921725481, 47223.0, 69920.75594330445, 74797.62601187069, 77324.61337693501, 77333.61333193298, 7276.381507571916, 7786.221377862168, 7845.960770196112, 7878.330341921001, 7949.523028618301, 42417.575824241365, 42855.785721071195, 43277.0, 43417.56582434135, 45192.096158076, 55865.44134558603, 62585.0, 62685.05972410326, 63060.0, 63223.0, 10213.795724085625, 10320.638777642747, 10476.793901508196, 10507.842382364424, 10573.365598064142, 11073.50169242402, 11183.440827958408, 11645.88354116448, 11754.823677644672, 11871.821922670993, 10615.31000484966, 10821.18841086906, 11184.384858832842, 11190.440477976232, 11248.7750244993, 10846.728831779268, 10992.450377480935, 11067.446627668423, 11427.657170284905, 11429.428528573704, 10004.899951000396, 10018.345138538147, 10326.0, 10740.0, 10749.462526873469, 8555.657773688983, 8730.956345218234, 8954.68658596972, 8971.82056358856, 9245.907540924505, 9081.228095611947, 9622.37454565451, 9644.807103858024, 9671.758206044906, 9768.681228034124], "value": 6333.0932717128, "unit": "score"}], "name": "dromaeo_css", "value": 6236.976449355095, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 117.0, 114.0, 115.0, 116.0, 115.0, 114.0, 117.0, 114.0, 115.0], "value": 114.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 128.0, 126.0, 164.0, 131.0, 127.0, 129.0, 128.0, 170.0, 132.0], "value": 139.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 162.0, 161.0, 161.0, 162.0, 161.0, 161.0, 161.0, 160.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 77.0, 109.0, 77.0, 78.0, 78.0, 76.0, 100.0, 77.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 115.0, 83.0, 84.0, 84.0, 111.0, 84.0, 83.0, 108.0], "value": 92.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.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, 147.0, 146.0, 146.0, 145.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0, 96.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 62.0, 63.0, 62.0, 65.0, 64.0, 65.0, 64.0, 64.0], "value": 63.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 66.0, 68.0, 66.0, 67.0, 67.0, 66.0, 66.0], "value": 66.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 83.0, 85.0, 84.0, 83.0, 83.0, 82.0, 82.0, 82.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 138.0, 139.0, 138.0, 139.0, 140.0, 139.0, 139.0, 182.0, 150.0], "value": 144.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 178.0, 174.0, 177.0, 181.0, 174.0, 174.0, 177.0, 175.0, 175.0], "value": 176.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 70.0, 73.0, 70.0, 70.0, 69.0, 74.0, 68.0, 74.0], "value": 70.7, "unit": "score"}], "name": "kraken", "value": 1552.0999999999997, "alertThreshold": 2.0}]} 13:26:58 INFO - Return code: 0 13:26:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:26:59 INFO - # TBPL SUCCESS # 13:26:59 INFO - Running post-action listener: _resource_record_post_action 13:26:59 INFO - [mozharness: 2016-10-07 20:26:59.014517Z] Finished run-tests step (success) 13:26:59 INFO - Running post-run listener: _resource_record_post_run 13:26:59 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392159232; Read time: 12; Write time: 224060 13:26:59 INFO - TinderboxPrint: CPU usage
13.0% 13:26:59 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 13:26:59 INFO - TinderboxPrint: I/O write bytes / time
392,159,232 / 224,060 13:26:59 INFO - TinderboxPrint: CPU idle
8,347.8 (87.0%) 13:26:59 INFO - TinderboxPrint: CPU user
1,202.9 (12.5%) 13:26:59 INFO - TinderboxPrint: Swap in / out
0 / 0 13:26:59 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99160064; Read time: 0; Write time: 51236 13:26:59 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 292999168; Read time: 0; Write time: 172824 13:26:59 INFO - Running post-run listener: _upload_blobber_files 13:26:59 INFO - Blob upload gear active. 13:26:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:26:59 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 13:26:59 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', 'Larch-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:26:59 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 Larch-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:27:00 INFO - (blobuploader) - INFO - Open directory for files ... 13:27:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:27:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:27:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:27:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:27:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:27:01 INFO - (blobuploader) - INFO - Done attempting. 13:27:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:27:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:27:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:27:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:27:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:27:02 INFO - (blobuploader) - INFO - Done attempting. 13:27:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:27:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:27:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:27:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:27:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:27:06 INFO - (blobuploader) - INFO - Done attempting. 13:27:06 INFO - (blobuploader) - INFO - Iteration through files over. 13:27:06 INFO - Return code: 0 13:27:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:27:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:27:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/32c270af9dc0f3091969b918fad81cc9bc1e224053037447f780586df39633fe2049a8b5b03eda2e7e0926faa0522f388bb88d7e2d20475f29f37bc0e3766971", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/f8c5807e9f5fe780d0a304f650911022e68872f84dae7a775a2988bf6029be509c37d94abeaaffc60f485721ee40e659c6e5c2bc9064a1716a9f143cb65a993a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/48d1b03026cc78bad33ce2cd1d17cff502e5fddcfe264cff6fd67fd863ae4966dfa32b57778ea401dd677e5d200fbe65807fb4c60b2230e89fc46706bbc1b4a9"} 13:27:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:27:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:27:06 INFO - Contents: 13:27:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/32c270af9dc0f3091969b918fad81cc9bc1e224053037447f780586df39633fe2049a8b5b03eda2e7e0926faa0522f388bb88d7e2d20475f29f37bc0e3766971", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/f8c5807e9f5fe780d0a304f650911022e68872f84dae7a775a2988bf6029be509c37d94abeaaffc60f485721ee40e659c6e5c2bc9064a1716a9f143cb65a993a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/48d1b03026cc78bad33ce2cd1d17cff502e5fddcfe264cff6fd67fd863ae4966dfa32b57778ea401dd677e5d200fbe65807fb4c60b2230e89fc46706bbc1b4a9"} 13:27:06 INFO - Running post-run listener: copy_logs_to_upload_dir 13:27:06 INFO - Copying logs to upload dir... 13:27:06 INFO - mkdir: /builds/slave/test/build/upload/logs 13:27:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.197730 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-07 13:27:05.631103) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 13:27:05.635568) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1475870776.943327-372654948 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/32c270af9dc0f3091969b918fad81cc9bc1e224053037447f780586df39633fe2049a8b5b03eda2e7e0926faa0522f388bb88d7e2d20475f29f37bc0e3766971", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/f8c5807e9f5fe780d0a304f650911022e68872f84dae7a775a2988bf6029be509c37d94abeaaffc60f485721ee40e659c6e5c2bc9064a1716a9f143cb65a993a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/48d1b03026cc78bad33ce2cd1d17cff502e5fddcfe264cff6fd67fd863ae4966dfa32b57778ea401dd677e5d200fbe65807fb4c60b2230e89fc46706bbc1b4a9"} build_url:https://queue.taskcluster.net/v1/task/HmWIxuYTRfS3svN6UIExnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011458 build_url: 'https://queue.taskcluster.net/v1/task/HmWIxuYTRfS3svN6UIExnw/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/Larch-Non-PGO/sha512/32c270af9dc0f3091969b918fad81cc9bc1e224053037447f780586df39633fe2049a8b5b03eda2e7e0926faa0522f388bb88d7e2d20475f29f37bc0e3766971", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/f8c5807e9f5fe780d0a304f650911022e68872f84dae7a775a2988bf6029be509c37d94abeaaffc60f485721ee40e659c6e5c2bc9064a1716a9f143cb65a993a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/48d1b03026cc78bad33ce2cd1d17cff502e5fddcfe264cff6fd67fd863ae4966dfa32b57778ea401dd677e5d200fbe65807fb4c60b2230e89fc46706bbc1b4a9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 13:27:05.665912) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 13:27:05.666504) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1475870776.943327-372654948 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004510 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 13:27:05.749667) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 13:27:05.750024) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 13:27:05.750370) ========= ========= Total master_lag: 0.18 =========